builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0382 starttime: 1489405198.5 results: success (0) buildid: 20170313030209 builduid: 0332e96d644b4a6e8aa41d76a1f3f055 revision: f9362554866b327700c7f9b18050d7b7eb3d2b23 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-13 04:39:58.497094) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-13 04:39:58.497599) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-13 04:39:58.497944) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-13 04:39:58.525891) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 04:39:58.526328) ========= 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.y7Z6F4kfJA/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.KXlfR6vQ1P/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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-03-13 04:39:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 17.1M=0.001s 2017-03-13 04:39:58 (17.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132510 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 04:39:58.683897) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 04:39:58.684214) ========= 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.y7Z6F4kfJA/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.KXlfR6vQ1P/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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.027030 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 04:39:58.732888) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-13 04:39:58.733242) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f9362554866b327700c7f9b18050d7b7eb3d2b23 --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 f9362554866b327700c7f9b18050d7b7eb3d2b23 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.y7Z6F4kfJA/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.KXlfR6vQ1P/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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-03-13 04:39:58,841 truncating revision to first 12 chars 2017-03-13 04:39:58,841 Setting DEBUG logging. 2017-03-13 04:39:58,841 attempt 1/10 2017-03-13 04:39:58,841 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f9362554866b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-13 04:40:00,602 unpacking tar archive at: mozilla-central-f9362554866b/testing/mozharness/ program finished with exit code 0 elapsedTime=2.037562 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-13 04:40:00.795046) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-13 04:40:00.795537) ========= script_repo_revision: f9362554866b327700c7f9b18050d7b7eb3d2b23 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-13 04:40:00.796101) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-13 04:40:00.796390) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-13 04:40:00.816488) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-13 04:40:00.816874) ========= /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.y7Z6F4kfJA/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.KXlfR6vQ1P/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:40:01 INFO - MultiFileLogger online at 20170313 04:40:01 in /builds/slave/test 04:40:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:40:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:40:01 INFO - {'append_to_log': False, 04:40:01 INFO - 'base_work_dir': '/builds/slave/test', 04:40:01 INFO - 'blob_upload_branch': 'Firefox', 04:40:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:40:01 INFO - 'branch': 'Firefox', 04:40:01 INFO - 'buildbot_json_path': 'buildprops.json', 04:40:01 INFO - 'config_files': ('talos/mac_config.py',), 04:40:01 INFO - 'default_actions': ('clobber', 04:40:01 INFO - 'read-buildbot-config', 04:40:01 INFO - 'download-and-extract', 04:40:01 INFO - 'populate-webroot', 04:40:01 INFO - 'create-virtualenv', 04:40:01 INFO - 'install', 04:40:01 INFO - 'run-tests'), 04:40:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:40:01 INFO - 'download_minidump_stackwalk': True, 04:40:01 INFO - 'download_symbols': 'ondemand', 04:40:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:40:01 INFO - 'tooltool.py': '/tools/tooltool.py', 04:40:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:40:01 INFO - '/tools/misc-python/virtualenv.py')}, 04:40:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:40:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:40:01 INFO - 'gecko_profile': False, 04:40:01 INFO - 'gecko_profile_interval': 0, 04:40:01 INFO - 'installer_path': 'installer.exe', 04:40:01 INFO - 'log_level': 'info', 04:40:01 INFO - 'log_name': 'talos', 04:40:01 INFO - 'log_to_console': True, 04:40:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:40:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:40:01 INFO - 'opt_config_files': (), 04:40:01 INFO - 'pip_index': False, 04:40:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:40:01 INFO - 'cmd': ('bash', 04:40:01 INFO - '-c', 04:40:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:40:01 INFO - 'enabled': True, 04:40:01 INFO - 'halt_on_failure': False, 04:40:01 INFO - 'name': 'check_screen_resolution'},), 04:40:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:40:01 INFO - 'cmd': ('bash', 04:40:01 INFO - '-c', 04:40:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:40:01 INFO - 'enabled': True, 04:40:01 INFO - 'halt_on_failure': False, 04:40:01 INFO - 'name': 'check_screen_resolution'},), 04:40:01 INFO - 'run_cmd_checks_enabled': True, 04:40:01 INFO - 'suite': 'dromaeojs', 04:40:01 INFO - 'system_bits': '32', 04:40:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:40:01 INFO - 'title': 't-yosemite-r7-0382', 04:40:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:40:01 INFO - 'use_talos_json': True, 04:40:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:40:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:40:01 INFO - 'work_dir': 'build'} 04:40:01 INFO - [mozharness: 2017-03-13 11:40:01.031268Z] Running clobber step. 04:40:01 INFO - Running pre-action listener: _resource_record_pre_action 04:40:01 INFO - Running main action method: clobber 04:40:01 INFO - rmtree: /builds/slave/test/build 04:40:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:40:03 INFO - Running post-action listener: _resource_record_post_action 04:40:03 INFO - [mozharness: 2017-03-13 11:40:03.338107Z] Finished clobber step (success) 04:40:03 INFO - [mozharness: 2017-03-13 11:40:03.338269Z] Running read-buildbot-config step. 04:40:03 INFO - Running pre-action listener: _resource_record_pre_action 04:40:03 INFO - Running main action method: read_buildbot_config 04:40:03 INFO - Using buildbot properties: 04:40:03 INFO - { 04:40:03 INFO - "project": "", 04:40:03 INFO - "product": "firefox", 04:40:03 INFO - "script_repo_revision": "production", 04:40:03 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:40:03 INFO - "repository": "", 04:40:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:40:03 INFO - "buildid": "20170313030209", 04:40:03 INFO - "stage_platform": "macosx64", 04:40:03 INFO - "basedir": "/builds/slave/test", 04:40:03 INFO - "nightly_build": "True", 04:40:03 INFO - "buildnumber": 66, 04:40:03 INFO - "slavename": "t-yosemite-r7-0382", 04:40:03 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:40:03 INFO - "platform": "yosemite_r7", 04:40:03 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:40:03 INFO - "branch": "mozilla-central", 04:40:03 INFO - "repo_path": "mozilla-central", 04:40:03 INFO - "revision": "f9362554866b327700c7f9b18050d7b7eb3d2b23", 04:40:03 INFO - "pgo_build": "False", 04:40:03 INFO - "builduid": "0332e96d644b4a6e8aa41d76a1f3f055", 04:40:03 INFO - "slavebuilddir": "test" 04:40:03 INFO - } 04:40:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/WvCYo8O0RGqt5M4Xx2IH2g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:40:03 INFO - Running post-action listener: _resource_record_post_action 04:40:03 INFO - [mozharness: 2017-03-13 11:40:03.341689Z] Finished read-buildbot-config step (success) 04:40:03 INFO - [mozharness: 2017-03-13 11:40:03.341804Z] Running download-and-extract step. 04:40:03 INFO - Running pre-action listener: _resource_record_pre_action 04:40:03 INFO - Running main action method: download_and_extract 04:40:03 INFO - mkdir: /builds/slave/test/build/tests 04:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:03 INFO - trying https://queue.taskcluster.net/v1/task/WvCYo8O0RGqt5M4Xx2IH2g/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:40:03 INFO - Downloading https://queue.taskcluster.net/v1/task/WvCYo8O0RGqt5M4Xx2IH2g/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:40:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WvCYo8O0RGqt5M4Xx2IH2g/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:40:04 INFO - Downloaded 1199 bytes. 04:40:04 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:40:04 INFO - Using the following test package requirements: 04:40:04 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:40:04 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:40:04 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:40:04 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:40:04 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:40:04 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:40:04 INFO - u'jsshell-mac.zip'], 04:40:04 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:40:04 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:40:04 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:40:04 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:40:04 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:40:04 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:40:04 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:40:04 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:40:04 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:40:04 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:40:04 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:40:04 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:40:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WvCYo8O0RGqt5M4Xx2IH2g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:40:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WvCYo8O0RGqt5M4Xx2IH2g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:40:04 INFO - Fetch https://queue.taskcluster.net/v1/task/WvCYo8O0RGqt5M4Xx2IH2g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:40:06 INFO - Expected file size: 51787947 04:40:06 INFO - Obtained file size: 51787947 04:40:22 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:40:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WvCYo8O0RGqt5M4Xx2IH2g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:40:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WvCYo8O0RGqt5M4Xx2IH2g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:40:22 INFO - Fetch https://queue.taskcluster.net/v1/task/WvCYo8O0RGqt5M4Xx2IH2g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:40:23 INFO - Expected file size: 51787947 04:40:23 INFO - Obtained file size: 51787947 04:40:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WvCYo8O0RGqt5M4Xx2IH2g/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:40:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WvCYo8O0RGqt5M4Xx2IH2g/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:40:39 INFO - Fetch https://queue.taskcluster.net/v1/task/WvCYo8O0RGqt5M4Xx2IH2g/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:40:40 INFO - Expected file size: 14404438 04:40:40 INFO - Obtained file size: 14404438 04:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:40 INFO - trying https://queue.taskcluster.net/v1/task/WvCYo8O0RGqt5M4Xx2IH2g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:40:40 INFO - Downloading https://queue.taskcluster.net/v1/task/WvCYo8O0RGqt5M4Xx2IH2g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:40:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WvCYo8O0RGqt5M4Xx2IH2g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:40:43 INFO - Downloaded 75021574 bytes. 04:40:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WvCYo8O0RGqt5M4Xx2IH2g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:40:43 INFO - mkdir: /builds/slave/test/properties 04:40:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:40:43 INFO - Writing to file /builds/slave/test/properties/build_url 04:40:43 INFO - Contents: 04:40:43 INFO - build_url:https://queue.taskcluster.net/v1/task/WvCYo8O0RGqt5M4Xx2IH2g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:40:44 INFO - Running post-action listener: _resource_record_post_action 04:40:44 INFO - Running post-action listener: set_extra_try_arguments 04:40:44 INFO - [mozharness: 2017-03-13 11:40:44.031417Z] Finished download-and-extract step (success) 04:40:44 INFO - [mozharness: 2017-03-13 11:40:44.031578Z] Running populate-webroot step. 04:40:44 INFO - Running pre-action listener: _resource_record_pre_action 04:40:44 INFO - Running main action method: populate_webroot 04:40:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:40:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:40:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:40:44 INFO - '--tppagecycles', 04:40:44 INFO - '7'], 04:40:44 INFO - 'tests': ['tsvgm']}}, 04:40:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:40:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:40:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:40:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:40:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:40:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:40:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:40:44 INFO - 'talos_options': ['--disable-e10s'], 04:40:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:40:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:40:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:40:44 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:40:44 INFO - 'talos_options': ['--disable-e10s'], 04:40:44 INFO - 'tests': ['damp', 'tps']}, 04:40:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:40:44 INFO - 'tests': ['damp', 'tps']}, 04:40:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:40:44 INFO - 'tests': ['dromaeo_dom']}, 04:40:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:40:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:40:44 INFO - 'tests': ['basic_compositor_video']}, 04:40:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:40:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:40:44 INFO - 'tests': ['a11yr', 04:40:44 INFO - 'ts_paint', 04:40:44 INFO - 'tpaint', 04:40:44 INFO - 'sessionrestore', 04:40:44 INFO - 'sessionrestore_no_auto_restore', 04:40:44 INFO - 'tabpaint']}, 04:40:44 INFO - 'other-e10s': {'tests': ['a11yr', 04:40:44 INFO - 'ts_paint', 04:40:44 INFO - 'tpaint', 04:40:44 INFO - 'sessionrestore', 04:40:44 INFO - 'sessionrestore_no_auto_restore', 04:40:44 INFO - 'tabpaint']}, 04:40:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:40:44 INFO - 'ts_paint', 04:40:44 INFO - 'tpaint', 04:40:44 INFO - 'sessionrestore', 04:40:44 INFO - 'sessionrestore_no_auto_restore', 04:40:44 INFO - 'tabpaint']}, 04:40:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:40:44 INFO - 'ts_paint', 04:40:44 INFO - 'tpaint', 04:40:44 INFO - 'sessionrestore', 04:40:44 INFO - 'sessionrestore_no_auto_restore', 04:40:44 INFO - 'tabpaint']}, 04:40:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:40:44 INFO - 'tests': ['a11yr', 04:40:44 INFO - 'ts_paint', 04:40:44 INFO - 'tpaint', 04:40:44 INFO - 'sessionrestore', 04:40:44 INFO - 'sessionrestore_no_auto_restore', 04:40:44 INFO - 'tabpaint']}, 04:40:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:40:44 INFO - 'tests': ['a11yr', 04:40:44 INFO - 'ts_paint', 04:40:44 INFO - 'tpaint', 04:40:44 INFO - 'sessionrestore', 04:40:44 INFO - 'sessionrestore_no_auto_restore', 04:40:44 INFO - 'tabpaint']}, 04:40:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:40:44 INFO - 'tests': ['tsvgx', 04:40:44 INFO - 'tsvgr_opacity', 04:40:44 INFO - 'tart', 04:40:44 INFO - 'tscrollx', 04:40:44 INFO - 'cart', 04:40:44 INFO - 'tsvg_static']}, 04:40:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:40:44 INFO - 'tsvgr_opacity', 04:40:44 INFO - 'tart', 04:40:44 INFO - 'tscrollx', 04:40:44 INFO - 'cart', 04:40:44 INFO - 'tsvg_static']}, 04:40:44 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:40:44 INFO - 'talos_options': ['--disable-e10s'], 04:40:44 INFO - 'tests': ['tp5o']}, 04:40:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:40:44 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:40:44 INFO - 'talos_options': ['--disable-e10s', 04:40:44 INFO - '--xperf_path', 04:40:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:40:44 INFO - 'tests': ['tp5n']}, 04:40:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:40:44 INFO - 'talos_options': ['--xperf_path', 04:40:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:40:44 INFO - 'tests': ['tp5n']}}, 04:40:44 INFO - 'talos.zip': {'path': '', 04:40:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:40:44 INFO - Running post-action listener: _resource_record_post_action 04:40:44 INFO - [mozharness: 2017-03-13 11:40:44.049858Z] Finished populate-webroot step (success) 04:40:44 INFO - [mozharness: 2017-03-13 11:40:44.049979Z] Running create-virtualenv step. 04:40:44 INFO - Running pre-action listener: _resource_record_pre_action 04:40:44 INFO - Running main action method: create_virtualenv 04:40:44 INFO - Creating virtualenv /builds/slave/test/build/venv 04:40:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:40:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:40:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:40:44 INFO - Using real prefix '/tools/python27' 04:40:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:40:44 INFO - Installing distribute.............................................................................................................................................................................................done. 04:40:47 INFO - Installing pip.................done. 04:40:47 INFO - Return code: 0 04:40:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:40:48 INFO - Reading from file tmpfile_stdout 04:40:48 INFO - Output received: 04:40:48 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:40:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:48 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 0x10ec1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd30d8faf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9fbd30>, '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 0x10e922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9f0be8>, '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.y7Z6F4kfJA/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.KXlfR6vQ1P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:40:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:40:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:40:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y7Z6F4kfJA/Render', 04:40:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:40:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:40:48 INFO - 'HOME': '/Users/cltbld', 04:40:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:40:48 INFO - 'LOGNAME': 'cltbld', 04:40:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:48 INFO - 'MOZ_NO_REMOTE': '1', 04:40:48 INFO - 'NO_EM_RESTART': '1', 04:40:48 INFO - 'PAGER': '/bin/cat', 04:40:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:40:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:48 INFO - 'PWD': '/builds/slave/test', 04:40:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:40:48 INFO - 'SHELL': '/bin/bash', 04:40:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KXlfR6vQ1P/Listeners', 04:40:48 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 04:40:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:40:48 INFO - 'USER': 'cltbld', 04:40:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:40:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:40:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:48 INFO - 'XPC_FLAGS': '0x0', 04:40:48 INFO - 'XPC_SERVICE_NAME': '0', 04:40:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:40:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:40:48 INFO - Cleaning up... 04:40:48 INFO - Return code: 0 04:40:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:48 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 0x10ec1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd30d8faf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9fbd30>, '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 0x10e922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9f0be8>, '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.y7Z6F4kfJA/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.KXlfR6vQ1P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:40:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:40:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:40:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y7Z6F4kfJA/Render', 04:40:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:40:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:40:48 INFO - 'HOME': '/Users/cltbld', 04:40:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:40:48 INFO - 'LOGNAME': 'cltbld', 04:40:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:48 INFO - 'MOZ_NO_REMOTE': '1', 04:40:48 INFO - 'NO_EM_RESTART': '1', 04:40:48 INFO - 'PAGER': '/bin/cat', 04:40:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:40:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:48 INFO - 'PWD': '/builds/slave/test', 04:40:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:40:48 INFO - 'SHELL': '/bin/bash', 04:40:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KXlfR6vQ1P/Listeners', 04:40:48 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 04:40:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:40:48 INFO - 'USER': 'cltbld', 04:40:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:40:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:40:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:48 INFO - 'XPC_FLAGS': '0x0', 04:40:48 INFO - 'XPC_SERVICE_NAME': '0', 04:40:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:40:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:48 INFO - Downloading/unpacking psutil>=3.1.1 04:40: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 04:40: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 04:40: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 04:40: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 04:40: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 04:40: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 04:40:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:40:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:40:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:40:52 INFO - Installing collected packages: psutil 04:40:52 INFO - Running setup.py install for psutil 04:40:52 INFO - building 'psutil._psutil_osx' extension 04:40:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:40:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:40:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:40:52 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:40:52 INFO - building 'psutil._psutil_posix' extension 04:40:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:40:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:40:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:40:53 INFO - ^ 04:40:53 INFO - 1 warning generated. 04:40:53 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:40:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:40:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:40:53 INFO - Successfully installed psutil 04:40:53 INFO - Cleaning up... 04:40:53 INFO - Return code: 0 04:40:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:40:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ec1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd30d8faf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9fbd30>, '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 0x10e922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9f0be8>, '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.y7Z6F4kfJA/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.KXlfR6vQ1P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:40:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:40:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:40:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y7Z6F4kfJA/Render', 04:40:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:40:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:40:53 INFO - 'HOME': '/Users/cltbld', 04:40:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:40:53 INFO - 'LOGNAME': 'cltbld', 04:40:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:53 INFO - 'MOZ_NO_REMOTE': '1', 04:40:53 INFO - 'NO_EM_RESTART': '1', 04:40:53 INFO - 'PAGER': '/bin/cat', 04:40:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:40:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:53 INFO - 'PWD': '/builds/slave/test', 04:40:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:40:53 INFO - 'SHELL': '/bin/bash', 04:40:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KXlfR6vQ1P/Listeners', 04:40:53 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 04:40:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:40:53 INFO - 'USER': 'cltbld', 04:40:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:40:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:40:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:53 INFO - 'XPC_FLAGS': '0x0', 04:40:53 INFO - 'XPC_SERVICE_NAME': '0', 04:40:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:40:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:40:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:40:57 INFO - Installing collected packages: mozsystemmonitor 04:40:57 INFO - Running setup.py install for mozsystemmonitor 04:40:57 INFO - Successfully installed mozsystemmonitor 04:40:57 INFO - Cleaning up... 04:40:57 INFO - Return code: 0 04:40:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:57 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 0x10ec1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd30d8faf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9fbd30>, '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 0x10e922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9f0be8>, '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.y7Z6F4kfJA/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.KXlfR6vQ1P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:40:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:40:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:40:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y7Z6F4kfJA/Render', 04:40:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:40:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:40:57 INFO - 'HOME': '/Users/cltbld', 04:40:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:40:57 INFO - 'LOGNAME': 'cltbld', 04:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:57 INFO - 'MOZ_NO_REMOTE': '1', 04:40:57 INFO - 'NO_EM_RESTART': '1', 04:40:57 INFO - 'PAGER': '/bin/cat', 04:40:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:57 INFO - 'PWD': '/builds/slave/test', 04:40:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:40:57 INFO - 'SHELL': '/bin/bash', 04:40:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KXlfR6vQ1P/Listeners', 04:40:57 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 04:40:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:40:57 INFO - 'USER': 'cltbld', 04:40:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:40:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:57 INFO - 'XPC_FLAGS': '0x0', 04:40:57 INFO - 'XPC_SERVICE_NAME': '0', 04:40:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:40:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:57 INFO - Downloading/unpacking jsonschema==2.5.1 04:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:40:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:40:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:41:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:00 INFO - Downloading functools32-3.2.3-2.tar.gz 04:41:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:41:00 INFO - warning: no files found matching '*.txt' 04:41:00 INFO - no previously-included directories found matching 'build' 04:41:00 INFO - no previously-included directories found matching 'dist' 04:41:00 INFO - no previously-included directories found matching '.git*' 04:41:00 INFO - Installing collected packages: jsonschema, functools32 04:41:00 INFO - Running setup.py install for functools32 04:41:00 INFO - warning: no files found matching '*.txt' 04:41:00 INFO - no previously-included directories found matching 'build' 04:41:00 INFO - no previously-included directories found matching 'dist' 04:41:00 INFO - no previously-included directories found matching '.git*' 04:41:01 INFO - Successfully installed jsonschema functools32 04:41:01 INFO - Cleaning up... 04:41:01 INFO - Return code: 0 04:41:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:01 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 0x10ec1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd30d8faf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9fbd30>, '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 0x10e922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9f0be8>, '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.y7Z6F4kfJA/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.KXlfR6vQ1P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:41:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:41:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y7Z6F4kfJA/Render', 04:41:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:41:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:41:01 INFO - 'HOME': '/Users/cltbld', 04:41:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:41:01 INFO - 'LOGNAME': 'cltbld', 04:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:01 INFO - 'MOZ_NO_REMOTE': '1', 04:41:01 INFO - 'NO_EM_RESTART': '1', 04:41:01 INFO - 'PAGER': '/bin/cat', 04:41:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:01 INFO - 'PWD': '/builds/slave/test', 04:41:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:41:01 INFO - 'SHELL': '/bin/bash', 04:41:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KXlfR6vQ1P/Listeners', 04:41:01 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 04:41:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:41:01 INFO - 'USER': 'cltbld', 04:41:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:41:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:01 INFO - 'XPC_FLAGS': '0x0', 04:41:01 INFO - 'XPC_SERVICE_NAME': '0', 04:41:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:41:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:41:01 INFO - Cleaning up... 04:41:01 INFO - Return code: 0 04:41:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:01 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 0x10ec1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd30d8faf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9fbd30>, '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 0x10e922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9f0be8>, '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.y7Z6F4kfJA/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.KXlfR6vQ1P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:41:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:41:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y7Z6F4kfJA/Render', 04:41:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:41:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:41:01 INFO - 'HOME': '/Users/cltbld', 04:41:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:41:01 INFO - 'LOGNAME': 'cltbld', 04:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:01 INFO - 'MOZ_NO_REMOTE': '1', 04:41:01 INFO - 'NO_EM_RESTART': '1', 04:41:01 INFO - 'PAGER': '/bin/cat', 04:41:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:01 INFO - 'PWD': '/builds/slave/test', 04:41:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:41:01 INFO - 'SHELL': '/bin/bash', 04:41:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KXlfR6vQ1P/Listeners', 04:41:01 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 04:41:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:41:01 INFO - 'USER': 'cltbld', 04:41:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:41:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:01 INFO - 'XPC_FLAGS': '0x0', 04:41:01 INFO - 'XPC_SERVICE_NAME': '0', 04:41:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:41:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:01 INFO - Downloading/unpacking blobuploader==1.2.4 04:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:04 INFO - Downloading blobuploader-1.2.4.tar.gz 04:41:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:41:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:41:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:05 INFO - Downloading docopt-0.6.1.tar.gz 04:41:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:41:05 INFO - Installing collected packages: blobuploader, requests, docopt 04:41:05 INFO - Running setup.py install for blobuploader 04:41:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:41:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:41:05 INFO - Running setup.py install for requests 04:41:06 INFO - Running setup.py install for docopt 04:41:06 INFO - Successfully installed blobuploader requests docopt 04:41:06 INFO - Cleaning up... 04:41:06 INFO - Return code: 0 04:41:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:06 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 0x10ec1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd30d8faf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9fbd30>, '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 0x10e922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9f0be8>, '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.y7Z6F4kfJA/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.KXlfR6vQ1P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:41:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:41:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y7Z6F4kfJA/Render', 04:41:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:41:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:41:06 INFO - 'HOME': '/Users/cltbld', 04:41:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:41:06 INFO - 'LOGNAME': 'cltbld', 04:41:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:06 INFO - 'MOZ_NO_REMOTE': '1', 04:41:06 INFO - 'NO_EM_RESTART': '1', 04:41:06 INFO - 'PAGER': '/bin/cat', 04:41:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:41:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:06 INFO - 'PWD': '/builds/slave/test', 04:41:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:41:06 INFO - 'SHELL': '/bin/bash', 04:41:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KXlfR6vQ1P/Listeners', 04:41:06 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 04:41:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:41:06 INFO - 'USER': 'cltbld', 04:41:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:41:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:41:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:06 INFO - 'XPC_FLAGS': '0x0', 04:41:06 INFO - 'XPC_SERVICE_NAME': '0', 04:41:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:41:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:41:06 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-5Ay8nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:41:06 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-ot0W3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:41:06 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-ErdGym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:41:07 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-q8NDZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:41:07 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-llmwa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:41:07 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-F_XQig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:41:07 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-ptJuva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:41:07 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-bIWlKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:41:07 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-PO2Cud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:41:07 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-mwHVQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:41:07 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-jxClA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:41:07 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-iIxEQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:41:07 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-uvyE0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:41:08 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-8lZd48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:41:08 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-pn8WPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:41:08 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-SxT8qg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:41:08 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-F1KulZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:41:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:41:08 INFO - Running setup.py install for manifestparser 04:41:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:41:08 INFO - Running setup.py install for mozcrash 04:41:08 INFO - Running setup.py install for mozdebug 04:41:08 INFO - Running setup.py install for mozdevice 04:41:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:41:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:41:09 INFO - Running setup.py install for mozfile 04:41:09 INFO - Running setup.py install for mozhttpd 04:41:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:41:09 INFO - Running setup.py install for mozinfo 04:41:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:41:09 INFO - Running setup.py install for mozInstall 04:41:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:41:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:41:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:41:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:41:09 INFO - Running setup.py install for mozleak 04:41:09 INFO - Running setup.py install for mozlog 04:41:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:41:09 INFO - Running setup.py install for moznetwork 04:41:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:41:10 INFO - Running setup.py install for mozprocess 04:41:10 INFO - Running setup.py install for mozprofile 04:41:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:41:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:41:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:41:10 INFO - Running setup.py install for mozrunner 04:41:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:41:10 INFO - Running setup.py install for mozscreenshot 04:41:10 INFO - Running setup.py install for moztest 04:41:10 INFO - Running setup.py install for mozversion 04:41:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:41:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:41:10 INFO - Cleaning up... 04:41:11 INFO - Return code: 0 04:41:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:11 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 0x10ec1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd30d8faf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9fbd30>, '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 0x10e922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9f0be8>, '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.y7Z6F4kfJA/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.KXlfR6vQ1P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:41:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:41:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:41:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y7Z6F4kfJA/Render', 04:41:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:41:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:41:11 INFO - 'HOME': '/Users/cltbld', 04:41:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:41:11 INFO - 'LOGNAME': 'cltbld', 04:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:11 INFO - 'MOZ_NO_REMOTE': '1', 04:41:11 INFO - 'NO_EM_RESTART': '1', 04:41:11 INFO - 'PAGER': '/bin/cat', 04:41:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:11 INFO - 'PWD': '/builds/slave/test', 04:41:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:41:11 INFO - 'SHELL': '/bin/bash', 04:41:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KXlfR6vQ1P/Listeners', 04:41:11 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 04:41:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:41:11 INFO - 'USER': 'cltbld', 04:41:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:41:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:11 INFO - 'XPC_FLAGS': '0x0', 04:41:11 INFO - 'XPC_SERVICE_NAME': '0', 04:41:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:41:11 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-12a6_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:41:11 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-PkCbsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:41:11 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-cKxfxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:41:11 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-Qw5AF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:41:11 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-6eRhw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:41:11 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-v0KSM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:41:11 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-AeU2Lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:41:12 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-Sb3PSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:41:12 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-BZi26c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:41:12 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-qBrx31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:41:12 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-6vdRyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:41:12 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-w9AdgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:41:12 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-57UPV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:41:12 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-v_EF8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:41:12 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-2uzoVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:41:12 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-NphuLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:41:12 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-sEOSmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:41:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:15 INFO - Downloading blessings-1.6.tar.gz 04:41:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:41:15 INFO - Installing collected packages: blessings 04:41:15 INFO - Running setup.py install for blessings 04:41:15 INFO - Successfully installed blessings 04:41:15 INFO - Cleaning up... 04:41:16 INFO - Return code: 0 04:41:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:41:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:41:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:41:16 INFO - Reading from file tmpfile_stdout 04:41:16 INFO - Current package versions: 04:41:16 INFO - blessings == 1.6 04:41:16 INFO - blobuploader == 1.2.4 04:41:16 INFO - docopt == 0.6.1 04:41:16 INFO - functools32 == 3.2.3-2 04:41:16 INFO - jsonschema == 2.5.1 04:41:16 INFO - manifestparser == 1.1 04:41:16 INFO - mozInstall == 1.12 04:41:16 INFO - mozcrash == 1.0 04:41:16 INFO - mozdebug == 0.1 04:41:16 INFO - mozdevice == 0.49 04:41:16 INFO - mozfile == 1.2 04:41:16 INFO - mozhttpd == 0.7 04:41:16 INFO - mozinfo == 0.9 04:41:16 INFO - mozleak == 0.1 04:41:16 INFO - mozlog == 3.4 04:41:16 INFO - moznetwork == 0.27 04:41:16 INFO - mozprocess == 0.25 04:41:16 INFO - mozprofile == 0.28 04:41:16 INFO - mozrunner == 6.13 04:41:16 INFO - mozscreenshot == 0.1 04:41:16 INFO - mozsystemmonitor == 0.3 04:41:16 INFO - moztest == 0.8 04:41:16 INFO - mozversion == 1.4 04:41:16 INFO - psutil == 3.1.1 04:41:16 INFO - requests == 1.2.3 04:41:16 INFO - wsgiref == 0.1.2 04:41:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:41:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:16 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 0x10ec1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd30d8faf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9fbd30>, '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 0x10e922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9f0be8>, '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.y7Z6F4kfJA/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.KXlfR6vQ1P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:41:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:41:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:41:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y7Z6F4kfJA/Render', 04:41:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:41:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:41:16 INFO - 'HOME': '/Users/cltbld', 04:41:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:41:16 INFO - 'LOGNAME': 'cltbld', 04:41:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:16 INFO - 'MOZ_NO_REMOTE': '1', 04:41:16 INFO - 'NO_EM_RESTART': '1', 04:41:16 INFO - 'PAGER': '/bin/cat', 04:41:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:41:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:16 INFO - 'PWD': '/builds/slave/test', 04:41:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:41:16 INFO - 'SHELL': '/bin/bash', 04:41:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KXlfR6vQ1P/Listeners', 04:41:16 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 04:41:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:41:16 INFO - 'USER': 'cltbld', 04:41:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:41:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:41:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:16 INFO - 'XPC_FLAGS': '0x0', 04:41:16 INFO - 'XPC_SERVICE_NAME': '0', 04:41:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:41:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:41:16 INFO - Cleaning up... 04:41:16 INFO - Return code: 0 04:41:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:41:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:41:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ec1db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec20768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd30d8faf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9fbd30>, '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 0x10e922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9f0be8>, '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.y7Z6F4kfJA/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.KXlfR6vQ1P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:41:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:41:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:41:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y7Z6F4kfJA/Render', 04:41:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:41:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:41:16 INFO - 'HOME': '/Users/cltbld', 04:41:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:41:16 INFO - 'LOGNAME': 'cltbld', 04:41:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:16 INFO - 'MOZ_NO_REMOTE': '1', 04:41:16 INFO - 'NO_EM_RESTART': '1', 04:41:16 INFO - 'PAGER': '/bin/cat', 04:41:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:41:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:16 INFO - 'PWD': '/builds/slave/test', 04:41:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:41:16 INFO - 'SHELL': '/bin/bash', 04:41:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KXlfR6vQ1P/Listeners', 04:41:16 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 04:41:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:41:16 INFO - 'USER': 'cltbld', 04:41:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:41:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:41:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:16 INFO - 'XPC_FLAGS': '0x0', 04:41:16 INFO - 'XPC_SERVICE_NAME': '0', 04:41:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:41:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:41:16 INFO - Cleaning up... 04:41:16 INFO - Return code: 0 04:41:16 INFO - Running post-action listener: _resource_record_post_action 04:41:16 INFO - Running post-action listener: _start_resource_monitoring 04:41:16 INFO - Starting resource monitoring. 04:41:16 INFO - [mozharness: 2017-03-13 11:41:16.866941Z] Finished create-virtualenv step (success) 04:41:16 INFO - [mozharness: 2017-03-13 11:41:16.867917Z] Running install step. 04:41:16 INFO - Running pre-action listener: _resource_record_pre_action 04:41:16 INFO - Running main action method: install 04:41:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:41:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:41:17 INFO - Reading from file tmpfile_stdout 04:41:17 INFO - Detecting whether we're running mozinstall >=1.0... 04:41:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:41:17 INFO - Reading from file tmpfile_stdout 04:41:17 INFO - Output received: 04:41:17 INFO - Usage: mozinstall [options] installer 04:41:17 INFO - Options: 04:41:17 INFO - -h, --help show this help message and exit 04:41:17 INFO - -d DEST, --destination=DEST 04:41:17 INFO - Directory to install application into. [default: 04:41:17 INFO - "/builds/slave/test"] 04:41:17 INFO - --app=APP Application being installed. [default: firefox] 04:41:17 INFO - mkdir: /builds/slave/test/build/application 04:41:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:41:37 INFO - Reading from file tmpfile_stdout 04:41:37 INFO - Output received: 04:41:37 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:41:37 INFO - Running post-action listener: _resource_record_post_action 04:41:37 INFO - [mozharness: 2017-03-13 11:41:37.168576Z] Finished install step (success) 04:41:37 INFO - [mozharness: 2017-03-13 11:41:37.168756Z] Running run-tests step. 04:41:37 INFO - Running pre-action listener: _resource_record_pre_action 04:41:37 INFO - Running main action method: run_tests 04:41:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:41:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:41:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:41:37 INFO - 2017-03-13 04:41:37.183 screenresolution[1638:7617] starting screenresolution argv=screenresolution get 04:41:37 INFO - 2017-03-13 04:41:37.186 screenresolution[1638:7617] Display 0: 1600x1200x32@60 04:41:37 INFO - 2017-03-13 04:41:37.191 screenresolution[1639:7620] starting screenresolution argv=screenresolution list 04:41:37 INFO - Available Modes on Display 0 04:41:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:41:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:41:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:41:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:41:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:41:37 INFO - Intel Iris: 04:41:37 INFO - Chipset Model: Intel Iris 04:41:37 INFO - Type: GPU 04:41:37 INFO - Bus: Built-In 04:41:37 INFO - VRAM (Dynamic, Max): 1536 MB 04:41:37 INFO - Vendor: Intel (0x8086) 04:41:37 INFO - Device ID: 0x0a2e 04:41:37 INFO - Revision ID: 0x0009 04:41:37 INFO - Displays: 04:41:37 INFO - Display: 04:41:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:41:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:41:37 INFO - Display Serial Number: 1600x1200 60 04:41:37 INFO - Main Display: Yes 04:41:37 INFO - Mirror: Off 04:41:37 INFO - Online: Yes 04:41:37 INFO - Rotation: Supported 04:41:37 INFO - Return code: 0 04:41:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:41:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:41:37 INFO - Python 2.7.3 04:41:37 INFO - Return code: 0 04:41:37 INFO - grabbing minidump binary from tooltool 04:41: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')]} 04:41:37 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 0x10e9fbd30>, '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 0x10e922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e9f0be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:41:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:41:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:41:37 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:41:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:41:37 INFO - Return code: 0 04:41:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:41:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:41:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:41:37 INFO - ENV: RUST_BACKTRACE is now 1 04:41:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:41:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:41:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WvCYo8O0RGqt5M4Xx2IH2g/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0382', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:41:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WvCYo8O0RGqt5M4Xx2IH2g/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0382 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:41:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y7Z6F4kfJA/Render', 04:41:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:41:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:41:37 INFO - 'HOME': '/Users/cltbld', 04:41:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:41:37 INFO - 'LOGNAME': 'cltbld', 04:41:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:41:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:41:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:37 INFO - 'MOZ_NO_REMOTE': '1', 04:41:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:41:37 INFO - 'NO_EM_RESTART': '1', 04:41:37 INFO - 'PAGER': '/bin/cat', 04:41:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:41:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:37 INFO - 'PWD': '/builds/slave/test', 04:41:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:41:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:41:37 INFO - 'RUST_BACKTRACE': '1', 04:41:37 INFO - 'SHELL': '/bin/bash', 04:41:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KXlfR6vQ1P/Listeners', 04:41:37 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 04:41:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:41:37 INFO - 'USER': 'cltbld', 04:41:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:41:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:41:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:37 INFO - 'XPC_FLAGS': '0x0', 04:41:37 INFO - 'XPC_SERVICE_NAME': '0', 04:41:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:41:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WvCYo8O0RGqt5M4Xx2IH2g/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0382', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:41:37 INFO - mozversion application_buildid: 20170313030209 04:41:37 INFO - mozversion application_changeset: f9362554866b327700c7f9b18050d7b7eb3d2b23 04:41:37 INFO - mozversion application_display_name: Nightly 04:41:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:41:37 INFO - mozversion application_name: Firefox 04:41:37 INFO - mozversion application_remotingname: firefox 04:41:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:41:37 INFO - mozversion application_vendor: Mozilla 04:41:37 INFO - mozversion application_version: 55.0a1 04:41:37 INFO - mozversion platform_buildid: 20170313030209 04:41:37 INFO - mozversion platform_changeset: f9362554866b327700c7f9b18050d7b7eb3d2b23 04:41:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:41:37 INFO - mozversion platform_version: 55.0a1 04:41:37 INFO - using testdate: 1489405297 04:41:37 INFO - actual date: 1489405297 04:41:37 INFO - starting webserver on 'localhost:49241' 04:41:37 INFO - SUITE-START | Running 2 tests 04:41:37 INFO - TEST-START | dromaeo_css 04:41:37 INFO - operating with platform_type : mac_ 04:41:37 INFO - Initialising browser for dromaeo_css test... 04:41:37 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/tmpyBVhRw/profile http://localhost:49241/getInfo.html) 04:41:40 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 04:41:40 INFO - PROCESS | 1649 | colorDepth:24 04:41:40 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 04:41:40 INFO - PROCESS | 1649 | __metrics 04:41:40 INFO - PROCESS | 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:41:40 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:41:41 INFO - TEST-INFO | 1649: exit 0 04:41:41 INFO - Browser initialized. 04:41:41 INFO - Running cycle 1/1 for dromaeo_css test... 04:41:41 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/tmpyBVhRw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:41:53 INFO - PROCESS | 1653 | RSS: Main: 233226240 04:41:53 INFO - PROCESS | 1653 | 04:44:56 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 04:45:00 INFO - PROCESS | 1653 | RSS: Main: 503226368 04:45:00 INFO - PROCESS | 1653 | 04:46:43 INFO - PROCESS | 1653 | ************************* 04:46:43 INFO - PROCESS | 1653 | A coding exception was thrown and uncaught in a Task. 04:46:43 INFO - PROCESS | 1653 | 04:46:43 ERROR - PROCESS | 1653 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:46:43 INFO - PROCESS | 1653 | Full stack: 04:46:43 INFO - PROCESS | 1653 | ************************* 04:48:03 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 04:48:04 INFO - PROCESS | 1653 | RSS: Main: 370196480 04:48:04 INFO - PROCESS | 1653 | 04:51:06 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 04:51:07 INFO - PROCESS | 1653 | RSS: Main: 342970368 04:51:07 INFO - PROCESS | 1653 | 04:54:09 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 04:54:10 INFO - PROCESS | 1653 | RSS: Main: 337334272 04:54:10 INFO - PROCESS | 1653 | 04:57:14 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 04:57:14 INFO - PROCESS | 1653 | RSS: Main: 348209152 04:57:14 INFO - PROCESS | 1653 | 05:00:18 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 05:00:18 INFO - PROCESS | 1653 | RSS: Main: 412045312 05:00:18 INFO - PROCESS | 1653 | 05:00:18 INFO - PROCESS | 1653 | __start_tp_report 05:00:18 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 05:00:18 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 05:00:18 INFO - PROCESS | 1653 | |i|pagename|runs| 05:00:18 INFO - PROCESS | 1653 | |0;dojo.html;3278.0657512608905;3345.3978283908896;3358.4290670585997;3388.8983330500096;3390.7117894978924;5597.160425936112;5662.546996240301;5727.398623144572;5776.537876969843;5803.448672376128;5615.2700148980675;5691.373948865632;5695.914561281584;5708.971455142719;5726.7422965966525;5138.7173705446185;5179.818706345279;5180.352455943007;5192.480751924815;5219.791208351661;5267.841964741045;5268.604854635918;5272.973635131819;5275.446078161795;5279.815206467774;5255.973720131413;5264.39459462161;5271;5275.024120537693;5281.70950597717;5260.210968354739;5265.973670131663;5269.815556455544;5275.446078161795;5281.36623605166;4238.724482908632;5115.897682046376;5227.790888364499;5237.13587258102;5239.423663397023;5843.707814609253;5868.295804503487;5889.234399528034;5891.793787217427;5912.526997840162;6297.4962003039645;6311.842203944892;6326.2724786649205;6327.8734425311695;6329.620222786648;6165.568410211287;6200.751969921198;6251.937480625181;6269.968650156766;6282.089097080943;4337.63130133939;5812;5894.204282421904;5966.552508561832;5986.910196347058;6308.463780578702;6359.268684101295;6359.395857393541;6360.586561873463;6361.713722882481;6233.906491402633;6239.563230573816;6254.186955695731;6255.96872015637;6264.123022776815;6129.481048574139;6200.81397558074;6232.18981532407;6233.594816336924;6240.00159974402;6046.788362407295;6183.752649894044;6185.103160041769;6185.567010309235;6211.596246243979;4490.326451032306;5852.122181672783;6027.246594175728;6221.906671399933;6254.405831446005;5032.144535428986;5051.292819005343;5065;5073.594112471067;5093.363329583802;4361.781910904506;4387.3418987151545;4418;4418.226810308248;4495.77521123949;5860.09168578871;5872.942870283305;5889.764409423661;5902;5924.674142922181;6142.1304578115505;6188;6260.7495700171485;6268.49852011838;6271.184745983084;5704.058830293038;5722.885542289214;5785;5898.852528686817;5922.02286622711;5505.724713764296;5520.254765606592;5529.0324193266015;5539.529140023063;5540.36285827135;6472.902906456501;6476.06097115925;6477.805665830033;6478.578892371981;6484.481241500763;6146.139540464428;6185;6204.968975155095;6223.657698826427;6240.875182496416;6397.424231818973;6438;6442.065900444316;6443.548951573345;6444.806655800334;6158.538109641705;6215.378462153749;6234.812955611339;6241.563090583615;6250.343713910156;6143.450468055886;6176;6233.127362169391;6277.278113016879;6279.874402512016;6106.3089915548935;6128.479079278133;6128.601640893327;6128.601640893327;6129.019356902874;6069;6071.666058366833;6077.027675571887;6086.482648974887;6130.111133885651;4482.708623939434;5891.086881533369;5905.911411328748;5922.378150294329;5956.8808623828145;6086.756529738938;6096.542759292982;6098.603590766586;6101.237345331833;6115.327313995368;5215.76529056201;5913.733881975408;5930.28836539618;5933.724249286424;5945.881082378415 05:00:18 INFO - PROCESS | 1653 | |1;ext.html;742.9702811887524;777.9572123533205;799.0690845165383;868.3704314372081;880.1594477274203;38457;39004.60995390045;40542.1891562169;40565.783026509176;40576.391354129715;39850.60149398505;40115;40126.79936600313;40136.19727605446;40175.397369039485;7208.639568021604;8891.91108088919;9068;9073.183413492785;9085.000649928503;7247.782566523013;7349.963250183769;7351.338379545839;7358.484906056551;10509.264351495398;10723.78552428951;10784.892151078506;10785.62250321239;10800.189985751062;10851.891481085167;10685.519151638195;10791.136709063256;10791.190660700478;10802.351858888493;10818;7038.260982596856;7233.782986510413;10503.474826258656;10565.41890196039;10571.365718056864;27181.592276115676;27372.863135684194;27381.45237095247;37633.62366376328;38135.04662383435;3748.287825313209;3796.544414670257;3811.803425835878;3841.5006049213425;3901.141748815256;26119.869400653064;27597.62011899417;27693.86153069222;27711.39751832269;27711.445771084465;3068.757153352896;3113.3928883867657;3188.1232661018175;3190.0429871038828;3213.983930080358;347257;347338;347701.26149369346;347777;348141;41247.793761031004;42404;49982.0003599926;50062.74843128951;50230.24654630184;43725;51690.48309516932;52433.2135017975;52540.73729631404;52592;13606.863931360758;14168.787468187986;14412.207328597027;14486.927565362106;14511.346989385504;11802.114841386758;11834.230774999598;11859.991900688365;11873.346965916957;11875.465604047838;12361.443735031946;12389.504419823106;12439.440225189888;12478.625641230778;12489.437975291134;5229.346331708536;5248.1340578804065;5251.973740131275;5256.500632439912;5275.57795376369;975.8633791269228;1089.7983872983523;1091.4870011094772;1103.3490240757992;1146.8910453506903;25542.48915021689;25891.35271618187;25933.962641494505;25967.870160649076;26026;1205.1624121235832;1207.2153100484754;1234.8016743073442;1239.7892358299111;1244.8443944506937;11003.944980275048;12475;13195.406206720721;13415;13457.289948518137;323553;418688;419740;420189;420544;54062.729686352104;54138.91722165535;54249.45750542523;54283.45716542784;54316.18525722117;1391.6729568551382;1437.7196446692794;1440.9351579178963;1444.6316189371853;1448.7464693678353;24260.75739242585;25044.246902716633;25163.87418062898;25184.874075629505;25240.73796310214;41685;44287.33568996532;44294;44300;44319.556804431544;402011;403339;403347;403427;403621;26843.463130736884;27467.467867801588;28323.43353132967;32670.183245418102;32865.50701739428;41786.791066044476;42695.14609707726;42787.572124279606;42884.35673464963;43094.13811723685;27990.58014129749;31757;33224.66775332216;34451.310973780885;35875.744348947665;34083.65916340805;34093;35320.940371788885;35367.46948795822;35412.64587354093;33398.833005834815;34420;34966.30067398587;35542.64457355393;35564.11089722778;21031.474213144793;26325.62578284981;29311.13777244602;29721.70278297276;30895;21243.468913276673;21259.8937005314;23242.76757232406;23302.41743956347;23522.64716029227 05:00:18 INFO - PROCESS | 1653 | |2;jquery.html;382.269864558693;398.51182301680444;409.77871949147465;424.1432306740385;439.0823179554732;12735.490580376785;17190.999999999985;21478.355649330526;22343.888280558614;22586.774132258673;21973;22401;22997.540049199008;23228.535429291405;23317.883410582923;5273.446288139748;6494.285628580852;6725.529212955095;6784.1858976922595;7678.46250762444;7734.071911370644;7865.724699635514;7868.449208555404;7868.803279918019;7876.448648594572;6800.523963322569;7642.465027448081;7713.074431068251;7716.305532502074;7722.652480638357;7446.404287656975;7672.117706463717;7702.653380597886;7715.1899050600005;7773.494722842997;7219.711211551584;7461.403087752967;7521.5111017783665;7545.811354716121;7555.962220188919;22134;27530;27639.30901727453;27729.029483967963;27837.4623986889;2792.3019245188702;2798.3423895384567;2824.830708739601;2849.985750071257;2856.985715071432;15336.693266134727;16313.429029983894;16342.591435214215;16581.91709041459;17338.566535836704;1988.6221617892554;2021.29254760834;2032.3090149349143;2040.4694779357474;2059.588082383529;153881.23059384743;157035.99999999886;157671;161591;162338.18830905887;15317.81365392024;20760.896195518926;21944;21988.560228795333;22174.66737998899;36791.63208367935;36804.44793328102;36806;37022.70420535268;37068.44397334042;9127.863082053775;10481.004304591052;10606.628767993083;10668.199885008655;10860;8530.74407767768;8547.658093676184;8553.272971797467;8725.956370218108;8737.650493980296;10351.275410721328;10427.322224055411;10464.895351046393;10562.947185264178;10618.628348007782;3544.7341449391397;4151.252774500558;4184.497860256728;4216.936745948813;4219.894502637398;997.5909876950416;1041.656253436364;1059.2902755153912;1067.8718553773442;1115.5593540551438;22211.77835219046;22685.43286417853;23241.651375229387;23357.649635255486;23367.649485257396;939.4316438554713;1074.0923919288189;1078.412265315405;1096.4188979840696;1108.1744100645071;9790.804183916282;10991.725206869893;11095.167862410352;11736.76763939791;12016.939915300542;661120;663190;669330;695881.8500427419;697123;120978;146791;152567;153372.46627533805;154505.22747386192;1213.3144773203112;1234.4753479771061;1262.659082047842;1269.7016201192712;1269.7650934577132;18901.43295701131;18978;19264.229430823172;19324.420267392;19383.51541211481;45488;57198;58783.70608146932;59517.7024114894;59737.70131149316;77084.61457692676;84579.73130402926;85803;86846.56576717076;96206.51896740751;11780.882191178322;11814.822777658514;12050.975667068398;12335.629931102081;12394.566190183301;13549.525766598123;13593.252371119288;13917.373718182504;13969.092009019381;13985.44058237659;11534.480948357177;11702.88297117018;11958;12078.879211207775;12084.912357887832;11509.424528773361;11546.13403994687;11659.825102623297;11708.531658733555;11998.880011200126;11570.826437603275;11790.469428875549;11968.880311196777;12045;12106.515739370327;11810.350430726392;12051.81922271149;12081.831768040012;12108.394580271128;12201.267923924594;11509.194356394972;11634.70913227176;11829.585964491202;11831.526738930346;11920.403979800802 05:00:18 INFO - PROCESS | 1653 | |3;mootools.html;1448.3916754962916;1562.1174036669274;1582.1377349344614;1609.1793185475403;1612.4356475233667;10246.948765256173;10897.836532452;10901.781964360718;10913.290636108648;10919.290246133996;8356.749297521068;10608.575656973731;10752.462376881163;10844.186685998542;10845.023947844693;2307.665388518668;2348.8942997565064;2350.6239001759723;2354.458474550854;2356.528694261146;2292.128990983424;2321.5240875620543;2327.3018094571644;2330.498942727313;2335.2877372401413;2285.04028308111;2303.67748515208;2304.043821813945;2309.515001849614;2315.8610483370967;2268.9092436302526;2291.4385975436044;2292.358139720881;2295.2081531871477;2301.7813307735737;2257.131004563255;2316.745158032615;2319.2810228829117;2320.1299512682745;2321.756215597372;10635.415052172128;10734.141268698486;10737.03366697001;10738;10739.516721747463;5509.256250406224;5682.460166284196;5684.857878553028;5685.346185188715;5692.117721753135;3299.670032996681;3399.6260411354733;3610.115521697201;3612.8735494257576;3617.819109044537;1069.903708666216;1110.0436550800714;1153.6387063265342;1204.4158583087196;1232.2668012532529;13376.996725245548;13685.794713079213;14073.64815879601;14885.181315027668;14902.254887255594;4130.56629053945;4253.744775313491;4255.404243405926;4255.446791917031;4256;9317.39436936597;11022.118230541537;11058.060064894413;11071.003609675168;11085.778284434266;5286.101362768339;5396.406395296514;5399.7030163340605;5402.973435047407;5421.783128674809;4791;5112.284280200774;5185.274061631375;5196.376434827769;5202.375714914235;3556.395412779834;3671.6511931366476;3698.7041036716996;3741.2330472253125;3772.679322257639;991.2218908157062;994.7264502261936;1004.5128112865254;1005.1255407795265;1010.2322235101376;881.7178502879145;915.9633614655339;919.2002957427081;937.1659223291276;944.7213072143734;6322.33615470369;6340.1440805490665;6475.190601174853;6549.312322206195;6613.239477460057;960.3613596958085;985.7979114281555;993.4436715439377;1011.6004178349658;1018.7351288665001;3886.766793992313;4060.451839001697;4092.3043082676018;4106.345352636156;4117.402976568381;12970.22178669283;13131.540396086282;13215.867841321657;13455.730885382238;13553.45786168562;13107;13284.667883302802;13425.328733563283;13456.394462249222;13463.394147263396;9680.709578712509;9940.403575785476;10025.899741002497;10029.348092373972;10033.297669163088;6169.136320915165;6328.46208072319;6356.459700925473;6363.745450181941;6393.392627700361;9934.864004239123;11739.295642261492;12092.97209737147;12124.93937530342;12139.453724582592;9083.45499270046;11954.462049207632;12282.570110046105;12457.252564846138;12506.874931250572;8003.759887203393;8034.317083048007;8119.269265766109;8161.79595510117;8162.918370816215;10015.749606259902;10019.148372388428;10156.695299141038;10179.134773544036;10241.846372304273;9000.459972401677;9066;9090.999990001226;9091.954540227256;9211.447313161232;7316.597587132759;8760.080191579793;8930.464172149692;9005.639774409212;9029.729108126767;7354.926450735638;7709.845803083795;7727.459077864495;7733.105389179687;7816.257455541714;4808.807647694193;5551.056320425457;5672.290963629546;5780.209324452949;5878.470937615635;5743.942560574508;5893;5942.316633587193;5969.164316995537;6105.877882442237 05:00:18 INFO - PROCESS | 1653 | |4;prototype.html;343.3065208279276;378.86550274652495;385.56816365670454;386.1389102301867;390.6795032789172;4162.771047592381;4249.298865687162;4911.852644420668;4956.851294461163;5009.173486374753;4110.664034188886;4398.824047038114;4846.878828029301;4857.247126695368;4879.243717223827;3398.7398380077343;3531.876384326549;3996.4804575405155;4007.759534427936;4087.386891966199;3845.0771814764394;4017;4050.9594904050878;4064.979675101635;4086.6322031017203;3485.721142308609;3994.2810294147043;4047.2310261050307;4076.9796151019204;4084.4690190275223;3357.446021406465;3638.180909545227;3928.6071392860626;3972.463717398172;4058.715889887694;3709.4621279914263;3711.2763011212824;3742.401215805485;3756.586775454698;3787.3750831112834;4101.671866250693;4496.234815588422;4705.1530724469585;4721.716696998191;4813.470518242991;4415.20526305265;4627.791749371253;4660.86017419478;4705.976470117662;4710.740909250024;4474.418325617681;5191.714455704935;5197.48025197481;5265.447128051576;5318.723506358446;3362.0922350965348;3901.5708272090046;4216.683748718859;4238.972975673123;4246.959494923733;5041.647084704072;5307.585048802785;5331.946680533184;5340.385855626575;5420.214068960018;3352.5138854866395;3617.855115984954;4232.724872883253;4235.915281694349;4299.935500967488;3963.6829053675638;4161.479815023122;4173.516757529265;4297.9255186203445;4392.516823149451;4205.212784566547;4338.305871060678;4371.69398142127;4414.587332053776;4740.146773580788;4854.878628034327;4906.362172917497;5135.071670172321;5208;5306.7611957462;1347.5755137131773;1370.3148425787106;1449.4419648435428;1496.4762333183517;1513.160196091158;924.3021518753299;1031.9019693129142;1114.359243435028;1127.7688073944985;1139.2139423797553;4256.59562341577;4282.957170428318;4506.7070640408265;4833.936533962523;4872.269159626085;4966.925496117561;5314.751033507123;5354.491323324278;5357.357117145967;5428.321459817523;4317.244482215599;4531.8187272509385;4785.282207668877;4857.275667138186;4883.364073035573;2775.4449110178043;2777.291790593426;2791.7627001704677;2813.803033787656;2815.7747380209535;5339.546138578186;5494.752736126884;5512.4211957744665;5512.972435137799;5522.907171983702;4667.533246675373;5199.268665514363;5251.52736253739;5295.311609490818;5340.75966581497;4503.414556107685;4645.767711614473;5121.8719532012;5185.559227465632;5560.053171818942;4693.906121877475;5238.4237733850005;5401.191380482206;5422.593305502024;5426.565874730091;4258.978705106455;4691.413573303337;4949.9257511138085;5386.276391554821;5426.496008313012;4695.36612557314;5397.8380648580605;5546.667199968015;5595.776168953196;5696.952130610103;4270.594293542109;4290.721103128287;4305.569443055795;4311.978440107905;4321.654267658642;5327.3074500314715;5445.346558413015;5474.644148130359;5494.450554944474;5496.725163741877;4241.200807467057;5195.532402083831;5248.6588371755715;5277.28756617867;5311.7609707564025;4423.867283981485;4479.552044795494;4562.258947662885;4644.465886423104;5060.49395060491;4155.439015732837;5117.5394214520875;5214.32213812202;5223.075077956357;5243.737813109406;4964.404271487445;5002.449730529712;5137.537621614073;5196.610254231024;5302.628815982998;4335.7615331157085;4383.641071267917;4871.220604703372;4919.606431485401;5066.138756411346 05:00:18 INFO - PROCESS | 1653 | |5;yui.html;701.7719241246594;742.5322047110323;779.2519181585677;836.6151570277674;841.2385010119597;11480.827787583194;15724.213789310546;15728.21358932053;15728.292226849791;15735.763963540541;14241.643958901033;14398.352074156663;14401.927990360033;14408.207548584824;14458.710825783479;909.6134142989237;940.9200217981446;945.2060269373725;946.049220533363;948.5873644964463;939.685205456173;945.3996712087805;947.166493485735;972.4116909269896;972.747085757701;1023.4933707814643;1025.2771795883884;1030.618671091697;1031.3090229546222;1031.360556454999;1021.6577446555339;1021.8467229915498;1022.7085280694967;1023.7184774187158;1024.2011231239644;758.2644834510571;762.7711686494085;764.3961270596278;766.5017738469984;767.205941850188;15594.29825657848;15848.286827092808;16122.435714750045;16141;16154.434594789243;14534.781978270334;14544.345504452325;14592.635184120376;14748;14762.926185369111;11521.942390288079;11637.476313565825;11841.526338946433;11945.761084778344;12168.939155304255;3537.1157210697324;3624.5469316335457;3694.3350196964534;3815.7901315427916;3823.5220597425323;99911.0008899909;101362.49318753433;102916.48541757319;103963;106151.93848061498;8882.955585222033;10731.89268107309;11354.091672666167;11478.426078696031;11676.416179191006;22389.44026399353;24526.264212073667;24536.877315613307;24551.87724061404;24562.385940351633;7663.693452261847;7739.806504837424;7742.6902923883545;7774.455788094892;7835.960820195863;4058.449632451691;4252.574742525784;4264.275073237495;4352.760598167131;4415.448068991376;2995.9400811983637;3800.2969450651717;3830.4637350770913;3830.7318487705593;3834.501514803058;676.82064252973;684.0286792754301;691.029104108728;692.5533031194951;692.5602242576;650.5622574111267;667.3926726678699;675.1695414639922;692.4218277738045;699.6152116336096;9426.340156189;9904.207663386911;10186.64346747875;10199.694009179737;10407.843882341771;665.1652176518535;674.4368452342251;696.3419568507711;701.6106061136119;703.2686006553128;4591;4900.730459824744;4901.852944411673;4936.827211047668;4945.505449455026;80559.59720201361;80779.19220807834;91367.54316228376;93929.53035234917;95041;45935.54064459313;86824.56587717147;87353.56323218471;87568;89506.55246723724;63857.36142638607;72076.55846883138;72381.91427128598;73504.89742653971;73777.63111184517;9393.765155871159;9874;10600.575976961143;10695.518701658288;10931.890681093088;47014.529854702385;47321.76339118282;47818.565443036765;48258.27612585884;49059.5094049055;59864.390974608505;61264.69367653133;61407.69296153491;61464.77070458655;62210.20054097486;11211.943940280247;12904.8064279034;12932.224066556037;13130.277834719182;13670.52153174634;14063.507777227747;14078.225697586731;14353.210573418562;14760.926195368955;14804.62988425298;13048.412821423248;13177.209367437985;13185.736285274432;13240.02099527637;13970.580882573538;13253.13854599448;13263;13308.600741977756;13324.200547967153;13388.665283367995;13047.975495070274;13074.187296449723;13190.208587484782;13216.140950838164;13558.93220533891;10838.295510791773;10915.290506117077;10931.781364372828;11089.390083545482;11570.363630000431;9756.902430975599;10645.361278323326;10918.18113641496;11030.172737044593;11033.889661103607 05:00:18 INFO - PROCESS | 1653 | __end_tp_report 05:00:18 INFO - PROCESS | 1653 | __start_cc_report 05:00:18 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,3488 05:00:18 INFO - PROCESS | 1653 | __end_cc_report 05:00:18 INFO - PROCESS | 1653 | __startTimestamp1489406418847__endTimestamp 05:00:18 INFO - PROCESS | 1653 | 05:00:18 INFO - PROCESS | 1653 | ------- Summary: start ------- 05:00:18 INFO - PROCESS | 1653 | Number of tests: 6 05:00:18 INFO - PROCESS | 1653 | 05:00:18 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5749.84 Median:5933.72 stddev:674.31 (11.4%) stddev-sans-first:647.90 05:00:18 INFO - PROCESS | 1653 | Values: 3278.1 3345.4 3358.4 3388.9 3390.7 5597.2 5662.5 5727.4 5776.5 5803.4 5615.3 5691.4 5695.9 5709.0 5726.7 5138.7 5179.8 5180.4 5192.5 5219.8 5267.8 5268.6 5273.0 5275.4 5279.8 5256.0 5264.4 5271.0 5275.0 5281.7 5260.2 5266.0 5269.8 5275.4 5281.4 4238.7 5115.9 5227.8 5237.1 5239.4 5843.7 5868.3 5889.2 5891.8 5912.5 6297.5 6311.8 6326.3 6327.9 6329.6 6165.6 6200.8 6251.9 6270.0 6282.1 4337.6 5812.0 5894.2 5966.6 5986.9 6308.5 6359.3 6359.4 6360.6 6361.7 6233.9 6239.6 6254.2 6256.0 6264.1 6129.5 6200.8 6232.2 6233.6 6240.0 6046.8 6183.8 6185.1 6185.6 6211.6 4490.3 5852.1 6027.2 6221.9 6254.4 5032.1 5051.3 5065.0 5073.6 5093.4 4361.8 4387.3 4418.0 4418.2 4495.8 5860.1 5872.9 5889.8 5902.0 5924.7 6142.1 6188.0 6260.7 6268.5 6271.2 5704.1 5722.9 5785.0 5898.9 5922.0 5505.7 5520.3 5529.0 5539.5 5540.4 6472.9 6476.1 6477.8 6478.6 6484.5 6146.1 6185.0 6205.0 6223.7 6240.9 6397.4 6438.0 6442.1 6443.5 6444.8 6158.5 6215.4 6234.8 6241.6 6250.3 6143.5 6176.0 6233.1 6277.3 6279.9 6106.3 6128.5 6128.6 6128.6 6129.0 6069.0 6071.7 6077.0 6086.5 6130.1 4482.7 5891.1 5905.9 5922.4 5956.9 6086.8 6096.5 6098.6 6101.2 6115.3 5215.8 5913.7 5930.3 5933.7 5945.9 05:00:18 INFO - PROCESS | 1653 | 05:00:18 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:52119.66 Median:33741.25 stddev:101944.39 (302.1%) stddev-sans-first:102157.39 05:00:18 INFO - PROCESS | 1653 | Values: 743.0 778.0 799.1 868.4 880.2 38457.0 39004.6 40542.2 40565.8 40576.4 39850.6 40115.0 40126.8 40136.2 40175.4 7208.6 8891.9 9068.0 9073.2 9085.0 7247.8 7350.0 7351.3 7358.5 10509.3 10723.8 10784.9 10785.6 10800.2 10851.9 10685.5 10791.1 10791.2 10802.4 10818.0 7038.3 7233.8 10503.5 10565.4 10571.4 27181.6 27372.9 27381.5 37633.6 38135.0 3748.3 3796.5 3811.8 3841.5 3901.1 26119.9 27597.6 27693.9 27711.4 27711.4 3068.8 3113.4 3188.1 3190.0 3214.0 347257.0 347338.0 347701.3 347777.0 348141.0 41247.8 42404.0 49982.0 50062.7 50230.2 43725.0 51690.5 52433.2 52540.7 52592.0 13606.9 14168.8 14412.2 14486.9 14511.3 11802.1 11834.2 11860.0 11873.3 11875.5 12361.4 12389.5 12439.4 12478.6 12489.4 5229.3 5248.1 5252.0 5256.5 5275.6 975.9 1089.8 1091.5 1103.3 1146.9 25542.5 25891.4 25934.0 25967.9 26026.0 1205.2 1207.2 1234.8 1239.8 1244.8 11003.9 12475.0 13195.4 13415.0 13457.3 323553.0 418688.0 419740.0 420189.0 420544.0 54062.7 54138.9 54249.5 54283.5 54316.2 1391.7 1437.7 1440.9 1444.6 1448.7 24260.8 25044.2 25163.9 25184.9 25240.7 41685.0 44287.3 44294.0 44300.0 44319.6 402011.0 403339.0 403347.0 403427.0 403621.0 26843.5 27467.5 28323.4 32670.2 32865.5 41786.8 42695.1 42787.6 42884.4 43094.1 27990.6 31757.0 33224.7 34451.3 35875.7 34083.7 34093.0 35320.9 35367.5 35412.6 33398.8 34420.0 34966.3 35542.6 35564.1 21031.5 26325.6 29311.1 29721.7 30895.0 21243.5 21259.9 23242.8 23302.4 23522.6 05:00:18 INFO - PROCESS | 1653 | 05:00:18 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:41213.48 Median:21711.18 stddev:113519.93 (522.9%) stddev-sans-first:113796.98 05:00:18 INFO - PROCESS | 1653 | Values: 382.3 398.5 409.8 424.1 439.1 12735.5 17191.0 21478.4 22343.9 22586.8 21973.0 22401.0 22997.5 23228.5 23317.9 5273.4 6494.3 6725.5 6784.2 7678.5 7734.1 7865.7 7868.4 7868.8 7876.4 6800.5 7642.5 7713.1 7716.3 7722.7 7446.4 7672.1 7702.7 7715.2 7773.5 7219.7 7461.4 7521.5 7545.8 7556.0 22134.0 27530.0 27639.3 27729.0 27837.5 2792.3 2798.3 2824.8 2850.0 2857.0 15336.7 16313.4 16342.6 16581.9 17338.6 1988.6 2021.3 2032.3 2040.5 2059.6 153881.2 157036.0 157671.0 161591.0 162338.2 15317.8 20760.9 21944.0 21988.6 22174.7 36791.6 36804.4 36806.0 37022.7 37068.4 9127.9 10481.0 10606.6 10668.2 10860.0 8530.7 8547.7 8553.3 8726.0 8737.7 10351.3 10427.3 10464.9 10562.9 10618.6 3544.7 4151.3 4184.5 4216.9 4219.9 997.6 1041.7 1059.3 1067.9 1115.6 22211.8 22685.4 23241.7 23357.6 23367.6 939.4 1074.1 1078.4 1096.4 1108.2 9790.8 10991.7 11095.2 11736.8 12016.9 661120.0 663190.0 669330.0 695881.9 697123.0 120978.0 146791.0 152567.0 153372.5 154505.2 1213.3 1234.5 1262.7 1269.7 1269.8 18901.4 18978.0 19264.2 19324.4 19383.5 45488.0 57198.0 58783.7 59517.7 59737.7 77084.6 84579.7 85803.0 86846.6 96206.5 11780.9 11814.8 12051.0 12335.6 12394.6 13549.5 13593.3 13917.4 13969.1 13985.4 11534.5 11702.9 11958.0 12078.9 12084.9 11509.4 11546.1 11659.8 11708.5 11998.9 11570.8 11790.5 11968.9 12045.0 12106.5 11810.4 12051.8 12081.8 12108.4 12201.3 11509.2 11634.7 11829.6 11831.5 11920.4 05:00:18 INFO - PROCESS | 1653 | 05:00:18 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:6475.91 Median:3478.01 stddev:4035.86 (116.0%) stddev-sans-first:4029.50 05:00:18 INFO - PROCESS | 1653 | Values: 1448.4 1562.1 1582.1 1609.2 1612.4 10246.9 10897.8 10901.8 10913.3 10919.3 8356.7 10608.6 10752.5 10844.2 10845.0 2307.7 2348.9 2350.6 2354.5 2356.5 2292.1 2321.5 2327.3 2330.5 2335.3 2285.0 2303.7 2304.0 2309.5 2315.9 2268.9 2291.4 2292.4 2295.2 2301.8 2257.1 2316.7 2319.3 2320.1 2321.8 10635.4 10734.1 10737.0 10738.0 10739.5 5509.3 5682.5 5684.9 5685.3 5692.1 3299.7 3399.6 3610.1 3612.9 3617.8 1069.9 1110.0 1153.6 1204.4 1232.3 13377.0 13685.8 14073.6 14885.2 14902.3 4130.6 4253.7 4255.4 4255.4 4256.0 9317.4 11022.1 11058.1 11071.0 11085.8 5286.1 5396.4 5399.7 5403.0 5421.8 4791.0 5112.3 5185.3 5196.4 5202.4 3556.4 3671.7 3698.7 3741.2 3772.7 991.2 994.7 1004.5 1005.1 1010.2 881.7 916.0 919.2 937.2 944.7 6322.3 6340.1 6475.2 6549.3 6613.2 960.4 985.8 993.4 1011.6 1018.7 3886.8 4060.5 4092.3 4106.3 4117.4 12970.2 13131.5 13215.9 13455.7 13553.5 13107.0 13284.7 13425.3 13456.4 13463.4 9680.7 9940.4 10025.9 10029.3 10033.3 6169.1 6328.5 6356.5 6363.7 6393.4 9934.9 11739.3 12093.0 12124.9 12139.5 9083.5 11954.5 12282.6 12457.3 12506.9 8003.8 8034.3 8119.3 8161.8 8162.9 10015.7 10019.1 10156.7 10179.1 10241.8 9000.5 9066.0 9091.0 9092.0 9211.4 7316.6 8760.1 8930.5 9005.6 9029.7 7354.9 7709.8 7727.5 7733.1 7816.3 4808.8 5551.1 5672.3 5780.2 5878.5 5743.9 5893.0 5942.3 5969.2 6105.9 05:00:18 INFO - PROCESS | 1653 | 05:00:18 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4317.04 Median:4636.13 stddev:1205.30 (26.0%) stddev-sans-first:1171.20 05:00:18 INFO - PROCESS | 1653 | Values: 343.3 378.9 385.6 386.1 390.7 4162.8 4249.3 4911.9 4956.9 5009.2 4110.7 4398.8 4846.9 4857.2 4879.2 3398.7 3531.9 3996.5 4007.8 4087.4 3845.1 4017.0 4051.0 4065.0 4086.6 3485.7 3994.3 4047.2 4077.0 4084.5 3357.4 3638.2 3928.6 3972.5 4058.7 3709.5 3711.3 3742.4 3756.6 3787.4 4101.7 4496.2 4705.2 4721.7 4813.5 4415.2 4627.8 4660.9 4706.0 4710.7 4474.4 5191.7 5197.5 5265.4 5318.7 3362.1 3901.6 4216.7 4239.0 4247.0 5041.6 5307.6 5331.9 5340.4 5420.2 3352.5 3617.9 4232.7 4235.9 4299.9 3963.7 4161.5 4173.5 4297.9 4392.5 4205.2 4338.3 4371.7 4414.6 4740.1 4854.9 4906.4 5135.1 5208.0 5306.8 1347.6 1370.3 1449.4 1496.5 1513.2 924.3 1031.9 1114.4 1127.8 1139.2 4256.6 4283.0 4506.7 4833.9 4872.3 4966.9 5314.8 5354.5 5357.4 5428.3 4317.2 4531.8 4785.3 4857.3 4883.4 2775.4 2777.3 2791.8 2813.8 2815.8 5339.5 5494.8 5512.4 5513.0 5522.9 4667.5 5199.3 5251.5 5295.3 5340.8 4503.4 4645.8 5121.9 5185.6 5560.1 4693.9 5238.4 5401.2 5422.6 5426.6 4259.0 4691.4 4949.9 5386.3 5426.5 4695.4 5397.8 5546.7 5595.8 5697.0 4270.6 4290.7 4305.6 4312.0 4321.7 5327.3 5445.3 5474.6 5494.5 5496.7 4241.2 5195.5 5248.7 5277.3 5311.8 4423.9 4479.6 4562.3 4644.5 5060.5 4155.4 5117.5 5214.3 5223.1 5243.7 4964.4 5002.4 5137.5 5196.6 5302.6 4335.8 4383.6 4871.2 4919.6 5066.1 05:00:18 INFO - PROCESS | 1653 | 05:00:18 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:19399.92 Median:3659.44 stddev:26850.56 (733.7%) stddev-sans-first:26889.17 05:00:18 INFO - PROCESS | 1653 | Values: 701.8 742.5 779.3 836.6 841.2 11480.8 15724.2 15728.2 15728.3 15735.8 14241.6 14398.4 14401.9 14408.2 14458.7 909.6 940.9 945.2 946.0 948.6 939.7 945.4 947.2 972.4 972.7 1023.5 1025.3 1030.6 1031.3 1031.4 1021.7 1021.8 1022.7 1023.7 1024.2 758.3 762.8 764.4 766.5 767.2 15594.3 15848.3 16122.4 16141.0 16154.4 14534.8 14544.3 14592.6 14748.0 14762.9 11521.9 11637.5 11841.5 11945.8 12168.9 3537.1 3624.5 3694.3 3815.8 3823.5 99911.0 101362.5 102916.5 103963.0 106151.9 8883.0 10731.9 11354.1 11478.4 11676.4 22389.4 24526.3 24536.9 24551.9 24562.4 7663.7 7739.8 7742.7 7774.5 7836.0 4058.4 4252.6 4264.3 4352.8 4415.4 2995.9 3800.3 3830.5 3830.7 3834.5 676.8 684.0 691.0 692.6 692.6 650.6 667.4 675.2 692.4 699.6 9426.3 9904.2 10186.6 10199.7 10407.8 665.2 674.4 696.3 701.6 703.3 4591.0 4900.7 4901.9 4936.8 4945.5 80559.6 80779.2 91367.5 93929.5 95041.0 45935.5 86824.6 87353.6 87568.0 89506.6 63857.4 72076.6 72381.9 73504.9 73777.6 9393.8 9874.0 10600.6 10695.5 10931.9 47014.5 47321.8 47818.6 48258.3 49059.5 59864.4 61264.7 61407.7 61464.8 62210.2 11211.9 12904.8 12932.2 13130.3 13670.5 14063.5 14078.2 14353.2 14760.9 14804.6 13048.4 13177.2 13185.7 13240.0 13970.6 13253.1 13263.0 13308.6 13324.2 13388.7 13048.0 13074.2 13190.2 13216.1 13558.9 10838.3 10915.3 10931.8 11089.4 11570.4 9756.9 10645.4 10918.2 11030.2 11033.9 05:00:18 INFO - PROCESS | 1653 | -------- Summary: end -------- 05:00:18 INFO - PROCESS | 1653 | 05:00:19 INFO - TEST-INFO | 1653: exit 0 05:00:19 INFO - TEST-OK | dromaeo_css | took 1121837ms 05:00:19 INFO - TEST-START | kraken 05:00:19 INFO - operating with platform_type : mac_ 05:00:19 INFO - Initialising browser for kraken test... 05:00:19 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/tmp0zlf7u/profile http://localhost:49241/getInfo.html) 05:00:21 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 05:00:21 INFO - PROCESS | 1662 | colorDepth:24 05:00:21 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 05:00:21 INFO - PROCESS | 1662 | __metrics 05:00:22 INFO - PROCESS | 1662 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:00:22 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:00:22 INFO - TEST-INFO | 1662: exit 0 05:00:22 INFO - Browser initialized. 05:00:22 INFO - Running cycle 1/1 for kraken test... 05:00:22 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/tmp0zlf7u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:00:34 INFO - PROCESS | 1664 | RSS: Main: 233234432 05:00:34 INFO - PROCESS | 1664 | 05:00:37 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 05:00:38 INFO - PROCESS | 1664 | RSS: Main: 284905472 05:00:38 INFO - PROCESS | 1664 | 05:00:41 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 05:00:42 INFO - PROCESS | 1664 | RSS: Main: 285810688 05:00:42 INFO - PROCESS | 1664 | 05:00:45 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 05:00:45 INFO - PROCESS | 1664 | RSS: Main: 377286656 05:00:45 INFO - PROCESS | 1664 | 05:00:48 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 05:00:48 INFO - PROCESS | 1664 | RSS: Main: 280084480 05:00:48 INFO - PROCESS | 1664 | 05:00:50 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:00:51 INFO - PROCESS | 1664 | RSS: Main: 283332608 05:00:51 INFO - PROCESS | 1664 | 05:00:54 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 05:00:54 INFO - PROCESS | 1664 | RSS: Main: 325566464 05:00:54 INFO - PROCESS | 1664 | 05:00:57 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 05:00:58 INFO - PROCESS | 1664 | RSS: Main: 330043392 05:00:58 INFO - PROCESS | 1664 | 05:01:01 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 05:01:02 INFO - PROCESS | 1664 | RSS: Main: 324628480 05:01:02 INFO - PROCESS | 1664 | 05:01:03 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:01:04 INFO - PROCESS | 1664 | RSS: Main: 303296512 05:01:04 INFO - PROCESS | 1664 | 05:01:06 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:01:06 INFO - PROCESS | 1664 | RSS: Main: 307142656 05:01:06 INFO - PROCESS | 1664 | 05:01:09 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:01:09 INFO - PROCESS | 1664 | RSS: Main: 309248000 05:01:09 INFO - PROCESS | 1664 | 05:01:12 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:01:13 INFO - PROCESS | 1664 | RSS: Main: 327421952 05:01:13 INFO - PROCESS | 1664 | 05:01:16 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:01:17 INFO - PROCESS | 1664 | RSS: Main: 321478656 05:01:17 INFO - PROCESS | 1664 | 05:01:18 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 05:01:19 INFO - PROCESS | 1664 | RSS: Main: 366600192 05:01:19 INFO - PROCESS | 1664 | 05:01:19 INFO - PROCESS | 1664 | __start_tp_report 05:01:19 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 05:01:19 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 05:01:19 INFO - PROCESS | 1664 | |i|pagename|runs| 05:01:19 INFO - PROCESS | 1664 | |0;ai-astar;117;120;170;175;116;116;116;115;116;115 05:01:19 INFO - PROCESS | 1664 | |1;audio-beat-detection;153;138;108;146;113;112;110;105;131;109 05:01:19 INFO - PROCESS | 1664 | |2;audio-dft;183;184;184;185;185;181;185;183;186;183 05:01:19 INFO - PROCESS | 1664 | |3;audio-fft;80;60;60;81;59;65;80;82;100;80 05:01:19 INFO - PROCESS | 1664 | |4;audio-oscillator;88;69;88;72;71;68;85;69;69;86 05:01:19 INFO - PROCESS | 1664 | |5;imaging-gaussian-blur;88;86;85;86;86;86;87;87;87;86 05:01:19 INFO - PROCESS | 1664 | |6;imaging-darkroom;93;94;95;94;93;94;94;95;97;94 05:01:19 INFO - PROCESS | 1664 | |7;imaging-desaturate;83;95;130;106;84;84;84;83;88;84 05:01:19 INFO - PROCESS | 1664 | |8;json-parse-financial;65;62;64;63;64;64;65;64;65;64 05:01:19 INFO - PROCESS | 1664 | |9;json-stringify-tinderbox;59;58;66;60;59;56;57;57;56;55 05:01:19 INFO - PROCESS | 1664 | |10;stanford-crypto-aes;89;89;89;90;87;94;109;109;89;88 05:01:19 INFO - PROCESS | 1664 | |11;stanford-crypto-ccm;144;139;139;158;133;145;164;118;196;158 05:01:19 INFO - PROCESS | 1664 | |12;stanford-crypto-pbkdf2;179;177;177;175;176;178;183;179;176;174 05:01:19 INFO - PROCESS | 1664 | |13;stanford-crypto-sha256-iterative;68;68;68;68;67;67;67;66;66;67 05:01:19 INFO - PROCESS | 1664 | __end_tp_report 05:01:19 INFO - PROCESS | 1664 | __start_cc_report 05:01:19 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,2245 05:01:19 INFO - PROCESS | 1664 | __end_cc_report 05:01:19 INFO - PROCESS | 1664 | __startTimestamp1489406479157__endTimestamp 05:01:19 INFO - PROCESS | 1664 | 05:01:19 INFO - PROCESS | 1664 | ------- Summary: start ------- 05:01:19 INFO - PROCESS | 1664 | Number of tests: 14 05:01:19 INFO - PROCESS | 1664 | 05:01:19 INFO - PROCESS | 1664 | [#0] ai-astar Cycles:10 Average:127.60 Median:116.50 stddev:23.74 (20.4%) stddev-sans-first:24.86 05:01:19 INFO - PROCESS | 1664 | Values: 117.0 120.0 170.0 175.0 116.0 116.0 116.0 115.0 116.0 115.0 05:01:19 INFO - PROCESS | 1664 | 05:01:19 INFO - PROCESS | 1664 | [#1] audio-beat-detection Cycles:10 Average:122.50 Median:122.00 stddev:17.80 (14.6%) stddev-sans-first:15.07 05:01:19 INFO - PROCESS | 1664 | Values: 153.0 138.0 108.0 146.0 113.0 112.0 110.0 105.0 131.0 109.0 05:01:19 INFO - PROCESS | 1664 | 05:01:19 INFO - PROCESS | 1664 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.50 stddev:1.45 (0.8%) stddev-sans-first:1.50 05:01:19 INFO - PROCESS | 1664 | Values: 183.0 184.0 184.0 185.0 185.0 181.0 185.0 183.0 186.0 183.0 05:01:19 INFO - PROCESS | 1664 | 05:01:19 INFO - PROCESS | 1664 | [#3] audio-fft Cycles:10 Average:74.70 Median:80.00 stddev:13.29 (16.6%) stddev-sans-first:13.96 05:01:19 INFO - PROCESS | 1664 | Values: 80.0 60.0 60.0 81.0 59.0 65.0 80.0 82.0 100.0 80.0 05:01:19 INFO - PROCESS | 1664 | 05:01:19 INFO - PROCESS | 1664 | [#4] audio-oscillator Cycles:10 Average:76.50 Median:78.50 stddev:8.93 (11.4%) stddev-sans-first:8.45 05:01:19 INFO - PROCESS | 1664 | Values: 88.0 69.0 88.0 72.0 71.0 68.0 85.0 69.0 69.0 86.0 05:01:19 INFO - PROCESS | 1664 | 05:01:19 INFO - PROCESS | 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:86.50 stddev:0.84 (1.0%) stddev-sans-first:0.67 05:01:19 INFO - PROCESS | 1664 | Values: 88.0 86.0 85.0 86.0 86.0 86.0 87.0 87.0 87.0 86.0 05:01:19 INFO - PROCESS | 1664 | 05:01:19 INFO - PROCESS | 1664 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.00 stddev:1.16 (1.2%) stddev-sans-first:1.13 05:01:19 INFO - PROCESS | 1664 | Values: 93.0 94.0 95.0 94.0 93.0 94.0 94.0 95.0 97.0 94.0 05:01:19 INFO - PROCESS | 1664 | 05:01:19 INFO - PROCESS | 1664 | [#7] imaging-desaturate Cycles:10 Average:92.10 Median:84.00 stddev:15.21 (18.1%) stddev-sans-first:15.78 05:01:19 INFO - PROCESS | 1664 | Values: 83.0 95.0 130.0 106.0 84.0 84.0 84.0 83.0 88.0 84.0 05:01:19 INFO - PROCESS | 1664 | 05:01:19 INFO - PROCESS | 1664 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:0.94 (1.5%) stddev-sans-first:0.93 05:01:19 INFO - PROCESS | 1664 | Values: 65.0 62.0 64.0 63.0 64.0 64.0 65.0 64.0 65.0 64.0 05:01:19 INFO - PROCESS | 1664 | 05:01:19 INFO - PROCESS | 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:58.50 stddev:3.13 (5.3%) stddev-sans-first:3.31 05:01:19 INFO - PROCESS | 1664 | Values: 59.0 58.0 66.0 60.0 59.0 56.0 57.0 57.0 56.0 55.0 05:01:19 INFO - PROCESS | 1664 | 05:01:19 INFO - PROCESS | 1664 | [#10] stanford-crypto-aes Cycles:10 Average:93.30 Median:89.00 stddev:8.47 (9.5%) stddev-sans-first:8.84 05:01:19 INFO - PROCESS | 1664 | Values: 89.0 89.0 89.0 90.0 87.0 94.0 109.0 109.0 89.0 88.0 05:01:19 INFO - PROCESS | 1664 | 05:01:19 INFO - PROCESS | 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:149.40 Median:151.50 stddev:21.22 (14.0%) stddev-sans-first:22.42 05:01:19 INFO - PROCESS | 1664 | Values: 144.0 139.0 139.0 158.0 133.0 145.0 164.0 118.0 196.0 158.0 05:01:19 INFO - PROCESS | 1664 | 05:01:19 INFO - PROCESS | 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.40 Median:177.50 stddev:2.55 (1.4%) stddev-sans-first:2.64 05:01:19 INFO - PROCESS | 1664 | Values: 179.0 177.0 177.0 175.0 176.0 178.0 183.0 179.0 176.0 174.0 05:01:19 INFO - PROCESS | 1664 | 05:01:19 INFO - PROCESS | 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:0.79 (1.2%) stddev-sans-first:0.78 05:01:19 INFO - PROCESS | 1664 | Values: 68.0 68.0 68.0 68.0 67.0 67.0 67.0 66.0 66.0 67.0 05:01:19 INFO - PROCESS | 1664 | -------- Summary: end -------- 05:01:19 INFO - PROCESS | 1664 | 05:01:20 INFO - TEST-INFO | 1664: exit 0 05:01:20 INFO - TEST-OK | kraken | took 60481ms 05:01:20 INFO - SUITE-END | took 1182s 05:01:20 INFO - Completed test suite (00:19:42) 05:01:20 INFO - javascript benchmark 05:01:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7538.920557266112, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3278.0657512608905, 3345.3978283908896, 3358.4290670585997, 3388.8983330500096, 3390.7117894978924, 5597.160425936112, 5662.546996240301, 5727.398623144572, 5776.537876969843, 5803.448672376128, 5615.2700148980675, 5691.373948865632, 5695.914561281584, 5708.971455142719, 5726.7422965966525, 5138.7173705446185, 5179.818706345279, 5180.352455943007, 5192.480751924815, 5219.791208351661, 5267.841964741045, 5268.604854635918, 5272.973635131819, 5275.446078161795, 5279.815206467774, 5255.973720131413, 5264.39459462161, 5271.0, 5275.024120537693, 5281.70950597717, 5260.210968354739, 5265.973670131663, 5269.815556455544, 5275.446078161795, 5281.36623605166, 4238.724482908632, 5115.897682046376, 5227.790888364499, 5237.13587258102, 5239.423663397023, 5843.707814609253, 5868.295804503487, 5889.234399528034, 5891.793787217427, 5912.526997840162, 6297.4962003039645, 6311.842203944892, 6326.2724786649205, 6327.8734425311695, 6329.620222786648, 6165.568410211287, 6200.751969921198, 6251.937480625181, 6269.968650156766, 6282.089097080943, 4337.63130133939, 5812.0, 5894.204282421904, 5966.552508561832, 5986.910196347058, 6308.463780578702, 6359.268684101295, 6359.395857393541, 6360.586561873463, 6361.713722882481, 6233.906491402633, 6239.563230573816, 6254.186955695731, 6255.96872015637, 6264.123022776815, 6129.481048574139, 6200.81397558074, 6232.18981532407, 6233.594816336924, 6240.00159974402, 6046.788362407295, 6183.752649894044, 6185.103160041769, 6185.567010309235, 6211.596246243979, 4490.326451032306, 5852.122181672783, 6027.246594175728, 6221.906671399933, 6254.405831446005, 5032.144535428986, 5051.292819005343, 5065.0, 5073.594112471067, 5093.363329583802, 4361.781910904506, 4387.3418987151545, 4418.0, 4418.226810308248, 4495.77521123949, 5860.09168578871, 5872.942870283305, 5889.764409423661, 5902.0, 5924.674142922181, 6142.1304578115505, 6188.0, 6260.7495700171485, 6268.49852011838, 6271.184745983084, 5704.058830293038, 5722.885542289214, 5785.0, 5898.852528686817, 5922.02286622711, 5505.724713764296, 5520.254765606592, 5529.0324193266015, 5539.529140023063, 5540.36285827135, 6472.902906456501, 6476.06097115925, 6477.805665830033, 6478.578892371981, 6484.481241500763, 6146.139540464428, 6185.0, 6204.968975155095, 6223.657698826427, 6240.875182496416, 6397.424231818973, 6438.0, 6442.065900444316, 6443.548951573345, 6444.806655800334, 6158.538109641705, 6215.378462153749, 6234.812955611339, 6241.563090583615, 6250.343713910156, 6143.450468055886, 6176.0, 6233.127362169391, 6277.278113016879, 6279.874402512016, 6106.3089915548935, 6128.479079278133, 6128.601640893327, 6128.601640893327, 6129.019356902874, 6069.0, 6071.666058366833, 6077.027675571887, 6086.482648974887, 6130.111133885651, 4482.708623939434, 5891.086881533369, 5905.911411328748, 5922.378150294329, 5956.8808623828145, 6086.756529738938, 6096.542759292982, 6098.603590766586, 6101.237345331833, 6115.327313995368, 5215.76529056201, 5913.733881975408, 5930.28836539618, 5933.724249286424, 5945.881082378415], "value": 5707.567795368861, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.9702811887524, 777.9572123533205, 799.0690845165383, 868.3704314372081, 880.1594477274203, 38457.0, 39004.60995390045, 40542.1891562169, 40565.783026509176, 40576.391354129715, 39850.60149398505, 40115.0, 40126.79936600313, 40136.19727605446, 40175.397369039485, 7208.639568021604, 8891.91108088919, 9068.0, 9073.183413492785, 9085.000649928503, 7247.782566523013, 7349.963250183769, 7351.338379545839, 7358.484906056551, 10509.264351495398, 10723.78552428951, 10784.892151078506, 10785.62250321239, 10800.189985751062, 10851.891481085167, 10685.519151638195, 10791.136709063256, 10791.190660700478, 10802.351858888493, 10818.0, 7038.260982596856, 7233.782986510413, 10503.474826258656, 10565.41890196039, 10571.365718056864, 27181.592276115676, 27372.863135684194, 27381.45237095247, 37633.62366376328, 38135.04662383435, 3748.287825313209, 3796.544414670257, 3811.803425835878, 3841.5006049213425, 3901.141748815256, 26119.869400653064, 27597.62011899417, 27693.86153069222, 27711.39751832269, 27711.445771084465, 3068.757153352896, 3113.3928883867657, 3188.1232661018175, 3190.0429871038828, 3213.983930080358, 347257.0, 347338.0, 347701.26149369346, 347777.0, 348141.0, 41247.793761031004, 42404.0, 49982.0003599926, 50062.74843128951, 50230.24654630184, 43725.0, 51690.48309516932, 52433.2135017975, 52540.73729631404, 52592.0, 13606.863931360758, 14168.787468187986, 14412.207328597027, 14486.927565362106, 14511.346989385504, 11802.114841386758, 11834.230774999598, 11859.991900688365, 11873.346965916957, 11875.465604047838, 12361.443735031946, 12389.504419823106, 12439.440225189888, 12478.625641230778, 12489.437975291134, 5229.346331708536, 5248.1340578804065, 5251.973740131275, 5256.500632439912, 5275.57795376369, 975.8633791269228, 1089.7983872983523, 1091.4870011094772, 1103.3490240757992, 1146.8910453506903, 25542.48915021689, 25891.35271618187, 25933.962641494505, 25967.870160649076, 26026.0, 1205.1624121235832, 1207.2153100484754, 1234.8016743073442, 1239.7892358299111, 1244.8443944506937, 11003.944980275048, 12475.0, 13195.406206720721, 13415.0, 13457.289948518137, 323553.0, 418688.0, 419740.0, 420189.0, 420544.0, 54062.729686352104, 54138.91722165535, 54249.45750542523, 54283.45716542784, 54316.18525722117, 1391.6729568551382, 1437.7196446692794, 1440.9351579178963, 1444.6316189371853, 1448.7464693678353, 24260.75739242585, 25044.246902716633, 25163.87418062898, 25184.874075629505, 25240.73796310214, 41685.0, 44287.33568996532, 44294.0, 44300.0, 44319.556804431544, 402011.0, 403339.0, 403347.0, 403427.0, 403621.0, 26843.463130736884, 27467.467867801588, 28323.43353132967, 32670.183245418102, 32865.50701739428, 41786.791066044476, 42695.14609707726, 42787.572124279606, 42884.35673464963, 43094.13811723685, 27990.58014129749, 31757.0, 33224.66775332216, 34451.310973780885, 35875.744348947665, 34083.65916340805, 34093.0, 35320.940371788885, 35367.46948795822, 35412.64587354093, 33398.833005834815, 34420.0, 34966.30067398587, 35542.64457355393, 35564.11089722778, 21031.474213144793, 26325.62578284981, 29311.13777244602, 29721.70278297276, 30895.0, 21243.468913276673, 21259.8937005314, 23242.76757232406, 23302.41743956347, 23522.64716029227], "value": 18039.728171494848, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.269864558693, 398.51182301680444, 409.77871949147465, 424.1432306740385, 439.0823179554732, 12735.490580376785, 17190.999999999985, 21478.355649330526, 22343.888280558614, 22586.774132258673, 21973.0, 22401.0, 22997.540049199008, 23228.535429291405, 23317.883410582923, 5273.446288139748, 6494.285628580852, 6725.529212955095, 6784.1858976922595, 7678.46250762444, 7734.071911370644, 7865.724699635514, 7868.449208555404, 7868.803279918019, 7876.448648594572, 6800.523963322569, 7642.465027448081, 7713.074431068251, 7716.305532502074, 7722.652480638357, 7446.404287656975, 7672.117706463717, 7702.653380597886, 7715.1899050600005, 7773.494722842997, 7219.711211551584, 7461.403087752967, 7521.5111017783665, 7545.811354716121, 7555.962220188919, 22134.0, 27530.0, 27639.30901727453, 27729.029483967963, 27837.4623986889, 2792.3019245188702, 2798.3423895384567, 2824.830708739601, 2849.985750071257, 2856.985715071432, 15336.693266134727, 16313.429029983894, 16342.591435214215, 16581.91709041459, 17338.566535836704, 1988.6221617892554, 2021.29254760834, 2032.3090149349143, 2040.4694779357474, 2059.588082383529, 153881.23059384743, 157035.99999999886, 157671.0, 161591.0, 162338.18830905887, 15317.81365392024, 20760.896195518926, 21944.0, 21988.560228795333, 22174.66737998899, 36791.63208367935, 36804.44793328102, 36806.0, 37022.70420535268, 37068.44397334042, 9127.863082053775, 10481.004304591052, 10606.628767993083, 10668.199885008655, 10860.0, 8530.74407767768, 8547.658093676184, 8553.272971797467, 8725.956370218108, 8737.650493980296, 10351.275410721328, 10427.322224055411, 10464.895351046393, 10562.947185264178, 10618.628348007782, 3544.7341449391397, 4151.252774500558, 4184.497860256728, 4216.936745948813, 4219.894502637398, 997.5909876950416, 1041.656253436364, 1059.2902755153912, 1067.8718553773442, 1115.5593540551438, 22211.77835219046, 22685.43286417853, 23241.651375229387, 23357.649635255486, 23367.649485257396, 939.4316438554713, 1074.0923919288189, 1078.412265315405, 1096.4188979840696, 1108.1744100645071, 9790.804183916282, 10991.725206869893, 11095.167862410352, 11736.76763939791, 12016.939915300542, 661120.0, 663190.0, 669330.0, 695881.8500427419, 697123.0, 120978.0, 146791.0, 152567.0, 153372.46627533805, 154505.22747386192, 1213.3144773203112, 1234.4753479771061, 1262.659082047842, 1269.7016201192712, 1269.7650934577132, 18901.43295701131, 18978.0, 19264.229430823172, 19324.420267392, 19383.51541211481, 45488.0, 57198.0, 58783.70608146932, 59517.7024114894, 59737.70131149316, 77084.61457692676, 84579.73130402926, 85803.0, 86846.56576717076, 96206.51896740751, 11780.882191178322, 11814.822777658514, 12050.975667068398, 12335.629931102081, 12394.566190183301, 13549.525766598123, 13593.252371119288, 13917.373718182504, 13969.092009019381, 13985.44058237659, 11534.480948357177, 11702.88297117018, 11958.0, 12078.879211207775, 12084.912357887832, 11509.424528773361, 11546.13403994687, 11659.825102623297, 11708.531658733555, 11998.880011200126, 11570.826437603275, 11790.469428875549, 11968.880311196777, 12045.0, 12106.515739370327, 11810.350430726392, 12051.81922271149, 12081.831768040012, 12108.394580271128, 12201.267923924594, 11509.194356394972, 11634.70913227176, 11829.585964491202, 11831.526738930346, 11920.403979800802], "value": 11933.704597103857, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.3916754962916, 1562.1174036669274, 1582.1377349344614, 1609.1793185475403, 1612.4356475233667, 10246.948765256173, 10897.836532452, 10901.781964360718, 10913.290636108648, 10919.290246133996, 8356.749297521068, 10608.575656973731, 10752.462376881163, 10844.186685998542, 10845.023947844693, 2307.665388518668, 2348.8942997565064, 2350.6239001759723, 2354.458474550854, 2356.528694261146, 2292.128990983424, 2321.5240875620543, 2327.3018094571644, 2330.498942727313, 2335.2877372401413, 2285.04028308111, 2303.67748515208, 2304.043821813945, 2309.515001849614, 2315.8610483370967, 2268.9092436302526, 2291.4385975436044, 2292.358139720881, 2295.2081531871477, 2301.7813307735737, 2257.131004563255, 2316.745158032615, 2319.2810228829117, 2320.1299512682745, 2321.756215597372, 10635.415052172128, 10734.141268698486, 10737.03366697001, 10738.0, 10739.516721747463, 5509.256250406224, 5682.460166284196, 5684.857878553028, 5685.346185188715, 5692.117721753135, 3299.670032996681, 3399.6260411354733, 3610.115521697201, 3612.8735494257576, 3617.819109044537, 1069.903708666216, 1110.0436550800714, 1153.6387063265342, 1204.4158583087196, 1232.2668012532529, 13376.996725245548, 13685.794713079213, 14073.64815879601, 14885.181315027668, 14902.254887255594, 4130.56629053945, 4253.744775313491, 4255.404243405926, 4255.446791917031, 4256.0, 9317.39436936597, 11022.118230541537, 11058.060064894413, 11071.003609675168, 11085.778284434266, 5286.101362768339, 5396.406395296514, 5399.7030163340605, 5402.973435047407, 5421.783128674809, 4791.0, 5112.284280200774, 5185.274061631375, 5196.376434827769, 5202.375714914235, 3556.395412779834, 3671.6511931366476, 3698.7041036716996, 3741.2330472253125, 3772.679322257639, 991.2218908157062, 994.7264502261936, 1004.5128112865254, 1005.1255407795265, 1010.2322235101376, 881.7178502879145, 915.9633614655339, 919.2002957427081, 937.1659223291276, 944.7213072143734, 6322.33615470369, 6340.1440805490665, 6475.190601174853, 6549.312322206195, 6613.239477460057, 960.3613596958085, 985.7979114281555, 993.4436715439377, 1011.6004178349658, 1018.7351288665001, 3886.766793992313, 4060.451839001697, 4092.3043082676018, 4106.345352636156, 4117.402976568381, 12970.22178669283, 13131.540396086282, 13215.867841321657, 13455.730885382238, 13553.45786168562, 13107.0, 13284.667883302802, 13425.328733563283, 13456.394462249222, 13463.394147263396, 9680.709578712509, 9940.403575785476, 10025.899741002497, 10029.348092373972, 10033.297669163088, 6169.136320915165, 6328.46208072319, 6356.459700925473, 6363.745450181941, 6393.392627700361, 9934.864004239123, 11739.295642261492, 12092.97209737147, 12124.93937530342, 12139.453724582592, 9083.45499270046, 11954.462049207632, 12282.570110046105, 12457.252564846138, 12506.874931250572, 8003.759887203393, 8034.317083048007, 8119.269265766109, 8161.79595510117, 8162.918370816215, 10015.749606259902, 10019.148372388428, 10156.695299141038, 10179.134773544036, 10241.846372304273, 9000.459972401677, 9066.0, 9090.999990001226, 9091.954540227256, 9211.447313161232, 7316.597587132759, 8760.080191579793, 8930.464172149692, 9005.639774409212, 9029.729108126767, 7354.926450735638, 7709.845803083795, 7727.459077864495, 7733.105389179687, 7816.257455541714, 4808.807647694193, 5551.056320425457, 5672.290963629546, 5780.209324452949, 5878.470937615635, 5743.942560574508, 5893.0, 5942.316633587193, 5969.164316995537, 6105.877882442237], "value": 4957.318944468801, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.3065208279276, 378.86550274652495, 385.56816365670454, 386.1389102301867, 390.6795032789172, 4162.771047592381, 4249.298865687162, 4911.852644420668, 4956.851294461163, 5009.173486374753, 4110.664034188886, 4398.824047038114, 4846.878828029301, 4857.247126695368, 4879.243717223827, 3398.7398380077343, 3531.876384326549, 3996.4804575405155, 4007.759534427936, 4087.386891966199, 3845.0771814764394, 4017.0, 4050.9594904050878, 4064.979675101635, 4086.6322031017203, 3485.721142308609, 3994.2810294147043, 4047.2310261050307, 4076.9796151019204, 4084.4690190275223, 3357.446021406465, 3638.180909545227, 3928.6071392860626, 3972.463717398172, 4058.715889887694, 3709.4621279914263, 3711.2763011212824, 3742.401215805485, 3756.586775454698, 3787.3750831112834, 4101.671866250693, 4496.234815588422, 4705.1530724469585, 4721.716696998191, 4813.470518242991, 4415.20526305265, 4627.791749371253, 4660.86017419478, 4705.976470117662, 4710.740909250024, 4474.418325617681, 5191.714455704935, 5197.48025197481, 5265.447128051576, 5318.723506358446, 3362.0922350965348, 3901.5708272090046, 4216.683748718859, 4238.972975673123, 4246.959494923733, 5041.647084704072, 5307.585048802785, 5331.946680533184, 5340.385855626575, 5420.214068960018, 3352.5138854866395, 3617.855115984954, 4232.724872883253, 4235.915281694349, 4299.935500967488, 3963.6829053675638, 4161.479815023122, 4173.516757529265, 4297.9255186203445, 4392.516823149451, 4205.212784566547, 4338.305871060678, 4371.69398142127, 4414.587332053776, 4740.146773580788, 4854.878628034327, 4906.362172917497, 5135.071670172321, 5208.0, 5306.7611957462, 1347.5755137131773, 1370.3148425787106, 1449.4419648435428, 1496.4762333183517, 1513.160196091158, 924.3021518753299, 1031.9019693129142, 1114.359243435028, 1127.7688073944985, 1139.2139423797553, 4256.59562341577, 4282.957170428318, 4506.7070640408265, 4833.936533962523, 4872.269159626085, 4966.925496117561, 5314.751033507123, 5354.491323324278, 5357.357117145967, 5428.321459817523, 4317.244482215599, 4531.8187272509385, 4785.282207668877, 4857.275667138186, 4883.364073035573, 2775.4449110178043, 2777.291790593426, 2791.7627001704677, 2813.803033787656, 2815.7747380209535, 5339.546138578186, 5494.752736126884, 5512.4211957744665, 5512.972435137799, 5522.907171983702, 4667.533246675373, 5199.268665514363, 5251.52736253739, 5295.311609490818, 5340.75966581497, 4503.414556107685, 4645.767711614473, 5121.8719532012, 5185.559227465632, 5560.053171818942, 4693.906121877475, 5238.4237733850005, 5401.191380482206, 5422.593305502024, 5426.565874730091, 4258.978705106455, 4691.413573303337, 4949.9257511138085, 5386.276391554821, 5426.496008313012, 4695.36612557314, 5397.8380648580605, 5546.667199968015, 5595.776168953196, 5696.952130610103, 4270.594293542109, 4290.721103128287, 4305.569443055795, 4311.978440107905, 4321.654267658642, 5327.3074500314715, 5445.346558413015, 5474.644148130359, 5494.450554944474, 5496.725163741877, 4241.200807467057, 5195.532402083831, 5248.6588371755715, 5277.28756617867, 5311.7609707564025, 4423.867283981485, 4479.552044795494, 4562.258947662885, 4644.465886423104, 5060.49395060491, 4155.439015732837, 5117.5394214520875, 5214.32213812202, 5223.075077956357, 5243.737813109406, 4964.404271487445, 5002.449730529712, 5137.537621614073, 5196.610254231024, 5302.628815982998, 4335.7615331157085, 4383.641071267917, 4871.220604703372, 4919.606431485401, 5066.138756411346], "value": 3971.9184117844547, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.7719241246594, 742.5322047110323, 779.2519181585677, 836.6151570277674, 841.2385010119597, 11480.827787583194, 15724.213789310546, 15728.21358932053, 15728.292226849791, 15735.763963540541, 14241.643958901033, 14398.352074156663, 14401.927990360033, 14408.207548584824, 14458.710825783479, 909.6134142989237, 940.9200217981446, 945.2060269373725, 946.049220533363, 948.5873644964463, 939.685205456173, 945.3996712087805, 947.166493485735, 972.4116909269896, 972.747085757701, 1023.4933707814643, 1025.2771795883884, 1030.618671091697, 1031.3090229546222, 1031.360556454999, 1021.6577446555339, 1021.8467229915498, 1022.7085280694967, 1023.7184774187158, 1024.2011231239644, 758.2644834510571, 762.7711686494085, 764.3961270596278, 766.5017738469984, 767.205941850188, 15594.29825657848, 15848.286827092808, 16122.435714750045, 16141.0, 16154.434594789243, 14534.781978270334, 14544.345504452325, 14592.635184120376, 14748.0, 14762.926185369111, 11521.942390288079, 11637.476313565825, 11841.526338946433, 11945.761084778344, 12168.939155304255, 3537.1157210697324, 3624.5469316335457, 3694.3350196964534, 3815.7901315427916, 3823.5220597425323, 99911.0008899909, 101362.49318753433, 102916.48541757319, 103963.0, 106151.93848061498, 8882.955585222033, 10731.89268107309, 11354.091672666167, 11478.426078696031, 11676.416179191006, 22389.44026399353, 24526.264212073667, 24536.877315613307, 24551.87724061404, 24562.385940351633, 7663.693452261847, 7739.806504837424, 7742.6902923883545, 7774.455788094892, 7835.960820195863, 4058.449632451691, 4252.574742525784, 4264.275073237495, 4352.760598167131, 4415.448068991376, 2995.9400811983637, 3800.2969450651717, 3830.4637350770913, 3830.7318487705593, 3834.501514803058, 676.82064252973, 684.0286792754301, 691.029104108728, 692.5533031194951, 692.5602242576, 650.5622574111267, 667.3926726678699, 675.1695414639922, 692.4218277738045, 699.6152116336096, 9426.340156189, 9904.207663386911, 10186.64346747875, 10199.694009179737, 10407.843882341771, 665.1652176518535, 674.4368452342251, 696.3419568507711, 701.6106061136119, 703.2686006553128, 4591.0, 4900.730459824744, 4901.852944411673, 4936.827211047668, 4945.505449455026, 80559.59720201361, 80779.19220807834, 91367.54316228376, 93929.53035234917, 95041.0, 45935.54064459313, 86824.56587717147, 87353.56323218471, 87568.0, 89506.55246723724, 63857.36142638607, 72076.55846883138, 72381.91427128598, 73504.89742653971, 73777.63111184517, 9393.765155871159, 9874.0, 10600.575976961143, 10695.518701658288, 10931.890681093088, 47014.529854702385, 47321.76339118282, 47818.565443036765, 48258.27612585884, 49059.5094049055, 59864.390974608505, 61264.69367653133, 61407.69296153491, 61464.77070458655, 62210.20054097486, 11211.943940280247, 12904.8064279034, 12932.224066556037, 13130.277834719182, 13670.52153174634, 14063.507777227747, 14078.225697586731, 14353.210573418562, 14760.926195368955, 14804.62988425298, 13048.412821423248, 13177.209367437985, 13185.736285274432, 13240.02099527637, 13970.580882573538, 13253.13854599448, 13263.0, 13308.600741977756, 13324.200547967153, 13388.665283367995, 13047.975495070274, 13074.187296449723, 13190.208587484782, 13216.140950838164, 13558.93220533891, 10838.295510791773, 10915.290506117077, 10931.781364372828, 11089.390083545482, 11570.363630000431, 9756.902430975599, 10645.361278323326, 10918.18113641496, 11030.172737044593, 11033.889661103607], "value": 7587.63412566966, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1467.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 120.0, 170.0, 175.0, 116.0, 116.0, 116.0, 115.0, 116.0, 115.0], "value": 127.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 138.0, 108.0, 146.0, 113.0, 112.0, 110.0, 105.0, 131.0, 109.0], "value": 122.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 184.0, 185.0, 185.0, 181.0, 185.0, 183.0, 186.0, 183.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 60.0, 81.0, 59.0, 65.0, 80.0, 82.0, 100.0, 80.0], "value": 74.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 69.0, 88.0, 72.0, 71.0, 68.0, 85.0, 69.0, 69.0, 86.0], "value": 76.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 85.0, 86.0, 86.0, 86.0, 87.0, 87.0, 87.0, 86.0], "value": 86.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 95.0, 94.0, 93.0, 94.0, 94.0, 95.0, 97.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 95.0, 130.0, 106.0, 84.0, 84.0, 84.0, 83.0, 88.0, 84.0], "value": 92.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 64.0, 63.0, 64.0, 64.0, 65.0, 64.0, 65.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 66.0, 60.0, 59.0, 56.0, 57.0, 57.0, 56.0, 55.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 89.0, 90.0, 87.0, 94.0, 109.0, 109.0, 89.0, 88.0], "value": 93.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 139.0, 139.0, 158.0, 133.0, 145.0, 164.0, 118.0, 196.0, 158.0], "value": 149.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 177.0, 177.0, 175.0, 176.0, 178.0, 183.0, 179.0, 176.0, 174.0], "value": 177.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 68.0, 67.0, 67.0, 67.0, 66.0, 66.0, 67.0], "value": 67.2, "unit": "score"}]}]} 05:01:20 INFO - Return code: 0 05:01:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:01:20 ERROR - # TBPL SUCCESS # 05:01:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:01:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:01:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:01:20 INFO - 2017-03-13 05:01:20.474 screenresolution[1668:10323] starting screenresolution argv=screenresolution get 05:01:20 INFO - 2017-03-13 05:01:20.477 screenresolution[1668:10323] Display 0: 1600x1200x32@60 05:01:20 INFO - 2017-03-13 05:01:20.483 screenresolution[1669:10327] starting screenresolution argv=screenresolution list 05:01:20 INFO - Available Modes on Display 0 05:01:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:01:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:01:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:01:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:01:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:01:20 INFO - Intel Iris: 05:01:20 INFO - Chipset Model: Intel Iris 05:01:20 INFO - Type: GPU 05:01:20 INFO - Bus: Built-In 05:01:20 INFO - VRAM (Dynamic, Max): 1536 MB 05:01:20 INFO - Vendor: Intel (0x8086) 05:01:20 INFO - Device ID: 0x0a2e 05:01:20 INFO - Revision ID: 0x0009 05:01:20 INFO - Displays: 05:01:20 INFO - Display: 05:01:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:01:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:01:20 INFO - Display Serial Number: 1600x1200 60 05:01:20 INFO - Main Display: Yes 05:01:20 INFO - Mirror: Off 05:01:20 INFO - Online: Yes 05:01:20 INFO - Rotation: Supported 05:01:20 INFO - Return code: 0 05:01:20 INFO - Running post-action listener: _resource_record_post_action 05:01:20 INFO - [mozharness: 2017-03-13 12:01:20.718570Z] Finished run-tests step (success) 05:01:20 INFO - Running post-run listener: _resource_record_post_run 05:01:20 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 37790720; Write bytes: 511970304; Read time: 244; Write time: 1582 05:01:20 INFO - TinderboxPrint: CPU usage
53.9% 05:01:20 INFO - TinderboxPrint: I/O read bytes / time
37,790,720 / 244 05:01:20 INFO - TinderboxPrint: I/O write bytes / time
511,970,304 / 1,582 05:01:20 INFO - TinderboxPrint: CPU idle
2,218.5 (46.1%) 05:01:20 INFO - TinderboxPrint: CPU system
958.1 (19.9%) 05:01:20 INFO - TinderboxPrint: CPU user
1,637.2 (34.0%) 05:01:20 INFO - TinderboxPrint: Swap in / out
247,025,664 / 0 05:01:20 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207571456; Write bytes: 203499520; Read time: 15606; Write time: 443 05:01:20 INFO - run-tests - Wall time: 1184s; CPU: 54.0%; Read bytes: 35648512; Write bytes: 297387008; Read time: 223; Write time: 1103 05:01:21 INFO - Running post-run listener: _upload_blobber_files 05:01:21 INFO - Blob upload gear active. 05:01:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:01:21 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:01:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:01:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:01:21 INFO - (blobuploader) - INFO - Open directory for files ... 05:01:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:01:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:01:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:01:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:01:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:01:22 INFO - (blobuploader) - INFO - Done attempting. 05:01:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:01:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:01:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:01:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:01:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:01:23 INFO - (blobuploader) - INFO - Done attempting. 05:01:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:01:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:01:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:01:24 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:01:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:01:24 INFO - (blobuploader) - INFO - Done attempting. 05:01:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:01:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:01:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:01:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:01:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:01:26 INFO - (blobuploader) - INFO - Done attempting. 05:01:26 INFO - (blobuploader) - INFO - Iteration through files over. 05:01:26 INFO - Return code: 0 05:01:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:01:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:01:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1e7cd1725f94b1019527d0f036497413b380f46c072a1a6c201175271061f0b96c4ec9954823beffa0d8ede5a51f3d3dfb1a86da9dda119aa9a65545dfa68af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81a7de3d7b2e2b5f8b8834db47a57db65ba40ead7738f8d592d0ab3a6a7acfbcd02a7d84f89df40a88fde9454b0b88288155b71f84ed20e6ce394e69ce54b910", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c32d81f8ab383e32f7256626bbf2e0cadf56e3ab9f2c93604c3c0efa074e4239ab0d0dc3d368b10b085912dd9ff53fd4fb217c68a3eb6be39ae9eea59d782fc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96f91d5af8b2bd7f3692c2956f17a143907daa866e425e2bf158bf1c2a05d766279de61d30464b2401e5c0b2b70174f18ca482216d7e0076122b38c7cb2faac7"} 05:01:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:01:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:01:26 INFO - Contents: 05:01:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1e7cd1725f94b1019527d0f036497413b380f46c072a1a6c201175271061f0b96c4ec9954823beffa0d8ede5a51f3d3dfb1a86da9dda119aa9a65545dfa68af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81a7de3d7b2e2b5f8b8834db47a57db65ba40ead7738f8d592d0ab3a6a7acfbcd02a7d84f89df40a88fde9454b0b88288155b71f84ed20e6ce394e69ce54b910", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c32d81f8ab383e32f7256626bbf2e0cadf56e3ab9f2c93604c3c0efa074e4239ab0d0dc3d368b10b085912dd9ff53fd4fb217c68a3eb6be39ae9eea59d782fc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96f91d5af8b2bd7f3692c2956f17a143907daa866e425e2bf158bf1c2a05d766279de61d30464b2401e5c0b2b70174f18ca482216d7e0076122b38c7cb2faac7"} 05:01:26 INFO - Running post-run listener: copy_logs_to_upload_dir 05:01:26 INFO - Copying logs to upload dir... 05:01:26 INFO - mkdir: /builds/slave/test/build/upload/logs 05:01:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.403928 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-13 05:01:26.258569) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-13 05:01:26.261825) ========= 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.y7Z6F4kfJA/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.KXlfR6vQ1P/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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/d1e7cd1725f94b1019527d0f036497413b380f46c072a1a6c201175271061f0b96c4ec9954823beffa0d8ede5a51f3d3dfb1a86da9dda119aa9a65545dfa68af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81a7de3d7b2e2b5f8b8834db47a57db65ba40ead7738f8d592d0ab3a6a7acfbcd02a7d84f89df40a88fde9454b0b88288155b71f84ed20e6ce394e69ce54b910", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c32d81f8ab383e32f7256626bbf2e0cadf56e3ab9f2c93604c3c0efa074e4239ab0d0dc3d368b10b085912dd9ff53fd4fb217c68a3eb6be39ae9eea59d782fc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96f91d5af8b2bd7f3692c2956f17a143907daa866e425e2bf158bf1c2a05d766279de61d30464b2401e5c0b2b70174f18ca482216d7e0076122b38c7cb2faac7"} build_url:https://queue.taskcluster.net/v1/task/WvCYo8O0RGqt5M4Xx2IH2g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011511 build_url: 'https://queue.taskcluster.net/v1/task/WvCYo8O0RGqt5M4Xx2IH2g/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/d1e7cd1725f94b1019527d0f036497413b380f46c072a1a6c201175271061f0b96c4ec9954823beffa0d8ede5a51f3d3dfb1a86da9dda119aa9a65545dfa68af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81a7de3d7b2e2b5f8b8834db47a57db65ba40ead7738f8d592d0ab3a6a7acfbcd02a7d84f89df40a88fde9454b0b88288155b71f84ed20e6ce394e69ce54b910", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c32d81f8ab383e32f7256626bbf2e0cadf56e3ab9f2c93604c3c0efa074e4239ab0d0dc3d368b10b085912dd9ff53fd4fb217c68a3eb6be39ae9eea59d782fc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/96f91d5af8b2bd7f3692c2956f17a143907daa866e425e2bf158bf1c2a05d766279de61d30464b2401e5c0b2b70174f18ca482216d7e0076122b38c7cb2faac7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-13 05:01:26.296847) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 05:01:26.297175) ========= 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.y7Z6F4kfJA/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.KXlfR6vQ1P/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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.004489 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 05:01:26.345288) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-13 05:01:26.345605) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-13 05:01:26.345938) ========= ========= Total master_lag: 0.18 =========