builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0228 starttime: 1490097254.61 results: success (0) buildid: 20170321030211 builduid: 05bca5e3d2de4aa48f69ae202c9ec153 revision: 5fe5dcf1c10a4523ba3f0a20295551462c2dae11 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 04:54:14.607558) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 04:54:14.607980) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 04:54:14.608251) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 04:54:14.632717) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 04:54:14.633003) ========= 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.J4tXAvpqk8/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.Htfuq3qo85/Listeners TMPDIR=/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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-21 04:54:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.5M=0.001s 2017-03-21 04:54:14 (19.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121140 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 04:54:14.777309) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 04:54:14.777632) ========= 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.J4tXAvpqk8/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.Htfuq3qo85/Listeners TMPDIR=/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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.020476 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 04:54:14.825833) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-21 04:54:14.826257) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5fe5dcf1c10a4523ba3f0a20295551462c2dae11 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5fe5dcf1c10a4523ba3f0a20295551462c2dae11 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.J4tXAvpqk8/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.Htfuq3qo85/Listeners TMPDIR=/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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-21 04:54:14,948 truncating revision to first 12 chars 2017-03-21 04:54:14,948 Setting DEBUG logging. 2017-03-21 04:54:14,948 attempt 1/10 2017-03-21 04:54:14,948 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5fe5dcf1c10a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-21 04:54:16,605 unpacking tar archive at: mozilla-central-5fe5dcf1c10a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.925483 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-21 04:54:16.775393) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 04:54:16.775766) ========= script_repo_revision: 5fe5dcf1c10a4523ba3f0a20295551462c2dae11 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 04:54:16.776145) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 04:54:16.776421) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 04:54:16.795962) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-21 04:54:16.796239) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.J4tXAvpqk8/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.Htfuq3qo85/Listeners TMPDIR=/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:54:17 INFO - MultiFileLogger online at 20170321 04:54:17 in /builds/slave/test 04:54:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:54:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:54:17 INFO - {'append_to_log': False, 04:54:17 INFO - 'base_work_dir': '/builds/slave/test', 04:54:17 INFO - 'blob_upload_branch': 'Firefox', 04:54:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:54:17 INFO - 'branch': 'Firefox', 04:54:17 INFO - 'buildbot_json_path': 'buildprops.json', 04:54:17 INFO - 'config_files': ('talos/mac_config.py',), 04:54:17 INFO - 'default_actions': ('clobber', 04:54:17 INFO - 'read-buildbot-config', 04:54:17 INFO - 'download-and-extract', 04:54:17 INFO - 'populate-webroot', 04:54:17 INFO - 'create-virtualenv', 04:54:17 INFO - 'install', 04:54:17 INFO - 'run-tests'), 04:54:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:54:17 INFO - 'download_minidump_stackwalk': True, 04:54:17 INFO - 'download_symbols': 'ondemand', 04:54:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:54:17 INFO - 'tooltool.py': '/tools/tooltool.py', 04:54:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:54:17 INFO - '/tools/misc-python/virtualenv.py')}, 04:54:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:54:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:54:17 INFO - 'gecko_profile': False, 04:54:17 INFO - 'gecko_profile_interval': 0, 04:54:17 INFO - 'installer_path': 'installer.exe', 04:54:17 INFO - 'log_level': 'info', 04:54:17 INFO - 'log_name': 'talos', 04:54:17 INFO - 'log_to_console': True, 04:54:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:54:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:54:17 INFO - 'opt_config_files': (), 04:54:17 INFO - 'pip_index': False, 04:54:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:54:17 INFO - 'cmd': ('bash', 04:54:17 INFO - '-c', 04:54:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:54:17 INFO - 'enabled': True, 04:54:17 INFO - 'halt_on_failure': False, 04:54:17 INFO - 'name': 'check_screen_resolution'},), 04:54:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:54:17 INFO - 'cmd': ('bash', 04:54:17 INFO - '-c', 04:54:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:54:17 INFO - 'enabled': True, 04:54:17 INFO - 'halt_on_failure': False, 04:54:17 INFO - 'name': 'check_screen_resolution'},), 04:54:17 INFO - 'run_cmd_checks_enabled': True, 04:54:17 INFO - 'suite': 'dromaeojs-e10s', 04:54:17 INFO - 'system_bits': '32', 04:54:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:54:17 INFO - 'title': 't-yosemite-r7-0228', 04:54:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:54:17 INFO - 'use_talos_json': True, 04:54:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:54:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:54:17 INFO - 'work_dir': 'build'} 04:54:17 INFO - [mozharness: 2017-03-21 11:54:17.037542Z] Running clobber step. 04:54:17 INFO - Running pre-action listener: _resource_record_pre_action 04:54:17 INFO - Running main action method: clobber 04:54:17 INFO - rmtree: /builds/slave/test/build 04:54:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:54:17 INFO - Running post-action listener: _resource_record_post_action 04:54:17 INFO - [mozharness: 2017-03-21 11:54:17.395331Z] Finished clobber step (success) 04:54:17 INFO - [mozharness: 2017-03-21 11:54:17.395469Z] Running read-buildbot-config step. 04:54:17 INFO - Running pre-action listener: _resource_record_pre_action 04:54:17 INFO - Running main action method: read_buildbot_config 04:54:17 INFO - Using buildbot properties: 04:54:17 INFO - { 04:54:17 INFO - "project": "", 04:54:17 INFO - "product": "firefox", 04:54:17 INFO - "script_repo_revision": "production", 04:54:17 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:54:17 INFO - "repository": "", 04:54:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:54:17 INFO - "buildid": "20170321030211", 04:54:17 INFO - "stage_platform": "macosx64", 04:54:17 INFO - "basedir": "/builds/slave/test", 04:54:17 INFO - "nightly_build": "True", 04:54:17 INFO - "buildnumber": 180, 04:54:17 INFO - "slavename": "t-yosemite-r7-0228", 04:54:17 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 04:54:17 INFO - "platform": "yosemite_r7", 04:54:17 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:54:17 INFO - "branch": "mozilla-central", 04:54:17 INFO - "repo_path": "mozilla-central", 04:54:17 INFO - "revision": "5fe5dcf1c10a4523ba3f0a20295551462c2dae11", 04:54:17 INFO - "pgo_build": "False", 04:54:17 INFO - "builduid": "05bca5e3d2de4aa48f69ae202c9ec153", 04:54:17 INFO - "slavebuilddir": "test" 04:54:17 INFO - } 04:54:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/NK_6f-0TTJWIvzumHztJ8w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:54:17 INFO - Running post-action listener: _resource_record_post_action 04:54:17 INFO - [mozharness: 2017-03-21 11:54:17.398886Z] Finished read-buildbot-config step (success) 04:54:17 INFO - [mozharness: 2017-03-21 11:54:17.398992Z] Running download-and-extract step. 04:54:17 INFO - Running pre-action listener: _resource_record_pre_action 04:54:17 INFO - Running main action method: download_and_extract 04:54:17 INFO - mkdir: /builds/slave/test/build/tests 04:54:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:17 INFO - trying https://queue.taskcluster.net/v1/task/NK_6f-0TTJWIvzumHztJ8w/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:54:17 INFO - Downloading https://queue.taskcluster.net/v1/task/NK_6f-0TTJWIvzumHztJ8w/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:54:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NK_6f-0TTJWIvzumHztJ8w/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:54:18 INFO - Downloaded 1325 bytes. 04:54:18 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:54:18 INFO - Using the following test package requirements: 04:54:18 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:54:18 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:54:18 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:54:18 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:54:18 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:54:18 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:54:18 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:54:18 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:54:18 INFO - u'jsshell-mac.zip'], 04:54:18 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:54:18 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:54:18 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:54:18 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:54:18 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:54:18 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:54:18 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:54:18 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:54:18 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:54:18 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:54:18 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:54:18 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:54:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NK_6f-0TTJWIvzumHztJ8w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:54:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NK_6f-0TTJWIvzumHztJ8w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:54:18 INFO - Fetch https://queue.taskcluster.net/v1/task/NK_6f-0TTJWIvzumHztJ8w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:54:20 INFO - Expected file size: 52473920 04:54:20 INFO - Obtained file size: 52473920 04:54:36 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:54:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NK_6f-0TTJWIvzumHztJ8w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:54:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NK_6f-0TTJWIvzumHztJ8w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:54:36 INFO - Fetch https://queue.taskcluster.net/v1/task/NK_6f-0TTJWIvzumHztJ8w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:54:37 INFO - Expected file size: 52473920 04:54:37 INFO - Obtained file size: 52473920 04:54:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NK_6f-0TTJWIvzumHztJ8w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:54:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NK_6f-0TTJWIvzumHztJ8w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:54:53 INFO - Fetch https://queue.taskcluster.net/v1/task/NK_6f-0TTJWIvzumHztJ8w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:54:54 INFO - Expected file size: 14404171 04:54:54 INFO - Obtained file size: 14404171 04:54:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:54 INFO - trying https://queue.taskcluster.net/v1/task/NK_6f-0TTJWIvzumHztJ8w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:54:54 INFO - Downloading https://queue.taskcluster.net/v1/task/NK_6f-0TTJWIvzumHztJ8w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:54:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NK_6f-0TTJWIvzumHztJ8w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:54:56 INFO - Downloaded 75310830 bytes. 04:54:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NK_6f-0TTJWIvzumHztJ8w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:54:56 INFO - mkdir: /builds/slave/test/properties 04:54:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:54:56 INFO - Writing to file /builds/slave/test/properties/build_url 04:54:56 INFO - Contents: 04:54:56 INFO - build_url:https://queue.taskcluster.net/v1/task/NK_6f-0TTJWIvzumHztJ8w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:54:57 INFO - Running post-action listener: _resource_record_post_action 04:54:57 INFO - Running post-action listener: set_extra_try_arguments 04:54:57 INFO - [mozharness: 2017-03-21 11:54:57.838033Z] Finished download-and-extract step (success) 04:54:57 INFO - [mozharness: 2017-03-21 11:54:57.838190Z] Running populate-webroot step. 04:54:57 INFO - Running pre-action listener: _resource_record_pre_action 04:54:57 INFO - Running main action method: populate_webroot 04:54:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:54:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:54:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:54:57 INFO - '--tppagecycles', 04:54:57 INFO - '7'], 04:54:57 INFO - 'tests': ['tsvgm']}}, 04:54:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:54:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:54:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:54:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:54:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:54:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:54:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:54:57 INFO - 'talos_options': ['--disable-e10s'], 04:54:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:54:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:54:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:54:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:54:57 INFO - 'talos_options': ['--disable-e10s'], 04:54:57 INFO - 'tests': ['damp', 'tps']}, 04:54:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:54:57 INFO - 'tests': ['damp', 'tps']}, 04:54:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:54:57 INFO - 'tests': ['dromaeo_dom']}, 04:54:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:54:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:54:57 INFO - 'tests': ['basic_compositor_video']}, 04:54:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:54:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:54:57 INFO - 'tests': ['a11yr', 04:54:57 INFO - 'ts_paint', 04:54:57 INFO - 'tpaint', 04:54:57 INFO - 'sessionrestore', 04:54:57 INFO - 'sessionrestore_no_auto_restore', 04:54:57 INFO - 'tabpaint']}, 04:54:57 INFO - 'other-e10s': {'tests': ['a11yr', 04:54:57 INFO - 'ts_paint', 04:54:57 INFO - 'tpaint', 04:54:57 INFO - 'sessionrestore', 04:54:57 INFO - 'sessionrestore_no_auto_restore', 04:54:57 INFO - 'tabpaint']}, 04:54:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:54:57 INFO - 'ts_paint', 04:54:57 INFO - 'tpaint', 04:54:57 INFO - 'sessionrestore', 04:54:57 INFO - 'sessionrestore_no_auto_restore', 04:54:57 INFO - 'tabpaint']}, 04:54:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:54:57 INFO - 'ts_paint', 04:54:57 INFO - 'tpaint', 04:54:57 INFO - 'sessionrestore', 04:54:57 INFO - 'sessionrestore_no_auto_restore', 04:54:57 INFO - 'tabpaint']}, 04:54:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:54:57 INFO - 'tests': ['a11yr', 04:54:57 INFO - 'ts_paint', 04:54:57 INFO - 'tpaint', 04:54:57 INFO - 'sessionrestore', 04:54:57 INFO - 'sessionrestore_no_auto_restore', 04:54:57 INFO - 'tabpaint']}, 04:54:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:54:57 INFO - 'tests': ['a11yr', 04:54:57 INFO - 'ts_paint', 04:54:57 INFO - 'tpaint', 04:54:57 INFO - 'sessionrestore', 04:54:57 INFO - 'sessionrestore_no_auto_restore', 04:54:57 INFO - 'tabpaint']}, 04:54:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:54:57 INFO - 'tests': ['tsvgx', 04:54:57 INFO - 'tsvgr_opacity', 04:54:57 INFO - 'tart', 04:54:57 INFO - 'tscrollx', 04:54:57 INFO - 'cart', 04:54:57 INFO - 'tsvg_static']}, 04:54:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:54:57 INFO - 'tsvgr_opacity', 04:54:57 INFO - 'tart', 04:54:57 INFO - 'tscrollx', 04:54:57 INFO - 'cart', 04:54:57 INFO - 'tsvg_static']}, 04:54:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:54:57 INFO - 'talos_options': ['--disable-e10s'], 04:54:57 INFO - 'tests': ['tp5o']}, 04:54:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:54:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:54:57 INFO - 'talos_options': ['--disable-e10s', 04:54:57 INFO - '--xperf_path', 04:54:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:54:57 INFO - 'tests': ['tp5n']}, 04:54:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:54:57 INFO - 'talos_options': ['--xperf_path', 04:54:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:54:57 INFO - 'tests': ['tp5n']}}, 04:54:57 INFO - 'talos.zip': {'path': '', 04:54:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:54:57 INFO - Running post-action listener: _resource_record_post_action 04:54:57 INFO - [mozharness: 2017-03-21 11:54:57.856891Z] Finished populate-webroot step (success) 04:54:57 INFO - [mozharness: 2017-03-21 11:54:57.857023Z] Running create-virtualenv step. 04:54:57 INFO - Running pre-action listener: _resource_record_pre_action 04:54:57 INFO - Running main action method: create_virtualenv 04:54:57 INFO - Creating virtualenv /builds/slave/test/build/venv 04:54:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:54:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:54:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:54:57 INFO - Using real prefix '/tools/python27' 04:54:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:54:58 INFO - Installing distribute.............................................................................................................................................................................................done. 04:55:01 INFO - Installing pip.................done. 04:55:01 INFO - Return code: 0 04:55:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:55:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:55:01 INFO - Reading from file tmpfile_stdout 04:55:01 INFO - Output received: 04:55:01 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:55:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:55:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:55:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:55:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a0eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a11768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8428d5c0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ecd30>, '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 0x109713db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097e1be8>, '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.J4tXAvpqk8/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.Htfuq3qo85/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:55:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:55:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:55:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J4tXAvpqk8/Render', 04:55:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:01 INFO - 'HOME': '/Users/cltbld', 04:55:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:01 INFO - 'LOGNAME': 'cltbld', 04:55:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:01 INFO - 'MOZ_NO_REMOTE': '1', 04:55:01 INFO - 'NO_EM_RESTART': '1', 04:55:01 INFO - 'PAGER': '/bin/cat', 04:55:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:01 INFO - 'PWD': '/builds/slave/test', 04:55:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:01 INFO - 'SHELL': '/bin/bash', 04:55:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Htfuq3qo85/Listeners', 04:55:01 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 04:55:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:01 INFO - 'USER': 'cltbld', 04:55:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:01 INFO - 'XPC_FLAGS': '0x0', 04:55:01 INFO - 'XPC_SERVICE_NAME': '0', 04:55:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:55:02 INFO - Cleaning up... 04:55:02 INFO - Return code: 0 04:55:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:02 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 0x109a0eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a11768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8428d5c0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ecd30>, '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 0x109713db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097e1be8>, '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.J4tXAvpqk8/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.Htfuq3qo85/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:55:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:55:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:55:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J4tXAvpqk8/Render', 04:55:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:02 INFO - 'HOME': '/Users/cltbld', 04:55:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:02 INFO - 'LOGNAME': 'cltbld', 04:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:02 INFO - 'MOZ_NO_REMOTE': '1', 04:55:02 INFO - 'NO_EM_RESTART': '1', 04:55:02 INFO - 'PAGER': '/bin/cat', 04:55:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:02 INFO - 'PWD': '/builds/slave/test', 04:55:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:02 INFO - 'SHELL': '/bin/bash', 04:55:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Htfuq3qo85/Listeners', 04:55:02 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 04:55:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:02 INFO - 'USER': 'cltbld', 04:55:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:02 INFO - 'XPC_FLAGS': '0x0', 04:55:02 INFO - 'XPC_SERVICE_NAME': '0', 04:55:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:02 INFO - Downloading/unpacking psutil>=3.1.1 04:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:55:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:55:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:55:05 INFO - Installing collected packages: psutil 04:55:05 INFO - Running setup.py install for psutil 04:55:05 INFO - building 'psutil._psutil_osx' extension 04:55:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:55:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:55:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:55:06 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:55:06 INFO - building 'psutil._psutil_posix' extension 04:55:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:55:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:55:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:55:06 INFO - ^ 04:55:06 INFO - 1 warning generated. 04:55:06 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:55:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:55:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:55:06 INFO - Successfully installed psutil 04:55:06 INFO - Cleaning up... 04:55:06 INFO - Return code: 0 04:55:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:55:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:55:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:06 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 0x109a0eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a11768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8428d5c0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ecd30>, '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 0x109713db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097e1be8>, '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.J4tXAvpqk8/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.Htfuq3qo85/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:55:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:55:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:55:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J4tXAvpqk8/Render', 04:55:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:06 INFO - 'HOME': '/Users/cltbld', 04:55:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:06 INFO - 'LOGNAME': 'cltbld', 04:55:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:06 INFO - 'MOZ_NO_REMOTE': '1', 04:55:06 INFO - 'NO_EM_RESTART': '1', 04:55:06 INFO - 'PAGER': '/bin/cat', 04:55:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:06 INFO - 'PWD': '/builds/slave/test', 04:55:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:06 INFO - 'SHELL': '/bin/bash', 04:55:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Htfuq3qo85/Listeners', 04:55:06 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 04:55:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:06 INFO - 'USER': 'cltbld', 04:55:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:06 INFO - 'XPC_FLAGS': '0x0', 04:55:06 INFO - 'XPC_SERVICE_NAME': '0', 04:55:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:55:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:55:09 INFO - Installing collected packages: mozsystemmonitor 04:55:09 INFO - Running setup.py install for mozsystemmonitor 04:55:09 INFO - Successfully installed mozsystemmonitor 04:55:09 INFO - Cleaning up... 04:55:10 INFO - Return code: 0 04:55:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:55:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:55:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:10 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 0x109a0eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a11768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8428d5c0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ecd30>, '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 0x109713db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097e1be8>, '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.J4tXAvpqk8/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.Htfuq3qo85/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:55:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:55:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:55:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J4tXAvpqk8/Render', 04:55:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:10 INFO - 'HOME': '/Users/cltbld', 04:55:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:10 INFO - 'LOGNAME': 'cltbld', 04:55:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:10 INFO - 'MOZ_NO_REMOTE': '1', 04:55:10 INFO - 'NO_EM_RESTART': '1', 04:55:10 INFO - 'PAGER': '/bin/cat', 04:55:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:10 INFO - 'PWD': '/builds/slave/test', 04:55:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:10 INFO - 'SHELL': '/bin/bash', 04:55:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Htfuq3qo85/Listeners', 04:55:10 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 04:55:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:10 INFO - 'USER': 'cltbld', 04:55:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:10 INFO - 'XPC_FLAGS': '0x0', 04:55:10 INFO - 'XPC_SERVICE_NAME': '0', 04:55:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:10 INFO - Downloading/unpacking jsonschema==2.5.1 04:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:55:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:13 INFO - Downloading functools32-3.2.3-2.tar.gz 04:55:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:55:13 INFO - warning: no files found matching '*.txt' 04:55:13 INFO - no previously-included directories found matching 'build' 04:55:13 INFO - no previously-included directories found matching 'dist' 04:55:13 INFO - no previously-included directories found matching '.git*' 04:55:13 INFO - Installing collected packages: jsonschema, functools32 04:55:13 INFO - Running setup.py install for functools32 04:55:13 INFO - warning: no files found matching '*.txt' 04:55:13 INFO - no previously-included directories found matching 'build' 04:55:13 INFO - no previously-included directories found matching 'dist' 04:55:13 INFO - no previously-included directories found matching '.git*' 04:55:13 INFO - Successfully installed jsonschema functools32 04:55:13 INFO - Cleaning up... 04:55:13 INFO - Return code: 0 04:55:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:55:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:14 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 0x109a0eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a11768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8428d5c0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ecd30>, '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 0x109713db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097e1be8>, '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.J4tXAvpqk8/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.Htfuq3qo85/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:55:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:55:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:55:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J4tXAvpqk8/Render', 04:55:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:14 INFO - 'HOME': '/Users/cltbld', 04:55:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:14 INFO - 'LOGNAME': 'cltbld', 04:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:14 INFO - 'MOZ_NO_REMOTE': '1', 04:55:14 INFO - 'NO_EM_RESTART': '1', 04:55:14 INFO - 'PAGER': '/bin/cat', 04:55:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:14 INFO - 'PWD': '/builds/slave/test', 04:55:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:14 INFO - 'SHELL': '/bin/bash', 04:55:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Htfuq3qo85/Listeners', 04:55:14 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 04:55:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:14 INFO - 'USER': 'cltbld', 04:55:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:14 INFO - 'XPC_FLAGS': '0x0', 04:55:14 INFO - 'XPC_SERVICE_NAME': '0', 04:55:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:55:14 INFO - Cleaning up... 04:55:14 INFO - Return code: 0 04:55:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:55:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:55:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:15 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 0x109a0eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a11768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8428d5c0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ecd30>, '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 0x109713db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097e1be8>, '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.J4tXAvpqk8/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.Htfuq3qo85/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:55:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:55:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:55:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J4tXAvpqk8/Render', 04:55:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:15 INFO - 'HOME': '/Users/cltbld', 04:55:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:15 INFO - 'LOGNAME': 'cltbld', 04:55:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:15 INFO - 'MOZ_NO_REMOTE': '1', 04:55:15 INFO - 'NO_EM_RESTART': '1', 04:55:15 INFO - 'PAGER': '/bin/cat', 04:55:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:15 INFO - 'PWD': '/builds/slave/test', 04:55:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:15 INFO - 'SHELL': '/bin/bash', 04:55:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Htfuq3qo85/Listeners', 04:55:15 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 04:55:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:15 INFO - 'USER': 'cltbld', 04:55:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:15 INFO - 'XPC_FLAGS': '0x0', 04:55:15 INFO - 'XPC_SERVICE_NAME': '0', 04:55:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:15 INFO - Downloading/unpacking blobuploader==1.2.4 04:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:18 INFO - Downloading blobuploader-1.2.4.tar.gz 04:55:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:55:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:55:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:55:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:55:19 INFO - Downloading docopt-0.6.1.tar.gz 04:55:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:55:19 INFO - Installing collected packages: blobuploader, requests, docopt 04:55:19 INFO - Running setup.py install for blobuploader 04:55:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:55:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:55:19 INFO - Running setup.py install for requests 04:55:20 INFO - Running setup.py install for docopt 04:55:20 INFO - Successfully installed blobuploader requests docopt 04:55:20 INFO - Cleaning up... 04:55:20 INFO - Return code: 0 04:55:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:55:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:55:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:20 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 0x109a0eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a11768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8428d5c0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ecd30>, '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 0x109713db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097e1be8>, '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.J4tXAvpqk8/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.Htfuq3qo85/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:55:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:55:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:55:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J4tXAvpqk8/Render', 04:55:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:20 INFO - 'HOME': '/Users/cltbld', 04:55:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:20 INFO - 'LOGNAME': 'cltbld', 04:55:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:20 INFO - 'MOZ_NO_REMOTE': '1', 04:55:20 INFO - 'NO_EM_RESTART': '1', 04:55:20 INFO - 'PAGER': '/bin/cat', 04:55:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:20 INFO - 'PWD': '/builds/slave/test', 04:55:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:20 INFO - 'SHELL': '/bin/bash', 04:55:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Htfuq3qo85/Listeners', 04:55:20 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 04:55:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:20 INFO - 'USER': 'cltbld', 04:55:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:20 INFO - 'XPC_FLAGS': '0x0', 04:55:20 INFO - 'XPC_SERVICE_NAME': '0', 04:55:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:55:20 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-vDRH2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:55:20 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-if6oPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:55:20 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-zJHE1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:55:21 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-2_FkuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:55:21 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-F3qaUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:55:21 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-tXki5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:55:21 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-5JCJ8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:55:21 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-dVrP6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:55:21 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-sxrlNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:55:21 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-22wIiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:55:21 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-_qHJpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:55:21 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-151nbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:55:22 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-2GTsRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:55:22 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-vznvA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:55:22 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-jPFQZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:55:22 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-iz8Hrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:55:22 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-7RXP8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:55:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:55:22 INFO - Running setup.py install for manifestparser 04:55:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:55:22 INFO - Running setup.py install for mozcrash 04:55:22 INFO - Running setup.py install for mozdebug 04:55:22 INFO - Running setup.py install for mozdevice 04:55:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:55:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:55:23 INFO - Running setup.py install for mozfile 04:55:23 INFO - Running setup.py install for mozhttpd 04:55:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:55:23 INFO - Running setup.py install for mozinfo 04:55:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:55:23 INFO - Running setup.py install for mozInstall 04:55:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:55:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:55:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:55:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:55:23 INFO - Running setup.py install for mozleak 04:55:23 INFO - Running setup.py install for mozlog 04:55:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:55:24 INFO - Running setup.py install for moznetwork 04:55:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:55:24 INFO - Running setup.py install for mozprocess 04:55:24 INFO - Running setup.py install for mozprofile 04:55:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:55:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:55:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:55:24 INFO - Running setup.py install for mozrunner 04:55:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:55:24 INFO - Running setup.py install for mozscreenshot 04:55:24 INFO - Running setup.py install for moztest 04:55:24 INFO - Running setup.py install for mozversion 04:55:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:55:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:55:25 INFO - Cleaning up... 04:55:25 INFO - Return code: 0 04:55:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:55:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:55:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:55:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:25 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 0x109a0eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a11768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8428d5c0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ecd30>, '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 0x109713db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097e1be8>, '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.J4tXAvpqk8/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.Htfuq3qo85/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:55:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:55:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:55:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J4tXAvpqk8/Render', 04:55:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:25 INFO - 'HOME': '/Users/cltbld', 04:55:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:25 INFO - 'LOGNAME': 'cltbld', 04:55:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:25 INFO - 'MOZ_NO_REMOTE': '1', 04:55:25 INFO - 'NO_EM_RESTART': '1', 04:55:25 INFO - 'PAGER': '/bin/cat', 04:55:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:25 INFO - 'PWD': '/builds/slave/test', 04:55:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:25 INFO - 'SHELL': '/bin/bash', 04:55:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Htfuq3qo85/Listeners', 04:55:25 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 04:55:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:25 INFO - 'USER': 'cltbld', 04:55:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:25 INFO - 'XPC_FLAGS': '0x0', 04:55:25 INFO - 'XPC_SERVICE_NAME': '0', 04:55:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:55:25 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-DI_DvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:55:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:55:25 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-xZ2h5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:55:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:55:25 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-ToWkHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:55:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:55:25 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-bOBdYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:55:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:55:25 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-nHpYFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:55:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:55:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:55:25 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-tStfHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:55:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:55:26 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-hWjnD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:55:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:55:26 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-uT91tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:55:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:55:26 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-0wjweB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:55:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:55:26 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-ivIYuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:55:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:55:26 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-J11xTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:55:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:55:26 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-q925es-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:55:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:55:26 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-VjJviF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:55:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:55:26 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-Uwbb3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:55:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:55:26 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-V7BYc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:55:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:55:27 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-RWFx9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:55:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:55:27 INFO - Running setup.py (path:/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/pip-amqQT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:55:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:55:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:55:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:55:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:55:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:55:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:55:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:55: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 04:55: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 04:55: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 04:55: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 04:55: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 04:55: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 04:55:29 INFO - Downloading blessings-1.6.tar.gz 04:55:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:55:29 INFO - Installing collected packages: blessings 04:55:29 INFO - Running setup.py install for blessings 04:55:30 INFO - Successfully installed blessings 04:55:30 INFO - Cleaning up... 04:55:30 INFO - Return code: 0 04:55:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:55:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:55:30 INFO - Reading from file tmpfile_stdout 04:55:30 INFO - Current package versions: 04:55:30 INFO - blessings == 1.6 04:55:30 INFO - blobuploader == 1.2.4 04:55:30 INFO - docopt == 0.6.1 04:55:30 INFO - functools32 == 3.2.3-2 04:55:30 INFO - jsonschema == 2.5.1 04:55:30 INFO - manifestparser == 1.1 04:55:30 INFO - mozInstall == 1.12 04:55:30 INFO - mozcrash == 1.0 04:55:30 INFO - mozdebug == 0.1 04:55:30 INFO - mozdevice == 0.49 04:55:30 INFO - mozfile == 1.2 04:55:30 INFO - mozhttpd == 0.7 04:55:30 INFO - mozinfo == 0.9 04:55:30 INFO - mozleak == 0.1 04:55:30 INFO - mozlog == 3.4 04:55:30 INFO - moznetwork == 0.27 04:55:30 INFO - mozprocess == 0.25 04:55:30 INFO - mozprofile == 0.28 04:55:30 INFO - mozrunner == 6.13 04:55:30 INFO - mozscreenshot == 0.1 04:55:30 INFO - mozsystemmonitor == 0.3 04:55:30 INFO - moztest == 0.8 04:55:30 INFO - mozversion == 1.4 04:55:30 INFO - psutil == 3.1.1 04:55:30 INFO - requests == 1.2.3 04:55:30 INFO - wsgiref == 0.1.2 04:55:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:55:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:55:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:30 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 0x109a0eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a11768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8428d5c0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ecd30>, '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 0x109713db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097e1be8>, '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.J4tXAvpqk8/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.Htfuq3qo85/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:55:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:55:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J4tXAvpqk8/Render', 04:55:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:30 INFO - 'HOME': '/Users/cltbld', 04:55:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:30 INFO - 'LOGNAME': 'cltbld', 04:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:30 INFO - 'MOZ_NO_REMOTE': '1', 04:55:30 INFO - 'NO_EM_RESTART': '1', 04:55:30 INFO - 'PAGER': '/bin/cat', 04:55:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:30 INFO - 'PWD': '/builds/slave/test', 04:55:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:30 INFO - 'SHELL': '/bin/bash', 04:55:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Htfuq3qo85/Listeners', 04:55:30 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 04:55:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:30 INFO - 'USER': 'cltbld', 04:55:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:30 INFO - 'XPC_FLAGS': '0x0', 04:55:30 INFO - 'XPC_SERVICE_NAME': '0', 04:55:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:55:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:55:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:55:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:55:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:55:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:55:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:55:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:55:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:55:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:55:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:55:30 INFO - Cleaning up... 04:55:30 INFO - Return code: 0 04:55:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:55:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:55:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:30 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 0x109a0eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a11768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8428d5c0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097ecd30>, '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 0x109713db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097e1be8>, '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.J4tXAvpqk8/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.Htfuq3qo85/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:55:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:55:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J4tXAvpqk8/Render', 04:55:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:30 INFO - 'HOME': '/Users/cltbld', 04:55:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:30 INFO - 'LOGNAME': 'cltbld', 04:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:30 INFO - 'MOZ_NO_REMOTE': '1', 04:55:30 INFO - 'NO_EM_RESTART': '1', 04:55:30 INFO - 'PAGER': '/bin/cat', 04:55:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:30 INFO - 'PWD': '/builds/slave/test', 04:55:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:30 INFO - 'SHELL': '/bin/bash', 04:55:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Htfuq3qo85/Listeners', 04:55:30 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 04:55:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:30 INFO - 'USER': 'cltbld', 04:55:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:30 INFO - 'XPC_FLAGS': '0x0', 04:55:30 INFO - 'XPC_SERVICE_NAME': '0', 04:55:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:55:30 INFO - Cleaning up... 04:55:30 INFO - Return code: 0 04:55:30 INFO - Running post-action listener: _resource_record_post_action 04:55:30 INFO - Running post-action listener: _start_resource_monitoring 04:55:31 INFO - Starting resource monitoring. 04:55:31 INFO - [mozharness: 2017-03-21 11:55:31.006155Z] Finished create-virtualenv step (success) 04:55:31 INFO - [mozharness: 2017-03-21 11:55:31.007101Z] Running install step. 04:55:31 INFO - Running pre-action listener: _resource_record_pre_action 04:55:31 INFO - Running main action method: install 04:55:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:55:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:55:31 INFO - Reading from file tmpfile_stdout 04:55:31 INFO - Detecting whether we're running mozinstall >=1.0... 04:55:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:55:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:55:31 INFO - Reading from file tmpfile_stdout 04:55:31 INFO - Output received: 04:55:31 INFO - Usage: mozinstall [options] installer 04:55:31 INFO - Options: 04:55:31 INFO - -h, --help show this help message and exit 04:55:31 INFO - -d DEST, --destination=DEST 04:55:31 INFO - Directory to install application into. [default: 04:55:31 INFO - "/builds/slave/test"] 04:55:31 INFO - --app=APP Application being installed. [default: firefox] 04:55:31 INFO - mkdir: /builds/slave/test/build/application 04:55:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:55:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:55:51 INFO - Reading from file tmpfile_stdout 04:55:51 INFO - Output received: 04:55:51 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:55:51 INFO - Running post-action listener: _resource_record_post_action 04:55:51 INFO - [mozharness: 2017-03-21 11:55:51.808130Z] Finished install step (success) 04:55:51 INFO - [mozharness: 2017-03-21 11:55:51.808298Z] Running run-tests step. 04:55:51 INFO - Running pre-action listener: _resource_record_pre_action 04:55:51 INFO - Running main action method: run_tests 04:55:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:55:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:55:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:55:51 INFO - 2017-03-21 04:55:51.822 screenresolution[1993:19797] starting screenresolution argv=screenresolution get 04:55:51 INFO - 2017-03-21 04:55:51.825 screenresolution[1993:19797] Display 0: 1600x1200x32@60 04:55:51 INFO - 2017-03-21 04:55:51.831 screenresolution[1994:19799] starting screenresolution argv=screenresolution list 04:55:51 INFO - Available Modes on Display 0 04:55:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:55:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:55:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:55:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:55:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:55:52 INFO - Intel Iris: 04:55:52 INFO - Chipset Model: Intel Iris 04:55:52 INFO - Type: GPU 04:55:52 INFO - Bus: Built-In 04:55:52 INFO - VRAM (Dynamic, Max): 1536 MB 04:55:52 INFO - Vendor: Intel (0x8086) 04:55:52 INFO - Device ID: 0x0a2e 04:55:52 INFO - Revision ID: 0x0009 04:55:52 INFO - Displays: 04:55:52 INFO - Display: 04:55:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:55:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:55:52 INFO - Display Serial Number: 1600x1200 60 04:55:52 INFO - Main Display: Yes 04:55:52 INFO - Mirror: Off 04:55:52 INFO - Online: Yes 04:55:52 INFO - Rotation: Supported 04:55:52 INFO - Return code: 0 04:55:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:55:52 INFO - Python 2.7.3 04:55:52 INFO - Return code: 0 04:55:52 INFO - grabbing minidump binary from tooltool 04:55: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')]} 04:55:52 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 0x1097ecd30>, '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 0x109713db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1097e1be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:55:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:55:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:55:52 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:55:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:55:52 INFO - Return code: 0 04:55:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:55:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:55:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:55:52 INFO - ENV: RUST_BACKTRACE is now 1 04:55:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:55:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:55:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NK_6f-0TTJWIvzumHztJ8w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0228', '--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 04:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NK_6f-0TTJWIvzumHztJ8w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0228 --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 04:55:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.J4tXAvpqk8/Render', 04:55:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:52 INFO - 'HOME': '/Users/cltbld', 04:55:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:52 INFO - 'LOGNAME': 'cltbld', 04:55:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:55:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:52 INFO - 'MOZ_NO_REMOTE': '1', 04:55:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:55:52 INFO - 'NO_EM_RESTART': '1', 04:55:52 INFO - 'PAGER': '/bin/cat', 04:55:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:52 INFO - 'PWD': '/builds/slave/test', 04:55:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:55:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:52 INFO - 'RUST_BACKTRACE': '1', 04:55:52 INFO - 'SHELL': '/bin/bash', 04:55:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Htfuq3qo85/Listeners', 04:55:52 INFO - 'TMPDIR': '/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/', 04:55:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:52 INFO - 'USER': 'cltbld', 04:55:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:52 INFO - 'XPC_FLAGS': '0x0', 04:55:52 INFO - 'XPC_SERVICE_NAME': '0', 04:55:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NK_6f-0TTJWIvzumHztJ8w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0228', '--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 04:55:52 INFO - mozversion application_buildid: 20170321030211 04:55:52 INFO - mozversion application_changeset: 5fe5dcf1c10a4523ba3f0a20295551462c2dae11 04:55:52 INFO - mozversion application_display_name: Nightly 04:55:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:55:52 INFO - mozversion application_name: Firefox 04:55:52 INFO - mozversion application_remotingname: firefox 04:55:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:55:52 INFO - mozversion application_vendor: Mozilla 04:55:52 INFO - mozversion application_version: 55.0a1 04:55:52 INFO - mozversion platform_buildid: 20170321030211 04:55:52 INFO - mozversion platform_changeset: 5fe5dcf1c10a4523ba3f0a20295551462c2dae11 04:55:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:55:52 INFO - mozversion platform_version: 55.0a1 04:55:52 INFO - using testdate: 1490097352 04:55:52 INFO - actual date: 1490097352 04:55:52 INFO - starting webserver on 'localhost:49306' 04:55:52 INFO - SUITE-START | Running 2 tests 04:55:52 INFO - TEST-START | dromaeo_css 04:55:52 INFO - operating with platform_type : mac_ 04:55:52 INFO - Initialising browser for dromaeo_css test... 04:55:52 INFO - TEST-INFO | started process 2004 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/tmpLphmGX/profile http://localhost:49306/getInfo.html) 04:55:55 INFO - PID 2004 | 2017-03-21 04:55:55.700 plugin-container[2008:19980] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b4b, name = 'com.apple.tsm.portname' 04:55:55 INFO - PID 2004 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:55:55 INFO - PID 2004 | 2017-03-21 04:55:55.701 plugin-container[2008:19980] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9213, name = 'com.apple.CFPasteboardClient' 04:55:55 INFO - PID 2004 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:55:55 INFO - PID 2004 | 2017-03-21 04:55:55.701 plugin-container[2008:19980] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:55:55 INFO - PID 2004 | __metrics Screen width/height:1600/1200 04:55:55 INFO - PID 2004 | colorDepth:24 04:55:55 INFO - PID 2004 | Browser inner width/height: 1024/689 04:55:55 INFO - PID 2004 | __metrics 04:55:55 ERROR - PID 2004 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 04:55:56 INFO - TEST-INFO | 2004: exit 0 04:55:56 INFO - Browser initialized. 04:55:56 INFO - Running cycle 1/1 for dromaeo_css test... 04:55:56 INFO - TEST-INFO | started process 2009 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/tmpLphmGX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:55:59 INFO - PID 2009 | 2017-03-21 04:55:59.170 plugin-container[2010:20108] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d4b, name = 'com.apple.tsm.portname' 04:55:59 INFO - PID 2009 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:55:59 INFO - PID 2009 | 2017-03-21 04:55:59.171 plugin-container[2010:20108] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900f, name = 'com.apple.CFPasteboardClient' 04:55:59 INFO - PID 2009 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:55:59 INFO - PID 2009 | 2017-03-21 04:55:59.171 plugin-container[2010:20108] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:56:08 INFO - PID 2009 | RSS: Main: 227495936 04:56:08 INFO - PID 2009 | 04:59:12 INFO - PID 2009 | Cycle 1(1): loaded http://localhost:49306/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49306/tests/dromaeo/cssquery-ext.html) 04:59:14 INFO - PID 2009 | RSS: Main: 250937344 04:59:14 INFO - PID 2009 | 05:00:56 INFO - PID 2009 | ************************* 05:00:56 INFO - PID 2009 | A coding exception was thrown and uncaught in a Task. 05:00:56 INFO - PID 2009 | 05:00:56 ERROR - PID 2009 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:00:56 INFO - PID 2009 | Full stack: 05:00:56 INFO - PID 2009 | ************************* 05:02:16 INFO - PID 2009 | Cycle 1(1): loaded http://localhost:49306/tests/dromaeo/cssquery-ext.html (next: http://localhost:49306/tests/dromaeo/cssquery-jquery.html) 05:02:17 INFO - PID 2009 | RSS: Main: 260177920 05:02:17 INFO - PID 2009 | 05:05:18 INFO - PID 2009 | Cycle 1(1): loaded http://localhost:49306/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49306/tests/dromaeo/cssquery-mootools.html) 05:05:19 INFO - PID 2009 | RSS: Main: 271249408 05:05:19 INFO - PID 2009 | 05:08:21 INFO - PID 2009 | Cycle 1(1): loaded http://localhost:49306/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49306/tests/dromaeo/cssquery-prototype.html) 05:08:22 INFO - PID 2009 | RSS: Main: 266219520 05:08:22 INFO - PID 2009 | 05:11:25 INFO - PID 2009 | Cycle 1(1): loaded http://localhost:49306/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49306/tests/dromaeo/cssquery-yui.html) 05:11:25 INFO - PID 2009 | RSS: Main: 276774912 05:11:25 INFO - PID 2009 | 05:14:28 INFO - PID 2009 | Cycle 1(1): loaded http://localhost:49306/tests/dromaeo/cssquery-yui.html (next: http://localhost:49306/tests/dromaeo/cssquery-dojo.html) 05:14:29 INFO - PID 2009 | RSS: Main: 273715200 05:14:29 INFO - PID 2009 | 05:14:29 INFO - PID 2009 | __start_tp_report 05:14:29 INFO - PID 2009 | _x_x_mozilla_page_load 05:14:29 INFO - PID 2009 | _x_x_mozilla_page_load_details 05:14:29 INFO - PID 2009 | |i|pagename|runs| 05:14:29 INFO - PID 2009 | |0;dojo.html;3190.441672707276;3449.206682463032;3479.165000399905;3506.421440462324;3514.789112653241;5627.986962346781;5950.940490595092;5982.312034116078;6074.5140388768905;6078.848028799277;6003.309619393771;6077.3314935357075;6081.939180608192;6142.785002524913;6179.073139029137;4369.934450983238;5465.316835395575;5466.262054622614;5516.448355164492;5540.612157149001;5370.677759334452;5459.12653975364;5513.228148059275;5517.420670829565;5535.446455354472;5446.128619420873;5495.148252020903;5497.120460726284;5533.391326954032;5534.723263836812;5382.703951282678;5397.298351214356;5409.675419474844;5456.045192091368;5488.121900495901;5347.759350829183;5376.838694839161;5390.811321603765;5391;5392.676439413609;4917.139500587418;5835.941640583582;5906.645601263938;6031.24609423822;6040.275166979946;6335.80992570219;6380.234371875405;6396.744130234785;6463.6768161591735;6464.612123272572;6551.05009773585;6555.93444065558;6560.147180866505;6561.93438065618;6565.474762019027;6176.104464852571;6178.660173690445;6201.782937597208;6204.658743769136;6204.720787564571;5572.3870374258795;6483.935160648428;6520.18497687789;6559.573627714279;6665.233498147775;5465.453454654503;6170.475509581646;6341.143945567382;6413.102165696806;6438.678066096676;6352.174217351715;6443.613383197023;6547.1161393211305;6552.017197420425;6552.737890484327;6399.360063993657;6448.806535803933;6483.902741458882;6509.934900651027;6515.413612774873;5304.734763261821;6287.49700023997;6365.745370185141;6372.872542549123;6381.3937675920715;4490.842820501267;4493.88765280864;5167.379914410295;5200.97399513;5223.5559977402345;4622.214223581999;4622.607078398307;4625.722456652545;4635.490096089427;4690.882727931829;6156.168917196211;6211.440970312694;6253.280872699698;6261.78083767066;6281.089242059876;6040.822039702216;6185.134081228542;6597.439217666552;6616.96691516549;6635.701393437307;5468.644538105011;5936.643801371932;6181.564801911172;6193.718427410477;6281.780137695158;5658.660480371191;5708.743106560215;5777.595568310262;5778.971105144447;5824.912626310524;6693.564918280394;6815.761448349483;6849.075374824534;6878.896816547655;6912.619805910522;6599.868002640016;6607.702653380706;6608.867822643424;6611.834704132435;6617.371349721769;6512.088307637029;6785.728570857111;6789.2192397872905;6845.863082738417;6854;5380.3274590676165;5389.514943654933;6365.077063825626;6466.450351719968;6485.740570377132;6446.871062578628;6604.669766511752;6618.2719900811835;6627.801165965029;6629.138212032405;6177.938220617736;6200.348963358782;6355.428011478989;6371.139896113966;6383.489320854228;6311.337309582428;6320.494360451061;6379.808605741835;6402.551821372459;6404.71178796946;5042.268871013755;5823.126531020381;6252.656103914328;6287.937120628918;6292.182016337847;6168.876622467616;6380.489560835029;6394.4564712;6404.775832845828;6410.391012853772;6170;6182.1345011697495;6200.844978875564;6243.843903902439;6254.906176407267 05:14:29 INFO - PID 2009 | |1;ext.html;663.1445435388349;698.7833771530824;790.5691398187987;796.096430551324;818.4475479051639;38582;39269.803650981776;39282.41076383857;39306.60693393065;39421.40867886984;38344.61655383445;38710.419343709866;38742.612573874256;38779;38897.80551097241;2572.9450925120705;2697.878595463204;2741.451709658066;2892.363679990399;2896.579995900593;2844.075675405491;2872.2962874095874;2885.2498350428937;2889.5810107534394;2891.08930686833;2864.3555200080023;2864.756495697868;2896.160113567063;2896.290408849835;2898.594196812448;2410.240774156135;2876.8417737024456;2885.7691384689383;2887.133859842039;2896.5510345896314;2846.7010963848707;2853.7146285371505;2855.4003659231585;2875.065603678792;2875.8274503529856;34382.6561734382;37946.81026594877;39652;40059.59940400617;40082.99792505211;2827.4486475137355;2839.943201135966;3024.9243768905953;3041.5437684347303;3072.830994295313;22738;28922.855385723145;29188.708112918812;29229.853850730822;29857.850710746523;2799.3281612412875;2810.3255218747354;2810.789190810697;2838.1627419911174;2922.2110030291915;343782;346448;346689.26655366813;347568.52431475866;347618.2619086888;52114.478855211724;52225;52303.47696523062;52370.47629523732;52445.95108097893;53267.46732532702;53719.462805372226;53727;54094.7295263529;54242;14663.560093197008;14980.850191497946;15086.924565377103;15089.773653395208;15093.773593396108;11979.760404791856;12212;12212.938935305267;12232.388380580935;12249;13466.596002119952;14016.859831401556;14027.929860350632;14072.944529160353;14127.50553730635;5851.268591426072;5879.618754404473;5922.230110085661;5922.851928701817;5922.970385148133;947.3842002698301;970.96601618943;980.5734505490135;982.415462799633;1001.6944831826218;24511.22031203934;24522.386940326636;24646.876765616056;24722.381940451272;24724.505509890063;1062.4050531702271;1068.6526878764432;1103.2332528892343;1106.6514048074991;1116.849225354583;11998.520059197534;12555.932745716535;12607.810882836764;12608.369581520887;12616.243025418504;437874;439385;440593;441895;442003.78998104803;53492.73253633707;55027.44972550304;57055.71472142696;57710.71144644334;58077;1447.131720967432;1468.8898332625097;1477.460726834719;1488.679933814235;1489.0693316677077;27894.721052789213;28714.85642571774;29138.7086129136;29598.55602165926;29835.254118647208;38272.808635956644;38548.80725596466;38612.80693596514;38668.6133138665;38703.80648096742;373251;373251;375453;375671;375825;26621.866890665424;32914.83542582272;33122;33216;33218.5017224737;41815.74552763422;42041.57958420377;42116;42209;42291.788541057096;30947.226319342197;30966.84516577493;34557.481637775956;34709.47935780915;35744.10639734028;32697.836510817295;34612.48081278833;34674.65325346714;35614.8219258902;35787.82106089453;33630.663693363735;34539.65460345465;36002.09994750152;36366.63633363633;36429.08927276839;29466.852665736533;31209.84395078101;31657.841710791297;31760.364792703553;31872.681273186972;23456.53086938286;23793.286201413986;23994.640080398458;23996.64005039891;24598 05:14:29 INFO - PID 2009 | |2;jquery.html;343.8212129692561;424.8130822438127;424.87041452357016;433.6249144490016;445.289762828289;21608.459788505275;21749.19389106904;22578.88710556447;22777.86110694467;22989.425264368398;22252.443688907784;22950.08199672011;23042.76957230427;23355.76644233557;23713.051477940906;3733.2720119576693;4143.544210136883;4293.248681480744;4344;4346.5436129206455;4176.68674849386;4251.723637963522;4265.360195970598;4299.978500107511;4314.697971142022;4258.659307255428;4273.87178384649;4286.39990401344;4290.849820256291;4292.61366477017;4172.561881002482;4271.743695378287;4282.871513854605;4287.764172970486;4299.742015479065;3839.9616003839883;3912.197999410114;3912.315344814646;3914.0606254499;3914.941275880864;27177.912883484638;27301.590476142876;27378.452430951467;27450.66669333109;27512.58731119035;1921.8846869187753;1923.1057558235348;2019.5052212207956;2054.311805545144;2060.3097962182687;15909.52271431859;16028.19859007045;16154.596135096599;16334.918325408416;16717.247723852455;1576.7398379267406;1594.744840825474;1597.27324067549;1600.3518574977154;1639.9344026238937;135980;143484.28257858643;144346.55653443543;145107;146598.26700866426;10291;10815.891841081646;10963.342199468058;11915.74884637118;12521.1235213536;15742.291596878167;16200.432984845474;16212.10833404174;16213.675726485404;16246.512604621881;8880.644774208959;9106.95446522763;9138.223251023737;9163.95418022919;9253.352265341497;8704;8761.693340733043;8858.63027647032;9039.005709371964;9046.502442365732;7823.804404889924;8007.239312265326;8018.358531317481;8033.357331413473;8059.63731632078;2123.766385697572;2125.234915430444;2129.98935005324;2133.5626196629655;2306.792388684993;849.9235068843834;894.190757364586;941.924646028316;956.9521523923916;978.1832170137873;18986.430407087533;19508.80491195098;20203;20667.896660516602;20840.374788756362;952.1478276942098;971.6647756523988;978.7863049818175;987.9950600246952;1005.1857995024054;10699.144068474503;10726.946365268279;10904.58240428755;10934.890651093547;10947.233693641529;397689.01155494037;398064;401382;514595.8540414623;667228;114991.70016599789;129689.05466418012;153074;156718.2164089195;160417;1123.3203911633343;1127.0870594818223;1153.7288737146764;1155.884571388614;1159.802833518304;15062.548123556311;17948.641027179645;18405.723914141032;18645;18767.624647506702;53766;54358.45641543692;54429.45570544244;54475;54959;87833;89090.55454722684;89247.55376223077;89416;90595.75233981134;8103.513789172668;8308.584570771558;8336.708215212439;8715.825683486422;9112.453252804853;13929.58211253664;14036.368363423875;14210.857891420954;14274.14355138695;14522.709545809235;11669.299842009166;11823.408829558315;11860.40697965081;11886.465109069939;12042.879571204527;11477.253978491372;11568.305901645928;11597.304161750322;11860.288382697066;12065.155439119177;10238.897611023795;11645.41772911368;11740.471678774305;12146.757064858477;12200.938995304967;8557.657693692183;8584.227419532272;8896.599653015759;8933.687320943736;9001.054889236535;11689.88310116922;11712.88287117118;11936.76126477483;11951.043916486835;12078.879211207775 05:14:29 INFO - PID 2009 | |3;mootools.html;1162.6105254739662;1216.5620376664401;1384.688445099852;1404.6558593144675;1418.5957002254356;10194.388336699803;10596.523156457959;10647.733806654838;10653.467326633676;10763.78472430551;10505.842412363821;10719.678409647704;10723.410212438313;10735.194860385463;10775.946120269407;2408.1330720940446;2452.791512721421;2460.963085553718;2462.113639089935;2469.2839076667747;2379.262428647125;2411.40920474484;2426.6360045993065;2428.5871401861637;2441.0967941861536;2018.8788672679614;2374.7387787343378;2392.509535545209;2415.2150551070886;2416.395901024744;2348.765123487655;2371.1108334374608;2373.9406514837096;2382.309130352196;2389.713234411873;2319.524497478013;2349.4009027698;2414.9879250603635;2418.9758102418928;2424.5393375258645;10594.364338139736;10614.416207108607;10625.043746062815;10645.627403040857;10651.733706657318;5935.169076329317;6061.212042434499;6159.876802463926;6165.660888651122;6169.827732730767;3493.3013397320638;3915.099527108752;3964.028812940819;4031.294523458383;4048.291548978946;1091.4215465803138;1151.4703236511216;1169.029705344562;1232.3345393487507;1240.0265791353834;13147.079704420694;13589.59231223055;14475.42098316066;14636.780448293284;14660.41358345665;5036.521530454601;5139.460356662571;5316.680999140064;5317.962997215506;5323.041852466593;8922.241609463139;10748.140148788234;10824.458777061116;10863;10888.29226100301;6139.723712432862;6148;6162.506999440034;6163.229596300463;6168.0439531872635;4803.5916947059195;5236.345456817898;5537.9169312459535;5714.085746280575;5820.447057529528;4155.3143731284;4164.4586203793315;4167.5832416758685;4200.915981680349;4206.0326124991425;1041.3595638682307;1239.6776838022179;1240.5782034108447;1251.474380760083;1251.8998480121568;738.1916801102784;740.3041141327243;759.7492827366956;771.714465647714;788.8658927982142;5244.108501554745;6021.458068773832;6270.592411493239;6473.482121430275;6527.8694426111215;490.443346801383;521.8564894654;560.3863769172749;567.7133047810829;570.9000924838136;3185.7132858042423;3254.2027203335333;3611.638836116367;3732.458793474985;3758.755680880734;13033.674158145932;13174.407151678197;13698.452061917611;13708.17750934947;13722.970777191751;10742.785144297226;13180.406881690154;13608.251546165056;13609.979251555975;13644.931775341258;9983;10035.197184225244;10147;10147.543360548792;10160.745981350525;5524.226608274925;6097.085437184458;6254.499640028877;6276.403741644536;6364.013577895434;12051.638450846489;12059.638210853689;12105.878941210474;12391.946684531555;12464.75070498603;11816.70458238551;11912.344821034927;12197.207181533173;12233.755324893275;12399.566015189424;8421.663133474838;8609.87085193735;8804.911950880409;8809.603567839335;8851.601677924638;9845.803083938137;9907.900920990698;10059.849102263619;10077.244206684674;10085.34445261085;8313.875291870747;8622.396432249683;8645.654173833227;8782.033976262734;8794.868076978979;8363.540005299767;8417.70538031166;8433;8471.788205294917;8487.108853570533;7555.811104722206;7573.659185336563;7593.5823529704185;7637.88543171864;7651.273129052731;4540.8637740867825;4894.265860120868;5501.477359650827;5564.749586268708;5717.342505611908;5471.425500322409;5578.246936663499;5606.934682410329;5651.124075768263;5768.365479797135 05:14:29 INFO - PID 2009 | |4;prototype.html;379.3494157519853;389.851856294608;395.5411722402013;404.54892794534095;406.4857954687319;4951.55436010759;5679.466544033108;5982.491488223501;6016.639001659903;6042.879142417154;4473.418455600776;4964.677295975768;5650.067738823089;5929.53924121489;5941.851453713659;4491.101779644068;4524.728516289017;4630.351750754897;4636.605888499482;4656.138614356338;4524.5249248828895;4611.815527378901;4644.837430689927;4652.790624421892;4665.813367465297;4266.8293268269235;4270.017895883933;4571.702839315451;4591.196540605398;4652.488226295105;4575.908481830378;4581.496035436099;4588.816447342102;4590.724556526619;4645.535446455361;3595.8741444049333;3907.472491213678;4014.8394064237395;4054.5742697016685;4097.8770636880945;4661.510541393172;5696.8006119785605;5799.507041901444;5820.5634577406445;5828.1549175369755;5400;5404.675719456806;5410.3507579090365;5420.91868621971;5447.782088716446;6158.168647232611;6160.322364539897;6239.968800156015;6264.749410023594;6350.23797144341;4543.182227199103;4548.840790572347;4561.361409402686;4567.314902764579;4568.834947088471;6341.795058938833;6520.380563846427;6548.410643042102;6591;6653.567518111307;4663.48701642819;4677.298405239173;4697.835575754901;4703.17694403478;4730.5032971538185;4805.063012712488;4819.999400497649;4830.9275360869615;4832.840118371566;4851.539103785135;4836.089744550953;4878.341423907727;5219.686818790885;5398.352197736218;5431.429699881534;5081.8475445736685;5835.562332825055;6077.817665470043;6376.840578985562;6549.377809108127;1373.7321222361743;1494.4171773008536;1652.396875140565;1656.345743431362;1677.4967509747028;1087.483445363462;1143.0912424622445;1143.4454289669504;1147;1163.3252713426193;5433.375161856437;5507.292739250845;5804.767809287581;5851.912221316684;5941.524678025748;5914.8817023659285;6165.938340616536;6513.772017979348;6537.967310163419;6547.377999090078;4978.431793984883;5200.739963001834;5873.941260587425;5968.731407086691;5987.191729116601;3056.5262384330463;3310.8546880463655;3426.7258619310396;3427.7943323400677;3432.828358582061;6048.431425459;6359.887019771521;6403.807885763435;6793.660316984131;6924.134483189601;6200.131981522591;6721.630310332978;6774.695138718769;6807.21717002551;6819.522633415613;6530.2816690164045;6868.175818901864;6934.965325173443;6956.234814170336;6960.955856621547;6562.704678289584;6599.901001485077;6622.072909792537;6627.50293727982;6635.23694775107;5918.763249469973;6021.578489505868;6327.620342779448;6495.350464953467;6582.979638156094;6906.482013848881;6910.965445172742;6931.133608298963;6960.582365058112;6967.407770339578;4315.719478233905;4342.676667982614;4350.782460877007;4358.869233922987;4362.7818609070055;5325.334333208349;6291.245050593958;6540.869182616416;6570.507211959218;6589.769358072636;6286.371362863677;6348.269948955929;6383.616982981036;6383.808485745435;6384.489240860627;5433.152728072474;5982.7008649568215;6316.810495685137;6362.936370636419;6376.4261216488885;5183.455737147545;6091.994820854687;6252.124702541557;6268.091126786681;6287.497000240061;4631.93052104212;5448.128299472065;5746.735718142002;6345.873082538231;6402.807915762534;5701.7434215461235;5773.797917072882;6100.420460056288;6126.172966649624;6185.567010309235 05:14:29 INFO - PID 2009 | |5;yui.html;699.3076853914627;730.3937731682704;730.7551970090019;733.644182571453;735.213321745732;14719.632009199775;15707.84292157078;15712.842871571282;16136.677266454664;16142.435014774484;14927.32827022784;15084.622884427894;15091.245437728097;15091.849081509208;15107;773.1379511844309;910.8204874687295;932.067932067932;934.1079269297804;939.8449255872773;927.8654595083709;928.9117533834309;939.7885475767931;941.7598512379368;943.3726571829725;970.8786401699788;987.2052997337141;987.377951890308;989.6288891665625;994.8358520844052;991.9801603967916;996.8504724291414;997.0677416615488;999.6751055906859;1007.7430255284892;726.9563826170447;739.2718172599984;739.3715341959345;740.7703611880335;740.8592367450167;16482.505524834272;16565.503034908972;16866.578335541588;16882.240299186567;17133.828661713473;14658.340374683059;14723.484678036324;14798.260086995715;14812.407503699838;14847.851521484863;11674.416279186007;11705.3562054087;11873.881261187364;11997.160198786089;12233.082518811036;2977.151511819121;3004.173852190643;3016.9698303016908;3085.1670049086847;3121.3352268510152;106497;107411.46294268478;112282;112828;114248.85751142465;10886.183536234814;11231.21381503287;11361.715957100972;11383.54465821358;11431.314121152758;24650.137245196333;24935.127270545807;25042;25089;25130.37174070663;7722.382209423233;7753.806154846061;7829.686812527549;7915.287624113742;8013.439059265796;4164.167166566699;4232.513260975027;4247.3628955656895;4263.936040959388;4265.701400901907;3374;4218.8523401680795;4223.852165174204;4227.767472788964;4228.556001619847;711.6228398948566;763.6258233465672;784.8234147316808;790.6363072986376;803.333233416263;531.9042572336939;535.1651423778917;564.2439131563642;575.9395263497272;581.1254062635707;9123.498207598514;9240.953795231115;9624.230061595055;9791.559379827924;10039.949800251097;537.8467136865975;554.2545276602963;579.6927628356977;580.3974482354882;593.2939801636126;4362.847300344472;4682.578567928903;4713.481517033124;4772.451168115711;4811.113162451196;98525;100863;101861;102485;104708;79858;83089.3382132354;83508.16491835004;84508;85598;53562.19656705153;53950.46049539533;63951.04073438902;70518.99999999897;70605.94091088534;9329.486878221764;10738.81789137374;10804.189685773756;10948.726281843017;11022.614208502664;28848.836337275206;33931.66068339285;34759.4786078204;35977.280454391286;37510;61906.69046654738;67310.3268967304;67730.64538709297;67897;68746;13087.672808179872;13291.534796282083;13323.333833308103;13549.119307244997;13566.86433135656;14095.224762637743;14246.786298205328;14451.49419770303;14587.562373128823;14670.606292402204;12992.415341309475;13222.735545289233;13224.272665003133;13373.39819708135;13738.313084345942;10670.362375556202;12946.676333091747;13245.20528768277;13925.303734813016;14225.573232803032;12916.325756819844;12928.612141635766;13186.208827470382;13659.385327660479;13805.447782089006;10802.621908233174;10932.508037138507;10933.890661093288;10952.671419857417;11526.88473115258;9208.053422904606;9790.849478242417;10411.427371494641;10954.233203675985;11233.269837460866 05:14:29 INFO - PID 2009 | __end_tp_report 05:14:29 INFO - PID 2009 | __start_cc_report 05:14:29 INFO - PID 2009 | _x_x_mozilla_cycle_collect,424 05:14:29 INFO - PID 2009 | __end_cc_report 05:14:29 INFO - PID 2009 | __startTimestamp1490098469000__endTimestamp 05:14:29 INFO - PID 2009 | 05:14:29 INFO - PID 2009 | ------- Summary: start ------- 05:14:29 INFO - PID 2009 | Number of tests: 6 05:14:29 INFO - PID 2009 | 05:14:29 INFO - PID 2009 | [#0] dojo.html Cycles:165 Average:5969.40 Median:6200.84 stddev:719.95 (11.6%) stddev-sans-first:688.36 05:14:29 INFO - PID 2009 | Values: 3190.4 3449.2 3479.2 3506.4 3514.8 5628.0 5950.9 5982.3 6074.5 6078.8 6003.3 6077.3 6081.9 6142.8 6179.1 4369.9 5465.3 5466.3 5516.4 5540.6 5370.7 5459.1 5513.2 5517.4 5535.4 5446.1 5495.1 5497.1 5533.4 5534.7 5382.7 5397.3 5409.7 5456.0 5488.1 5347.8 5376.8 5390.8 5391.0 5392.7 4917.1 5835.9 5906.6 6031.2 6040.3 6335.8 6380.2 6396.7 6463.7 6464.6 6551.1 6555.9 6560.1 6561.9 6565.5 6176.1 6178.7 6201.8 6204.7 6204.7 5572.4 6483.9 6520.2 6559.6 6665.2 5465.5 6170.5 6341.1 6413.1 6438.7 6352.2 6443.6 6547.1 6552.0 6552.7 6399.4 6448.8 6483.9 6509.9 6515.4 5304.7 6287.5 6365.7 6372.9 6381.4 4490.8 4493.9 5167.4 5201.0 5223.6 4622.2 4622.6 4625.7 4635.5 4690.9 6156.2 6211.4 6253.3 6261.8 6281.1 6040.8 6185.1 6597.4 6617.0 6635.7 5468.6 5936.6 6181.6 6193.7 6281.8 5658.7 5708.7 5777.6 5779.0 5824.9 6693.6 6815.8 6849.1 6878.9 6912.6 6599.9 6607.7 6608.9 6611.8 6617.4 6512.1 6785.7 6789.2 6845.9 6854.0 5380.3 5389.5 6365.1 6466.5 6485.7 6446.9 6604.7 6618.3 6627.8 6629.1 6177.9 6200.3 6355.4 6371.1 6383.5 6311.3 6320.5 6379.8 6402.6 6404.7 5042.3 5823.1 6252.7 6287.9 6292.2 6168.9 6380.5 6394.5 6404.8 6410.4 6170.0 6182.1 6200.8 6243.8 6254.9 05:14:29 INFO - PID 2009 | 05:14:29 INFO - PID 2009 | [#1] ext.html Cycles:180 Average:52128.24 Median:31433.84 stddev:103333.49 (328.7%) stddev-sans-first:103551.12 05:14:29 INFO - PID 2009 | Values: 663.1 698.8 790.6 796.1 818.4 38582.0 39269.8 39282.4 39306.6 39421.4 38344.6 38710.4 38742.6 38779.0 38897.8 2572.9 2697.9 2741.5 2892.4 2896.6 2844.1 2872.3 2885.2 2889.6 2891.1 2864.4 2864.8 2896.2 2896.3 2898.6 2410.2 2876.8 2885.8 2887.1 2896.6 2846.7 2853.7 2855.4 2875.1 2875.8 34382.7 37946.8 39652.0 40059.6 40083.0 2827.4 2839.9 3024.9 3041.5 3072.8 22738.0 28922.9 29188.7 29229.9 29857.9 2799.3 2810.3 2810.8 2838.2 2922.2 343782.0 346448.0 346689.3 347568.5 347618.3 52114.5 52225.0 52303.5 52370.5 52446.0 53267.5 53719.5 53727.0 54094.7 54242.0 14663.6 14980.9 15086.9 15089.8 15093.8 11979.8 12212.0 12212.9 12232.4 12249.0 13466.6 14016.9 14027.9 14072.9 14127.5 5851.3 5879.6 5922.2 5922.9 5923.0 947.4 971.0 980.6 982.4 1001.7 24511.2 24522.4 24646.9 24722.4 24724.5 1062.4 1068.7 1103.2 1106.7 1116.8 11998.5 12555.9 12607.8 12608.4 12616.2 437874.0 439385.0 440593.0 441895.0 442003.8 53492.7 55027.4 57055.7 57710.7 58077.0 1447.1 1468.9 1477.5 1488.7 1489.1 27894.7 28714.9 29138.7 29598.6 29835.3 38272.8 38548.8 38612.8 38668.6 38703.8 373251.0 373251.0 375453.0 375671.0 375825.0 26621.9 32914.8 33122.0 33216.0 33218.5 41815.7 42041.6 42116.0 42209.0 42291.8 30947.2 30966.8 34557.5 34709.5 35744.1 32697.8 34612.5 34674.7 35614.8 35787.8 33630.7 34539.7 36002.1 36366.6 36429.1 29466.9 31209.8 31657.8 31760.4 31872.7 23456.5 23793.3 23994.6 23996.6 24598.0 05:14:29 INFO - PID 2009 | 05:14:29 INFO - PID 2009 | [#2] jquery.html Cycles:180 Average:33477.77 Median:22969.75 stddev:84209.81 (366.6%) stddev-sans-first:84409.29 05:14:29 INFO - PID 2009 | Values: 343.8 424.8 424.9 433.6 445.3 21608.5 21749.2 22578.9 22777.9 22989.4 22252.4 22950.1 23042.8 23355.8 23713.1 3733.3 4143.5 4293.2 4344.0 4346.5 4176.7 4251.7 4265.4 4300.0 4314.7 4258.7 4273.9 4286.4 4290.8 4292.6 4172.6 4271.7 4282.9 4287.8 4299.7 3840.0 3912.2 3912.3 3914.1 3914.9 27177.9 27301.6 27378.5 27450.7 27512.6 1921.9 1923.1 2019.5 2054.3 2060.3 15909.5 16028.2 16154.6 16334.9 16717.2 1576.7 1594.7 1597.3 1600.4 1639.9 135980.0 143484.3 144346.6 145107.0 146598.3 10291.0 10815.9 10963.3 11915.7 12521.1 15742.3 16200.4 16212.1 16213.7 16246.5 8880.6 9107.0 9138.2 9164.0 9253.4 8704.0 8761.7 8858.6 9039.0 9046.5 7823.8 8007.2 8018.4 8033.4 8059.6 2123.8 2125.2 2130.0 2133.6 2306.8 849.9 894.2 941.9 957.0 978.2 18986.4 19508.8 20203.0 20667.9 20840.4 952.1 971.7 978.8 988.0 1005.2 10699.1 10726.9 10904.6 10934.9 10947.2 397689.0 398064.0 401382.0 514595.9 667228.0 114991.7 129689.1 153074.0 156718.2 160417.0 1123.3 1127.1 1153.7 1155.9 1159.8 15062.5 17948.6 18405.7 18645.0 18767.6 53766.0 54358.5 54429.5 54475.0 54959.0 87833.0 89090.6 89247.6 89416.0 90595.8 8103.5 8308.6 8336.7 8715.8 9112.5 13929.6 14036.4 14210.9 14274.1 14522.7 11669.3 11823.4 11860.4 11886.5 12042.9 11477.3 11568.3 11597.3 11860.3 12065.2 10238.9 11645.4 11740.5 12146.8 12200.9 8557.7 8584.2 8896.6 8933.7 9001.1 11689.9 11712.9 11936.8 11951.0 12078.9 05:14:29 INFO - PID 2009 | 05:14:29 INFO - PID 2009 | [#3] mootools.html Cycles:180 Average:6532.03 Median:2827.50 stddev:4041.55 (142.9%) stddev-sans-first:4032.74 05:14:29 INFO - PID 2009 | Values: 1162.6 1216.6 1384.7 1404.7 1418.6 10194.4 10596.5 10647.7 10653.5 10763.8 10505.8 10719.7 10723.4 10735.2 10775.9 2408.1 2452.8 2461.0 2462.1 2469.3 2379.3 2411.4 2426.6 2428.6 2441.1 2018.9 2374.7 2392.5 2415.2 2416.4 2348.8 2371.1 2373.9 2382.3 2389.7 2319.5 2349.4 2415.0 2419.0 2424.5 10594.4 10614.4 10625.0 10645.6 10651.7 5935.2 6061.2 6159.9 6165.7 6169.8 3493.3 3915.1 3964.0 4031.3 4048.3 1091.4 1151.5 1169.0 1232.3 1240.0 13147.1 13589.6 14475.4 14636.8 14660.4 5036.5 5139.5 5316.7 5318.0 5323.0 8922.2 10748.1 10824.5 10863.0 10888.3 6139.7 6148.0 6162.5 6163.2 6168.0 4803.6 5236.3 5537.9 5714.1 5820.4 4155.3 4164.5 4167.6 4200.9 4206.0 1041.4 1239.7 1240.6 1251.5 1251.9 738.2 740.3 759.7 771.7 788.9 5244.1 6021.5 6270.6 6473.5 6527.9 490.4 521.9 560.4 567.7 570.9 3185.7 3254.2 3611.6 3732.5 3758.8 13033.7 13174.4 13698.5 13708.2 13723.0 10742.8 13180.4 13608.3 13610.0 13644.9 9983.0 10035.2 10147.0 10147.5 10160.7 5524.2 6097.1 6254.5 6276.4 6364.0 12051.6 12059.6 12105.9 12391.9 12464.8 11816.7 11912.3 12197.2 12233.8 12399.6 8421.7 8609.9 8804.9 8809.6 8851.6 9845.8 9907.9 10059.8 10077.2 10085.3 8313.9 8622.4 8645.7 8782.0 8794.9 8363.5 8417.7 8433.0 8471.8 8487.1 7555.8 7573.7 7593.6 7637.9 7651.3 4540.9 4894.3 5501.5 5564.7 5717.3 5471.4 5578.2 5606.9 5651.1 5768.4 05:14:29 INFO - PID 2009 | 05:14:29 INFO - PID 2009 | [#4] prototype.html Cycles:180 Average:5193.93 Median:5688.13 stddev:1557.97 (27.4%) stddev-sans-first:1519.86 05:14:29 INFO - PID 2009 | Values: 379.3 389.9 395.5 404.5 406.5 4951.6 5679.5 5982.5 6016.6 6042.9 4473.4 4964.7 5650.1 5929.5 5941.9 4491.1 4524.7 4630.4 4636.6 4656.1 4524.5 4611.8 4644.8 4652.8 4665.8 4266.8 4270.0 4571.7 4591.2 4652.5 4575.9 4581.5 4588.8 4590.7 4645.5 3595.9 3907.5 4014.8 4054.6 4097.9 4661.5 5696.8 5799.5 5820.6 5828.2 5400.0 5404.7 5410.4 5420.9 5447.8 6158.2 6160.3 6240.0 6264.7 6350.2 4543.2 4548.8 4561.4 4567.3 4568.8 6341.8 6520.4 6548.4 6591.0 6653.6 4663.5 4677.3 4697.8 4703.2 4730.5 4805.1 4820.0 4830.9 4832.8 4851.5 4836.1 4878.3 5219.7 5398.4 5431.4 5081.8 5835.6 6077.8 6376.8 6549.4 1373.7 1494.4 1652.4 1656.3 1677.5 1087.5 1143.1 1143.4 1147.0 1163.3 5433.4 5507.3 5804.8 5851.9 5941.5 5914.9 6165.9 6513.8 6538.0 6547.4 4978.4 5200.7 5873.9 5968.7 5987.2 3056.5 3310.9 3426.7 3427.8 3432.8 6048.4 6359.9 6403.8 6793.7 6924.1 6200.1 6721.6 6774.7 6807.2 6819.5 6530.3 6868.2 6935.0 6956.2 6961.0 6562.7 6599.9 6622.1 6627.5 6635.2 5918.8 6021.6 6327.6 6495.4 6583.0 6906.5 6911.0 6931.1 6960.6 6967.4 4315.7 4342.7 4350.8 4358.9 4362.8 5325.3 6291.2 6540.9 6570.5 6589.8 6286.4 6348.3 6383.6 6383.8 6384.5 5433.2 5982.7 6316.8 6362.9 6376.4 5183.5 6092.0 6252.1 6268.1 6287.5 4631.9 5448.1 5746.7 6345.9 6402.8 5701.7 5773.8 6100.4 6126.2 6185.6 05:14:29 INFO - PID 2009 | 05:14:29 INFO - PID 2009 | [#5] yui.html Cycles:180 Average:19705.91 Median:34345.57 stddev:28218.29 (82.2%) stddev-sans-first:28261.36 05:14:29 INFO - PID 2009 | Values: 699.3 730.4 730.8 733.6 735.2 14719.6 15707.8 15712.8 16136.7 16142.4 14927.3 15084.6 15091.2 15091.8 15107.0 773.1 910.8 932.1 934.1 939.8 927.9 928.9 939.8 941.8 943.4 970.9 987.2 987.4 989.6 994.8 992.0 996.9 997.1 999.7 1007.7 727.0 739.3 739.4 740.8 740.9 16482.5 16565.5 16866.6 16882.2 17133.8 14658.3 14723.5 14798.3 14812.4 14847.9 11674.4 11705.4 11873.9 11997.2 12233.1 2977.2 3004.2 3017.0 3085.2 3121.3 106497.0 107411.5 112282.0 112828.0 114248.9 10886.2 11231.2 11361.7 11383.5 11431.3 24650.1 24935.1 25042.0 25089.0 25130.4 7722.4 7753.8 7829.7 7915.3 8013.4 4164.2 4232.5 4247.4 4263.9 4265.7 3374.0 4218.9 4223.9 4227.8 4228.6 711.6 763.6 784.8 790.6 803.3 531.9 535.2 564.2 575.9 581.1 9123.5 9241.0 9624.2 9791.6 10039.9 537.8 554.3 579.7 580.4 593.3 4362.8 4682.6 4713.5 4772.5 4811.1 98525.0 100863.0 101861.0 102485.0 104708.0 79858.0 83089.3 83508.2 84508.0 85598.0 53562.2 53950.5 63951.0 70519.0 70605.9 9329.5 10738.8 10804.2 10948.7 11022.6 28848.8 33931.7 34759.5 35977.3 37510.0 61906.7 67310.3 67730.6 67897.0 68746.0 13087.7 13291.5 13323.3 13549.1 13566.9 14095.2 14246.8 14451.5 14587.6 14670.6 12992.4 13222.7 13224.3 13373.4 13738.3 10670.4 12946.7 13245.2 13925.3 14225.6 12916.3 12928.6 13186.2 13659.4 13805.4 10802.6 10932.5 10933.9 10952.7 11526.9 9208.1 9790.8 10411.4 10954.2 11233.3 05:14:29 INFO - PID 2009 | -------- Summary: end -------- 05:14:29 INFO - PID 2009 | 05:14:29 INFO - TEST-INFO | 2009: exit 0 05:14:29 INFO - TEST-OK | dromaeo_css | took 1117268ms 05:14:29 INFO - TEST-START | kraken 05:14:29 INFO - operating with platform_type : mac_ 05:14:29 INFO - Initialising browser for kraken test... 05:14:29 INFO - TEST-INFO | started process 2017 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/tmpi9eIyV/profile http://localhost:49306/getInfo.html) 05:14:32 INFO - PID 2017 | 2017-03-21 05:14:32.523 plugin-container[2019:22366] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 05:14:32 INFO - PID 2017 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:14:32 INFO - PID 2017 | 2017-03-21 05:14:32.523 plugin-container[2019:22366] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 05:14:32 INFO - PID 2017 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:14:32 INFO - PID 2017 | 2017-03-21 05:14:32.523 plugin-container[2019:22366] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:14:32 INFO - PID 2017 | __metrics Screen width/height:1600/1200 05:14:32 INFO - PID 2017 | colorDepth:24 05:14:32 INFO - PID 2017 | Browser inner width/height: 1024/689 05:14:32 INFO - PID 2017 | __metrics 05:14:32 ERROR - PID 2017 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 05:14:33 INFO - TEST-INFO | 2017: exit 0 05:14:33 INFO - Browser initialized. 05:14:33 INFO - Running cycle 1/1 for kraken test... 05:14:33 INFO - TEST-INFO | started process 2020 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/T/tmpi9eIyV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:14:36 INFO - PID 2020 | 2017-03-21 05:14:36.063 plugin-container[2021:22483] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.tsm.portname' 05:14:36 INFO - PID 2020 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:14:36 INFO - PID 2020 | 2017-03-21 05:14:36.064 plugin-container[2021:22483] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900f, name = 'com.apple.CFPasteboardClient' 05:14:36 INFO - PID 2020 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:14:36 INFO - PID 2020 | 2017-03-21 05:14:36.064 plugin-container[2021:22483] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:14:45 INFO - PID 2020 | RSS: Main: 227835904 05:14:45 INFO - PID 2020 | 05:14:48 INFO - PID 2020 | Cycle 1(1): loaded http://localhost:49306/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49306/tests/kraken/driver.html?testName=audio-beat-detection) 05:14:49 INFO - PID 2020 | RSS: Main: 241844224 05:14:49 INFO - PID 2020 | 05:14:52 INFO - PID 2020 | Cycle 1(1): loaded http://localhost:49306/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49306/tests/kraken/driver.html?testName=audio-dft) 05:14:53 INFO - PID 2020 | RSS: Main: 250191872 05:14:53 INFO - PID 2020 | 05:14:56 INFO - PID 2020 | Cycle 1(1): loaded http://localhost:49306/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49306/tests/kraken/driver.html?testName=audio-fft) 05:14:57 INFO - PID 2020 | RSS: Main: 252813312 05:14:57 INFO - PID 2020 | 05:14:59 INFO - PID 2020 | Cycle 1(1): loaded http://localhost:49306/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49306/tests/kraken/driver.html?testName=audio-oscillator) 05:14:59 INFO - PID 2020 | RSS: Main: 254054400 05:14:59 INFO - PID 2020 | 05:15:01 INFO - PID 2020 | Cycle 1(1): loaded http://localhost:49306/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49306/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:15:02 INFO - PID 2020 | RSS: Main: 255778816 05:15:02 INFO - PID 2020 | 05:15:05 INFO - PID 2020 | Cycle 1(1): loaded http://localhost:49306/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49306/tests/kraken/driver.html?testName=imaging-darkroom) 05:15:06 INFO - PID 2020 | RSS: Main: 261443584 05:15:06 INFO - PID 2020 | 05:15:09 INFO - PID 2020 | Cycle 1(1): loaded http://localhost:49306/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49306/tests/kraken/driver.html?testName=imaging-desaturate) 05:15:10 INFO - PID 2020 | RSS: Main: 261726208 05:15:10 INFO - PID 2020 | 05:15:13 INFO - PID 2020 | Cycle 1(1): loaded http://localhost:49306/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49306/tests/kraken/driver.html?testName=json-parse-financial) 05:15:14 INFO - PID 2020 | RSS: Main: 262205440 05:15:14 INFO - PID 2020 | 05:15:15 INFO - PID 2020 | Cycle 1(1): loaded http://localhost:49306/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49306/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:15:16 INFO - PID 2020 | RSS: Main: 261242880 05:15:16 INFO - PID 2020 | 05:15:18 INFO - PID 2020 | Cycle 1(1): loaded http://localhost:49306/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49306/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:15:19 INFO - PID 2020 | RSS: Main: 261169152 05:15:19 INFO - PID 2020 | 05:15:21 INFO - PID 2020 | Cycle 1(1): loaded http://localhost:49306/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49306/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:15:21 INFO - PID 2020 | RSS: Main: 261251072 05:15:21 INFO - PID 2020 | 05:15:24 INFO - PID 2020 | Cycle 1(1): loaded http://localhost:49306/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:15:25 INFO - PID 2020 | RSS: Main: 261681152 05:15:25 INFO - PID 2020 | 05:15:28 INFO - PID 2020 | Cycle 1(1): loaded http://localhost:49306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:15:29 INFO - PID 2020 | RSS: Main: 261509120 05:15:29 INFO - PID 2020 | 05:15:31 INFO - PID 2020 | Cycle 1(1): loaded http://localhost:49306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49306/tests/kraken/driver.html?testName=ai-astar) 05:15:31 INFO - PID 2020 | RSS: Main: 264515584 05:15:31 INFO - PID 2020 | 05:15:31 INFO - PID 2020 | __start_tp_report 05:15:31 INFO - PID 2020 | _x_x_mozilla_page_load 05:15:31 INFO - PID 2020 | _x_x_mozilla_page_load_details 05:15:31 INFO - PID 2020 | |i|pagename|runs| 05:15:31 INFO - PID 2020 | |0;ai-astar;102;116;116;113;116;117;115;115;116;113 05:15:31 INFO - PID 2020 | |1;audio-beat-detection;147;116;115;165;146;128;115;116;160;166 05:15:31 INFO - PID 2020 | |2;audio-dft;273;256;214;208;205;207;193;199;198;198 05:15:31 INFO - PID 2020 | |3;audio-fft;80;60;73;85;61;62;60;58;76;56 05:15:31 INFO - PID 2020 | |4;audio-oscillator;97;103;81;82;66;64;80;57;107;117 05:15:31 INFO - PID 2020 | |5;imaging-gaussian-blur;91;90;108;103;135;78;130;136;91;78 05:15:31 INFO - PID 2020 | |6;imaging-darkroom;99;100;97;98;150;138;98;99;98;97 05:15:31 INFO - PID 2020 | |7;imaging-desaturate;145;141;109;143;106;90;91;89;133;145 05:15:31 INFO - PID 2020 | |8;json-parse-financial;68;68;67;72;96;100;101;96;70;67 05:15:31 INFO - PID 2020 | |9;json-stringify-tinderbox;69;59;60;74;58;53;60;86;84;79 05:15:31 INFO - PID 2020 | |10;stanford-crypto-aes;87;83;82;85;85;86;87;83;86;85 05:15:31 INFO - PID 2020 | |11;stanford-crypto-ccm;183;146;149;144;143;151;175;143;205;170 05:15:31 INFO - PID 2020 | |12;stanford-crypto-pbkdf2;186;192;186;187;192;188;172;242;251;217 05:15:31 INFO - PID 2020 | |13;stanford-crypto-sha256-iterative;71;74;73;72;70;73;68;71;72;72 05:15:31 INFO - PID 2020 | __end_tp_report 05:15:31 INFO - PID 2020 | __start_cc_report 05:15:31 INFO - PID 2020 | _x_x_mozilla_cycle_collect,1025 05:15:31 INFO - PID 2020 | __end_cc_report 05:15:31 INFO - PID 2020 | __startTimestamp1490098531673__endTimestamp 05:15:31 INFO - PID 2020 | 05:15:31 INFO - PID 2020 | ------- Summary: start ------- 05:15:31 INFO - PID 2020 | Number of tests: 14 05:15:31 INFO - PID 2020 | 05:15:31 INFO - PID 2020 | [#0] ai-astar Cycles:10 Average:113.90 Median:116.00 stddev:4.38 (3.8%) stddev-sans-first:1.39 05:15:31 INFO - PID 2020 | Values: 102.0 116.0 116.0 113.0 116.0 117.0 115.0 115.0 116.0 113.0 05:15:31 INFO - PID 2020 | 05:15:31 INFO - PID 2020 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:146.50 stddev:21.77 (14.9%) stddev-sans-first:22.81 05:15:31 INFO - PID 2020 | Values: 147.0 116.0 115.0 165.0 146.0 128.0 115.0 116.0 160.0 166.0 05:15:31 INFO - PID 2020 | 05:15:31 INFO - PID 2020 | [#2] audio-dft Cycles:10 Average:215.10 Median:207.50 stddev:27.03 (13.0%) stddev-sans-first:18.88 05:15:31 INFO - PID 2020 | Values: 273.0 256.0 214.0 208.0 205.0 207.0 193.0 199.0 198.0 198.0 05:15:31 INFO - PID 2020 | 05:15:31 INFO - PID 2020 | [#3] audio-fft Cycles:10 Average:67.10 Median:67.50 stddev:10.39 (15.4%) stddev-sans-first:9.91 05:15:31 INFO - PID 2020 | Values: 80.0 60.0 73.0 85.0 61.0 62.0 60.0 58.0 76.0 56.0 05:15:31 INFO - PID 2020 | 05:15:31 INFO - PID 2020 | [#4] audio-oscillator Cycles:10 Average:85.40 Median:73.00 stddev:20.03 (27.4%) stddev-sans-first:20.80 05:15:31 INFO - PID 2020 | Values: 97.0 103.0 81.0 82.0 66.0 64.0 80.0 57.0 107.0 117.0 05:15:31 INFO - PID 2020 | 05:15:31 INFO - PID 2020 | [#5] imaging-gaussian-blur Cycles:10 Average:104.00 Median:78.00 stddev:22.52 (28.9%) stddev-sans-first:23.39 05:15:31 INFO - PID 2020 | Values: 91.0 90.0 108.0 103.0 135.0 78.0 130.0 136.0 91.0 78.0 05:15:31 INFO - PID 2020 | 05:15:31 INFO - PID 2020 | [#6] imaging-darkroom Cycles:10 Average:107.40 Median:98.00 stddev:19.52 (19.9%) stddev-sans-first:20.46 05:15:31 INFO - PID 2020 | Values: 99.0 100.0 97.0 98.0 150.0 138.0 98.0 99.0 98.0 97.0 05:15:31 INFO - PID 2020 | 05:15:31 INFO - PID 2020 | [#7] imaging-desaturate Cycles:10 Average:119.20 Median:145.00 stddev:24.50 (16.9%) stddev-sans-first:24.14 05:15:31 INFO - PID 2020 | Values: 145.0 141.0 109.0 143.0 106.0 90.0 91.0 89.0 133.0 145.0 05:15:31 INFO - PID 2020 | 05:15:31 INFO - PID 2020 | [#8] json-parse-financial Cycles:10 Average:80.50 Median:69.00 stddev:15.42 (22.4%) stddev-sans-first:15.68 05:15:31 INFO - PID 2020 | Values: 68.0 68.0 67.0 72.0 96.0 100.0 101.0 96.0 70.0 67.0 05:15:31 INFO - PID 2020 | 05:15:31 INFO - PID 2020 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:71.50 stddev:11.89 (16.6%) stddev-sans-first:12.60 05:15:31 INFO - PID 2020 | Values: 69.0 59.0 60.0 74.0 58.0 53.0 60.0 86.0 84.0 79.0 05:15:31 INFO - PID 2020 | 05:15:31 INFO - PID 2020 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:85.50 stddev:1.73 (2.0%) stddev-sans-first:1.66 05:15:31 INFO - PID 2020 | Values: 87.0 83.0 82.0 85.0 85.0 86.0 87.0 83.0 86.0 85.0 05:15:31 INFO - PID 2020 | 05:15:31 INFO - PID 2020 | [#11] stanford-crypto-ccm Cycles:10 Average:160.90 Median:160.50 stddev:21.35 (13.3%) stddev-sans-first:21.10 05:15:31 INFO - PID 2020 | Values: 183.0 146.0 149.0 144.0 143.0 151.0 175.0 143.0 205.0 170.0 05:15:31 INFO - PID 2020 | 05:15:31 INFO - PID 2020 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:201.30 Median:192.00 stddev:26.36 (13.7%) stddev-sans-first:27.37 05:15:31 INFO - PID 2020 | Values: 186.0 192.0 186.0 187.0 192.0 188.0 172.0 242.0 251.0 217.0 05:15:31 INFO - PID 2020 | 05:15:31 INFO - PID 2020 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:72.00 stddev:1.71 (2.4%) stddev-sans-first:1.80 05:15:31 INFO - PID 2020 | Values: 71.0 74.0 73.0 72.0 70.0 73.0 68.0 71.0 72.0 72.0 05:15:31 INFO - PID 2020 | -------- Summary: end -------- 05:15:31 INFO - PID 2020 | 05:15:32 INFO - TEST-INFO | 2020: exit 0 05:15:32 INFO - TEST-OK | kraken | took 63068ms 05:15:32 INFO - SUITE-END | took 1180s 05:15:32 INFO - Completed test suite (00:19:40) 05:15:32 INFO - javascript benchmark 05:15:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7325.502884650159, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3190.441672707276, 3449.206682463032, 3479.165000399905, 3506.421440462324, 3514.789112653241, 5627.986962346781, 5950.940490595092, 5982.312034116078, 6074.5140388768905, 6078.848028799277, 6003.309619393771, 6077.3314935357075, 6081.939180608192, 6142.785002524913, 6179.073139029137, 4369.934450983238, 5465.316835395575, 5466.262054622614, 5516.448355164492, 5540.612157149001, 5370.677759334452, 5459.12653975364, 5513.228148059275, 5517.420670829565, 5535.446455354472, 5446.128619420873, 5495.148252020903, 5497.120460726284, 5533.391326954032, 5534.723263836812, 5382.703951282678, 5397.298351214356, 5409.675419474844, 5456.045192091368, 5488.121900495901, 5347.759350829183, 5376.838694839161, 5390.811321603765, 5391.0, 5392.676439413609, 4917.139500587418, 5835.941640583582, 5906.645601263938, 6031.24609423822, 6040.275166979946, 6335.80992570219, 6380.234371875405, 6396.744130234785, 6463.6768161591735, 6464.612123272572, 6551.05009773585, 6555.93444065558, 6560.147180866505, 6561.93438065618, 6565.474762019027, 6176.104464852571, 6178.660173690445, 6201.782937597208, 6204.658743769136, 6204.720787564571, 5572.3870374258795, 6483.935160648428, 6520.18497687789, 6559.573627714279, 6665.233498147775, 5465.453454654503, 6170.475509581646, 6341.143945567382, 6413.102165696806, 6438.678066096676, 6352.174217351715, 6443.613383197023, 6547.1161393211305, 6552.017197420425, 6552.737890484327, 6399.360063993657, 6448.806535803933, 6483.902741458882, 6509.934900651027, 6515.413612774873, 5304.734763261821, 6287.49700023997, 6365.745370185141, 6372.872542549123, 6381.3937675920715, 4490.842820501267, 4493.88765280864, 5167.379914410295, 5200.97399513, 5223.5559977402345, 4622.214223581999, 4622.607078398307, 4625.722456652545, 4635.490096089427, 4690.882727931829, 6156.168917196211, 6211.440970312694, 6253.280872699698, 6261.78083767066, 6281.089242059876, 6040.822039702216, 6185.134081228542, 6597.439217666552, 6616.96691516549, 6635.701393437307, 5468.644538105011, 5936.643801371932, 6181.564801911172, 6193.718427410477, 6281.780137695158, 5658.660480371191, 5708.743106560215, 5777.595568310262, 5778.971105144447, 5824.912626310524, 6693.564918280394, 6815.761448349483, 6849.075374824534, 6878.896816547655, 6912.619805910522, 6599.868002640016, 6607.702653380706, 6608.867822643424, 6611.834704132435, 6617.371349721769, 6512.088307637029, 6785.728570857111, 6789.2192397872905, 6845.863082738417, 6854.0, 5380.3274590676165, 5389.514943654933, 6365.077063825626, 6466.450351719968, 6485.740570377132, 6446.871062578628, 6604.669766511752, 6618.2719900811835, 6627.801165965029, 6629.138212032405, 6177.938220617736, 6200.348963358782, 6355.428011478989, 6371.139896113966, 6383.489320854228, 6311.337309582428, 6320.494360451061, 6379.808605741835, 6402.551821372459, 6404.71178796946, 5042.268871013755, 5823.126531020381, 6252.656103914328, 6287.937120628918, 6292.182016337847, 6168.876622467616, 6380.489560835029, 6394.4564712, 6404.775832845828, 6410.391012853772, 6170.0, 6182.1345011697495, 6200.844978875564, 6243.843903902439, 6254.906176407267], "value": 5923.095977042395, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.1445435388349, 698.7833771530824, 790.5691398187987, 796.096430551324, 818.4475479051639, 38582.0, 39269.803650981776, 39282.41076383857, 39306.60693393065, 39421.40867886984, 38344.61655383445, 38710.419343709866, 38742.612573874256, 38779.0, 38897.80551097241, 2572.9450925120705, 2697.878595463204, 2741.451709658066, 2892.363679990399, 2896.579995900593, 2844.075675405491, 2872.2962874095874, 2885.2498350428937, 2889.5810107534394, 2891.08930686833, 2864.3555200080023, 2864.756495697868, 2896.160113567063, 2896.290408849835, 2898.594196812448, 2410.240774156135, 2876.8417737024456, 2885.7691384689383, 2887.133859842039, 2896.5510345896314, 2846.7010963848707, 2853.7146285371505, 2855.4003659231585, 2875.065603678792, 2875.8274503529856, 34382.6561734382, 37946.81026594877, 39652.0, 40059.59940400617, 40082.99792505211, 2827.4486475137355, 2839.943201135966, 3024.9243768905953, 3041.5437684347303, 3072.830994295313, 22738.0, 28922.855385723145, 29188.708112918812, 29229.853850730822, 29857.850710746523, 2799.3281612412875, 2810.3255218747354, 2810.789190810697, 2838.1627419911174, 2922.2110030291915, 343782.0, 346448.0, 346689.26655366813, 347568.52431475866, 347618.2619086888, 52114.478855211724, 52225.0, 52303.47696523062, 52370.47629523732, 52445.95108097893, 53267.46732532702, 53719.462805372226, 53727.0, 54094.7295263529, 54242.0, 14663.560093197008, 14980.850191497946, 15086.924565377103, 15089.773653395208, 15093.773593396108, 11979.760404791856, 12212.0, 12212.938935305267, 12232.388380580935, 12249.0, 13466.596002119952, 14016.859831401556, 14027.929860350632, 14072.944529160353, 14127.50553730635, 5851.268591426072, 5879.618754404473, 5922.230110085661, 5922.851928701817, 5922.970385148133, 947.3842002698301, 970.96601618943, 980.5734505490135, 982.415462799633, 1001.6944831826218, 24511.22031203934, 24522.386940326636, 24646.876765616056, 24722.381940451272, 24724.505509890063, 1062.4050531702271, 1068.6526878764432, 1103.2332528892343, 1106.6514048074991, 1116.849225354583, 11998.520059197534, 12555.932745716535, 12607.810882836764, 12608.369581520887, 12616.243025418504, 437874.0, 439385.0, 440593.0, 441895.0, 442003.78998104803, 53492.73253633707, 55027.44972550304, 57055.71472142696, 57710.71144644334, 58077.0, 1447.131720967432, 1468.8898332625097, 1477.460726834719, 1488.679933814235, 1489.0693316677077, 27894.721052789213, 28714.85642571774, 29138.7086129136, 29598.55602165926, 29835.254118647208, 38272.808635956644, 38548.80725596466, 38612.80693596514, 38668.6133138665, 38703.80648096742, 373251.0, 373251.0, 375453.0, 375671.0, 375825.0, 26621.866890665424, 32914.83542582272, 33122.0, 33216.0, 33218.5017224737, 41815.74552763422, 42041.57958420377, 42116.0, 42209.0, 42291.788541057096, 30947.226319342197, 30966.84516577493, 34557.481637775956, 34709.47935780915, 35744.10639734028, 32697.836510817295, 34612.48081278833, 34674.65325346714, 35614.8219258902, 35787.82106089453, 33630.663693363735, 34539.65460345465, 36002.09994750152, 36366.63633363633, 36429.08927276839, 29466.852665736533, 31209.84395078101, 31657.841710791297, 31760.364792703553, 31872.681273186972, 23456.53086938286, 23793.286201413986, 23994.640080398458, 23996.64005039891, 24598.0], "value": 15406.045756145535, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.8212129692561, 424.8130822438127, 424.87041452357016, 433.6249144490016, 445.289762828289, 21608.459788505275, 21749.19389106904, 22578.88710556447, 22777.86110694467, 22989.425264368398, 22252.443688907784, 22950.08199672011, 23042.76957230427, 23355.76644233557, 23713.051477940906, 3733.2720119576693, 4143.544210136883, 4293.248681480744, 4344.0, 4346.5436129206455, 4176.68674849386, 4251.723637963522, 4265.360195970598, 4299.978500107511, 4314.697971142022, 4258.659307255428, 4273.87178384649, 4286.39990401344, 4290.849820256291, 4292.61366477017, 4172.561881002482, 4271.743695378287, 4282.871513854605, 4287.764172970486, 4299.742015479065, 3839.9616003839883, 3912.197999410114, 3912.315344814646, 3914.0606254499, 3914.941275880864, 27177.912883484638, 27301.590476142876, 27378.452430951467, 27450.66669333109, 27512.58731119035, 1921.8846869187753, 1923.1057558235348, 2019.5052212207956, 2054.311805545144, 2060.3097962182687, 15909.52271431859, 16028.19859007045, 16154.596135096599, 16334.918325408416, 16717.247723852455, 1576.7398379267406, 1594.744840825474, 1597.27324067549, 1600.3518574977154, 1639.9344026238937, 135980.0, 143484.28257858643, 144346.55653443543, 145107.0, 146598.26700866426, 10291.0, 10815.891841081646, 10963.342199468058, 11915.74884637118, 12521.1235213536, 15742.291596878167, 16200.432984845474, 16212.10833404174, 16213.675726485404, 16246.512604621881, 8880.644774208959, 9106.95446522763, 9138.223251023737, 9163.95418022919, 9253.352265341497, 8704.0, 8761.693340733043, 8858.63027647032, 9039.005709371964, 9046.502442365732, 7823.804404889924, 8007.239312265326, 8018.358531317481, 8033.357331413473, 8059.63731632078, 2123.766385697572, 2125.234915430444, 2129.98935005324, 2133.5626196629655, 2306.792388684993, 849.9235068843834, 894.190757364586, 941.924646028316, 956.9521523923916, 978.1832170137873, 18986.430407087533, 19508.80491195098, 20203.0, 20667.896660516602, 20840.374788756362, 952.1478276942098, 971.6647756523988, 978.7863049818175, 987.9950600246952, 1005.1857995024054, 10699.144068474503, 10726.946365268279, 10904.58240428755, 10934.890651093547, 10947.233693641529, 397689.01155494037, 398064.0, 401382.0, 514595.8540414623, 667228.0, 114991.70016599789, 129689.05466418012, 153074.0, 156718.2164089195, 160417.0, 1123.3203911633343, 1127.0870594818223, 1153.7288737146764, 1155.884571388614, 1159.802833518304, 15062.548123556311, 17948.641027179645, 18405.723914141032, 18645.0, 18767.624647506702, 53766.0, 54358.45641543692, 54429.45570544244, 54475.0, 54959.0, 87833.0, 89090.55454722684, 89247.55376223077, 89416.0, 90595.75233981134, 8103.513789172668, 8308.584570771558, 8336.708215212439, 8715.825683486422, 9112.453252804853, 13929.58211253664, 14036.368363423875, 14210.857891420954, 14274.14355138695, 14522.709545809235, 11669.299842009166, 11823.408829558315, 11860.40697965081, 11886.465109069939, 12042.879571204527, 11477.253978491372, 11568.305901645928, 11597.304161750322, 11860.288382697066, 12065.155439119177, 10238.897611023795, 11645.41772911368, 11740.471678774305, 12146.757064858477, 12200.938995304967, 8557.657693692183, 8584.227419532272, 8896.599653015759, 8933.687320943736, 9001.054889236535, 11689.88310116922, 11712.88287117118, 11936.76126477483, 11951.043916486835, 12078.879211207775], "value": 9732.972947133074, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1162.6105254739662, 1216.5620376664401, 1384.688445099852, 1404.6558593144675, 1418.5957002254356, 10194.388336699803, 10596.523156457959, 10647.733806654838, 10653.467326633676, 10763.78472430551, 10505.842412363821, 10719.678409647704, 10723.410212438313, 10735.194860385463, 10775.946120269407, 2408.1330720940446, 2452.791512721421, 2460.963085553718, 2462.113639089935, 2469.2839076667747, 2379.262428647125, 2411.40920474484, 2426.6360045993065, 2428.5871401861637, 2441.0967941861536, 2018.8788672679614, 2374.7387787343378, 2392.509535545209, 2415.2150551070886, 2416.395901024744, 2348.765123487655, 2371.1108334374608, 2373.9406514837096, 2382.309130352196, 2389.713234411873, 2319.524497478013, 2349.4009027698, 2414.9879250603635, 2418.9758102418928, 2424.5393375258645, 10594.364338139736, 10614.416207108607, 10625.043746062815, 10645.627403040857, 10651.733706657318, 5935.169076329317, 6061.212042434499, 6159.876802463926, 6165.660888651122, 6169.827732730767, 3493.3013397320638, 3915.099527108752, 3964.028812940819, 4031.294523458383, 4048.291548978946, 1091.4215465803138, 1151.4703236511216, 1169.029705344562, 1232.3345393487507, 1240.0265791353834, 13147.079704420694, 13589.59231223055, 14475.42098316066, 14636.780448293284, 14660.41358345665, 5036.521530454601, 5139.460356662571, 5316.680999140064, 5317.962997215506, 5323.041852466593, 8922.241609463139, 10748.140148788234, 10824.458777061116, 10863.0, 10888.29226100301, 6139.723712432862, 6148.0, 6162.506999440034, 6163.229596300463, 6168.0439531872635, 4803.5916947059195, 5236.345456817898, 5537.9169312459535, 5714.085746280575, 5820.447057529528, 4155.3143731284, 4164.4586203793315, 4167.5832416758685, 4200.915981680349, 4206.0326124991425, 1041.3595638682307, 1239.6776838022179, 1240.5782034108447, 1251.474380760083, 1251.8998480121568, 738.1916801102784, 740.3041141327243, 759.7492827366956, 771.714465647714, 788.8658927982142, 5244.108501554745, 6021.458068773832, 6270.592411493239, 6473.482121430275, 6527.8694426111215, 490.443346801383, 521.8564894654, 560.3863769172749, 567.7133047810829, 570.9000924838136, 3185.7132858042423, 3254.2027203335333, 3611.638836116367, 3732.458793474985, 3758.755680880734, 13033.674158145932, 13174.407151678197, 13698.452061917611, 13708.17750934947, 13722.970777191751, 10742.785144297226, 13180.406881690154, 13608.251546165056, 13609.979251555975, 13644.931775341258, 9983.0, 10035.197184225244, 10147.0, 10147.543360548792, 10160.745981350525, 5524.226608274925, 6097.085437184458, 6254.499640028877, 6276.403741644536, 6364.013577895434, 12051.638450846489, 12059.638210853689, 12105.878941210474, 12391.946684531555, 12464.75070498603, 11816.70458238551, 11912.344821034927, 12197.207181533173, 12233.755324893275, 12399.566015189424, 8421.663133474838, 8609.87085193735, 8804.911950880409, 8809.603567839335, 8851.601677924638, 9845.803083938137, 9907.900920990698, 10059.849102263619, 10077.244206684674, 10085.34445261085, 8313.875291870747, 8622.396432249683, 8645.654173833227, 8782.033976262734, 8794.868076978979, 8363.540005299767, 8417.70538031166, 8433.0, 8471.788205294917, 8487.108853570533, 7555.811104722206, 7573.659185336563, 7593.5823529704185, 7637.88543171864, 7651.273129052731, 4540.8637740867825, 4894.265860120868, 5501.477359650827, 5564.749586268708, 5717.342505611908, 5471.425500322409, 5578.246936663499, 5606.934682410329, 5651.124075768263, 5768.365479797135], "value": 4932.25826498241, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.3494157519853, 389.851856294608, 395.5411722402013, 404.54892794534095, 406.4857954687319, 4951.55436010759, 5679.466544033108, 5982.491488223501, 6016.639001659903, 6042.879142417154, 4473.418455600776, 4964.677295975768, 5650.067738823089, 5929.53924121489, 5941.851453713659, 4491.101779644068, 4524.728516289017, 4630.351750754897, 4636.605888499482, 4656.138614356338, 4524.5249248828895, 4611.815527378901, 4644.837430689927, 4652.790624421892, 4665.813367465297, 4266.8293268269235, 4270.017895883933, 4571.702839315451, 4591.196540605398, 4652.488226295105, 4575.908481830378, 4581.496035436099, 4588.816447342102, 4590.724556526619, 4645.535446455361, 3595.8741444049333, 3907.472491213678, 4014.8394064237395, 4054.5742697016685, 4097.8770636880945, 4661.510541393172, 5696.8006119785605, 5799.507041901444, 5820.5634577406445, 5828.1549175369755, 5400.0, 5404.675719456806, 5410.3507579090365, 5420.91868621971, 5447.782088716446, 6158.168647232611, 6160.322364539897, 6239.968800156015, 6264.749410023594, 6350.23797144341, 4543.182227199103, 4548.840790572347, 4561.361409402686, 4567.314902764579, 4568.834947088471, 6341.795058938833, 6520.380563846427, 6548.410643042102, 6591.0, 6653.567518111307, 4663.48701642819, 4677.298405239173, 4697.835575754901, 4703.17694403478, 4730.5032971538185, 4805.063012712488, 4819.999400497649, 4830.9275360869615, 4832.840118371566, 4851.539103785135, 4836.089744550953, 4878.341423907727, 5219.686818790885, 5398.352197736218, 5431.429699881534, 5081.8475445736685, 5835.562332825055, 6077.817665470043, 6376.840578985562, 6549.377809108127, 1373.7321222361743, 1494.4171773008536, 1652.396875140565, 1656.345743431362, 1677.4967509747028, 1087.483445363462, 1143.0912424622445, 1143.4454289669504, 1147.0, 1163.3252713426193, 5433.375161856437, 5507.292739250845, 5804.767809287581, 5851.912221316684, 5941.524678025748, 5914.8817023659285, 6165.938340616536, 6513.772017979348, 6537.967310163419, 6547.377999090078, 4978.431793984883, 5200.739963001834, 5873.941260587425, 5968.731407086691, 5987.191729116601, 3056.5262384330463, 3310.8546880463655, 3426.7258619310396, 3427.7943323400677, 3432.828358582061, 6048.431425459, 6359.887019771521, 6403.807885763435, 6793.660316984131, 6924.134483189601, 6200.131981522591, 6721.630310332978, 6774.695138718769, 6807.21717002551, 6819.522633415613, 6530.2816690164045, 6868.175818901864, 6934.965325173443, 6956.234814170336, 6960.955856621547, 6562.704678289584, 6599.901001485077, 6622.072909792537, 6627.50293727982, 6635.23694775107, 5918.763249469973, 6021.578489505868, 6327.620342779448, 6495.350464953467, 6582.979638156094, 6906.482013848881, 6910.965445172742, 6931.133608298963, 6960.582365058112, 6967.407770339578, 4315.719478233905, 4342.676667982614, 4350.782460877007, 4358.869233922987, 4362.7818609070055, 5325.334333208349, 6291.245050593958, 6540.869182616416, 6570.507211959218, 6589.769358072636, 6286.371362863677, 6348.269948955929, 6383.616982981036, 6383.808485745435, 6384.489240860627, 5433.152728072474, 5982.7008649568215, 6316.810495685137, 6362.936370636419, 6376.4261216488885, 5183.455737147545, 6091.994820854687, 6252.124702541557, 6268.091126786681, 6287.497000240061, 4631.93052104212, 5448.128299472065, 5746.735718142002, 6345.873082538231, 6402.807915762534, 5701.7434215461235, 5773.797917072882, 6100.420460056288, 6126.172966649624, 6185.567010309235], "value": 4720.07658916878, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.3076853914627, 730.3937731682704, 730.7551970090019, 733.644182571453, 735.213321745732, 14719.632009199775, 15707.84292157078, 15712.842871571282, 16136.677266454664, 16142.435014774484, 14927.32827022784, 15084.622884427894, 15091.245437728097, 15091.849081509208, 15107.0, 773.1379511844309, 910.8204874687295, 932.067932067932, 934.1079269297804, 939.8449255872773, 927.8654595083709, 928.9117533834309, 939.7885475767931, 941.7598512379368, 943.3726571829725, 970.8786401699788, 987.2052997337141, 987.377951890308, 989.6288891665625, 994.8358520844052, 991.9801603967916, 996.8504724291414, 997.0677416615488, 999.6751055906859, 1007.7430255284892, 726.9563826170447, 739.2718172599984, 739.3715341959345, 740.7703611880335, 740.8592367450167, 16482.505524834272, 16565.503034908972, 16866.578335541588, 16882.240299186567, 17133.828661713473, 14658.340374683059, 14723.484678036324, 14798.260086995715, 14812.407503699838, 14847.851521484863, 11674.416279186007, 11705.3562054087, 11873.881261187364, 11997.160198786089, 12233.082518811036, 2977.151511819121, 3004.173852190643, 3016.9698303016908, 3085.1670049086847, 3121.3352268510152, 106497.0, 107411.46294268478, 112282.0, 112828.0, 114248.85751142465, 10886.183536234814, 11231.21381503287, 11361.715957100972, 11383.54465821358, 11431.314121152758, 24650.137245196333, 24935.127270545807, 25042.0, 25089.0, 25130.37174070663, 7722.382209423233, 7753.806154846061, 7829.686812527549, 7915.287624113742, 8013.439059265796, 4164.167166566699, 4232.513260975027, 4247.3628955656895, 4263.936040959388, 4265.701400901907, 3374.0, 4218.8523401680795, 4223.852165174204, 4227.767472788964, 4228.556001619847, 711.6228398948566, 763.6258233465672, 784.8234147316808, 790.6363072986376, 803.333233416263, 531.9042572336939, 535.1651423778917, 564.2439131563642, 575.9395263497272, 581.1254062635707, 9123.498207598514, 9240.953795231115, 9624.230061595055, 9791.559379827924, 10039.949800251097, 537.8467136865975, 554.2545276602963, 579.6927628356977, 580.3974482354882, 593.2939801636126, 4362.847300344472, 4682.578567928903, 4713.481517033124, 4772.451168115711, 4811.113162451196, 98525.0, 100863.0, 101861.0, 102485.0, 104708.0, 79858.0, 83089.3382132354, 83508.16491835004, 84508.0, 85598.0, 53562.19656705153, 53950.46049539533, 63951.04073438902, 70518.99999999897, 70605.94091088534, 9329.486878221764, 10738.81789137374, 10804.189685773756, 10948.726281843017, 11022.614208502664, 28848.836337275206, 33931.66068339285, 34759.4786078204, 35977.280454391286, 37510.0, 61906.69046654738, 67310.3268967304, 67730.64538709297, 67897.0, 68746.0, 13087.672808179872, 13291.534796282083, 13323.333833308103, 13549.119307244997, 13566.86433135656, 14095.224762637743, 14246.786298205328, 14451.49419770303, 14587.562373128823, 14670.606292402204, 12992.415341309475, 13222.735545289233, 13224.272665003133, 13373.39819708135, 13738.313084345942, 10670.362375556202, 12946.676333091747, 13245.20528768277, 13925.303734813016, 14225.573232803032, 12916.325756819844, 12928.612141635766, 13186.208827470382, 13659.385327660479, 13805.447782089006, 10802.621908233174, 10932.508037138507, 10933.890661093288, 10952.671419857417, 11526.88473115258, 9208.053422904606, 9790.849478242417, 10411.427371494641, 10954.233203675985, 11233.269837460866], "value": 7473.3573603325385, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1616.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 116.0, 116.0, 113.0, 116.0, 117.0, 115.0, 115.0, 116.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 116.0, 115.0, 165.0, 146.0, 128.0, 115.0, 116.0, 160.0, 166.0], "value": 137.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [273.0, 256.0, 214.0, 208.0, 205.0, 207.0, 193.0, 199.0, 198.0, 198.0], "value": 215.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 73.0, 85.0, 61.0, 62.0, 60.0, 58.0, 76.0, 56.0], "value": 67.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 103.0, 81.0, 82.0, 66.0, 64.0, 80.0, 57.0, 107.0, 117.0], "value": 85.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 108.0, 103.0, 135.0, 78.0, 130.0, 136.0, 91.0, 78.0], "value": 104.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 100.0, 97.0, 98.0, 150.0, 138.0, 98.0, 99.0, 98.0, 97.0], "value": 107.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 141.0, 109.0, 143.0, 106.0, 90.0, 91.0, 89.0, 133.0, 145.0], "value": 119.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 72.0, 96.0, 100.0, 101.0, 96.0, 70.0, 67.0], "value": 80.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 59.0, 60.0, 74.0, 58.0, 53.0, 60.0, 86.0, 84.0, 79.0], "value": 68.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 82.0, 85.0, 85.0, 86.0, 87.0, 83.0, 86.0, 85.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 146.0, 149.0, 144.0, 143.0, 151.0, 175.0, 143.0, 205.0, 170.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 192.0, 186.0, 187.0, 192.0, 188.0, 172.0, 242.0, 251.0, 217.0], "value": 201.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 74.0, 73.0, 72.0, 70.0, 73.0, 68.0, 71.0, 72.0, 72.0], "value": 71.6, "unit": "score"}]}]} 05:15:32 INFO - Return code: 0 05:15:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:15:32 ERROR - # TBPL SUCCESS # 05:15:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:15:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:15:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:15:32 INFO - 2017-03-21 05:15:32.982 screenresolution[2025:22871] starting screenresolution argv=screenresolution get 05:15:32 INFO - 2017-03-21 05:15:32.985 screenresolution[2025:22871] Display 0: 1600x1200x32@60 05:15:32 INFO - 2017-03-21 05:15:32.991 screenresolution[2026:22874] starting screenresolution argv=screenresolution list 05:15:32 INFO - Available Modes on Display 0 05:15:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:15:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:15:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:15:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:15:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:15:33 INFO - Intel Iris: 05:15:33 INFO - Chipset Model: Intel Iris 05:15:33 INFO - Type: GPU 05:15:33 INFO - Bus: Built-In 05:15:33 INFO - VRAM (Dynamic, Max): 1536 MB 05:15:33 INFO - Vendor: Intel (0x8086) 05:15:33 INFO - Device ID: 0x0a2e 05:15:33 INFO - Revision ID: 0x0009 05:15:33 INFO - Displays: 05:15:33 INFO - Display: 05:15:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:15:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:15:33 INFO - Display Serial Number: 1600x1200 60 05:15:33 INFO - Main Display: Yes 05:15:33 INFO - Mirror: Off 05:15:33 INFO - Online: Yes 05:15:33 INFO - Rotation: Supported 05:15:33 INFO - Return code: 0 05:15:33 INFO - Running post-action listener: _resource_record_post_action 05:15:33 INFO - [mozharness: 2017-03-21 12:15:33.238092Z] Finished run-tests step (success) 05:15:33 INFO - Running post-run listener: _resource_record_post_run 05:15:33 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 31399936; Write bytes: 515855360; Read time: 192; Write time: 1610 05:15:33 INFO - TinderboxPrint: CPU usage
54.0% 05:15:33 INFO - TinderboxPrint: I/O read bytes / time
31,399,936 / 192 05:15:33 INFO - TinderboxPrint: I/O write bytes / time
515,855,360 / 1,610 05:15:33 INFO - TinderboxPrint: CPU idle
2,209.4 (46.0%) 05:15:33 INFO - TinderboxPrint: CPU system
962.8 (20.0%) 05:15:33 INFO - TinderboxPrint: CPU user
1,633.6 (34.0%) 05:15:33 INFO - TinderboxPrint: Swap in / out
236,507,136 / 0 05:15:33 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 202680832; Write bytes: 203151360; Read time: 15697; Write time: 406 05:15:33 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 31399936; Write bytes: 302763008; Read time: 192; Write time: 1168 05:15:33 INFO - Running post-run listener: _upload_blobber_files 05:15:33 INFO - Blob upload gear active. 05:15:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:15:33 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:15:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:15:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:15:34 INFO - (blobuploader) - INFO - Open directory for files ... 05:15:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:15:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:15:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:15:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:15:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:15:34 INFO - (blobuploader) - INFO - Done attempting. 05:15:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:15:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:15:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:15:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:15:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:15:35 INFO - (blobuploader) - INFO - Done attempting. 05:15:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:15:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:15:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:15:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:15:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:15:36 INFO - (blobuploader) - INFO - Done attempting. 05:15:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:15:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:15:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:15:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:15:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:15:39 INFO - (blobuploader) - INFO - Done attempting. 05:15:39 INFO - (blobuploader) - INFO - Iteration through files over. 05:15:39 INFO - Return code: 0 05:15:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:15:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:15:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75f5331dfb565d0d62b34f1f6edb6589b4266fe780b2bea5d78be3d0d306b8aadff4966b8415ea8359a92a20848aae2058bc2b9bc50b190f9910de7bfb726d0f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a126b576a8c93f711d15c559721f20f4efd7c4996a597cacf06cf797e455de213c581df252e2b4eaf04cadfe43780fc3e024941fa30ca5cc2b5711e74a53012", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d7d0be1832746b0d3d1029f050e6bceaee7c8df81cd9988c5fc4c93644df4e6dc52dfd41c58a76fdc69aa2cf760349d99c02121c5bf4b1a156fabfe4c3a6e90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d455a8041d6c98f2268ae4b88d2b51d4d0fe0e9b60d294ef27296afecc08bc4c2e39e1f6074a5c87b20cb2bcdefc947c0a49c9bbc15317f7bd0b7150f37be436"} 05:15:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:15:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:15:39 INFO - Contents: 05:15:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75f5331dfb565d0d62b34f1f6edb6589b4266fe780b2bea5d78be3d0d306b8aadff4966b8415ea8359a92a20848aae2058bc2b9bc50b190f9910de7bfb726d0f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a126b576a8c93f711d15c559721f20f4efd7c4996a597cacf06cf797e455de213c581df252e2b4eaf04cadfe43780fc3e024941fa30ca5cc2b5711e74a53012", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d7d0be1832746b0d3d1029f050e6bceaee7c8df81cd9988c5fc4c93644df4e6dc52dfd41c58a76fdc69aa2cf760349d99c02121c5bf4b1a156fabfe4c3a6e90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d455a8041d6c98f2268ae4b88d2b51d4d0fe0e9b60d294ef27296afecc08bc4c2e39e1f6074a5c87b20cb2bcdefc947c0a49c9bbc15317f7bd0b7150f37be436"} 05:15:39 INFO - Running post-run listener: copy_logs_to_upload_dir 05:15:39 INFO - Copying logs to upload dir... 05:15:39 INFO - mkdir: /builds/slave/test/build/upload/logs 05:15:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.282721 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-21 05:15:39.120681) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 05:15:39.123773) ========= 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.J4tXAvpqk8/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.Htfuq3qo85/Listeners TMPDIR=/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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/Firefox/sha512/75f5331dfb565d0d62b34f1f6edb6589b4266fe780b2bea5d78be3d0d306b8aadff4966b8415ea8359a92a20848aae2058bc2b9bc50b190f9910de7bfb726d0f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a126b576a8c93f711d15c559721f20f4efd7c4996a597cacf06cf797e455de213c581df252e2b4eaf04cadfe43780fc3e024941fa30ca5cc2b5711e74a53012", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d7d0be1832746b0d3d1029f050e6bceaee7c8df81cd9988c5fc4c93644df4e6dc52dfd41c58a76fdc69aa2cf760349d99c02121c5bf4b1a156fabfe4c3a6e90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d455a8041d6c98f2268ae4b88d2b51d4d0fe0e9b60d294ef27296afecc08bc4c2e39e1f6074a5c87b20cb2bcdefc947c0a49c9bbc15317f7bd0b7150f37be436"} build_url:https://queue.taskcluster.net/v1/task/NK_6f-0TTJWIvzumHztJ8w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011223 build_url: 'https://queue.taskcluster.net/v1/task/NK_6f-0TTJWIvzumHztJ8w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75f5331dfb565d0d62b34f1f6edb6589b4266fe780b2bea5d78be3d0d306b8aadff4966b8415ea8359a92a20848aae2058bc2b9bc50b190f9910de7bfb726d0f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a126b576a8c93f711d15c559721f20f4efd7c4996a597cacf06cf797e455de213c581df252e2b4eaf04cadfe43780fc3e024941fa30ca5cc2b5711e74a53012", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d7d0be1832746b0d3d1029f050e6bceaee7c8df81cd9988c5fc4c93644df4e6dc52dfd41c58a76fdc69aa2cf760349d99c02121c5bf4b1a156fabfe4c3a6e90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d455a8041d6c98f2268ae4b88d2b51d4d0fe0e9b60d294ef27296afecc08bc4c2e39e1f6074a5c87b20cb2bcdefc947c0a49c9bbc15317f7bd0b7150f37be436"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 05:15:39.157984) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 05:15:39.158275) ========= 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.J4tXAvpqk8/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.Htfuq3qo85/Listeners TMPDIR=/var/folders/p7/w1dx92jj7lv8cq11sn2wgyk800000w/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.005261 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 05:15:39.205940) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 05:15:39.206228) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 05:15:39.206546) ========= ========= Total master_lag: 0.18 =========