builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0375 starttime: 1488591826.79 results: success (0) buildid: 20170303162023 builduid: 1bdd524be485483baf6a814fec7890db revision: e11b1a808700d7428c6ce94ca22921ae000424c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-03 17:43:46.789976) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-03 17:43:46.790531) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-03 17:43:46.790836) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-03 17:43:46.858845) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 17:43:46.859232) ========= 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.hKNnASELPO/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.jWEwVuAHSA/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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-03 17:43:46-- 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% 8.11M=0.001s 2017-03-03 17:43:47 (8.11 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.606175 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 17:43:47.489271) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 17:43:47.489584) ========= 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.hKNnASELPO/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.jWEwVuAHSA/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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.020730 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 17:43:47.538020) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-03 17:43:47.538424) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e11b1a808700d7428c6ce94ca22921ae000424c1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e11b1a808700d7428c6ce94ca22921ae000424c1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hKNnASELPO/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.jWEwVuAHSA/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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-03 17:43:47,628 truncating revision to first 12 chars 2017-03-03 17:43:47,628 Setting DEBUG logging. 2017-03-03 17:43:47,628 attempt 1/10 2017-03-03 17:43:47,628 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e11b1a808700?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-03 17:43:48,772 unpacking tar archive at: mozilla-aurora-e11b1a808700/testing/mozharness/ program finished with exit code 0 elapsedTime=1.409464 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-03 17:43:48.973236) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-03 17:43:48.973548) ========= script_repo_revision: e11b1a808700d7428c6ce94ca22921ae000424c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-03 17:43:48.973945) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-03 17:43:48.974239) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-03 17:43:48.994386) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-03-03 17:43:48.994808) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hKNnASELPO/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.jWEwVuAHSA/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 17:43:49 INFO - MultiFileLogger online at 20170303 17:43:49 in /builds/slave/test 17:43:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 17:43:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:43:49 INFO - {'append_to_log': False, 17:43:49 INFO - 'base_work_dir': '/builds/slave/test', 17:43:49 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:43:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:43:49 INFO - 'branch': 'Mozilla-Aurora', 17:43:49 INFO - 'buildbot_json_path': 'buildprops.json', 17:43:49 INFO - 'config_files': ('talos/mac_config.py',), 17:43:49 INFO - 'default_actions': ('clobber', 17:43:49 INFO - 'read-buildbot-config', 17:43:49 INFO - 'download-and-extract', 17:43:49 INFO - 'populate-webroot', 17:43:49 INFO - 'create-virtualenv', 17:43:49 INFO - 'install', 17:43:49 INFO - 'run-tests'), 17:43:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:43:49 INFO - 'download_minidump_stackwalk': True, 17:43:49 INFO - 'download_symbols': 'ondemand', 17:43:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:43:49 INFO - 'tooltool.py': '/tools/tooltool.py', 17:43:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:43:49 INFO - '/tools/misc-python/virtualenv.py')}, 17:43:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:43:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:43:49 INFO - 'installer_path': 'installer.exe', 17:43:49 INFO - 'log_level': 'info', 17:43:49 INFO - 'log_name': 'talos', 17:43:49 INFO - 'log_to_console': True, 17:43:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:43:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:43:49 INFO - 'opt_config_files': (), 17:43:49 INFO - 'pip_index': False, 17:43:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:43:49 INFO - 'cmd': ('bash', 17:43:49 INFO - '-c', 17:43:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:43:49 INFO - 'enabled': True, 17:43:49 INFO - 'halt_on_failure': False, 17:43:49 INFO - 'name': 'check_screen_resolution'},), 17:43:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:43:49 INFO - 'cmd': ('bash', 17:43:49 INFO - '-c', 17:43:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:43:49 INFO - 'enabled': True, 17:43:49 INFO - 'halt_on_failure': False, 17:43:49 INFO - 'name': 'check_screen_resolution'},), 17:43:49 INFO - 'run_cmd_checks_enabled': True, 17:43:49 INFO - 'sps_profile': False, 17:43:49 INFO - 'sps_profile_interval': 0, 17:43:49 INFO - 'suite': 'dromaeojs-e10s', 17:43:49 INFO - 'system_bits': '32', 17:43:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:43:49 INFO - 'title': 't-yosemite-r7-0375', 17:43:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:43:49 INFO - 'use_talos_json': True, 17:43:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:43:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:43:49 INFO - 'work_dir': 'build'} 17:43:49 INFO - [mozharness: 2017-03-04 01:43:49.203642Z] Running clobber step. 17:43:49 INFO - Running pre-action listener: _resource_record_pre_action 17:43:49 INFO - Running main action method: clobber 17:43:49 INFO - rmtree: /builds/slave/test/build 17:43:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:43:52 INFO - Running post-action listener: _resource_record_post_action 17:43:52 INFO - [mozharness: 2017-03-04 01:43:52.387190Z] Finished clobber step (success) 17:43:52 INFO - [mozharness: 2017-03-04 01:43:52.387330Z] Running read-buildbot-config step. 17:43:52 INFO - Running pre-action listener: _resource_record_pre_action 17:43:52 INFO - Running main action method: read_buildbot_config 17:43:52 INFO - Using buildbot properties: 17:43:52 INFO - { 17:43:52 INFO - "project": "", 17:43:52 INFO - "product": "firefox", 17:43:52 INFO - "script_repo_revision": "production", 17:43:52 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 17:43:52 INFO - "repository": "", 17:43:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 17:43:52 INFO - "buildid": "20170303162023", 17:43:52 INFO - "pgo_build": "False", 17:43:52 INFO - "basedir": "/builds/slave/test", 17:43:52 INFO - "buildnumber": 2, 17:43:52 INFO - "slavename": "t-yosemite-r7-0375", 17:43:52 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 17:43:52 INFO - "platform": "yosemite_r7", 17:43:52 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 17:43:52 INFO - "branch": "mozilla-aurora", 17:43:52 INFO - "repo_path": "releases/mozilla-aurora", 17:43:52 INFO - "revision": "e11b1a808700d7428c6ce94ca22921ae000424c1", 17:43:52 INFO - "stage_platform": "macosx64", 17:43:52 INFO - "builduid": "1bdd524be485483baf6a814fec7890db", 17:43:52 INFO - "slavebuilddir": "test" 17:43:52 INFO - } 17:43:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 17:43:52 INFO - Running post-action listener: _resource_record_post_action 17:43:52 INFO - [mozharness: 2017-03-04 01:43:52.390681Z] Finished read-buildbot-config step (success) 17:43:52 INFO - [mozharness: 2017-03-04 01:43:52.390802Z] Running download-and-extract step. 17:43:52 INFO - Running pre-action listener: _resource_record_pre_action 17:43:52 INFO - Running main action method: download_and_extract 17:43:52 INFO - mkdir: /builds/slave/test/build/tests 17:43:52 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')]} 17:43:52 INFO - trying https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 17:43:52 INFO - Downloading https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 17:43:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 17:43:53 INFO - Downloaded 1199 bytes. 17:43:53 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 17:43:53 INFO - Using the following test package requirements: 17:43:53 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 17:43:53 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:43:53 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 17:43:53 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:43:53 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 17:43:53 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:43:53 INFO - u'jsshell-mac.zip'], 17:43:53 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:43:53 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 17:43:53 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 17:43:53 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:43:53 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 17:43:53 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:43:53 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 17:43:53 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:43:53 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 17:43:53 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:43:53 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 17:43:53 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 17:43:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 17:43:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 17:43:53 INFO - Fetch https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 17:43:54 INFO - Expected file size: 16357703 17:43:54 INFO - Obtained file size: 16357703 17:44:01 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 17:44:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 17:44:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 17:44:01 INFO - Fetch https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 17:44:02 INFO - Expected file size: 16357703 17:44:02 INFO - Obtained file size: 16357703 17:44:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 17:44:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 17:44:08 INFO - Fetch https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 17:44:09 INFO - Expected file size: 14403650 17:44:09 INFO - Obtained file size: 14403650 17:44:09 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')]} 17:44:09 INFO - trying https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 17:44:09 INFO - Downloading https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 17:44:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 17:44:11 INFO - Downloaded 73931039 bytes. 17:44:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 17:44:11 INFO - mkdir: /builds/slave/test/properties 17:44:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:44:11 INFO - Writing to file /builds/slave/test/properties/build_url 17:44:11 INFO - Contents: 17:44:11 INFO - build_url:https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 17:44:12 INFO - Running post-action listener: _resource_record_post_action 17:44:12 INFO - Running post-action listener: set_extra_try_arguments 17:44:12 INFO - [mozharness: 2017-03-04 01:44:12.591603Z] Finished download-and-extract step (success) 17:44:12 INFO - [mozharness: 2017-03-04 01:44:12.591750Z] Running populate-webroot step. 17:44:12 INFO - Running pre-action listener: _resource_record_pre_action 17:44:12 INFO - Running main action method: populate_webroot 17:44:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:44:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:44:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:44:12 INFO - '--tppagecycles', 17:44:12 INFO - '7'], 17:44:12 INFO - 'tests': ['tsvgm']}}, 17:44:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:44:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:44:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:44:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:44:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:44:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:44:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:44:12 INFO - 'talos_options': ['--disable-e10s'], 17:44:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:44:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:44:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:44:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:44:12 INFO - 'talos_options': ['--disable-e10s'], 17:44:12 INFO - 'tests': ['damp', 'tps']}, 17:44:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:44:12 INFO - 'tests': ['damp', 'tps']}, 17:44:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:44:12 INFO - 'tests': ['dromaeo_dom']}, 17:44:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:44:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:44:12 INFO - 'tests': ['basic_compositor_video']}, 17:44:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:44:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:44:12 INFO - 'tests': ['a11yr', 17:44:12 INFO - 'ts_paint', 17:44:12 INFO - 'tpaint', 17:44:12 INFO - 'sessionrestore', 17:44:12 INFO - 'sessionrestore_no_auto_restore', 17:44:12 INFO - 'tabpaint']}, 17:44:12 INFO - 'other-e10s': {'tests': ['a11yr', 17:44:12 INFO - 'ts_paint', 17:44:12 INFO - 'tpaint', 17:44:12 INFO - 'sessionrestore', 17:44:12 INFO - 'sessionrestore_no_auto_restore', 17:44:12 INFO - 'tabpaint']}, 17:44:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:44:12 INFO - 'ts_paint', 17:44:12 INFO - 'tpaint', 17:44:12 INFO - 'sessionrestore', 17:44:12 INFO - 'sessionrestore_no_auto_restore', 17:44:12 INFO - 'tabpaint']}, 17:44:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:44:12 INFO - 'ts_paint', 17:44:12 INFO - 'tpaint', 17:44:12 INFO - 'sessionrestore', 17:44:12 INFO - 'sessionrestore_no_auto_restore', 17:44:12 INFO - 'tabpaint']}, 17:44:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:44:12 INFO - 'tests': ['a11yr', 17:44:12 INFO - 'ts_paint', 17:44:12 INFO - 'tpaint', 17:44:12 INFO - 'sessionrestore', 17:44:12 INFO - 'sessionrestore_no_auto_restore', 17:44:12 INFO - 'tabpaint']}, 17:44:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:44:12 INFO - 'tests': ['a11yr', 17:44:12 INFO - 'ts_paint', 17:44:12 INFO - 'tpaint', 17:44:12 INFO - 'sessionrestore', 17:44:12 INFO - 'sessionrestore_no_auto_restore', 17:44:12 INFO - 'tabpaint']}, 17:44:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:44:12 INFO - 'tests': ['tsvgx', 17:44:12 INFO - 'tsvgr_opacity', 17:44:12 INFO - 'tart', 17:44:12 INFO - 'tscrollx', 17:44:12 INFO - 'cart', 17:44:12 INFO - 'tsvg_static']}, 17:44:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:44:12 INFO - 'tsvgr_opacity', 17:44:12 INFO - 'tart', 17:44:12 INFO - 'tscrollx', 17:44:12 INFO - 'cart', 17:44:12 INFO - 'tsvg_static']}, 17:44:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:44:12 INFO - 'talos_options': ['--disable-e10s'], 17:44:12 INFO - 'tests': ['tp5o']}, 17:44:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:44:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:44:12 INFO - 'talos_options': ['--disable-e10s', 17:44:12 INFO - '--xperf_path', 17:44:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:44:12 INFO - 'tests': ['tp5n']}, 17:44:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:44:12 INFO - 'talos_options': ['--xperf_path', 17:44:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:44:12 INFO - 'tests': ['tp5n']}}, 17:44:12 INFO - 'talos.zip': {'path': '', 17:44:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:44:12 INFO - Running post-action listener: _resource_record_post_action 17:44:12 INFO - [mozharness: 2017-03-04 01:44:12.610122Z] Finished populate-webroot step (success) 17:44:12 INFO - [mozharness: 2017-03-04 01:44:12.610251Z] Running create-virtualenv step. 17:44:12 INFO - Running pre-action listener: _resource_record_pre_action 17:44:12 INFO - Running main action method: create_virtualenv 17:44:12 INFO - Creating virtualenv /builds/slave/test/build/venv 17:44:12 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 17:44:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:44:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:44:12 INFO - Using real prefix '/tools/python27' 17:44:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:44:13 INFO - Installing distribute.............................................................................................................................................................................................done. 17:44:16 INFO - Installing pip.................done. 17:44:16 INFO - Return code: 0 17:44:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:44:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:44:16 INFO - Reading from file tmpfile_stdout 17:44:16 INFO - Output received: 17:44:16 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) 17:44:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:44: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')]} 17:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44: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')]} 17:44:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c7d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9eebd770d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5b6d30>, '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 0x10c4dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5abbe8>, '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.hKNnASELPO/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.jWEwVuAHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 17:44: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', 'pip>=1.5'] in /builds/slave/test/build 17:44: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 pip>=1.5 17:44:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKNnASELPO/Render', 17:44:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:16 INFO - 'HOME': '/Users/cltbld', 17:44:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:16 INFO - 'LOGNAME': 'cltbld', 17:44:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:16 INFO - 'MOZ_NO_REMOTE': '1', 17:44:16 INFO - 'NO_EM_RESTART': '1', 17:44:16 INFO - 'PAGER': '/bin/cat', 17:44:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:16 INFO - 'PWD': '/builds/slave/test', 17:44:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:16 INFO - 'SHELL': '/bin/bash', 17:44:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWEwVuAHSA/Listeners', 17:44:16 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:44:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:16 INFO - 'USER': 'cltbld', 17:44:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:16 INFO - 'XPC_FLAGS': '0x0', 17:44:16 INFO - 'XPC_SERVICE_NAME': '0', 17:44:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:16 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 17:44:16 INFO - Cleaning up... 17:44:16 INFO - Return code: 0 17:44:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:44: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')]} 17:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44: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')]} 17:44:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44: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', '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 0x10c7d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9eebd770d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5b6d30>, '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 0x10c4dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5abbe8>, '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.hKNnASELPO/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.jWEwVuAHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 17:44: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', 'psutil>=3.1.1'] in /builds/slave/test/build 17:44: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 psutil>=3.1.1 17:44:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKNnASELPO/Render', 17:44:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:16 INFO - 'HOME': '/Users/cltbld', 17:44:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:16 INFO - 'LOGNAME': 'cltbld', 17:44:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:16 INFO - 'MOZ_NO_REMOTE': '1', 17:44:16 INFO - 'NO_EM_RESTART': '1', 17:44:16 INFO - 'PAGER': '/bin/cat', 17:44:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:16 INFO - 'PWD': '/builds/slave/test', 17:44:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:16 INFO - 'SHELL': '/bin/bash', 17:44:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWEwVuAHSA/Listeners', 17:44:16 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:44:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:16 INFO - 'USER': 'cltbld', 17:44:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:16 INFO - 'XPC_FLAGS': '0x0', 17:44:16 INFO - 'XPC_SERVICE_NAME': '0', 17:44:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:17 INFO - Downloading/unpacking psutil>=3.1.1 17:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:44:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:44:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:44:21 INFO - Installing collected packages: psutil 17:44:21 INFO - Running setup.py install for psutil 17:44:21 INFO - building 'psutil._psutil_osx' extension 17:44:21 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 17:44:21 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 17:44:21 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 17:44:21 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 17:44:21 INFO - building 'psutil._psutil_posix' extension 17:44:21 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 17:44:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:44:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:44:21 INFO - ^ 17:44:21 INFO - 1 warning generated. 17:44:21 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 17:44:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:44:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:44:21 INFO - Successfully installed psutil 17:44:21 INFO - Cleaning up... 17:44:21 INFO - Return code: 0 17:44:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c7d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9eebd770d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5b6d30>, '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 0x10c4dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5abbe8>, '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.hKNnASELPO/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.jWEwVuAHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 17:44:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:44:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:44:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKNnASELPO/Render', 17:44:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:21 INFO - 'HOME': '/Users/cltbld', 17:44:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:21 INFO - 'LOGNAME': 'cltbld', 17:44:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:21 INFO - 'MOZ_NO_REMOTE': '1', 17:44:21 INFO - 'NO_EM_RESTART': '1', 17:44:21 INFO - 'PAGER': '/bin/cat', 17:44:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:21 INFO - 'PWD': '/builds/slave/test', 17:44:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:21 INFO - 'SHELL': '/bin/bash', 17:44:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWEwVuAHSA/Listeners', 17:44:21 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:44:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:21 INFO - 'USER': 'cltbld', 17:44:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:21 INFO - 'XPC_FLAGS': '0x0', 17:44:21 INFO - 'XPC_SERVICE_NAME': '0', 17:44:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:44:22 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 17:44:22 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 17:44:22 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 17:44:22 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 17:44:22 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 17:44:22 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 17:44:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:44:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:44:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:44:24 INFO - Installing collected packages: mozsystemmonitor 17:44:24 INFO - Running setup.py install for mozsystemmonitor 17:44:24 INFO - Successfully installed mozsystemmonitor 17:44:24 INFO - Cleaning up... 17:44:25 INFO - Return code: 0 17:44:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:25 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 0x10c7d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9eebd770d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5b6d30>, '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 0x10c4dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5abbe8>, '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.hKNnASELPO/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.jWEwVuAHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 17:44:25 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 17:44:25 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 17:44:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKNnASELPO/Render', 17:44:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:25 INFO - 'HOME': '/Users/cltbld', 17:44:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:25 INFO - 'LOGNAME': 'cltbld', 17:44:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:25 INFO - 'MOZ_NO_REMOTE': '1', 17:44:25 INFO - 'NO_EM_RESTART': '1', 17:44:25 INFO - 'PAGER': '/bin/cat', 17:44:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:25 INFO - 'PWD': '/builds/slave/test', 17:44:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:25 INFO - 'SHELL': '/bin/bash', 17:44:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWEwVuAHSA/Listeners', 17:44:25 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:44:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:25 INFO - 'USER': 'cltbld', 17:44:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:25 INFO - 'XPC_FLAGS': '0x0', 17:44:25 INFO - 'XPC_SERVICE_NAME': '0', 17:44:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:25 INFO - Downloading/unpacking jsonschema==2.5.1 17:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:44:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:28 INFO - Downloading functools32-3.2.3-2.tar.gz 17:44:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:44:28 INFO - warning: no files found matching '*.txt' 17:44:28 INFO - no previously-included directories found matching 'build' 17:44:28 INFO - no previously-included directories found matching 'dist' 17:44:28 INFO - no previously-included directories found matching '.git*' 17:44:28 INFO - Installing collected packages: jsonschema, functools32 17:44:28 INFO - Running setup.py install for functools32 17:44:28 INFO - warning: no files found matching '*.txt' 17:44:28 INFO - no previously-included directories found matching 'build' 17:44:28 INFO - no previously-included directories found matching 'dist' 17:44:28 INFO - no previously-included directories found matching '.git*' 17:44:28 INFO - Successfully installed jsonschema functools32 17:44:28 INFO - Cleaning up... 17:44:28 INFO - Return code: 0 17:44:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:44:28 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')]} 17:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:28 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')]} 17:44:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:28 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 0x10c7d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9eebd770d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5b6d30>, '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 0x10c4dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5abbe8>, '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.hKNnASELPO/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.jWEwVuAHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 17:44:28 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 17:44:28 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 17:44:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKNnASELPO/Render', 17:44:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:28 INFO - 'HOME': '/Users/cltbld', 17:44:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:28 INFO - 'LOGNAME': 'cltbld', 17:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:28 INFO - 'MOZ_NO_REMOTE': '1', 17:44:28 INFO - 'NO_EM_RESTART': '1', 17:44:28 INFO - 'PAGER': '/bin/cat', 17:44:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:28 INFO - 'PWD': '/builds/slave/test', 17:44:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:28 INFO - 'SHELL': '/bin/bash', 17:44:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWEwVuAHSA/Listeners', 17:44:28 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:44:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:28 INFO - 'USER': 'cltbld', 17:44:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:28 INFO - 'XPC_FLAGS': '0x0', 17:44:28 INFO - 'XPC_SERVICE_NAME': '0', 17:44:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:44:29 INFO - Cleaning up... 17:44:29 INFO - Return code: 0 17:44:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:44:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c7d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9eebd770d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5b6d30>, '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 0x10c4dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5abbe8>, '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.hKNnASELPO/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.jWEwVuAHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 17:44:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:44:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:44:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKNnASELPO/Render', 17:44:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:29 INFO - 'HOME': '/Users/cltbld', 17:44:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:29 INFO - 'LOGNAME': 'cltbld', 17:44:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:29 INFO - 'MOZ_NO_REMOTE': '1', 17:44:29 INFO - 'NO_EM_RESTART': '1', 17:44:29 INFO - 'PAGER': '/bin/cat', 17:44:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:29 INFO - 'PWD': '/builds/slave/test', 17:44:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:29 INFO - 'SHELL': '/bin/bash', 17:44:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWEwVuAHSA/Listeners', 17:44:29 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:44:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:29 INFO - 'USER': 'cltbld', 17:44:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:29 INFO - 'XPC_FLAGS': '0x0', 17:44:29 INFO - 'XPC_SERVICE_NAME': '0', 17:44:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:29 INFO - Downloading/unpacking blobuploader==1.2.4 17:44:29 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 17:44:29 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 17:44:29 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 17:44:29 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 17:44:29 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 17:44:29 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 17:44:31 INFO - Downloading blobuploader-1.2.4.tar.gz 17:44:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:44:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:44:31 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 17:44:31 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 17:44:31 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 17:44:31 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 17:44:31 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 17:44:31 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 17:44:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:44:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:33 INFO - Downloading docopt-0.6.1.tar.gz 17:44:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:44:33 INFO - Installing collected packages: blobuploader, requests, docopt 17:44:33 INFO - Running setup.py install for blobuploader 17:44:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:44:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:44:33 INFO - Running setup.py install for requests 17:44:33 INFO - Running setup.py install for docopt 17:44:34 INFO - Successfully installed blobuploader requests docopt 17:44:34 INFO - Cleaning up... 17:44:34 INFO - Return code: 0 17:44:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:34 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 0x10c7d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9eebd770d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5b6d30>, '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 0x10c4dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5abbe8>, '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.hKNnASELPO/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.jWEwVuAHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 17:44:34 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 17:44:34 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 17:44:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKNnASELPO/Render', 17:44:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:34 INFO - 'HOME': '/Users/cltbld', 17:44:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:34 INFO - 'LOGNAME': 'cltbld', 17:44:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:34 INFO - 'MOZ_NO_REMOTE': '1', 17:44:34 INFO - 'NO_EM_RESTART': '1', 17:44:34 INFO - 'PAGER': '/bin/cat', 17:44:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:34 INFO - 'PWD': '/builds/slave/test', 17:44:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:34 INFO - 'SHELL': '/bin/bash', 17:44:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWEwVuAHSA/Listeners', 17:44:34 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:44:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:34 INFO - 'USER': 'cltbld', 17:44:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:34 INFO - 'XPC_FLAGS': '0x0', 17:44:34 INFO - 'XPC_SERVICE_NAME': '0', 17:44:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:44:34 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-tuvQTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:44:34 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-71w6so-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:44:34 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-dgUh_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:44:34 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-heIdkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:44:34 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-ULplkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:44:34 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-frzacU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:44:34 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-EoFwfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:44:35 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-TvSWCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:44:35 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-gyfyE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:44:35 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-YIlRYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:44:35 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-IGUMD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:44:35 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-9QBVW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:44:35 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-lLRR_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:44:35 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-ukS_wP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:35 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-MTFD1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:44:35 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-OJSxfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:44:36 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-8NMEOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:44:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:44:36 INFO - Running setup.py install for manifestparser 17:44:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:44:36 INFO - Running setup.py install for mozcrash 17:44:36 INFO - Running setup.py install for mozdebug 17:44:36 INFO - Running setup.py install for mozdevice 17:44:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:44:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:44:36 INFO - Running setup.py install for mozfile 17:44:36 INFO - Running setup.py install for mozhttpd 17:44:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:44:37 INFO - Running setup.py install for mozinfo 17:44:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:44:37 INFO - Running setup.py install for mozInstall 17:44:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:44:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:44:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:44:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:44:37 INFO - Running setup.py install for mozleak 17:44:37 INFO - Running setup.py install for mozlog 17:44:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:44:37 INFO - Running setup.py install for moznetwork 17:44:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:44:37 INFO - Running setup.py install for mozprocess 17:44:37 INFO - Running setup.py install for mozprofile 17:44:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:44:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:44:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:44:38 INFO - Running setup.py install for mozrunner 17:44:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:44:38 INFO - Running setup.py install for mozscreenshot 17:44:38 INFO - Running setup.py install for moztest 17:44:38 INFO - Running setup.py install for mozversion 17:44:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:44:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:44:38 INFO - Cleaning up... 17:44:38 INFO - Return code: 0 17:44:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:38 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 0x10c7d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9eebd770d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5b6d30>, '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 0x10c4dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5abbe8>, '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.hKNnASELPO/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.jWEwVuAHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 17:44:38 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 17:44:38 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 17:44:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKNnASELPO/Render', 17:44:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:38 INFO - 'HOME': '/Users/cltbld', 17:44:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:38 INFO - 'LOGNAME': 'cltbld', 17:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:38 INFO - 'MOZ_NO_REMOTE': '1', 17:44:38 INFO - 'NO_EM_RESTART': '1', 17:44:38 INFO - 'PAGER': '/bin/cat', 17:44:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:38 INFO - 'PWD': '/builds/slave/test', 17:44:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:38 INFO - 'SHELL': '/bin/bash', 17:44:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWEwVuAHSA/Listeners', 17:44:38 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:44:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:38 INFO - 'USER': 'cltbld', 17:44:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:38 INFO - 'XPC_FLAGS': '0x0', 17:44:38 INFO - 'XPC_SERVICE_NAME': '0', 17:44:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:44:38 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-UsjlyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:44:39 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)) 17:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:44:39 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-ycu6eQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:44:39 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)) 17:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:44:39 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-6xiiNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:44:39 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)) 17:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:44:39 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-B3lOsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:44:39 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)) 17:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:44:39 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-pRSudr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:44:39 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)) 17:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:44:39 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-q7_fwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:44:39 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)) 17:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:44:39 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-tZ7LUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:44:39 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)) 17:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:44:39 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-Q3zxhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:44:39 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)) 17:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:44:39 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-xgGxuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:44:39 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)) 17:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:44:39 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-zHLjmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:44:40 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)) 17:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:44:40 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-z9YU0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:44:40 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)) 17:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:44:40 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-n8OElR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:44:40 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-GErIlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:44:40 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)) 17:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:44:40 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-JwUydP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:44:40 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)) 17:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:40 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-efBcew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:40 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)) 17:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:44:40 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-MRS_aY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:44:40 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)) 17:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:44:40 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-kiuVEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:44:40 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)) 17:44:40 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)) 17:44:40 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)) 17:44:40 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)) 17:44:40 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)) 17:44:40 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)) 17:44:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:43 INFO - Downloading blessings-1.6.tar.gz 17:44:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:44:43 INFO - Installing collected packages: blessings 17:44:43 INFO - Running setup.py install for blessings 17:44:43 INFO - Successfully installed blessings 17:44:43 INFO - Cleaning up... 17:44:43 INFO - Return code: 0 17:44:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:44:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:44:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:44:44 INFO - Reading from file tmpfile_stdout 17:44:44 INFO - Current package versions: 17:44:44 INFO - blessings == 1.6 17:44:44 INFO - blobuploader == 1.2.4 17:44:44 INFO - docopt == 0.6.1 17:44:44 INFO - functools32 == 3.2.3-2 17:44:44 INFO - jsonschema == 2.5.1 17:44:44 INFO - manifestparser == 1.1 17:44:44 INFO - mozInstall == 1.12 17:44:44 INFO - mozcrash == 1.0 17:44:44 INFO - mozdebug == 0.1 17:44:44 INFO - mozdevice == 0.49 17:44:44 INFO - mozfile == 1.2 17:44:44 INFO - mozhttpd == 0.7 17:44:44 INFO - mozinfo == 0.9 17:44:44 INFO - mozleak == 0.1 17:44:44 INFO - mozlog == 3.4 17:44:44 INFO - moznetwork == 0.27 17:44:44 INFO - mozprocess == 0.24 17:44:44 INFO - mozprofile == 0.28 17:44:44 INFO - mozrunner == 6.13 17:44:44 INFO - mozscreenshot == 0.1 17:44:44 INFO - mozsystemmonitor == 0.3 17:44:44 INFO - moztest == 0.8 17:44:44 INFO - mozversion == 1.4 17:44:44 INFO - psutil == 3.1.1 17:44:44 INFO - requests == 1.2.3 17:44:44 INFO - wsgiref == 0.1.2 17:44:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:44 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 0x10c7d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9eebd770d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5b6d30>, '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 0x10c4dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5abbe8>, '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.hKNnASELPO/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.jWEwVuAHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 17:44:44 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 17:44:44 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 17:44:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKNnASELPO/Render', 17:44:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:44 INFO - 'HOME': '/Users/cltbld', 17:44:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:44 INFO - 'LOGNAME': 'cltbld', 17:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:44 INFO - 'MOZ_NO_REMOTE': '1', 17:44:44 INFO - 'NO_EM_RESTART': '1', 17:44:44 INFO - 'PAGER': '/bin/cat', 17:44:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:44 INFO - 'PWD': '/builds/slave/test', 17:44:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:44 INFO - 'SHELL': '/bin/bash', 17:44:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWEwVuAHSA/Listeners', 17:44:44 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:44:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:44 INFO - 'USER': 'cltbld', 17:44:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:44 INFO - 'XPC_FLAGS': '0x0', 17:44:44 INFO - 'XPC_SERVICE_NAME': '0', 17:44:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:44 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)) 17:44:44 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)) 17:44:44 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)) 17:44:44 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)) 17:44:44 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)) 17:44:44 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)) 17:44:44 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)) 17:44:44 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)) 17:44:44 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)) 17:44:44 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)) 17:44:44 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)) 17:44:44 INFO - Cleaning up... 17:44:44 INFO - Return code: 0 17:44:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c7d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9eebd770d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c5b6d30>, '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 0x10c4dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5abbe8>, '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.hKNnASELPO/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.jWEwVuAHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 17:44:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:44:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKNnASELPO/Render', 17:44:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:44 INFO - 'HOME': '/Users/cltbld', 17:44:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:44 INFO - 'LOGNAME': 'cltbld', 17:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:44 INFO - 'MOZ_NO_REMOTE': '1', 17:44:44 INFO - 'NO_EM_RESTART': '1', 17:44:44 INFO - 'PAGER': '/bin/cat', 17:44:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:44 INFO - 'PWD': '/builds/slave/test', 17:44:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:44 INFO - 'SHELL': '/bin/bash', 17:44:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWEwVuAHSA/Listeners', 17:44:44 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:44:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:44 INFO - 'USER': 'cltbld', 17:44:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:44 INFO - 'XPC_FLAGS': '0x0', 17:44:44 INFO - 'XPC_SERVICE_NAME': '0', 17:44:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:44:44 INFO - Cleaning up... 17:44:44 INFO - Return code: 0 17:44:44 INFO - Running post-action listener: _resource_record_post_action 17:44:44 INFO - Running post-action listener: _start_resource_monitoring 17:44:44 INFO - Starting resource monitoring. 17:44:44 INFO - [mozharness: 2017-03-04 01:44:44.601811Z] Finished create-virtualenv step (success) 17:44:44 INFO - [mozharness: 2017-03-04 01:44:44.602746Z] Running install step. 17:44:44 INFO - Running pre-action listener: _resource_record_pre_action 17:44:44 INFO - Running main action method: install 17:44:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:44:44 INFO - Reading from file tmpfile_stdout 17:44:44 INFO - Detecting whether we're running mozinstall >=1.0... 17:44:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:44:44 INFO - Reading from file tmpfile_stdout 17:44:44 INFO - Output received: 17:44:44 INFO - Usage: mozinstall [options] installer 17:44:44 INFO - Options: 17:44:44 INFO - -h, --help show this help message and exit 17:44:44 INFO - -d DEST, --destination=DEST 17:44:44 INFO - Directory to install application into. [default: 17:44:44 INFO - "/builds/slave/test"] 17:44:44 INFO - --app=APP Application being installed. [default: firefox] 17:44:44 INFO - mkdir: /builds/slave/test/build/application 17:44:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:44:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 17:45:04 INFO - Reading from file tmpfile_stdout 17:45:04 INFO - Output received: 17:45:04 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 17:45:04 INFO - Running post-action listener: _resource_record_post_action 17:45:04 INFO - [mozharness: 2017-03-04 01:45:04.713744Z] Finished install step (success) 17:45:04 INFO - [mozharness: 2017-03-04 01:45:04.713867Z] Running run-tests step. 17:45:04 INFO - Running pre-action listener: _resource_record_pre_action 17:45:04 INFO - Running main action method: run_tests 17:45:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:45:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:45:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:45:04 INFO - 2017-03-03 17:45:04.728 screenresolution[1898:12169] starting screenresolution argv=screenresolution get 17:45:04 INFO - 2017-03-03 17:45:04.730 screenresolution[1898:12169] Display 0: 1600x1200x32@60 17:45:04 INFO - 2017-03-03 17:45:04.736 screenresolution[1899:12172] starting screenresolution argv=screenresolution list 17:45:04 INFO - Available Modes on Display 0 17:45:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:45:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:45:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:45:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:45:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:45:04 INFO - Intel Iris: 17:45:04 INFO - Chipset Model: Intel Iris 17:45:04 INFO - Type: GPU 17:45:04 INFO - Bus: Built-In 17:45:04 INFO - VRAM (Dynamic, Max): 1536 MB 17:45:04 INFO - Vendor: Intel (0x8086) 17:45:04 INFO - Device ID: 0x0a2e 17:45:04 INFO - Revision ID: 0x0009 17:45:04 INFO - Displays: 17:45:04 INFO - Display: 17:45:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:45:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:45:04 INFO - Display Serial Number: 1600x1200 60 17:45:04 INFO - Main Display: Yes 17:45:04 INFO - Mirror: Off 17:45:04 INFO - Online: Yes 17:45:04 INFO - Rotation: Supported 17:45:04 INFO - Return code: 0 17:45:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:45:04 INFO - Python 2.7.3 17:45:04 INFO - Return code: 0 17:45:04 INFO - grabbing minidump binary from tooltool 17:45:04 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')]} 17:45:04 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 0x10c5b6d30>, '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 0x10c4dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c5abbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:45:04 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 17:45:04 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 17:45:04 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 17:45:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:45:05 INFO - Return code: 0 17:45:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:45:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:45:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:45:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:45:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:45:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0375', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:45:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0375 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:45:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKNnASELPO/Render', 17:45:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:45:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:45:05 INFO - 'HOME': '/Users/cltbld', 17:45:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:45:05 INFO - 'LOGNAME': 'cltbld', 17:45:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:45:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:45:05 INFO - 'MOZ_NO_REMOTE': '1', 17:45:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:45:05 INFO - 'NO_EM_RESTART': '1', 17:45:05 INFO - 'PAGER': '/bin/cat', 17:45:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:45:05 INFO - 'PWD': '/builds/slave/test', 17:45:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:45:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:45:05 INFO - 'SHELL': '/bin/bash', 17:45:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWEwVuAHSA/Listeners', 17:45:05 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:45:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:45:05 INFO - 'USER': 'cltbld', 17:45:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:45:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:45:05 INFO - 'XPC_FLAGS': '0x0', 17:45:05 INFO - 'XPC_SERVICE_NAME': '0', 17:45:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:45:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0375', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:45:05 INFO - mozversion application_buildid: 20170303162023 17:45:05 INFO - mozversion application_changeset: e11b1a808700d7428c6ce94ca22921ae000424c1 17:45:05 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:45:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:45:05 INFO - mozversion application_name: Firefox 17:45:05 INFO - mozversion application_remotingname: firefox-dev 17:45:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:45:05 INFO - mozversion application_vendor: Mozilla 17:45:05 INFO - mozversion application_version: 53.0a2 17:45:05 INFO - mozversion platform_buildid: 20170303162023 17:45:05 INFO - mozversion platform_changeset: e11b1a808700d7428c6ce94ca22921ae000424c1 17:45:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:45:05 INFO - mozversion platform_version: 53.0a2 17:45:05 INFO - using testdate: 1488591905 17:45:05 INFO - actual date: 1488591905 17:45:05 INFO - starting webserver on 'localhost:49301' 17:45:05 INFO - SUITE-START | Running 2 tests 17:45:05 INFO - TEST-START | dromaeo_css 17:45:05 INFO - operating with platform_type : mac_ 17:45:05 INFO - Initialising browser for dromaeo_css test... 17:45:05 INFO - TEST-INFO | started process 1909 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpk09zel/profile http://localhost:49301/getInfo.html) 17:45:08 INFO - PROCESS | 1909 | 2017-03-03 17:45:08.293 plugin-container[1911:12338] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c3f, name = 'com.apple.tsm.portname' 17:45:08 INFO - PROCESS | 1909 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:45:08 INFO - PROCESS | 1909 | 2017-03-03 17:45:08.296 plugin-container[1911:12338] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9403, name = 'com.apple.CFPasteboardClient' 17:45:08 INFO - PROCESS | 1909 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:45:08 INFO - PROCESS | 1909 | 2017-03-03 17:45:08.296 plugin-container[1911:12338] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:45:08 INFO - PROCESS | 1909 | __metrics Screen width/height:1600/1200 17:45:08 INFO - PROCESS | 1909 | colorDepth:24 17:45:08 INFO - PROCESS | 1909 | Browser inner width/height: 1024/689 17:45:08 INFO - PROCESS | 1909 | __metrics 17:45:08 ERROR - PROCESS | 1909 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 17:45:09 INFO - TEST-INFO | 1909: exit 0 17:45:09 INFO - Browser initialized. 17:45:09 INFO - Running cycle 1/1 for dromaeo_css test... 17:45:09 INFO - TEST-INFO | started process 1912 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpk09zel/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:45:11 INFO - PROCESS | 1912 | 2017-03-03 17:45:11.655 plugin-container[1913:12470] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x433b, name = 'com.apple.tsm.portname' 17:45:11 INFO - PROCESS | 1912 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:45:11 INFO - PROCESS | 1912 | 2017-03-03 17:45:11.655 plugin-container[1913:12470] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4717, name = 'com.apple.CFPasteboardClient' 17:45:11 INFO - PROCESS | 1912 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:45:11 INFO - PROCESS | 1912 | 2017-03-03 17:45:11.655 plugin-container[1913:12470] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:45:21 INFO - PROCESS | 1912 | RSS: Main: 218624000 17:45:21 INFO - PROCESS | 1912 | 17:48:23 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49301/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49301/tests/dromaeo/cssquery-ext.html) 17:48:25 INFO - PROCESS | 1912 | RSS: Main: 235864064 17:48:25 INFO - PROCESS | 1912 | 17:50:09 INFO - PROCESS | 1912 | ************************* 17:50:09 INFO - PROCESS | 1912 | A coding exception was thrown and uncaught in a Task. 17:50:09 INFO - PROCESS | 1912 | 17:50:09 ERROR - PROCESS | 1912 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:50:09 INFO - PROCESS | 1912 | Full stack: 17:50:09 INFO - PROCESS | 1912 | ************************* 17:51:28 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49301/tests/dromaeo/cssquery-ext.html (next: http://localhost:49301/tests/dromaeo/cssquery-jquery.html) 17:51:28 INFO - PROCESS | 1912 | RSS: Main: 250290176 17:51:28 INFO - PROCESS | 1912 | 17:54:30 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49301/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49301/tests/dromaeo/cssquery-mootools.html) 17:54:31 INFO - PROCESS | 1912 | RSS: Main: 257572864 17:54:31 INFO - PROCESS | 1912 | 17:57:33 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49301/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49301/tests/dromaeo/cssquery-prototype.html) 17:57:33 INFO - PROCESS | 1912 | RSS: Main: 254013440 17:57:33 INFO - PROCESS | 1912 | 18:00:36 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49301/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49301/tests/dromaeo/cssquery-yui.html) 18:00:37 INFO - PROCESS | 1912 | RSS: Main: 257896448 18:00:37 INFO - PROCESS | 1912 | 18:03:40 INFO - PROCESS | 1912 | Cycle 1(1): loaded http://localhost:49301/tests/dromaeo/cssquery-yui.html (next: http://localhost:49301/tests/dromaeo/cssquery-dojo.html) 18:03:40 INFO - PROCESS | 1912 | RSS: Main: 260173824 18:03:40 INFO - PROCESS | 1912 | 18:03:40 INFO - PROCESS | 1912 | __start_tp_report 18:03:40 INFO - PROCESS | 1912 | _x_x_mozilla_page_load 18:03:40 INFO - PROCESS | 1912 | _x_x_mozilla_page_load_details 18:03:40 INFO - PROCESS | 1912 | |i|pagename|runs| 18:03:40 INFO - PROCESS | 1912 | |0;dojo.html;3375.932481350373;3377.273886114486;3379.5775528058994;3417.4361230396994;3426.4175090234658;4975.6019518438525;5429.348478182624;5686.744096515651;5716.971415142923;5813.82558523245;5710.885782284352;5802.622829516078;5821.8835623287505;5835.766569337232;5862.149988251701;4596.471405788344;5224.399194092671;5260.92108618371;5271.762770675329;5324.840254792362;5250.9474905250845;5353.839384818461;5361.892762144755;5364.517193452589;5387.488188622075;5176.663516871429;5198.662086964373;5227.947720522803;5295.973520132413;5302;5036.571891389236;5040.193569028937;5073.670211436245;5110.770015349281;5157.30376399185;5044;5045.5459008689395;5046.44489106198;5074.467180945984;5141.562967147797;5318.813841515528;5492.533134683556;5492.697901615409;5534.889302213933;5608.4111168327145;6128.38716128388;6218.347073557302;6229.6573688447115;6270.372962703739;6323.683815809237;6252;6258.749650013994;6260.843478913018;6266.749330026793;6284.277308109535;5895.322037965646;5923.763049477972;5932.406759324076;5933.376995415462;5979.282486101695;4565;6170.382961703884;6196.194494715658;6207.379262073757;6249.843753906189;6138.355472675394;6203.410675985774;6204.658743769136;6220.315765265817;6235.095911092866;6080.635161890213;6233.940230160883;6243.687815609202;6259;6277.340879207709;5005.674631148963;5146.408163061221;6131.070842498441;6179.227596550431;6237.812865614039;6231.034189700604;6258.530610204253;6271.529635277281;6290.937090629035;6298.275698294755;5040.218766091189;5046.596272298208;5049.873753156127;5062.7215503146945;5064;4389.034412429261;4405.537418571068;4429.82280708768;4502.234620114588;4503.301988191835;5846.561507886926;5851.648901065864;5922.230110085661;5955.702214889238;5970.31341395745;5225.712585807741;5872.618279811799;6260.499160067184;6274.749010039639;6304.8423789404715;5718.342390625048;5762.423757624204;5837.474627283565;5845;5868.501177399883;5470.316210473691;5471.069918113851;5472.26124473199;5486.451354864482;5498.1752737088955;5454.209139674725;6463.159789227464;6466.64433456155;6485.448736857231;6497.5126865484335;6131.621347939075;6161.907571386522;6169.784057557964;6178.1659475971965;6233.501319894488;6235.501159907106;6421.967890160519;6451.2903580607035;6455.9347707629595;6480.611163330215;6195.876082478415;6211.16149319836;6235.376462353728;6238;6267.592606480564;6148.708771158107;6176.9073463897175;6276.843078923063;6289.182406287154;6391.041343798467;6106.6336019838955;6111.022236442148;6129.172561704113;6144.078388241799;6202.193714817045;6160;6175.84560385994;6178.598391104564;6181.134641150153;6186.133941248138;4912.312276281395;5861.7655293787775;6012.7294271757;6028.698565071817;6046.90929636047;5069.417017043087;6014.458698717136;6108.0688921796145;6133.53998450127;6195.287541932736;6067.635941843503;6069.808775135277;6075.301340345917;6076.058210977306;6114.877702446015 18:03:40 INFO - PROCESS | 1912 | |1;ext.html;493.4079105073912;499.47908618257424;501.8494451664501;512.3595505617977;526.9578433725301;39530.011749706275;41942.79028604856;42131.78934105325;42171.57828421715;42336.57663423365;43412.56587434125;43830.12339753203;43842.342364864555;43967.56032439675;43980.3402948956;8469.407141500098;8975.012748597665;9180.449173049605;9202.723918282461;9216.124468175512;8518.531480768555;11211.327320360804;11474.426278686075;11483.770324593503;11663.475143618514;11426;11516.827247591293;11520;11531.019863311587;11537.596184133557;11471.541138354456;11534.423278836024;11544.653660390202;11548.249363791327;11556.826647600292;11303.717407064807;11317.320960742381;11353.432328383547;11382.373969431677;11395.943020284929;40869;40968.38547421791;41098.38352424716;41163.58836411627;41189.38215926763;3919.529656441217;3943.112799620091;4039;4055.107876267246;4077.9184416311805;29498.705012950024;29990;30330;30513.542296865566;30578.235544111354;3111.673274306188;3168.350488149924;3236.077717850425;3271.371769383698;3347.09628400333;400584;410217;412665;413122;413399.86600134213;60551.78896422047;60919.69540152271;60996;61031.6948415264;61152;58416.707916460145;58584.12123818146;58590;59048.70475647594;59086.704566477754;14172.85827141736;16263.268152933146;16777.328906843835;16794.6641067178;16818;11565;11890.583829565923;12602.054845886596;13019.609411717664;13073.477060917647;13431.731365372832;16396.590085247724;16404.015759054495;16429.67140657204;16496.6700665986;6201.317855035943;7284.745033923788;7285.271472852673;7315.158756742936;7356.5218260813945;868.887044684187;875.0137188581883;877.6489404238229;896.6996056321075;915.057490784493;29536;29800.552991705143;29984.40031199364;30403.695963040085;30609.234769130504;896.4755617963565;1062.2670357453333;1093.3221402730358;1115.3140818396628;1187.5843454790754;14641.780258665718;15108.169050702318;15374.538763837103;15568.754499640001;15777.132257725936;618319;621133;622867;623870;625400;61199.38800612026;61290.38709612936;61560;61603.6919815407;61607;1423.843377228504;1461.7734251191082;1462.4881291547872;1466.765317549187;1468.4566710317038;25913.6112958302;28355.291117722223;28810.423791523634;29271.70728292775;29978.550321745628;50544.49455505545;50930.745346273034;51037.23444148415;51306;51335.94656213859;502503;507742;509309;509666;510228;24647.260582182564;25316.493670126863;25384;40779.7961010193;40983.385249220686;34760.304793904485;41638.95902602459;42818.57181428146;42968.78515607402;43514.34728479139;35401.822990885914;35795.284094318486;35801.64198357983;37200.25599488049;38015.66945157017;35571.82214088913;35838.64161358457;36729.08177295482;36992;37040.25919481649;34371.20019136097;34441.794537191076;34766.47850282197;35341.29317413586;35414.29171416609;25379.085422239223;28428.85785571059;30253;32402.35195296128;32705.509417359233;21101;21791.237306694824;23644.172453964027;24152.637710434006;24288.271351859472 18:03:40 INFO - PROCESS | 1912 | |2;jquery.html;389.5773086201471;390.38124572552505;396.47467106084434;399.63034193371124;422.80768233581296;17197.656046879085;19601;20466.079026443807;21106.99999999998;21112;20667.069981850815;20759.16963321469;21148.788512114876;21176.25883094092;21338.573228535457;5302.1781623848265;5900.144479050535;5937.584369094165;5947.018741907602;5967.104934259874;5638.859028524279;5761.452661997125;5777.306723193223;5869.266341707286;5871.647701137946;5727.198192253088;5782.768689252425;5788.27646544182;5788.739506722208;5798.478136967672;5022.723750193738;5660.745266463019;5708.22938903249;5757.625754325955;5804.738786754606;5143.742812859342;5162.432132465426;5169.198774189969;5172.043172013189;5182.170852663593;25753;26222.86888565545;26527.734722652913;26711.732882671313;26723.599146012824;3042.3154790172034;3049.1157564306322;3050.877964881402;3058.938821223563;3062.617172853393;14645.6338591535;15683.607909802233;15767.526974190792;15893.125878076702;16489.34042638305;1791.2118667786262;1791.2745338138075;1816.30980227514;1818;1848.5471059590352;127006.72993270133;128066.71933280642;133307;134472;134525;10906.454677266105;11672.88327116718;11707.88292117068;11746.295222286519;11932.582359617545;13170.682931706753;13678.247696376597;14720.852791472162;14759.92620036893;14765.630859228391;8850.822983540293;9083.18251357381;9092.590833412512;9144.497052662035;9249.90750092504;8904.8664270036;8938.240249578728;9031.187193152648;9172.082791720908;9442.811143777224;7513.661885215179;7573.394128469709;7691.5769632670745;7693.653785579662;7702.3453006493955;1969.4190213886939;2005.7191993120975;2016.2136766661015;2020.6160829442358;2028.3103744726568;833.8957630296213;939.7689027374025;1017.3387298256192;1035.30634474902;1049.506731836036;20663.690044649342;22091.558168836535;22961.655575166387;22989.425264368525;23014.53970920572;908.5366463103733;956.6986399284203;981.4749109226673;987.4272921705393;1016.1972042086817;8328.625211865481;10591.57633694659;12014.038876889828;12188.14682972201;12379.93810030944;414407.35032247496;415618;417028;809309;813366;157426.21286893493;159881;164429.3557064438;167020;169449;1045.2996492350144;1047.9109275711498;1058.3755584205355;1071.0467683761303;1071.3678929431674;19154.329598463988;20136.4011091963;20250.291239806535;20320.59358812845;20323.491912702302;48222.67168251147;60131.39868601258;62649.37350626435;62675.37324626695;64547;80914.59542702249;89088;95067;98979;100095;8080.474769139987;8286.627101780314;8613.09562495929;8755.868661969947;8761;7685.961570192113;10467.94766026165;10486.79026419452;12432;13516.93241533786;11259.268147570381;11476;11540.826887596524;11720.70698232551;11868.76262474763;9949.751256218653;9992.450415226942;11061.225714199929;11362.318260904372;11448.484818183368;11529.942350288195;11676.416179191176;11708.88291117078;11974.58088966882;12059.15585908978;8439.493630382196;8474.830503390021;8493.10822363643;8652.351073669373;8742.038375778786;9290.814183716153;9425.858612120961;10890.019898209199;11410.973012428922;11878 18:03:40 INFO - PROCESS | 1912 | |3;mootools.html;1431.3558898495673;1442.516756886443;1443.076431084106;1450.2458721464839;1459.080779109161;6660;7480.700771969128;8113.959430202848;8518;8527.360447966405;6835.384815366616;8177.100518942912;8206.179382061791;8361.038480574736;8372.748817535483;2254.627986382245;2304.2165663674346;2305.0318866076204;2306.7001289832297;2311.3874823171873;1898.610784789122;2050.507878109258;2285.565742508926;2316.918907838226;2318.7217533895955;1981.7621885373703;2314.7338056123594;2317.2005658047947;2319.2230602748014;2324.151684635113;2286.9199578014773;2289.2903200007886;2301.9654705179437;2306.400335912658;2311.6648086027517;2299.494111295512;2308.307507747669;2323.186884590397;2325.2442956039354;2332.918347857834;8422.78943026423;8465.95767021161;8473.830523389559;8488.193621605998;8495.150484951455;5042.168042273021;5206.5314121729225;5207.297014902978;5208.947910520922;5212.661177023481;3255.3814775192636;3365.612954510238;3391.118309239591;3406.3527929693278;3435;1157.4964890272759;1170.3270619393882;1192.9582464613784;1215.769003889258;1216.4769149265812;10055.145312648434;10115.786105667294;10779.137668986463;10795.406252656101;10846.078083362923;4171.895702607399;4369.082492676574;4430.933535996963;4431.246688063037;4489.640828733759;8554.743357699279;8611.354148438892;8620.956895215484;8624.051354351017;8633.22300992901;4244.959984803681;4442.267025940683;4457.531959144243;5080.26336181259;5095.974520127375;3897.5517815451585;4483.775811209426;4655;4657.301404789308;4715.151272770934;3198.72810811079;3687.11509237781;3699.519062521909;3724.6834019108137;3824.598417166213;946.7964387656687;1086.9347839129518;1166.381817636637;1172.0096518441903;1187.827764974074;657.710607332772;781.9609019549114;808.7654580171802;835.7826964989025;836.9455985360933;5040.31955685985;5079.780852595424;5333.839984800462;5640.464155905182;5723.513501352349;883.2757139145839;921.7142086789025;948.4214629076396;985.2413641496008;993.8544506636415;3476.774009689362;3832.2718683450057;3833.3483307837178;3859.054531639766;3922.78424686645;9267.953660231655;9816.705498835046;9922.80154396908;9946.20430365569;9955.402675839472;9697.515124243759;9886.7033988979;9888.703338899844;9903.158231550255;9928.652497162564;7663.885041724378;7865.567393793282;7870.409719271192;7883.6058197089915;7907.130215676271;5340.786368545215;5403.83788486346;5409.296791417248;5473.452654734654;5507.906995341745;9053;9088.863667045132;9167.266618670357;9228.35401521887;9313.627454901729;8751.91248087511;9346.20557252641;9377.578008989476;9443.433393996382;9488.620455181715;6602.372774586406;6643.435307998681;6656.534042617164;6658.1344425224415;6662.433693136138;7521;7709.2290770922455;7765.0681918170185;7796.376289896682;7806.843863122592;5399.433059528693;5987.970060149672;6933.514653974174;7077.433805295667;7112;6929.376356127973;6964.65176741171;7026.367626913602;7031.753888613874;7061.646917653994;6290.937090629218;6405.93594064072;6412.839679008062;6429.678516074271;6431.517636177399;4786.545278198566;4845.1520983828395;4928.162212423968;4987.226979818134;5087.847364579068;4272.423222864873;4950.653454258311;4956.801727930842;4961.70229786214;5076 18:03:40 INFO - PROCESS | 1912 | |4;prototype.html;332.8914714002372;340.55387442450376;349.3135987784004;361.94027985382405;371.62465909431484;4765.901324860617;5160.380754309488;5335.279737235472;5368.597355198361;5495;4189.7695626740515;4781.5218478152165;5228.843134705965;5334.626576139672;5366.329208848894;3455.429854074081;4223.577642235768;4223.767692776896;4252.298370768819;4258.765767882765;3773.471713960034;4161.7306721450095;4213.220554197468;4214.936775948363;4241.2365774160635;4034.979825100885;4052.5136983562015;4059.1180262014004;4067.3695577185435;4070.5115386153702;3562.71498280137;3701.9074523137;3903.1850189661945;4006.8998275043064;4029.2344454553686;3229.6608856070243;3501.8774342897877;3529.400001999666;3559.4482855157494;3567.4292113262013;4955.677880937727;5077.49225077493;5280.6303558750515;5328.387235467932;5369.543588794957;4285.721428107163;4425.623821975136;4512.4133862597655;4647.790849411751;4664.15765772518;5074.720890351029;5104.719240441774;5696.145578163268;5717.371089180187;5722.942770572283;3453.3438646657055;3640.4175331947026;3832.310184166849;3898.8693278949354;3909.3940439231965;5409.594280428983;5439.945600543983;5673.609965558423;5685.857853553653;5948.583599148062;3922.2939870823525;3923.47033150521;3923.6468717814964;3935.252302062599;3969.54350249725;3269.9509507357407;3427.9657203428146;3694.7783133012103;3716.8141592920247;4054.2296963576828;3964.682825373963;4611.086399144385;4615.653825962999;4628.560286772751;4686.2895043308945;5736.254286942671;5772.3938986406665;5778.093229234342;5798.217240672455;5832.591718579743;1109.6615532262738;1147.2657499200518;1204.3015051270243;1231.5504840733247;1240.2434514945876;768.4121646940096;837.3552364679163;872.3718922375879;874.8162885793927;882.2544949517647;4444.6666500012625;5127.6154288428515;5166.011085732021;5172.043172013189;5179.611529135254;4723.834665786681;5186.844394668091;5305.867353316198;5345.705986170798;5689.971550142222;4747.009384088003;4807.9422527044;4904.705717656952;4918.803247870045;5141.948580514222;2457.5453541094953;2734.5898115282866;2922.517784565523;2935.722960512184;2939.955900661492;5133.25567792668;5502.58730595207;5566.805161819317;5701.686407247641;5773.3072031356505;5190.714510701948;5621.269234999424;5712.742926568314;5734.132933533233;5748.310202775694;5618.353889302701;5723.627964182315;5778.6532808030815;5809.564282678816;5817.38917413674;4996.900681849987;5025.321581586585;5105.28526006352;5134.741988212912;5597.524210442158;4785.234362501983;5320.441353657965;5421.891562168814;5531.861703457445;5561.610687251854;5080.364954380702;5512.6968016759465;5643.576731745054;5646.2942132233475;5736.479832844216;3652.9634703653687;3686.262747450467;3726.2425804903633;3726.7763934164036;3750.8499660014386;5561.330561330503;5621.184928185308;5623.634463759842;5630;5639.349505732299;4641.814327426865;4890.608751299958;4909.239067944474;5201.089809283436;5477.685355514727;4804.534616941726;5665.773369065191;5669.858253543694;5679.545636349165;5703.372629010722;4639.262834927409;5286.3392075990505;5424.294841670558;5563.666180029049;5613.550915926798;4835.8065677372515;5049.419316778471;5143.948560514347;5375.489328513785;5694.743736531949;4626.285216668486;5579.8884022320135;5597.096987024432;5605.411431799603;5621.409751975983 18:03:40 INFO - PROCESS | 1912 | |5;yui.html;693.6497068980165;719.3921136639541;746.3767753925472;752.525908677533;809.5833935701929;14596.416143354267;14891.47879824205;15193.772093418607;15207.46773862915;15483.922580387096;13859;13982.300884955737;14024.368903399347;14176.929115354435;14211.005229633929;834.2158371131147;836.188896770132;840.5251033166272;842.4145219072747;846.0101681033206;667.4293479075393;683.8187880211748;824.5464994253167;837.7068026190815;846.7332790171076;878.3982971664399;888.4935586715575;888.5868071346822;888.7378223424106;890;874.2263097158997;882.6557642519423;884.6505630276005;884.9115088491163;885.9468431894107;600.9369016253318;603.8762053778964;642.6915080761214;655.2661019657966;659.8449364399362;14466.987310888242;14474.782878256834;14484.42062317506;14604.196769177692;15265.694686106215;13923.164610123426;14292.785608215885;14339.42642294307;14366.13803171813;14383.856161438356;11415.372154531497;11450.828237576443;11470.254433461798;11521.711957201052;11766.764664706743;3550.431930891045;3561.8397172127316;3665.9083522911874;3704.0369503928905;3886.630770076838;94728;105602;106625;108067;108778.45610771896;10393.896061039293;10661.147108231324;10765.977232162932;10796.686551355413;10798.67603971882;21920;22484.55030899373;22705.318840434815;22847.428814279443;22925.312240632808;7665.731699390494;7713.575753333508;7802.648880800378;7826.726064587712;7950.1254861965135;4223.598758117974;4224.493060832659;4300.935485967713;4315.3095504719095;4394.626456751212;3541.13242255649;3644.6902013328636;3644.7630903991158;3655.1593133579427;3656.4149736042104;580.5906835680835;618.4588485075559;639.4724352409188;652.655529609007;728.6793810723265;633.2274624957545;633.8098570428853;658.1167735403319;704.7181127548919;714.6891102370486;9866.703998880044;10112.728140283843;10137.087662110445;10503.107235885036;10505.107065899332;636.4558302651259;668.9598624082571;695.7059868644318;703.8486725353971;713.8964850096706;4078.490188726409;4576.832907608605;4948.579370753526;4971.955889263223;4996.325496058058;96362.51818740861;102532.48733756284;106368;109444;111359.77280454345;91839.54080229689;92601.07398926059;94658;96028;97111.54332685015;83098.75351869727;84931;85157;85760.14239857647;86688;9634.855477167708;9666.516674166403;9775.022497750453;9805.656802011896;9810.411375317504;46407.535924640324;49094.75452622714;50909.74545127251;51115.72210694614;51201;63960.68019659872;65660.6716966412;68649.31350686429;69308.6534567344;74034;12627.368631568568;12982.480700771863;13155.342232888508;13402.93298533501;13459.798103028266;14077.436902524194;14458.98787084894;14534.563963081124;14669.266536673336;14830.110193388431;13441.731165376834;13591.864081359456;13751.449942002208;13777.655558611115;13822.239776812372;12718.364081795688;13215.537456188988;13376.264305463294;13542.59372218835;13792.724145517233;12820.423080961566;13210;13305.201687898758;13340.86659133435;13359.933200333937;10669.946650266698;10938.289011214245;10962.890371096506;11242;11519.712007199887;9530.270982160684;9723.513824308615;10897.782044359226;11115.83326250123;11123.944380278046 18:03:40 INFO - PROCESS | 1912 | __end_tp_report 18:03:40 INFO - PROCESS | 1912 | __start_cc_report 18:03:40 INFO - PROCESS | 1912 | _x_x_mozilla_cycle_collect,385 18:03:40 INFO - PROCESS | 1912 | __end_cc_report 18:03:40 INFO - PROCESS | 1912 | __startTimestamp1488593020466__endTimestamp 18:03:40 INFO - PROCESS | 1912 | 18:03:40 INFO - PROCESS | 1912 | ------- Summary: start ------- 18:03:40 INFO - PROCESS | 1912 | Number of tests: 6 18:03:40 INFO - PROCESS | 1912 | 18:03:40 INFO - PROCESS | 1912 | [#0] dojo.html Cycles:165 Average:5725.03 Median:5970.31 stddev:663.53 (11.1%) stddev-sans-first:639.46 18:03:40 INFO - PROCESS | 1912 | Values: 3375.9 3377.3 3379.6 3417.4 3426.4 4975.6 5429.3 5686.7 5717.0 5813.8 5710.9 5802.6 5821.9 5835.8 5862.1 4596.5 5224.4 5260.9 5271.8 5324.8 5250.9 5353.8 5361.9 5364.5 5387.5 5176.7 5198.7 5227.9 5296.0 5302.0 5036.6 5040.2 5073.7 5110.8 5157.3 5044.0 5045.5 5046.4 5074.5 5141.6 5318.8 5492.5 5492.7 5534.9 5608.4 6128.4 6218.3 6229.7 6270.4 6323.7 6252.0 6258.7 6260.8 6266.7 6284.3 5895.3 5923.8 5932.4 5933.4 5979.3 4565.0 6170.4 6196.2 6207.4 6249.8 6138.4 6203.4 6204.7 6220.3 6235.1 6080.6 6233.9 6243.7 6259.0 6277.3 5005.7 5146.4 6131.1 6179.2 6237.8 6231.0 6258.5 6271.5 6290.9 6298.3 5040.2 5046.6 5049.9 5062.7 5064.0 4389.0 4405.5 4429.8 4502.2 4503.3 5846.6 5851.6 5922.2 5955.7 5970.3 5225.7 5872.6 6260.5 6274.7 6304.8 5718.3 5762.4 5837.5 5845.0 5868.5 5470.3 5471.1 5472.3 5486.5 5498.2 5454.2 6463.2 6466.6 6485.4 6497.5 6131.6 6161.9 6169.8 6178.2 6233.5 6235.5 6422.0 6451.3 6455.9 6480.6 6195.9 6211.2 6235.4 6238.0 6267.6 6148.7 6176.9 6276.8 6289.2 6391.0 6106.6 6111.0 6129.2 6144.1 6202.2 6160.0 6175.8 6178.6 6181.1 6186.1 4912.3 5861.8 6012.7 6028.7 6046.9 5069.4 6014.5 6108.1 6133.5 6195.3 6067.6 6069.8 6075.3 6076.1 6114.9 18:03:40 INFO - PROCESS | 1912 | 18:03:40 INFO - PROCESS | 1912 | [#1] ext.html Cycles:180 Average:65359.24 Median:35820.14 stddev:138902.45 (387.8%) stddev-sans-first:139206.73 18:03:40 INFO - PROCESS | 1912 | Values: 493.4 499.5 501.8 512.4 527.0 39530.0 41942.8 42131.8 42171.6 42336.6 43412.6 43830.1 43842.3 43967.6 43980.3 8469.4 8975.0 9180.4 9202.7 9216.1 8518.5 11211.3 11474.4 11483.8 11663.5 11426.0 11516.8 11520.0 11531.0 11537.6 11471.5 11534.4 11544.7 11548.2 11556.8 11303.7 11317.3 11353.4 11382.4 11395.9 40869.0 40968.4 41098.4 41163.6 41189.4 3919.5 3943.1 4039.0 4055.1 4077.9 29498.7 29990.0 30330.0 30513.5 30578.2 3111.7 3168.4 3236.1 3271.4 3347.1 400584.0 410217.0 412665.0 413122.0 413399.9 60551.8 60919.7 60996.0 61031.7 61152.0 58416.7 58584.1 58590.0 59048.7 59086.7 14172.9 16263.3 16777.3 16794.7 16818.0 11565.0 11890.6 12602.1 13019.6 13073.5 13431.7 16396.6 16404.0 16429.7 16496.7 6201.3 7284.7 7285.3 7315.2 7356.5 868.9 875.0 877.6 896.7 915.1 29536.0 29800.6 29984.4 30403.7 30609.2 896.5 1062.3 1093.3 1115.3 1187.6 14641.8 15108.2 15374.5 15568.8 15777.1 618319.0 621133.0 622867.0 623870.0 625400.0 61199.4 61290.4 61560.0 61603.7 61607.0 1423.8 1461.8 1462.5 1466.8 1468.5 25913.6 28355.3 28810.4 29271.7 29978.6 50544.5 50930.7 51037.2 51306.0 51335.9 502503.0 507742.0 509309.0 509666.0 510228.0 24647.3 25316.5 25384.0 40779.8 40983.4 34760.3 41639.0 42818.6 42968.8 43514.3 35401.8 35795.3 35801.6 37200.3 38015.7 35571.8 35838.6 36729.1 36992.0 37040.3 34371.2 34441.8 34766.5 35341.3 35414.3 25379.1 28428.9 30253.0 32402.4 32705.5 21101.0 21791.2 23644.2 24152.6 24288.3 18:03:40 INFO - PROCESS | 1912 | 18:03:40 INFO - PROCESS | 1912 | [#2] jquery.html Cycles:180 Average:36687.06 Median:26375.30 stddev:102919.25 (390.2%) stddev-sans-first:103171.88 18:03:40 INFO - PROCESS | 1912 | Values: 389.6 390.4 396.5 399.6 422.8 17197.7 19601.0 20466.1 21107.0 21112.0 20667.1 20759.2 21148.8 21176.3 21338.6 5302.2 5900.1 5937.6 5947.0 5967.1 5638.9 5761.5 5777.3 5869.3 5871.6 5727.2 5782.8 5788.3 5788.7 5798.5 5022.7 5660.7 5708.2 5757.6 5804.7 5143.7 5162.4 5169.2 5172.0 5182.2 25753.0 26222.9 26527.7 26711.7 26723.6 3042.3 3049.1 3050.9 3058.9 3062.6 14645.6 15683.6 15767.5 15893.1 16489.3 1791.2 1791.3 1816.3 1818.0 1848.5 127006.7 128066.7 133307.0 134472.0 134525.0 10906.5 11672.9 11707.9 11746.3 11932.6 13170.7 13678.2 14720.9 14759.9 14765.6 8850.8 9083.2 9092.6 9144.5 9249.9 8904.9 8938.2 9031.2 9172.1 9442.8 7513.7 7573.4 7691.6 7693.7 7702.3 1969.4 2005.7 2016.2 2020.6 2028.3 833.9 939.8 1017.3 1035.3 1049.5 20663.7 22091.6 22961.7 22989.4 23014.5 908.5 956.7 981.5 987.4 1016.2 8328.6 10591.6 12014.0 12188.1 12379.9 414407.4 415618.0 417028.0 809309.0 813366.0 157426.2 159881.0 164429.4 167020.0 169449.0 1045.3 1047.9 1058.4 1071.0 1071.4 19154.3 20136.4 20250.3 20320.6 20323.5 48222.7 60131.4 62649.4 62675.4 64547.0 80914.6 89088.0 95067.0 98979.0 100095.0 8080.5 8286.6 8613.1 8755.9 8761.0 7686.0 10467.9 10486.8 12432.0 13516.9 11259.3 11476.0 11540.8 11720.7 11868.8 9949.8 9992.5 11061.2 11362.3 11448.5 11529.9 11676.4 11708.9 11974.6 12059.2 8439.5 8474.8 8493.1 8652.4 8742.0 9290.8 9425.9 10890.0 11411.0 11878.0 18:03:40 INFO - PROCESS | 1912 | 18:03:40 INFO - PROCESS | 1912 | [#3] mootools.html Cycles:180 Average:5291.78 Median:5273.25 stddev:2901.05 (55.0%) stddev-sans-first:2894.68 18:03:40 INFO - PROCESS | 1912 | Values: 1431.4 1442.5 1443.1 1450.2 1459.1 6660.0 7480.7 8114.0 8518.0 8527.4 6835.4 8177.1 8206.2 8361.0 8372.7 2254.6 2304.2 2305.0 2306.7 2311.4 1898.6 2050.5 2285.6 2316.9 2318.7 1981.8 2314.7 2317.2 2319.2 2324.2 2286.9 2289.3 2302.0 2306.4 2311.7 2299.5 2308.3 2323.2 2325.2 2332.9 8422.8 8466.0 8473.8 8488.2 8495.2 5042.2 5206.5 5207.3 5208.9 5212.7 3255.4 3365.6 3391.1 3406.4 3435.0 1157.5 1170.3 1193.0 1215.8 1216.5 10055.1 10115.8 10779.1 10795.4 10846.1 4171.9 4369.1 4430.9 4431.2 4489.6 8554.7 8611.4 8621.0 8624.1 8633.2 4245.0 4442.3 4457.5 5080.3 5096.0 3897.6 4483.8 4655.0 4657.3 4715.2 3198.7 3687.1 3699.5 3724.7 3824.6 946.8 1086.9 1166.4 1172.0 1187.8 657.7 782.0 808.8 835.8 836.9 5040.3 5079.8 5333.8 5640.5 5723.5 883.3 921.7 948.4 985.2 993.9 3476.8 3832.3 3833.3 3859.1 3922.8 9268.0 9816.7 9922.8 9946.2 9955.4 9697.5 9886.7 9888.7 9903.2 9928.7 7663.9 7865.6 7870.4 7883.6 7907.1 5340.8 5403.8 5409.3 5473.5 5507.9 9053.0 9088.9 9167.3 9228.4 9313.6 8751.9 9346.2 9377.6 9443.4 9488.6 6602.4 6643.4 6656.5 6658.1 6662.4 7521.0 7709.2 7765.1 7796.4 7806.8 5399.4 5988.0 6933.5 7077.4 7112.0 6929.4 6964.7 7026.4 7031.8 7061.6 6290.9 6405.9 6412.8 6429.7 6431.5 4786.5 4845.2 4928.2 4987.2 5087.8 4272.4 4950.7 4956.8 4961.7 5076.0 18:03:40 INFO - PROCESS | 1912 | 18:03:40 INFO - PROCESS | 1912 | [#4] prototype.html Cycles:180 Average:4478.70 Median:5062.07 stddev:1370.07 (27.1%) stddev-sans-first:1338.11 18:03:40 INFO - PROCESS | 1912 | Values: 332.9 340.6 349.3 361.9 371.6 4765.9 5160.4 5335.3 5368.6 5495.0 4189.8 4781.5 5228.8 5334.6 5366.3 3455.4 4223.6 4223.8 4252.3 4258.8 3773.5 4161.7 4213.2 4214.9 4241.2 4035.0 4052.5 4059.1 4067.4 4070.5 3562.7 3701.9 3903.2 4006.9 4029.2 3229.7 3501.9 3529.4 3559.4 3567.4 4955.7 5077.5 5280.6 5328.4 5369.5 4285.7 4425.6 4512.4 4647.8 4664.2 5074.7 5104.7 5696.1 5717.4 5722.9 3453.3 3640.4 3832.3 3898.9 3909.4 5409.6 5439.9 5673.6 5685.9 5948.6 3922.3 3923.5 3923.6 3935.3 3969.5 3270.0 3428.0 3694.8 3716.8 4054.2 3964.7 4611.1 4615.7 4628.6 4686.3 5736.3 5772.4 5778.1 5798.2 5832.6 1109.7 1147.3 1204.3 1231.6 1240.2 768.4 837.4 872.4 874.8 882.3 4444.7 5127.6 5166.0 5172.0 5179.6 4723.8 5186.8 5305.9 5345.7 5690.0 4747.0 4807.9 4904.7 4918.8 5141.9 2457.5 2734.6 2922.5 2935.7 2940.0 5133.3 5502.6 5566.8 5701.7 5773.3 5190.7 5621.3 5712.7 5734.1 5748.3 5618.4 5723.6 5778.7 5809.6 5817.4 4996.9 5025.3 5105.3 5134.7 5597.5 4785.2 5320.4 5421.9 5531.9 5561.6 5080.4 5512.7 5643.6 5646.3 5736.5 3653.0 3686.3 3726.2 3726.8 3750.8 5561.3 5621.2 5623.6 5630.0 5639.3 4641.8 4890.6 4909.2 5201.1 5477.7 4804.5 5665.8 5669.9 5679.5 5703.4 4639.3 5286.3 5424.3 5563.7 5613.6 4835.8 5049.4 5143.9 5375.5 5694.7 4626.3 5579.9 5597.1 5605.4 5621.4 18:03:40 INFO - PROCESS | 1912 | 18:03:40 INFO - PROCESS | 1912 | [#5] yui.html Cycles:180 Average:20851.75 Median:4151.04 stddev:30298.86 (729.9%) stddev-sans-first:30346.05 18:03:40 INFO - PROCESS | 1912 | Values: 693.6 719.4 746.4 752.5 809.6 14596.4 14891.5 15193.8 15207.5 15483.9 13859.0 13982.3 14024.4 14176.9 14211.0 834.2 836.2 840.5 842.4 846.0 667.4 683.8 824.5 837.7 846.7 878.4 888.5 888.6 888.7 890.0 874.2 882.7 884.7 884.9 885.9 600.9 603.9 642.7 655.3 659.8 14467.0 14474.8 14484.4 14604.2 15265.7 13923.2 14292.8 14339.4 14366.1 14383.9 11415.4 11450.8 11470.3 11521.7 11766.8 3550.4 3561.8 3665.9 3704.0 3886.6 94728.0 105602.0 106625.0 108067.0 108778.5 10393.9 10661.1 10766.0 10796.7 10798.7 21920.0 22484.6 22705.3 22847.4 22925.3 7665.7 7713.6 7802.6 7826.7 7950.1 4223.6 4224.5 4300.9 4315.3 4394.6 3541.1 3644.7 3644.8 3655.2 3656.4 580.6 618.5 639.5 652.7 728.7 633.2 633.8 658.1 704.7 714.7 9866.7 10112.7 10137.1 10503.1 10505.1 636.5 669.0 695.7 703.8 713.9 4078.5 4576.8 4948.6 4972.0 4996.3 96362.5 102532.5 106368.0 109444.0 111359.8 91839.5 92601.1 94658.0 96028.0 97111.5 83098.8 84931.0 85157.0 85760.1 86688.0 9634.9 9666.5 9775.0 9805.7 9810.4 46407.5 49094.8 50909.7 51115.7 51201.0 63960.7 65660.7 68649.3 69308.7 74034.0 12627.4 12982.5 13155.3 13402.9 13459.8 14077.4 14459.0 14534.6 14669.3 14830.1 13441.7 13591.9 13751.4 13777.7 13822.2 12718.4 13215.5 13376.3 13542.6 13792.7 12820.4 13210.0 13305.2 13340.9 13359.9 10669.9 10938.3 10962.9 11242.0 11519.7 9530.3 9723.5 10897.8 11115.8 11123.9 18:03:40 INFO - PROCESS | 1912 | -------- Summary: end -------- 18:03:40 INFO - PROCESS | 1912 | 18:03:41 INFO - TEST-INFO | 1912: exit 0 18:03:41 INFO - TEST-OK | dromaeo_css | took 1115778ms 18:03:41 INFO - TEST-START | kraken 18:03:41 INFO - operating with platform_type : mac_ 18:03:41 INFO - Initialising browser for kraken test... 18:03:41 INFO - TEST-INFO | started process 1919 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpAzPejo/profile http://localhost:49301/getInfo.html) 18:03:43 INFO - PROCESS | 1919 | 2017-03-03 18:03:43.908 plugin-container[1920:14411] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4743, name = 'com.apple.tsm.portname' 18:03:43 INFO - PROCESS | 1919 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:03:43 INFO - PROCESS | 1919 | 2017-03-03 18:03:43.910 plugin-container[1920:14411] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893b, name = 'com.apple.CFPasteboardClient' 18:03:43 INFO - PROCESS | 1919 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:03:43 INFO - PROCESS | 1919 | 2017-03-03 18:03:43.910 plugin-container[1920:14411] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:03:43 INFO - PROCESS | 1919 | __metrics Screen width/height:1600/1200 18:03:43 INFO - PROCESS | 1919 | colorDepth:24 18:03:43 INFO - PROCESS | 1919 | Browser inner width/height: 1024/689 18:03:43 INFO - PROCESS | 1919 | __metrics 18:03:44 ERROR - PROCESS | 1919 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 18:03:44 INFO - TEST-INFO | 1919: exit 0 18:03:44 INFO - Browser initialized. 18:03:44 INFO - Running cycle 1/1 for kraken test... 18:03:44 INFO - TEST-INFO | started process 1921 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpAzPejo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:03:47 INFO - PROCESS | 1921 | 2017-03-03 18:03:47.504 plugin-container[1922:14533] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 18:03:47 INFO - PROCESS | 1921 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:03:47 INFO - PROCESS | 1921 | 2017-03-03 18:03:47.505 plugin-container[1922:14533] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b53, name = 'com.apple.CFPasteboardClient' 18:03:47 INFO - PROCESS | 1921 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:03:47 INFO - PROCESS | 1921 | 2017-03-03 18:03:47.505 plugin-container[1922:14533] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:03:57 INFO - PROCESS | 1921 | RSS: Main: 218472448 18:03:57 INFO - PROCESS | 1921 | 18:04:00 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:49301/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49301/tests/kraken/driver.html?testName=audio-beat-detection) 18:04:01 INFO - PROCESS | 1921 | RSS: Main: 232775680 18:04:01 INFO - PROCESS | 1921 | 18:04:03 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:49301/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49301/tests/kraken/driver.html?testName=audio-dft) 18:04:04 INFO - PROCESS | 1921 | RSS: Main: 241991680 18:04:04 INFO - PROCESS | 1921 | 18:04:07 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:49301/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49301/tests/kraken/driver.html?testName=audio-fft) 18:04:08 INFO - PROCESS | 1921 | RSS: Main: 244940800 18:04:08 INFO - PROCESS | 1921 | 18:04:10 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:49301/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49301/tests/kraken/driver.html?testName=audio-oscillator) 18:04:10 INFO - PROCESS | 1921 | RSS: Main: 246165504 18:04:10 INFO - PROCESS | 1921 | 18:04:12 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:49301/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49301/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:04:13 INFO - PROCESS | 1921 | RSS: Main: 246185984 18:04:13 INFO - PROCESS | 1921 | 18:04:16 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:49301/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49301/tests/kraken/driver.html?testName=imaging-darkroom) 18:04:17 INFO - PROCESS | 1921 | RSS: Main: 250114048 18:04:17 INFO - PROCESS | 1921 | 18:04:20 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:49301/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49301/tests/kraken/driver.html?testName=imaging-desaturate) 18:04:21 INFO - PROCESS | 1921 | RSS: Main: 249151488 18:04:21 INFO - PROCESS | 1921 | 18:04:23 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:49301/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49301/tests/kraken/driver.html?testName=json-parse-financial) 18:04:24 INFO - PROCESS | 1921 | RSS: Main: 249196544 18:04:24 INFO - PROCESS | 1921 | 18:04:26 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:49301/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49301/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:04:26 INFO - PROCESS | 1921 | RSS: Main: 248733696 18:04:26 INFO - PROCESS | 1921 | 18:04:28 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:49301/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49301/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:04:29 INFO - PROCESS | 1921 | RSS: Main: 248786944 18:04:29 INFO - PROCESS | 1921 | 18:04:31 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:49301/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49301/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:04:32 INFO - PROCESS | 1921 | RSS: Main: 248803328 18:04:32 INFO - PROCESS | 1921 | 18:04:35 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:49301/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49301/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:04:36 INFO - PROCESS | 1921 | RSS: Main: 249180160 18:04:36 INFO - PROCESS | 1921 | 18:04:39 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:49301/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49301/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:04:39 INFO - PROCESS | 1921 | RSS: Main: 248909824 18:04:39 INFO - PROCESS | 1921 | 18:04:41 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:49301/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49301/tests/kraken/driver.html?testName=ai-astar) 18:04:41 INFO - PROCESS | 1921 | RSS: Main: 250982400 18:04:41 INFO - PROCESS | 1921 | 18:04:41 INFO - PROCESS | 1921 | __start_tp_report 18:04:41 INFO - PROCESS | 1921 | _x_x_mozilla_page_load 18:04:41 INFO - PROCESS | 1921 | _x_x_mozilla_page_load_details 18:04:41 INFO - PROCESS | 1921 | |i|pagename|runs| 18:04:41 INFO - PROCESS | 1921 | |0;ai-astar;103;122;117;123;120;119;119;132;174;123 18:04:41 INFO - PROCESS | 1921 | |1;audio-beat-detection;149;111;116;143;112;115;114;115;132;112 18:04:41 INFO - PROCESS | 1921 | |2;audio-dft;210;198;196;205;199;198;195;197;202;196 18:04:41 INFO - PROCESS | 1921 | |3;audio-fft;106;79;84;83;59;57;59;59;71;58 18:04:41 INFO - PROCESS | 1921 | |4;audio-oscillator;86;71;86;96;99;83;82;70;69;82 18:04:41 INFO - PROCESS | 1921 | |5;imaging-gaussian-blur;107;104;88;87;89;121;111;84;135;74 18:04:41 INFO - PROCESS | 1921 | |6;imaging-darkroom;103;96;126;120;138;130;91;152;153;112 18:04:41 INFO - PROCESS | 1921 | |7;imaging-desaturate;93;93;76;146;150;93;97;93;93;95 18:04:41 INFO - PROCESS | 1921 | |8;json-parse-financial;59;61;59;62;64;64;63;64;64;64 18:04:41 INFO - PROCESS | 1921 | |9;json-stringify-tinderbox;89;98;105;94;79;70;69;71;87;66 18:04:41 INFO - PROCESS | 1921 | |10;stanford-crypto-aes;88;94;104;79;87;92;88;98;87;88 18:04:41 INFO - PROCESS | 1921 | |11;stanford-crypto-ccm;139;142;151;163;147;148;152;154;208;142 18:04:41 INFO - PROCESS | 1921 | |12;stanford-crypto-pbkdf2;170;171;170;171;175;176;231;168;149;225 18:04:41 INFO - PROCESS | 1921 | |13;stanford-crypto-sha256-iterative;65;69;67;68;71;85;86;88;87;88 18:04:41 INFO - PROCESS | 1921 | __end_tp_report 18:04:41 INFO - PROCESS | 1921 | __start_cc_report 18:04:41 INFO - PROCESS | 1921 | _x_x_mozilla_cycle_collect,979 18:04:41 INFO - PROCESS | 1921 | __end_cc_report 18:04:41 INFO - PROCESS | 1921 | __startTimestamp1488593081967__endTimestamp 18:04:41 INFO - PROCESS | 1921 | 18:04:41 INFO - PROCESS | 1921 | ------- Summary: start ------- 18:04:41 INFO - PROCESS | 1921 | Number of tests: 14 18:04:41 INFO - PROCESS | 1921 | 18:04:41 INFO - PROCESS | 1921 | [#0] ai-astar Cycles:10 Average:125.20 Median:122.50 stddev:18.59 (15.2%) stddev-sans-first:17.90 18:04:41 INFO - PROCESS | 1921 | Values: 103.0 122.0 117.0 123.0 120.0 119.0 119.0 132.0 174.0 123.0 18:04:41 INFO - PROCESS | 1921 | 18:04:41 INFO - PROCESS | 1921 | [#1] audio-beat-detection Cycles:10 Average:121.90 Median:115.50 stddev:14.10 (12.2%) stddev-sans-first:11.03 18:04:41 INFO - PROCESS | 1921 | Values: 149.0 111.0 116.0 143.0 112.0 115.0 114.0 115.0 132.0 112.0 18:04:41 INFO - PROCESS | 1921 | 18:04:41 INFO - PROCESS | 1921 | [#2] audio-dft Cycles:10 Average:199.60 Median:198.50 stddev:4.74 (2.4%) stddev-sans-first:3.21 18:04:41 INFO - PROCESS | 1921 | Values: 210.0 198.0 196.0 205.0 199.0 198.0 195.0 197.0 202.0 196.0 18:04:41 INFO - PROCESS | 1921 | 18:04:41 INFO - PROCESS | 1921 | [#3] audio-fft Cycles:10 Average:71.50 Median:65.00 stddev:16.32 (25.1%) stddev-sans-first:11.59 18:04:41 INFO - PROCESS | 1921 | Values: 106.0 79.0 84.0 83.0 59.0 57.0 59.0 59.0 71.0 58.0 18:04:41 INFO - PROCESS | 1921 | 18:04:41 INFO - PROCESS | 1921 | [#4] audio-oscillator Cycles:10 Average:82.40 Median:84.50 stddev:10.28 (12.2%) stddev-sans-first:10.82 18:04:41 INFO - PROCESS | 1921 | Values: 86.0 71.0 86.0 96.0 99.0 83.0 82.0 70.0 69.0 82.0 18:04:41 INFO - PROCESS | 1921 | 18:04:41 INFO - PROCESS | 1921 | [#5] imaging-gaussian-blur Cycles:10 Average:100.00 Median:79.00 stddev:18.91 (23.9%) stddev-sans-first:19.89 18:04:41 INFO - PROCESS | 1921 | Values: 107.0 104.0 88.0 87.0 89.0 121.0 111.0 84.0 135.0 74.0 18:04:41 INFO - PROCESS | 1921 | 18:04:41 INFO - PROCESS | 1921 | [#6] imaging-darkroom Cycles:10 Average:122.10 Median:145.00 stddev:21.86 (15.1%) stddev-sans-first:22.06 18:04:41 INFO - PROCESS | 1921 | Values: 103.0 96.0 126.0 120.0 138.0 130.0 91.0 152.0 153.0 112.0 18:04:41 INFO - PROCESS | 1921 | 18:04:41 INFO - PROCESS | 1921 | [#7] imaging-desaturate Cycles:10 Average:102.90 Median:93.00 stddev:24.47 (26.3%) stddev-sans-first:25.69 18:04:41 INFO - PROCESS | 1921 | Values: 93.0 93.0 76.0 146.0 150.0 93.0 97.0 93.0 93.0 95.0 18:04:41 INFO - PROCESS | 1921 | 18:04:41 INFO - PROCESS | 1921 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:64.00 stddev:2.07 (3.2%) stddev-sans-first:1.79 18:04:41 INFO - PROCESS | 1921 | Values: 59.0 61.0 59.0 62.0 64.0 64.0 63.0 64.0 64.0 64.0 18:04:41 INFO - PROCESS | 1921 | 18:04:41 INFO - PROCESS | 1921 | [#9] json-stringify-tinderbox Cycles:10 Average:82.80 Median:83.00 stddev:13.73 (16.5%) stddev-sans-first:14.37 18:04:41 INFO - PROCESS | 1921 | Values: 89.0 98.0 105.0 94.0 79.0 70.0 69.0 71.0 87.0 66.0 18:04:41 INFO - PROCESS | 1921 | 18:04:41 INFO - PROCESS | 1921 | [#10] stanford-crypto-aes Cycles:10 Average:90.50 Median:88.00 stddev:6.90 (7.8%) stddev-sans-first:7.26 18:04:41 INFO - PROCESS | 1921 | Values: 88.0 94.0 104.0 79.0 87.0 92.0 88.0 98.0 87.0 88.0 18:04:41 INFO - PROCESS | 1921 | 18:04:41 INFO - PROCESS | 1921 | [#11] stanford-crypto-ccm Cycles:10 Average:154.60 Median:151.50 stddev:20.01 (13.2%) stddev-sans-first:20.41 18:04:41 INFO - PROCESS | 1921 | Values: 139.0 142.0 151.0 163.0 147.0 148.0 152.0 154.0 208.0 142.0 18:04:41 INFO - PROCESS | 1921 | 18:04:41 INFO - PROCESS | 1921 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.60 Median:173.00 stddev:26.10 (15.1%) stddev-sans-first:27.40 18:04:41 INFO - PROCESS | 1921 | Values: 170.0 171.0 170.0 171.0 175.0 176.0 231.0 168.0 149.0 225.0 18:04:41 INFO - PROCESS | 1921 | 18:04:41 INFO - PROCESS | 1921 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.40 Median:85.50 stddev:10.06 (11.8%) stddev-sans-first:9.61 18:04:41 INFO - PROCESS | 1921 | Values: 65.0 69.0 67.0 68.0 71.0 85.0 86.0 88.0 87.0 88.0 18:04:41 INFO - PROCESS | 1921 | -------- Summary: end -------- 18:04:41 INFO - PROCESS | 1921 | 18:04:42 INFO - TEST-INFO | 1921: exit 0 18:04:42 INFO - TEST-OK | kraken | took 61763ms 18:04:42 INFO - SUITE-END | took 1177s 18:04:43 INFO - Completed test suite (00:19:37) 18:04:43 INFO - javascript benchmark 18:04:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7284.517465166327, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3375.932481350373, 3377.273886114486, 3379.5775528058994, 3417.4361230396994, 3426.4175090234658, 4975.6019518438525, 5429.348478182624, 5686.744096515651, 5716.971415142923, 5813.82558523245, 5710.885782284352, 5802.622829516078, 5821.8835623287505, 5835.766569337232, 5862.149988251701, 4596.471405788344, 5224.399194092671, 5260.92108618371, 5271.762770675329, 5324.840254792362, 5250.9474905250845, 5353.839384818461, 5361.892762144755, 5364.517193452589, 5387.488188622075, 5176.663516871429, 5198.662086964373, 5227.947720522803, 5295.973520132413, 5302.0, 5036.571891389236, 5040.193569028937, 5073.670211436245, 5110.770015349281, 5157.30376399185, 5044.0, 5045.5459008689395, 5046.44489106198, 5074.467180945984, 5141.562967147797, 5318.813841515528, 5492.533134683556, 5492.697901615409, 5534.889302213933, 5608.4111168327145, 6128.38716128388, 6218.347073557302, 6229.6573688447115, 6270.372962703739, 6323.683815809237, 6252.0, 6258.749650013994, 6260.843478913018, 6266.749330026793, 6284.277308109535, 5895.322037965646, 5923.763049477972, 5932.406759324076, 5933.376995415462, 5979.282486101695, 4565.0, 6170.382961703884, 6196.194494715658, 6207.379262073757, 6249.843753906189, 6138.355472675394, 6203.410675985774, 6204.658743769136, 6220.315765265817, 6235.095911092866, 6080.635161890213, 6233.940230160883, 6243.687815609202, 6259.0, 6277.340879207709, 5005.674631148963, 5146.408163061221, 6131.070842498441, 6179.227596550431, 6237.812865614039, 6231.034189700604, 6258.530610204253, 6271.529635277281, 6290.937090629035, 6298.275698294755, 5040.218766091189, 5046.596272298208, 5049.873753156127, 5062.7215503146945, 5064.0, 4389.034412429261, 4405.537418571068, 4429.82280708768, 4502.234620114588, 4503.301988191835, 5846.561507886926, 5851.648901065864, 5922.230110085661, 5955.702214889238, 5970.31341395745, 5225.712585807741, 5872.618279811799, 6260.499160067184, 6274.749010039639, 6304.8423789404715, 5718.342390625048, 5762.423757624204, 5837.474627283565, 5845.0, 5868.501177399883, 5470.316210473691, 5471.069918113851, 5472.26124473199, 5486.451354864482, 5498.1752737088955, 5454.209139674725, 6463.159789227464, 6466.64433456155, 6485.448736857231, 6497.5126865484335, 6131.621347939075, 6161.907571386522, 6169.784057557964, 6178.1659475971965, 6233.501319894488, 6235.501159907106, 6421.967890160519, 6451.2903580607035, 6455.9347707629595, 6480.611163330215, 6195.876082478415, 6211.16149319836, 6235.376462353728, 6238.0, 6267.592606480564, 6148.708771158107, 6176.9073463897175, 6276.843078923063, 6289.182406287154, 6391.041343798467, 6106.6336019838955, 6111.022236442148, 6129.172561704113, 6144.078388241799, 6202.193714817045, 6160.0, 6175.84560385994, 6178.598391104564, 6181.134641150153, 6186.133941248138, 4912.312276281395, 5861.7655293787775, 6012.7294271757, 6028.698565071817, 6046.90929636047, 5069.417017043087, 6014.458698717136, 6108.0688921796145, 6133.53998450127, 6195.287541932736, 6067.635941843503, 6069.808775135277, 6075.301340345917, 6076.058210977306, 6114.877702446015], "value": 5684.98663332325, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.4079105073912, 499.47908618257424, 501.8494451664501, 512.3595505617977, 526.9578433725301, 39530.011749706275, 41942.79028604856, 42131.78934105325, 42171.57828421715, 42336.57663423365, 43412.56587434125, 43830.12339753203, 43842.342364864555, 43967.56032439675, 43980.3402948956, 8469.407141500098, 8975.012748597665, 9180.449173049605, 9202.723918282461, 9216.124468175512, 8518.531480768555, 11211.327320360804, 11474.426278686075, 11483.770324593503, 11663.475143618514, 11426.0, 11516.827247591293, 11520.0, 11531.019863311587, 11537.596184133557, 11471.541138354456, 11534.423278836024, 11544.653660390202, 11548.249363791327, 11556.826647600292, 11303.717407064807, 11317.320960742381, 11353.432328383547, 11382.373969431677, 11395.943020284929, 40869.0, 40968.38547421791, 41098.38352424716, 41163.58836411627, 41189.38215926763, 3919.529656441217, 3943.112799620091, 4039.0, 4055.107876267246, 4077.9184416311805, 29498.705012950024, 29990.0, 30330.0, 30513.542296865566, 30578.235544111354, 3111.673274306188, 3168.350488149924, 3236.077717850425, 3271.371769383698, 3347.09628400333, 400584.0, 410217.0, 412665.0, 413122.0, 413399.86600134213, 60551.78896422047, 60919.69540152271, 60996.0, 61031.6948415264, 61152.0, 58416.707916460145, 58584.12123818146, 58590.0, 59048.70475647594, 59086.704566477754, 14172.85827141736, 16263.268152933146, 16777.328906843835, 16794.6641067178, 16818.0, 11565.0, 11890.583829565923, 12602.054845886596, 13019.609411717664, 13073.477060917647, 13431.731365372832, 16396.590085247724, 16404.015759054495, 16429.67140657204, 16496.6700665986, 6201.317855035943, 7284.745033923788, 7285.271472852673, 7315.158756742936, 7356.5218260813945, 868.887044684187, 875.0137188581883, 877.6489404238229, 896.6996056321075, 915.057490784493, 29536.0, 29800.552991705143, 29984.40031199364, 30403.695963040085, 30609.234769130504, 896.4755617963565, 1062.2670357453333, 1093.3221402730358, 1115.3140818396628, 1187.5843454790754, 14641.780258665718, 15108.169050702318, 15374.538763837103, 15568.754499640001, 15777.132257725936, 618319.0, 621133.0, 622867.0, 623870.0, 625400.0, 61199.38800612026, 61290.38709612936, 61560.0, 61603.6919815407, 61607.0, 1423.843377228504, 1461.7734251191082, 1462.4881291547872, 1466.765317549187, 1468.4566710317038, 25913.6112958302, 28355.291117722223, 28810.423791523634, 29271.70728292775, 29978.550321745628, 50544.49455505545, 50930.745346273034, 51037.23444148415, 51306.0, 51335.94656213859, 502503.0, 507742.0, 509309.0, 509666.0, 510228.0, 24647.260582182564, 25316.493670126863, 25384.0, 40779.7961010193, 40983.385249220686, 34760.304793904485, 41638.95902602459, 42818.57181428146, 42968.78515607402, 43514.34728479139, 35401.822990885914, 35795.284094318486, 35801.64198357983, 37200.25599488049, 38015.66945157017, 35571.82214088913, 35838.64161358457, 36729.08177295482, 36992.0, 37040.25919481649, 34371.20019136097, 34441.794537191076, 34766.47850282197, 35341.29317413586, 35414.29171416609, 25379.085422239223, 28428.85785571059, 30253.0, 32402.35195296128, 32705.509417359233, 21101.0, 21791.237306694824, 23644.172453964027, 24152.637710434006, 24288.271351859472], "value": 19861.448054468397, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.5773086201471, 390.38124572552505, 396.47467106084434, 399.63034193371124, 422.80768233581296, 17197.656046879085, 19601.0, 20466.079026443807, 21106.99999999998, 21112.0, 20667.069981850815, 20759.16963321469, 21148.788512114876, 21176.25883094092, 21338.573228535457, 5302.1781623848265, 5900.144479050535, 5937.584369094165, 5947.018741907602, 5967.104934259874, 5638.859028524279, 5761.452661997125, 5777.306723193223, 5869.266341707286, 5871.647701137946, 5727.198192253088, 5782.768689252425, 5788.27646544182, 5788.739506722208, 5798.478136967672, 5022.723750193738, 5660.745266463019, 5708.22938903249, 5757.625754325955, 5804.738786754606, 5143.742812859342, 5162.432132465426, 5169.198774189969, 5172.043172013189, 5182.170852663593, 25753.0, 26222.86888565545, 26527.734722652913, 26711.732882671313, 26723.599146012824, 3042.3154790172034, 3049.1157564306322, 3050.877964881402, 3058.938821223563, 3062.617172853393, 14645.6338591535, 15683.607909802233, 15767.526974190792, 15893.125878076702, 16489.34042638305, 1791.2118667786262, 1791.2745338138075, 1816.30980227514, 1818.0, 1848.5471059590352, 127006.72993270133, 128066.71933280642, 133307.0, 134472.0, 134525.0, 10906.454677266105, 11672.88327116718, 11707.88292117068, 11746.295222286519, 11932.582359617545, 13170.682931706753, 13678.247696376597, 14720.852791472162, 14759.92620036893, 14765.630859228391, 8850.822983540293, 9083.18251357381, 9092.590833412512, 9144.497052662035, 9249.90750092504, 8904.8664270036, 8938.240249578728, 9031.187193152648, 9172.082791720908, 9442.811143777224, 7513.661885215179, 7573.394128469709, 7691.5769632670745, 7693.653785579662, 7702.3453006493955, 1969.4190213886939, 2005.7191993120975, 2016.2136766661015, 2020.6160829442358, 2028.3103744726568, 833.8957630296213, 939.7689027374025, 1017.3387298256192, 1035.30634474902, 1049.506731836036, 20663.690044649342, 22091.558168836535, 22961.655575166387, 22989.425264368525, 23014.53970920572, 908.5366463103733, 956.6986399284203, 981.4749109226673, 987.4272921705393, 1016.1972042086817, 8328.625211865481, 10591.57633694659, 12014.038876889828, 12188.14682972201, 12379.93810030944, 414407.35032247496, 415618.0, 417028.0, 809309.0, 813366.0, 157426.21286893493, 159881.0, 164429.3557064438, 167020.0, 169449.0, 1045.2996492350144, 1047.9109275711498, 1058.3755584205355, 1071.0467683761303, 1071.3678929431674, 19154.329598463988, 20136.4011091963, 20250.291239806535, 20320.59358812845, 20323.491912702302, 48222.67168251147, 60131.39868601258, 62649.37350626435, 62675.37324626695, 64547.0, 80914.59542702249, 89088.0, 95067.0, 98979.0, 100095.0, 8080.474769139987, 8286.627101780314, 8613.09562495929, 8755.868661969947, 8761.0, 7685.961570192113, 10467.94766026165, 10486.79026419452, 12432.0, 13516.93241533786, 11259.268147570381, 11476.0, 11540.826887596524, 11720.70698232551, 11868.76262474763, 9949.751256218653, 9992.450415226942, 11061.225714199929, 11362.318260904372, 11448.484818183368, 11529.942350288195, 11676.416179191176, 11708.88291117078, 11974.58088966882, 12059.15585908978, 8439.493630382196, 8474.830503390021, 8493.10822363643, 8652.351073669373, 8742.038375778786, 9290.814183716153, 9425.858612120961, 10890.019898209199, 11410.973012428922, 11878.0], "value": 10179.356199406653, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.3558898495673, 1442.516756886443, 1443.076431084106, 1450.2458721464839, 1459.080779109161, 6660.0, 7480.700771969128, 8113.959430202848, 8518.0, 8527.360447966405, 6835.384815366616, 8177.100518942912, 8206.179382061791, 8361.038480574736, 8372.748817535483, 2254.627986382245, 2304.2165663674346, 2305.0318866076204, 2306.7001289832297, 2311.3874823171873, 1898.610784789122, 2050.507878109258, 2285.565742508926, 2316.918907838226, 2318.7217533895955, 1981.7621885373703, 2314.7338056123594, 2317.2005658047947, 2319.2230602748014, 2324.151684635113, 2286.9199578014773, 2289.2903200007886, 2301.9654705179437, 2306.400335912658, 2311.6648086027517, 2299.494111295512, 2308.307507747669, 2323.186884590397, 2325.2442956039354, 2332.918347857834, 8422.78943026423, 8465.95767021161, 8473.830523389559, 8488.193621605998, 8495.150484951455, 5042.168042273021, 5206.5314121729225, 5207.297014902978, 5208.947910520922, 5212.661177023481, 3255.3814775192636, 3365.612954510238, 3391.118309239591, 3406.3527929693278, 3435.0, 1157.4964890272759, 1170.3270619393882, 1192.9582464613784, 1215.769003889258, 1216.4769149265812, 10055.145312648434, 10115.786105667294, 10779.137668986463, 10795.406252656101, 10846.078083362923, 4171.895702607399, 4369.082492676574, 4430.933535996963, 4431.246688063037, 4489.640828733759, 8554.743357699279, 8611.354148438892, 8620.956895215484, 8624.051354351017, 8633.22300992901, 4244.959984803681, 4442.267025940683, 4457.531959144243, 5080.26336181259, 5095.974520127375, 3897.5517815451585, 4483.775811209426, 4655.0, 4657.301404789308, 4715.151272770934, 3198.72810811079, 3687.11509237781, 3699.519062521909, 3724.6834019108137, 3824.598417166213, 946.7964387656687, 1086.9347839129518, 1166.381817636637, 1172.0096518441903, 1187.827764974074, 657.710607332772, 781.9609019549114, 808.7654580171802, 835.7826964989025, 836.9455985360933, 5040.31955685985, 5079.780852595424, 5333.839984800462, 5640.464155905182, 5723.513501352349, 883.2757139145839, 921.7142086789025, 948.4214629076396, 985.2413641496008, 993.8544506636415, 3476.774009689362, 3832.2718683450057, 3833.3483307837178, 3859.054531639766, 3922.78424686645, 9267.953660231655, 9816.705498835046, 9922.80154396908, 9946.20430365569, 9955.402675839472, 9697.515124243759, 9886.7033988979, 9888.703338899844, 9903.158231550255, 9928.652497162564, 7663.885041724378, 7865.567393793282, 7870.409719271192, 7883.6058197089915, 7907.130215676271, 5340.786368545215, 5403.83788486346, 5409.296791417248, 5473.452654734654, 5507.906995341745, 9053.0, 9088.863667045132, 9167.266618670357, 9228.35401521887, 9313.627454901729, 8751.91248087511, 9346.20557252641, 9377.578008989476, 9443.433393996382, 9488.620455181715, 6602.372774586406, 6643.435307998681, 6656.534042617164, 6658.1344425224415, 6662.433693136138, 7521.0, 7709.2290770922455, 7765.0681918170185, 7796.376289896682, 7806.843863122592, 5399.433059528693, 5987.970060149672, 6933.514653974174, 7077.433805295667, 7112.0, 6929.376356127973, 6964.65176741171, 7026.367626913602, 7031.753888613874, 7061.646917653994, 6290.937090629218, 6405.93594064072, 6412.839679008062, 6429.678516074271, 6431.517636177399, 4786.545278198566, 4845.1520983828395, 4928.162212423968, 4987.226979818134, 5087.847364579068, 4272.423222864873, 4950.653454258311, 4956.801727930842, 4961.70229786214, 5076.0], "value": 4292.925856330705, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.8914714002372, 340.55387442450376, 349.3135987784004, 361.94027985382405, 371.62465909431484, 4765.901324860617, 5160.380754309488, 5335.279737235472, 5368.597355198361, 5495.0, 4189.7695626740515, 4781.5218478152165, 5228.843134705965, 5334.626576139672, 5366.329208848894, 3455.429854074081, 4223.577642235768, 4223.767692776896, 4252.298370768819, 4258.765767882765, 3773.471713960034, 4161.7306721450095, 4213.220554197468, 4214.936775948363, 4241.2365774160635, 4034.979825100885, 4052.5136983562015, 4059.1180262014004, 4067.3695577185435, 4070.5115386153702, 3562.71498280137, 3701.9074523137, 3903.1850189661945, 4006.8998275043064, 4029.2344454553686, 3229.6608856070243, 3501.8774342897877, 3529.400001999666, 3559.4482855157494, 3567.4292113262013, 4955.677880937727, 5077.49225077493, 5280.6303558750515, 5328.387235467932, 5369.543588794957, 4285.721428107163, 4425.623821975136, 4512.4133862597655, 4647.790849411751, 4664.15765772518, 5074.720890351029, 5104.719240441774, 5696.145578163268, 5717.371089180187, 5722.942770572283, 3453.3438646657055, 3640.4175331947026, 3832.310184166849, 3898.8693278949354, 3909.3940439231965, 5409.594280428983, 5439.945600543983, 5673.609965558423, 5685.857853553653, 5948.583599148062, 3922.2939870823525, 3923.47033150521, 3923.6468717814964, 3935.252302062599, 3969.54350249725, 3269.9509507357407, 3427.9657203428146, 3694.7783133012103, 3716.8141592920247, 4054.2296963576828, 3964.682825373963, 4611.086399144385, 4615.653825962999, 4628.560286772751, 4686.2895043308945, 5736.254286942671, 5772.3938986406665, 5778.093229234342, 5798.217240672455, 5832.591718579743, 1109.6615532262738, 1147.2657499200518, 1204.3015051270243, 1231.5504840733247, 1240.2434514945876, 768.4121646940096, 837.3552364679163, 872.3718922375879, 874.8162885793927, 882.2544949517647, 4444.6666500012625, 5127.6154288428515, 5166.011085732021, 5172.043172013189, 5179.611529135254, 4723.834665786681, 5186.844394668091, 5305.867353316198, 5345.705986170798, 5689.971550142222, 4747.009384088003, 4807.9422527044, 4904.705717656952, 4918.803247870045, 5141.948580514222, 2457.5453541094953, 2734.5898115282866, 2922.517784565523, 2935.722960512184, 2939.955900661492, 5133.25567792668, 5502.58730595207, 5566.805161819317, 5701.686407247641, 5773.3072031356505, 5190.714510701948, 5621.269234999424, 5712.742926568314, 5734.132933533233, 5748.310202775694, 5618.353889302701, 5723.627964182315, 5778.6532808030815, 5809.564282678816, 5817.38917413674, 4996.900681849987, 5025.321581586585, 5105.28526006352, 5134.741988212912, 5597.524210442158, 4785.234362501983, 5320.441353657965, 5421.891562168814, 5531.861703457445, 5561.610687251854, 5080.364954380702, 5512.6968016759465, 5643.576731745054, 5646.2942132233475, 5736.479832844216, 3652.9634703653687, 3686.262747450467, 3726.2425804903633, 3726.7763934164036, 3750.8499660014386, 5561.330561330503, 5621.184928185308, 5623.634463759842, 5630.0, 5639.349505732299, 4641.814327426865, 4890.608751299958, 4909.239067944474, 5201.089809283436, 5477.685355514727, 4804.534616941726, 5665.773369065191, 5669.858253543694, 5679.545636349165, 5703.372629010722, 4639.262834927409, 5286.3392075990505, 5424.294841670558, 5563.666180029049, 5613.550915926798, 4835.8065677372515, 5049.419316778471, 5143.948560514347, 5375.489328513785, 5694.743736531949, 4626.285216668486, 5579.8884022320135, 5597.096987024432, 5605.411431799603, 5621.409751975983], "value": 4046.2428329942077, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.6497068980165, 719.3921136639541, 746.3767753925472, 752.525908677533, 809.5833935701929, 14596.416143354267, 14891.47879824205, 15193.772093418607, 15207.46773862915, 15483.922580387096, 13859.0, 13982.300884955737, 14024.368903399347, 14176.929115354435, 14211.005229633929, 834.2158371131147, 836.188896770132, 840.5251033166272, 842.4145219072747, 846.0101681033206, 667.4293479075393, 683.8187880211748, 824.5464994253167, 837.7068026190815, 846.7332790171076, 878.3982971664399, 888.4935586715575, 888.5868071346822, 888.7378223424106, 890.0, 874.2263097158997, 882.6557642519423, 884.6505630276005, 884.9115088491163, 885.9468431894107, 600.9369016253318, 603.8762053778964, 642.6915080761214, 655.2661019657966, 659.8449364399362, 14466.987310888242, 14474.782878256834, 14484.42062317506, 14604.196769177692, 15265.694686106215, 13923.164610123426, 14292.785608215885, 14339.42642294307, 14366.13803171813, 14383.856161438356, 11415.372154531497, 11450.828237576443, 11470.254433461798, 11521.711957201052, 11766.764664706743, 3550.431930891045, 3561.8397172127316, 3665.9083522911874, 3704.0369503928905, 3886.630770076838, 94728.0, 105602.0, 106625.0, 108067.0, 108778.45610771896, 10393.896061039293, 10661.147108231324, 10765.977232162932, 10796.686551355413, 10798.67603971882, 21920.0, 22484.55030899373, 22705.318840434815, 22847.428814279443, 22925.312240632808, 7665.731699390494, 7713.575753333508, 7802.648880800378, 7826.726064587712, 7950.1254861965135, 4223.598758117974, 4224.493060832659, 4300.935485967713, 4315.3095504719095, 4394.626456751212, 3541.13242255649, 3644.6902013328636, 3644.7630903991158, 3655.1593133579427, 3656.4149736042104, 580.5906835680835, 618.4588485075559, 639.4724352409188, 652.655529609007, 728.6793810723265, 633.2274624957545, 633.8098570428853, 658.1167735403319, 704.7181127548919, 714.6891102370486, 9866.703998880044, 10112.728140283843, 10137.087662110445, 10503.107235885036, 10505.107065899332, 636.4558302651259, 668.9598624082571, 695.7059868644318, 703.8486725353971, 713.8964850096706, 4078.490188726409, 4576.832907608605, 4948.579370753526, 4971.955889263223, 4996.325496058058, 96362.51818740861, 102532.48733756284, 106368.0, 109444.0, 111359.77280454345, 91839.54080229689, 92601.07398926059, 94658.0, 96028.0, 97111.54332685015, 83098.75351869727, 84931.0, 85157.0, 85760.14239857647, 86688.0, 9634.855477167708, 9666.516674166403, 9775.022497750453, 9805.656802011896, 9810.411375317504, 46407.535924640324, 49094.75452622714, 50909.74545127251, 51115.72210694614, 51201.0, 63960.68019659872, 65660.6716966412, 68649.31350686429, 69308.6534567344, 74034.0, 12627.368631568568, 12982.480700771863, 13155.342232888508, 13402.93298533501, 13459.798103028266, 14077.436902524194, 14458.98787084894, 14534.563963081124, 14669.266536673336, 14830.110193388431, 13441.731165376834, 13591.864081359456, 13751.449942002208, 13777.655558611115, 13822.239776812372, 12718.364081795688, 13215.537456188988, 13376.264305463294, 13542.59372218835, 13792.724145517233, 12820.423080961566, 13210.0, 13305.201687898758, 13340.86659133435, 13359.933200333937, 10669.946650266698, 10938.289011214245, 10962.890371096506, 11242.0, 11519.712007199887, 9530.270982160684, 9723.513824308615, 10897.782044359226, 11115.83326250123, 11123.944380278046], "value": 7483.228448432766, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1573.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 122.0, 117.0, 123.0, 120.0, 119.0, 119.0, 132.0, 174.0, 123.0], "value": 125.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 111.0, 116.0, 143.0, 112.0, 115.0, 114.0, 115.0, 132.0, 112.0], "value": 121.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [210.0, 198.0, 196.0, 205.0, 199.0, 198.0, 195.0, 197.0, 202.0, 196.0], "value": 199.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 79.0, 84.0, 83.0, 59.0, 57.0, 59.0, 59.0, 71.0, 58.0], "value": 71.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 86.0, 96.0, 99.0, 83.0, 82.0, 70.0, 69.0, 82.0], "value": 82.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 104.0, 88.0, 87.0, 89.0, 121.0, 111.0, 84.0, 135.0, 74.0], "value": 100.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 96.0, 126.0, 120.0, 138.0, 130.0, 91.0, 152.0, 153.0, 112.0], "value": 122.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 76.0, 146.0, 150.0, 93.0, 97.0, 93.0, 93.0, 95.0], "value": 102.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 59.0, 62.0, 64.0, 64.0, 63.0, 64.0, 64.0, 64.0], "value": 62.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 98.0, 105.0, 94.0, 79.0, 70.0, 69.0, 71.0, 87.0, 66.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 94.0, 104.0, 79.0, 87.0, 92.0, 88.0, 98.0, 87.0, 88.0], "value": 90.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 142.0, 151.0, 163.0, 147.0, 148.0, 152.0, 154.0, 208.0, 142.0], "value": 154.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 171.0, 170.0, 171.0, 175.0, 176.0, 231.0, 168.0, 149.0, 225.0], "value": 180.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 67.0, 68.0, 71.0, 85.0, 86.0, 88.0, 87.0, 88.0], "value": 77.4, "unit": "score"}]}]} 18:04:43 INFO - Return code: 0 18:04:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:04:43 ERROR - # TBPL SUCCESS # 18:04:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:04:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:04:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:04:43 INFO - 2017-03-03 18:04:43.297 screenresolution[1926:14927] starting screenresolution argv=screenresolution get 18:04:43 INFO - 2017-03-03 18:04:43.301 screenresolution[1926:14927] Display 0: 1600x1200x32@60 18:04:43 INFO - 2017-03-03 18:04:43.307 screenresolution[1927:14930] starting screenresolution argv=screenresolution list 18:04:43 INFO - Available Modes on Display 0 18:04:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:04:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:04:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:04:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:04:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:04:43 INFO - Intel Iris: 18:04:43 INFO - Chipset Model: Intel Iris 18:04:43 INFO - Type: GPU 18:04:43 INFO - Bus: Built-In 18:04:43 INFO - VRAM (Dynamic, Max): 1536 MB 18:04:43 INFO - Vendor: Intel (0x8086) 18:04:43 INFO - Device ID: 0x0a2e 18:04:43 INFO - Revision ID: 0x0009 18:04:43 INFO - Displays: 18:04:43 INFO - Display: 18:04:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:04:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:04:43 INFO - Display Serial Number: 1600x1200 60 18:04:43 INFO - Main Display: Yes 18:04:43 INFO - Mirror: Off 18:04:43 INFO - Online: Yes 18:04:43 INFO - Rotation: Supported 18:04:43 INFO - Return code: 0 18:04:43 INFO - Running post-action listener: _resource_record_post_action 18:04:43 INFO - [mozharness: 2017-03-04 02:04:43.544804Z] Finished run-tests step (success) 18:04:43 INFO - Running post-run listener: _resource_record_post_run 18:04:43 INFO - Total resource usage - Wall time: 1198s; CPU: 55.0%; Read bytes: 28927488; Write bytes: 512866304; Read time: 163; Write time: 1611 18:04:43 INFO - TinderboxPrint: CPU usage
54.5% 18:04:43 INFO - TinderboxPrint: I/O read bytes / time
28,927,488 / 163 18:04:43 INFO - TinderboxPrint: I/O write bytes / time
512,866,304 / 1,611 18:04:43 INFO - TinderboxPrint: CPU idle
2,179.8 (45.5%) 18:04:43 INFO - TinderboxPrint: CPU system
968.8 (20.2%) 18:04:43 INFO - TinderboxPrint: CPU user
1,645.2 (34.3%) 18:04:43 INFO - TinderboxPrint: Swap in / out
230,395,904 / 0 18:04:43 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208822784; Write bytes: 211334656; Read time: 15950; Write time: 465 18:04:43 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 28833280; Write bytes: 300069376; Read time: 161; Write time: 1136 18:04:44 INFO - Running post-run listener: _upload_blobber_files 18:04:44 INFO - Blob upload gear active. 18:04:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:04:44 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 18:04:44 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:04:44 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:04:44 INFO - (blobuploader) - INFO - Open directory for files ... 18:04:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:04:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:04:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:45 INFO - (blobuploader) - INFO - Done attempting. 18:04:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:04:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:04:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:47 INFO - (blobuploader) - INFO - Done attempting. 18:04:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:04:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:04:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:48 INFO - (blobuploader) - INFO - Done attempting. 18:04:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:04:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:04:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:50 INFO - (blobuploader) - INFO - Done attempting. 18:04:50 INFO - (blobuploader) - INFO - Iteration through files over. 18:04:50 INFO - Return code: 0 18:04:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:04:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:04:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/729104995472c2b19fe1abb695b4fa94743a985f778a546172dedc5ffa21c37fa418fdbacd1c0128191655f7554d54fc50fa666dd36cdfc65820d06f9b6217b7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d7fd2abec01473760ad35cb4a6571693df25db0309b6ef1b6e15985177b3ff51dc9831c21d76fae813ccdbf00b884fe8acc12ba6bc9ded0f1ae54bf25e541b6a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/086c05fc5d5fca46385fd788358cf0c8ae3b534de0cd8c7e6c8fe23067bce7cfd158a007d3c594af8e3dfda2ece59cc83bfc52401853d8d09c517566c80aa86e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73c9392041770ebd82b9614634ac155ce582e1ab8d6a90e3be4e07c8533f5f9a3489f34b3e3cbd994ca4c854ccced1b652cde2f15c89e9ddf4e60ff5d002e235"} 18:04:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:04:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:04:50 INFO - Contents: 18:04:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/729104995472c2b19fe1abb695b4fa94743a985f778a546172dedc5ffa21c37fa418fdbacd1c0128191655f7554d54fc50fa666dd36cdfc65820d06f9b6217b7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d7fd2abec01473760ad35cb4a6571693df25db0309b6ef1b6e15985177b3ff51dc9831c21d76fae813ccdbf00b884fe8acc12ba6bc9ded0f1ae54bf25e541b6a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/086c05fc5d5fca46385fd788358cf0c8ae3b534de0cd8c7e6c8fe23067bce7cfd158a007d3c594af8e3dfda2ece59cc83bfc52401853d8d09c517566c80aa86e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73c9392041770ebd82b9614634ac155ce582e1ab8d6a90e3be4e07c8533f5f9a3489f34b3e3cbd994ca4c854ccced1b652cde2f15c89e9ddf4e60ff5d002e235"} 18:04:50 INFO - Running post-run listener: copy_logs_to_upload_dir 18:04:50 INFO - Copying logs to upload dir... 18:04:50 INFO - mkdir: /builds/slave/test/build/upload/logs 18:04:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.468261 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-03-03 18:04:50.503839) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-03 18:04:50.507359) ========= 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.hKNnASELPO/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.jWEwVuAHSA/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/729104995472c2b19fe1abb695b4fa94743a985f778a546172dedc5ffa21c37fa418fdbacd1c0128191655f7554d54fc50fa666dd36cdfc65820d06f9b6217b7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d7fd2abec01473760ad35cb4a6571693df25db0309b6ef1b6e15985177b3ff51dc9831c21d76fae813ccdbf00b884fe8acc12ba6bc9ded0f1ae54bf25e541b6a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/086c05fc5d5fca46385fd788358cf0c8ae3b534de0cd8c7e6c8fe23067bce7cfd158a007d3c594af8e3dfda2ece59cc83bfc52401853d8d09c517566c80aa86e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73c9392041770ebd82b9614634ac155ce582e1ab8d6a90e3be4e07c8533f5f9a3489f34b3e3cbd994ca4c854ccced1b652cde2f15c89e9ddf4e60ff5d002e235"} build_url:https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011081 build_url: 'https://queue.taskcluster.net/v1/task/UZivvoNIROClM2qGSk4zpQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/729104995472c2b19fe1abb695b4fa94743a985f778a546172dedc5ffa21c37fa418fdbacd1c0128191655f7554d54fc50fa666dd36cdfc65820d06f9b6217b7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d7fd2abec01473760ad35cb4a6571693df25db0309b6ef1b6e15985177b3ff51dc9831c21d76fae813ccdbf00b884fe8acc12ba6bc9ded0f1ae54bf25e541b6a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/086c05fc5d5fca46385fd788358cf0c8ae3b534de0cd8c7e6c8fe23067bce7cfd158a007d3c594af8e3dfda2ece59cc83bfc52401853d8d09c517566c80aa86e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/73c9392041770ebd82b9614634ac155ce582e1ab8d6a90e3be4e07c8533f5f9a3489f34b3e3cbd994ca4c854ccced1b652cde2f15c89e9ddf4e60ff5d002e235"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-03 18:04:50.541894) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 18:04:50.542212) ========= 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.hKNnASELPO/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.jWEwVuAHSA/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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.005356 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 18:04:50.590863) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-03 18:04:50.591177) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-03 18:04:50.591476) ========= ========= Total master_lag: 0.18 =========