builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0079 starttime: 1493426006.56 results: success (0) buildid: 20170428170833 builduid: cd2a6231fa3946d6a5ba61468fc0d46d revision: b3b32894d9326d147238d9f071e1814ab3fdc850 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 17:33:26.560424) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 17:33:26.560848) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 17:33:26.561141) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 17:33:26.586561) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:33:26.586901) ========= 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.2k5DDSdgi2/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.eRPt6WYJX3/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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-04-28 17:33:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 12.8M=0.001s 2017-04-28 17:33:26 (12.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124994 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:33:26.736813) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:33:26.737142) ========= 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.2k5DDSdgi2/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.eRPt6WYJX3/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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.022343 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:33:26.786052) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-28 17:33:26.786404) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b3b32894d9326d147238d9f071e1814ab3fdc850 --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 b3b32894d9326d147238d9f071e1814ab3fdc850 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2k5DDSdgi2/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.eRPt6WYJX3/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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-04-28 17:33:26,871 truncating revision to first 12 chars 2017-04-28 17:33:26,871 Setting DEBUG logging. 2017-04-28 17:33:26,871 attempt 1/10 2017-04-28 17:33:26,871 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b3b32894d932?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-28 17:33:27,598 unpacking tar archive at: mozilla-central-b3b32894d932/testing/mozharness/ program finished with exit code 0 elapsedTime=0.979834 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-28 17:33:27.790719) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 17:33:27.791087) ========= script_repo_revision: b3b32894d9326d147238d9f071e1814ab3fdc850 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 17:33:27.791498) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 17:33:27.791777) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 17:33:27.812455) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-04-28 17:33:27.812893) ========= /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.2k5DDSdgi2/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.eRPt6WYJX3/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 17:33:28 INFO - MultiFileLogger online at 20170428 17:33:28 in /builds/slave/test 17:33:28 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 17:33:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:33:28 INFO - {'append_to_log': False, 17:33:28 INFO - 'base_work_dir': '/builds/slave/test', 17:33:28 INFO - 'blob_upload_branch': 'Firefox', 17:33:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:33:28 INFO - 'branch': 'Firefox', 17:33:28 INFO - 'buildbot_json_path': 'buildprops.json', 17:33:28 INFO - 'config_files': ('talos/mac_config.py',), 17:33:28 INFO - 'default_actions': ('clobber', 17:33:28 INFO - 'read-buildbot-config', 17:33:28 INFO - 'download-and-extract', 17:33:28 INFO - 'populate-webroot', 17:33:28 INFO - 'create-virtualenv', 17:33:28 INFO - 'install', 17:33:28 INFO - 'run-tests'), 17:33:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:33:28 INFO - 'download_minidump_stackwalk': True, 17:33:28 INFO - 'download_symbols': 'ondemand', 17:33:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:33:28 INFO - 'tooltool.py': '/tools/tooltool.py', 17:33:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:33:28 INFO - '/tools/misc-python/virtualenv.py')}, 17:33:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:33:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:33:28 INFO - 'gecko_profile': False, 17:33:28 INFO - 'gecko_profile_interval': 0, 17:33:28 INFO - 'installer_path': 'installer.exe', 17:33:28 INFO - 'log_level': 'info', 17:33:28 INFO - 'log_name': 'talos', 17:33:28 INFO - 'log_to_console': True, 17:33:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:33:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:33:28 INFO - 'opt_config_files': (), 17:33:28 INFO - 'pip_index': False, 17:33:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:33:28 INFO - 'cmd': ('bash', 17:33:28 INFO - '-c', 17:33:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:33:28 INFO - 'enabled': True, 17:33:28 INFO - 'halt_on_failure': False, 17:33:28 INFO - 'name': 'check_screen_resolution'},), 17:33:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:33:28 INFO - 'cmd': ('bash', 17:33:28 INFO - '-c', 17:33:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:33:28 INFO - 'enabled': True, 17:33:28 INFO - 'halt_on_failure': False, 17:33:28 INFO - 'name': 'check_screen_resolution'},), 17:33:28 INFO - 'run_cmd_checks_enabled': True, 17:33:28 INFO - 'suite': 'dromaeojs-e10s', 17:33:28 INFO - 'system_bits': '32', 17:33:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:33:28 INFO - 'title': 't-yosemite-r7-0079', 17:33:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:33:28 INFO - 'use_talos_json': True, 17:33:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:33:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:33:28 INFO - 'work_dir': 'build'} 17:33:28 INFO - [mozharness: 2017-04-29 00:33:28.026927Z] Running clobber step. 17:33:28 INFO - Running pre-action listener: _resource_record_pre_action 17:33:28 INFO - Running main action method: clobber 17:33:28 INFO - rmtree: /builds/slave/test/build 17:33:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:33:29 INFO - Running post-action listener: _resource_record_post_action 17:33:29 INFO - [mozharness: 2017-04-29 00:33:29.972236Z] Finished clobber step (success) 17:33:29 INFO - [mozharness: 2017-04-29 00:33:29.972345Z] Running read-buildbot-config step. 17:33:29 INFO - Running pre-action listener: _resource_record_pre_action 17:33:29 INFO - Running main action method: read_buildbot_config 17:33:29 INFO - Using buildbot properties: 17:33:29 INFO - { 17:33:29 INFO - "project": "", 17:33:29 INFO - "product": "firefox", 17:33:29 INFO - "script_repo_revision": "production", 17:33:29 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 17:33:29 INFO - "repository": "", 17:33:29 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 17:33:29 INFO - "buildid": "20170428170833", 17:33:29 INFO - "stage_platform": "macosx64", 17:33:29 INFO - "basedir": "/builds/slave/test", 17:33:29 INFO - "buildnumber": 52, 17:33:29 INFO - "platform": "yosemite_r7", 17:33:29 INFO - "mozci_request": { 17:33:29 INFO - "priority": 0, 17:33:29 INFO - "type": "trigger_all_talos_jobs", 17:33:29 INFO - "times": 6 17:33:29 INFO - }, 17:33:29 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 17:33:29 INFO - "slavebuilddir": "test", 17:33:29 INFO - "branch": "mozilla-central", 17:33:29 INFO - "revision": "b3b32894d9326d147238d9f071e1814ab3fdc850", 17:33:29 INFO - "slavename": "t-yosemite-r7-0079", 17:33:29 INFO - "builduid": "cd2a6231fa3946d6a5ba61468fc0d46d", 17:33:29 INFO - "repo_path": "mozilla-central" 17:33:29 INFO - } 17:33:29 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg. 17:33:29 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.test_packages.json. 17:33:29 INFO - Running post-action listener: _resource_record_post_action 17:33:29 INFO - [mozharness: 2017-04-29 00:33:29.975633Z] Finished read-buildbot-config step (success) 17:33:29 INFO - [mozharness: 2017-04-29 00:33:29.975732Z] Running download-and-extract step. 17:33:29 INFO - Running pre-action listener: _resource_record_pre_action 17:33:29 INFO - Running main action method: download_and_extract 17:33:29 INFO - mkdir: /builds/slave/test/build/tests 17:33:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:33:29 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.test_packages.json 17:33:29 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:33:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/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 17:33:30 INFO - Downloaded 1325 bytes. 17:33:30 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:33:30 INFO - Using the following test package requirements: 17:33:30 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:33:30 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 17:33:30 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:33:30 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:33:30 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 17:33:30 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:33:30 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 17:33:30 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:33:30 INFO - u'jsshell-mac.zip'], 17:33:30 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:33:30 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 17:33:30 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:33:30 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:33:30 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 17:33:30 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:33:30 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 17:33:30 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:33:30 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 17:33:30 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:33:30 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 17:33:30 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:33:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.common.tests.zip 17:33:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:33:30 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:33:31 INFO - Content-Length response header: 52698163 17:33:31 INFO - Bytes received: 52698163 17:33:48 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 17:33:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.common.tests.zip 17:33:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:33:48 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:33:49 INFO - Content-Length response header: 52698163 17:33:49 INFO - Bytes received: 52698163 17:34:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.talos.tests.zip 17:34:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:34:05 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 17:34:05 INFO - Content-Length response header: 14408809 17:34:05 INFO - Bytes received: 14408809 17:34: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')]} 17:34:06 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg 17:34:06 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 17:34:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 17:34:07 INFO - Downloaded 71219323 bytes. 17:34:07 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg 17:34:07 INFO - mkdir: /builds/slave/test/properties 17:34:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:34:07 INFO - Writing to file /builds/slave/test/properties/build_url 17:34:07 INFO - Contents: 17:34:07 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg 17:34:07 INFO - Running post-action listener: _resource_record_post_action 17:34:07 INFO - Running post-action listener: set_extra_try_arguments 17:34:07 INFO - [mozharness: 2017-04-29 00:34:07.886198Z] Finished download-and-extract step (success) 17:34:07 INFO - [mozharness: 2017-04-29 00:34:07.886346Z] Running populate-webroot step. 17:34:07 INFO - Running pre-action listener: _resource_record_pre_action 17:34:07 INFO - Running main action method: populate_webroot 17:34:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:34:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:34:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:34:07 INFO - '--tppagecycles', 17:34:07 INFO - '7'], 17:34:07 INFO - 'tests': ['tsvgm']}}, 17:34:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:34:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:34:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:34:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:34:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:34:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:34:07 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:34:07 INFO - 'talos_options': ['--disable-e10s'], 17:34:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:34:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:34:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:34:07 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:34:07 INFO - 'talos_options': ['--disable-e10s'], 17:34:07 INFO - 'tests': ['damp', 'tps']}, 17:34:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:34:07 INFO - 'tests': ['damp', 'tps']}, 17:34:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:34:07 INFO - 'tests': ['dromaeo_dom']}, 17:34:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:34:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:34:07 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:34:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:34:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:34:07 INFO - 'tests': ['a11yr', 17:34:07 INFO - 'ts_paint', 17:34:07 INFO - 'tpaint', 17:34:07 INFO - 'sessionrestore', 17:34:07 INFO - 'sessionrestore_no_auto_restore', 17:34:07 INFO - 'tabpaint']}, 17:34:07 INFO - 'other-e10s': {'tests': ['a11yr', 17:34:07 INFO - 'ts_paint', 17:34:07 INFO - 'tpaint', 17:34:07 INFO - 'sessionrestore', 17:34:07 INFO - 'sessionrestore_no_auto_restore', 17:34:07 INFO - 'tabpaint']}, 17:34:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:34:07 INFO - 'ts_paint', 17:34:07 INFO - 'tpaint', 17:34:07 INFO - 'sessionrestore', 17:34:07 INFO - 'sessionrestore_no_auto_restore', 17:34:07 INFO - 'tabpaint']}, 17:34:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:34:07 INFO - 'ts_paint', 17:34:07 INFO - 'tpaint', 17:34:07 INFO - 'sessionrestore', 17:34:07 INFO - 'sessionrestore_no_auto_restore', 17:34:07 INFO - 'tabpaint']}, 17:34:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:34:07 INFO - 'tests': ['a11yr', 17:34:07 INFO - 'ts_paint', 17:34:07 INFO - 'tpaint', 17:34:07 INFO - 'sessionrestore', 17:34:07 INFO - 'sessionrestore_no_auto_restore', 17:34:07 INFO - 'tabpaint']}, 17:34:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:34:07 INFO - 'tests': ['a11yr', 17:34:07 INFO - 'ts_paint', 17:34:07 INFO - 'tpaint', 17:34:07 INFO - 'sessionrestore', 17:34:07 INFO - 'sessionrestore_no_auto_restore', 17:34:07 INFO - 'tabpaint']}, 17:34:07 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 17:34:07 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 17:34:07 INFO - 'bloom_basic_ref']}, 17:34:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:34:07 INFO - 'tests': ['tsvgx', 17:34:07 INFO - 'tsvgr_opacity', 17:34:07 INFO - 'tart', 17:34:07 INFO - 'tscrollx', 17:34:07 INFO - 'cart', 17:34:07 INFO - 'tsvg_static']}, 17:34:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:34:07 INFO - 'tsvgr_opacity', 17:34:07 INFO - 'tart', 17:34:07 INFO - 'tscrollx', 17:34:07 INFO - 'cart', 17:34:07 INFO - 'tsvg_static']}, 17:34:07 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:34:07 INFO - 'talos_options': ['--disable-e10s'], 17:34:07 INFO - 'tests': ['tp5o']}, 17:34:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:34:07 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:34:07 INFO - 'talos_options': ['--disable-e10s', 17:34:07 INFO - '--xperf_path', 17:34:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:34:07 INFO - 'tests': ['tp5n']}, 17:34:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:34:07 INFO - 'talos_options': ['--xperf_path', 17:34:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:34:07 INFO - 'tests': ['tp5n']}}, 17:34:07 INFO - 'talos.zip': {'path': '', 17:34:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:34:07 INFO - Running post-action listener: _resource_record_post_action 17:34:07 INFO - [mozharness: 2017-04-29 00:34:07.905646Z] Finished populate-webroot step (success) 17:34:07 INFO - [mozharness: 2017-04-29 00:34:07.905761Z] Running create-virtualenv step. 17:34:07 INFO - Running pre-action listener: _resource_record_pre_action 17:34:07 INFO - Running main action method: create_virtualenv 17:34:07 INFO - Creating virtualenv /builds/slave/test/build/venv 17:34:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:34:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:34:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:34:08 INFO - Using real prefix '/tools/python27' 17:34:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:34:08 INFO - Installing distribute.............................................................................................................................................................................................done. 17:34:11 INFO - Installing pip.................done. 17:34:11 INFO - Return code: 0 17:34:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:34:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:34:11 INFO - Reading from file tmpfile_stdout 17:34:11 INFO - Output received: 17:34:11 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 17:34:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:11 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 0x10562cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10562f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faac2d5b060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10540ad30>, '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 0x105330db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053ffbe8>, '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.2k5DDSdgi2/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.eRPt6WYJX3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:34:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:34:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:34:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2k5DDSdgi2/Render', 17:34:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:11 INFO - 'HOME': '/Users/cltbld', 17:34:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:11 INFO - 'LOGNAME': 'cltbld', 17:34:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:11 INFO - 'MOZ_NO_REMOTE': '1', 17:34:11 INFO - 'NO_EM_RESTART': '1', 17:34:11 INFO - 'PAGER': '/bin/cat', 17:34:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:11 INFO - 'PWD': '/builds/slave/test', 17:34:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:11 INFO - 'SHELL': '/bin/bash', 17:34:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRPt6WYJX3/Listeners', 17:34:11 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 17:34:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:11 INFO - 'USER': 'cltbld', 17:34:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:11 INFO - 'XPC_FLAGS': '0x0', 17:34:11 INFO - 'XPC_SERVICE_NAME': '0', 17:34:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:34:12 INFO - Cleaning up... 17:34:12 INFO - Return code: 0 17:34:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:12 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 0x10562cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10562f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faac2d5b060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10540ad30>, '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 0x105330db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053ffbe8>, '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.2k5DDSdgi2/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.eRPt6WYJX3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:34:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:34:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:34:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2k5DDSdgi2/Render', 17:34:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:12 INFO - 'HOME': '/Users/cltbld', 17:34:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:12 INFO - 'LOGNAME': 'cltbld', 17:34:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:12 INFO - 'MOZ_NO_REMOTE': '1', 17:34:12 INFO - 'NO_EM_RESTART': '1', 17:34:12 INFO - 'PAGER': '/bin/cat', 17:34:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:12 INFO - 'PWD': '/builds/slave/test', 17:34:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:12 INFO - 'SHELL': '/bin/bash', 17:34:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRPt6WYJX3/Listeners', 17:34:12 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 17:34:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:12 INFO - 'USER': 'cltbld', 17:34:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:12 INFO - 'XPC_FLAGS': '0x0', 17:34:12 INFO - 'XPC_SERVICE_NAME': '0', 17:34:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:12 INFO - Downloading/unpacking psutil>=3.1.1 17:34: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 17:34: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 17:34: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 17:34: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 17:34: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 17:34: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 17:34:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:34:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:34:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:34:15 INFO - Installing collected packages: psutil 17:34:15 INFO - Running setup.py install for psutil 17:34:15 INFO - building 'psutil._psutil_osx' extension 17:34:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 17:34:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 17:34:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 17:34:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 17:34:16 INFO - building 'psutil._psutil_posix' extension 17:34:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 17:34:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:34:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:34:16 INFO - ^ 17:34:16 INFO - 1 warning generated. 17:34:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 17:34:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:34:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:34:16 INFO - Successfully installed psutil 17:34:16 INFO - Cleaning up... 17:34:16 INFO - Return code: 0 17:34:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:34:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10562cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10562f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faac2d5b060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10540ad30>, '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 0x105330db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053ffbe8>, '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.2k5DDSdgi2/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.eRPt6WYJX3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:34:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:34:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:34:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2k5DDSdgi2/Render', 17:34:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:16 INFO - 'HOME': '/Users/cltbld', 17:34:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:16 INFO - 'LOGNAME': 'cltbld', 17:34:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:16 INFO - 'MOZ_NO_REMOTE': '1', 17:34:16 INFO - 'NO_EM_RESTART': '1', 17:34:16 INFO - 'PAGER': '/bin/cat', 17:34:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:16 INFO - 'PWD': '/builds/slave/test', 17:34:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:16 INFO - 'SHELL': '/bin/bash', 17:34:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRPt6WYJX3/Listeners', 17:34:16 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 17:34:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:16 INFO - 'USER': 'cltbld', 17:34:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:16 INFO - 'XPC_FLAGS': '0x0', 17:34:16 INFO - 'XPC_SERVICE_NAME': '0', 17:34:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:34:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:34:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:34:19 INFO - Installing collected packages: mozsystemmonitor 17:34:19 INFO - Running setup.py install for mozsystemmonitor 17:34:19 INFO - Successfully installed mozsystemmonitor 17:34:19 INFO - Cleaning up... 17:34:19 INFO - Return code: 0 17:34:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:34:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:19 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 0x10562cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10562f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faac2d5b060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10540ad30>, '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 0x105330db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053ffbe8>, '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.2k5DDSdgi2/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.eRPt6WYJX3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:34:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:34:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:34:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2k5DDSdgi2/Render', 17:34:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:19 INFO - 'HOME': '/Users/cltbld', 17:34:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:19 INFO - 'LOGNAME': 'cltbld', 17:34:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:19 INFO - 'MOZ_NO_REMOTE': '1', 17:34:19 INFO - 'NO_EM_RESTART': '1', 17:34:19 INFO - 'PAGER': '/bin/cat', 17:34:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:19 INFO - 'PWD': '/builds/slave/test', 17:34:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:19 INFO - 'SHELL': '/bin/bash', 17:34:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRPt6WYJX3/Listeners', 17:34:19 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 17:34:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:19 INFO - 'USER': 'cltbld', 17:34:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:19 INFO - 'XPC_FLAGS': '0x0', 17:34:19 INFO - 'XPC_SERVICE_NAME': '0', 17:34:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:20 INFO - Downloading/unpacking jsonschema==2.5.1 17:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:34:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:23 INFO - Downloading functools32-3.2.3-2.tar.gz 17:34:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:34:23 INFO - warning: no files found matching '*.txt' 17:34:23 INFO - no previously-included directories found matching 'build' 17:34:23 INFO - no previously-included directories found matching 'dist' 17:34:23 INFO - no previously-included directories found matching '.git*' 17:34:23 INFO - Installing collected packages: jsonschema, functools32 17:34:23 INFO - Running setup.py install for functools32 17:34:23 INFO - warning: no files found matching '*.txt' 17:34:23 INFO - no previously-included directories found matching 'build' 17:34:23 INFO - no previously-included directories found matching 'dist' 17:34:23 INFO - no previously-included directories found matching '.git*' 17:34:23 INFO - Successfully installed jsonschema functools32 17:34:23 INFO - Cleaning up... 17:34:23 INFO - Return code: 0 17:34:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:34:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:24 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 0x10562cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10562f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faac2d5b060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10540ad30>, '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 0x105330db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053ffbe8>, '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.2k5DDSdgi2/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.eRPt6WYJX3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:34:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:34:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:34:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2k5DDSdgi2/Render', 17:34:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:24 INFO - 'HOME': '/Users/cltbld', 17:34:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:24 INFO - 'LOGNAME': 'cltbld', 17:34:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:24 INFO - 'MOZ_NO_REMOTE': '1', 17:34:24 INFO - 'NO_EM_RESTART': '1', 17:34:24 INFO - 'PAGER': '/bin/cat', 17:34:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:24 INFO - 'PWD': '/builds/slave/test', 17:34:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:24 INFO - 'SHELL': '/bin/bash', 17:34:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRPt6WYJX3/Listeners', 17:34:24 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 17:34:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:24 INFO - 'USER': 'cltbld', 17:34:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:24 INFO - 'XPC_FLAGS': '0x0', 17:34:24 INFO - 'XPC_SERVICE_NAME': '0', 17:34:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:34:24 INFO - Cleaning up... 17:34:24 INFO - Return code: 0 17:34:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:24 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 0x10562cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10562f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faac2d5b060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10540ad30>, '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 0x105330db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053ffbe8>, '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.2k5DDSdgi2/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.eRPt6WYJX3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:34:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:34:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:34:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2k5DDSdgi2/Render', 17:34:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:24 INFO - 'HOME': '/Users/cltbld', 17:34:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:24 INFO - 'LOGNAME': 'cltbld', 17:34:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:24 INFO - 'MOZ_NO_REMOTE': '1', 17:34:24 INFO - 'NO_EM_RESTART': '1', 17:34:24 INFO - 'PAGER': '/bin/cat', 17:34:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:24 INFO - 'PWD': '/builds/slave/test', 17:34:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:24 INFO - 'SHELL': '/bin/bash', 17:34:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRPt6WYJX3/Listeners', 17:34:24 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 17:34:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:24 INFO - 'USER': 'cltbld', 17:34:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:24 INFO - 'XPC_FLAGS': '0x0', 17:34:24 INFO - 'XPC_SERVICE_NAME': '0', 17:34:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:25 INFO - Downloading/unpacking blobuploader==1.2.4 17:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:28 INFO - Downloading blobuploader-1.2.4.tar.gz 17:34:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:34:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:34:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:29 INFO - Downloading docopt-0.6.1.tar.gz 17:34:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:34:29 INFO - Installing collected packages: blobuploader, requests, docopt 17:34:29 INFO - Running setup.py install for blobuploader 17:34:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:34:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:34:29 INFO - Running setup.py install for requests 17:34:30 INFO - Running setup.py install for docopt 17:34:30 INFO - Successfully installed blobuploader requests docopt 17:34:30 INFO - Cleaning up... 17:34:30 INFO - Return code: 0 17:34:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:34: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')]} 17:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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')]} 17:34:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:30 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 0x10562cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10562f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faac2d5b060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10540ad30>, '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 0x105330db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053ffbe8>, '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.2k5DDSdgi2/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.eRPt6WYJX3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:34:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:34:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:34:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2k5DDSdgi2/Render', 17:34:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:30 INFO - 'HOME': '/Users/cltbld', 17:34:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:30 INFO - 'LOGNAME': 'cltbld', 17:34:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:30 INFO - 'MOZ_NO_REMOTE': '1', 17:34:30 INFO - 'NO_EM_RESTART': '1', 17:34:30 INFO - 'PAGER': '/bin/cat', 17:34:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:30 INFO - 'PWD': '/builds/slave/test', 17:34:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:30 INFO - 'SHELL': '/bin/bash', 17:34:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRPt6WYJX3/Listeners', 17:34:30 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 17:34:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:30 INFO - 'USER': 'cltbld', 17:34:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:30 INFO - 'XPC_FLAGS': '0x0', 17:34:30 INFO - 'XPC_SERVICE_NAME': '0', 17:34:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:34:30 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-1MdI1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:34:30 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-qQw3_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:34:30 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-iya0fp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:34:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:34:30 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-gDYYO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:34:31 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-wifoPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:34:31 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-ZxxslK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:34:31 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-a9pACq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:34:31 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-jYb1Zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:34:31 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-_hH7a2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:34:31 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-xj8eb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:34:31 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-fJT6Sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:34:31 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-EUQJhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:34:31 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-UeBazx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:34:31 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-X9PzIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:34:32 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-EC9CRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:34:32 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-Nk3PzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:34:32 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-imlR7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:34:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:34:32 INFO - Running setup.py install for manifestparser 17:34:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:34:32 INFO - Running setup.py install for mozcrash 17:34:32 INFO - Running setup.py install for mozdebug 17:34:32 INFO - Running setup.py install for mozdevice 17:34:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:34:32 INFO - Running setup.py install for mozfile 17:34:33 INFO - Running setup.py install for mozhttpd 17:34:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:34:33 INFO - Running setup.py install for mozinfo 17:34:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:34:33 INFO - Running setup.py install for mozInstall 17:34:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:34:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:34:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:34:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:34:33 INFO - Running setup.py install for mozleak 17:34:33 INFO - Running setup.py install for mozlog 17:34:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:34:33 INFO - Running setup.py install for moznetwork 17:34:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:34:34 INFO - Running setup.py install for mozprocess 17:34:34 INFO - Running setup.py install for mozprofile 17:34:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:34:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:34:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:34:34 INFO - Running setup.py install for mozrunner 17:34:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:34:34 INFO - Running setup.py install for mozscreenshot 17:34:34 INFO - Running setup.py install for moztest 17:34:34 INFO - Running setup.py install for mozversion 17:34:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:34:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:34:34 INFO - Cleaning up... 17:34:34 INFO - Return code: 0 17:34:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:34:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:34 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 0x10562cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10562f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faac2d5b060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10540ad30>, '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 0x105330db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053ffbe8>, '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.2k5DDSdgi2/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.eRPt6WYJX3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:34:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:34:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:34:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2k5DDSdgi2/Render', 17:34:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:34 INFO - 'HOME': '/Users/cltbld', 17:34:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:34 INFO - 'LOGNAME': 'cltbld', 17:34:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:34 INFO - 'MOZ_NO_REMOTE': '1', 17:34:34 INFO - 'NO_EM_RESTART': '1', 17:34:34 INFO - 'PAGER': '/bin/cat', 17:34:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:34 INFO - 'PWD': '/builds/slave/test', 17:34:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:34 INFO - 'SHELL': '/bin/bash', 17:34:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRPt6WYJX3/Listeners', 17:34:34 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 17:34:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:34 INFO - 'USER': 'cltbld', 17:34:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:34 INFO - 'XPC_FLAGS': '0x0', 17:34:34 INFO - 'XPC_SERVICE_NAME': '0', 17:34:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:34:35 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-iuuzcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:34:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:34:35 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-3R52jX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:34:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:34:35 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-s0Fb4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:34:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:34:35 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-diiJd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:34:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:34:35 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-1QgjVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:34:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:34:35 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-602egy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:34:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:34:35 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-t41VEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:34:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:34:35 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-WwUmIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:34:36 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-TwsObr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:34:36 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-fAdEEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:34:36 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-FgVPeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:34:36 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-ORmFE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:34:36 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)) 17:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:34:36 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-cyZf6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:34:36 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-OoqLGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:34:36 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-Znp4MT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:34:36 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-ANrunL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:34:36 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-tRUMRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:34:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:34:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:34:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:34:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:34:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:34:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:34:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:34:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:34:39 INFO - Downloading blessings-1.6.tar.gz 17:34:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:34:39 INFO - Installing collected packages: blessings 17:34:39 INFO - Running setup.py install for blessings 17:34:39 INFO - Successfully installed blessings 17:34:39 INFO - Cleaning up... 17:34:40 INFO - Return code: 0 17:34:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:34:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:34:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:34:40 INFO - Reading from file tmpfile_stdout 17:34:40 INFO - Current package versions: 17:34:40 INFO - blessings == 1.6 17:34:40 INFO - blobuploader == 1.2.4 17:34:40 INFO - docopt == 0.6.1 17:34:40 INFO - functools32 == 3.2.3-2 17:34:40 INFO - jsonschema == 2.5.1 17:34:40 INFO - manifestparser == 1.1 17:34:40 INFO - mozInstall == 1.12 17:34:40 INFO - mozcrash == 1.0 17:34:40 INFO - mozdebug == 0.1 17:34:40 INFO - mozdevice == 0.50 17:34:40 INFO - mozfile == 1.2 17:34:40 INFO - mozhttpd == 0.7 17:34:40 INFO - mozinfo == 0.9 17:34:40 INFO - mozleak == 0.1 17:34:40 INFO - mozlog == 3.4 17:34:40 INFO - moznetwork == 0.27 17:34:40 INFO - mozprocess == 0.25 17:34:40 INFO - mozprofile == 0.28 17:34:40 INFO - mozrunner == 6.13 17:34:40 INFO - mozscreenshot == 0.1 17:34:40 INFO - mozsystemmonitor == 0.3 17:34:40 INFO - moztest == 0.8 17:34:40 INFO - mozversion == 1.4 17:34:40 INFO - psutil == 3.1.1 17:34:40 INFO - requests == 1.2.3 17:34:40 INFO - wsgiref == 0.1.2 17:34:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:40 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 0x10562cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10562f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faac2d5b060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10540ad30>, '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 0x105330db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053ffbe8>, '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.2k5DDSdgi2/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.eRPt6WYJX3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:34:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:34:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:34:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2k5DDSdgi2/Render', 17:34:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:40 INFO - 'HOME': '/Users/cltbld', 17:34:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:40 INFO - 'LOGNAME': 'cltbld', 17:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:40 INFO - 'MOZ_NO_REMOTE': '1', 17:34:40 INFO - 'NO_EM_RESTART': '1', 17:34:40 INFO - 'PAGER': '/bin/cat', 17:34:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:40 INFO - 'PWD': '/builds/slave/test', 17:34:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:40 INFO - 'SHELL': '/bin/bash', 17:34:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRPt6WYJX3/Listeners', 17:34:40 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 17:34:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:40 INFO - 'USER': 'cltbld', 17:34:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:40 INFO - 'XPC_FLAGS': '0x0', 17:34:40 INFO - 'XPC_SERVICE_NAME': '0', 17:34:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:34:40 INFO - Cleaning up... 17:34:40 INFO - Return code: 0 17:34:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:34:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10562cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10562f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faac2d5b060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10540ad30>, '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 0x105330db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053ffbe8>, '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.2k5DDSdgi2/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.eRPt6WYJX3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:34:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:34:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:34:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2k5DDSdgi2/Render', 17:34:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:34:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:34:40 INFO - 'HOME': '/Users/cltbld', 17:34:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:34:40 INFO - 'LOGNAME': 'cltbld', 17:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:40 INFO - 'MOZ_NO_REMOTE': '1', 17:34:40 INFO - 'NO_EM_RESTART': '1', 17:34:40 INFO - 'PAGER': '/bin/cat', 17:34:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:40 INFO - 'PWD': '/builds/slave/test', 17:34:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:34:40 INFO - 'SHELL': '/bin/bash', 17:34:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRPt6WYJX3/Listeners', 17:34:40 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 17:34:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:34:40 INFO - 'USER': 'cltbld', 17:34:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:34:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:40 INFO - 'XPC_FLAGS': '0x0', 17:34:40 INFO - 'XPC_SERVICE_NAME': '0', 17:34:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:34:40 INFO - Cleaning up... 17:34:40 INFO - Return code: 0 17:34:40 INFO - Running post-action listener: _resource_record_post_action 17:34:40 INFO - Running post-action listener: _start_resource_monitoring 17:34:40 INFO - Starting resource monitoring. 17:34:40 INFO - [mozharness: 2017-04-29 00:34:40.834570Z] Finished create-virtualenv step (success) 17:34:40 INFO - [mozharness: 2017-04-29 00:34:40.835538Z] Running install step. 17:34:40 INFO - Running pre-action listener: _resource_record_pre_action 17:34:40 INFO - Running main action method: install 17:34:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:34:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:34:41 INFO - Reading from file tmpfile_stdout 17:34:41 INFO - Detecting whether we're running mozinstall >=1.0... 17:34:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:34:41 INFO - Reading from file tmpfile_stdout 17:34:41 INFO - Output received: 17:34:41 INFO - Usage: mozinstall [options] installer 17:34:41 INFO - Options: 17:34:41 INFO - -h, --help show this help message and exit 17:34:41 INFO - -d DEST, --destination=DEST 17:34:41 INFO - Directory to install application into. [default: 17:34:41 INFO - "/builds/slave/test"] 17:34:41 INFO - --app=APP Application being installed. [default: firefox] 17:34:41 INFO - mkdir: /builds/slave/test/build/application 17:34:41 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'] 17:34:41 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 17:35:00 INFO - Reading from file tmpfile_stdout 17:35:00 INFO - Output received: 17:35:00 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:35:00 INFO - Running post-action listener: _resource_record_post_action 17:35:00 INFO - [mozharness: 2017-04-29 00:35:00.991358Z] Finished install step (success) 17:35:00 INFO - [mozharness: 2017-04-29 00:35:00.991487Z] Running run-tests step. 17:35:00 INFO - Running pre-action listener: _resource_record_pre_action 17:35:00 INFO - Running main action method: run_tests 17:35:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:35:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:35:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:35:01 INFO - 2017-04-28 17:35:01.006 screenresolution[2431:32990] starting screenresolution argv=screenresolution get 17:35:01 INFO - 2017-04-28 17:35:01.008 screenresolution[2431:32990] Display 0: 1600x1200x32@60 17:35:01 INFO - 2017-04-28 17:35:01.014 screenresolution[2432:32992] starting screenresolution argv=screenresolution list 17:35:01 INFO - Available Modes on Display 0 17:35:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:35:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:35:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:35:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:35:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:35:01 INFO - Intel Iris: 17:35:01 INFO - Chipset Model: Intel Iris 17:35:01 INFO - Type: GPU 17:35:01 INFO - Bus: Built-In 17:35:01 INFO - VRAM (Dynamic, Max): 1536 MB 17:35:01 INFO - Vendor: Intel (0x8086) 17:35:01 INFO - Device ID: 0x0a2e 17:35:01 INFO - Revision ID: 0x0009 17:35:01 INFO - Displays: 17:35:01 INFO - Display: 17:35:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:35:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:35:01 INFO - Display Serial Number: 1600x1200 60 17:35:01 INFO - Main Display: Yes 17:35:01 INFO - Mirror: Off 17:35:01 INFO - Online: Yes 17:35:01 INFO - Rotation: Supported 17:35:01 INFO - Return code: 0 17:35:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:35:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:35:01 INFO - Python 2.7.3 17:35:01 INFO - Return code: 0 17:35:01 INFO - grabbing minidump binary from tooltool 17:35: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')]} 17:35:01 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 0x10540ad30>, '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 0x105330db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053ffbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:35:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:35:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 17:35:01 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:35:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:35:01 INFO - Return code: 0 17:35:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:35:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:35:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:35:01 INFO - ENV: RUST_BACKTRACE is now 1 17:35:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:35:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:35:01 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0079', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:35:01 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0079 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:35:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2k5DDSdgi2/Render', 17:35:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:35:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:35:01 INFO - 'HOME': '/Users/cltbld', 17:35:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:35:01 INFO - 'LOGNAME': 'cltbld', 17:35:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:35:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:01 INFO - 'MOZ_NO_REMOTE': '1', 17:35:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:35:01 INFO - 'NO_EM_RESTART': '1', 17:35:01 INFO - 'PAGER': '/bin/cat', 17:35:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:01 INFO - 'PWD': '/builds/slave/test', 17:35:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:35:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:35:01 INFO - 'RUST_BACKTRACE': '1', 17:35:01 INFO - 'SHELL': '/bin/bash', 17:35:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRPt6WYJX3/Listeners', 17:35:01 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 17:35:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:35:01 INFO - 'USER': 'cltbld', 17:35:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:35:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:01 INFO - 'XPC_FLAGS': '0x0', 17:35:01 INFO - 'XPC_SERVICE_NAME': '0', 17:35:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:35:01 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0079', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:35:01 INFO - mozversion application_buildid: 20170428075320 17:35:01 INFO - mozversion application_changeset: b3b32894d9326d147238d9f071e1814ab3fdc850 17:35:01 INFO - mozversion application_display_name: Nightly 17:35:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:35:01 INFO - mozversion application_name: Firefox 17:35:01 INFO - mozversion application_remotingname: firefox 17:35:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:35:01 INFO - mozversion application_vendor: Mozilla 17:35:01 INFO - mozversion application_version: 55.0a1 17:35:01 INFO - mozversion platform_buildid: 20170428075320 17:35:01 INFO - mozversion platform_changeset: b3b32894d9326d147238d9f071e1814ab3fdc850 17:35:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:35:01 INFO - mozversion platform_version: 55.0a1 17:35:01 INFO - using testdate: 1493426101 17:35:01 INFO - actual date: 1493426101 17:35:01 INFO - starting webserver on 'localhost:58923' 17:35:01 INFO - SUITE-START | Running 2 tests 17:35:01 INFO - TEST-START | dromaeo_css 17:35:01 INFO - operating with platform_type : mac_ 17:35:01 INFO - Initialising browser for dromaeo_css test... 17:35:01 INFO - TEST-INFO | started process 2442 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpjb8Si_/profile http://localhost:58923/getInfo.html) 17:35:04 INFO - PID 2442 | 2017-04-28 17:35:04.007 plugin-container[2444:33165] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x973f, name = 'com.apple.tsm.portname' 17:35:04 INFO - PID 2442 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:35:04 INFO - PID 2442 | 2017-04-28 17:35:04.012 plugin-container[2444:33165] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9d0b, name = 'com.apple.CFPasteboardClient' 17:35:04 INFO - PID 2442 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:35:04 INFO - PID 2442 | 2017-04-28 17:35:04.012 plugin-container[2444:33165] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:35:04 INFO - PID 2442 | __metrics Screen width/height:1600/1200 17:35:04 INFO - PID 2442 | colorDepth:24 17:35:04 INFO - PID 2442 | Browser inner width/height: 1024/689 17:35:04 INFO - PID 2442 | __metrics 17:35:04 ERROR - PID 2442 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 17:35:05 INFO - TEST-INFO | 2442: exit 0 17:35:05 INFO - Browser initialized. 17:35:05 INFO - Running cycle 1/1 for dromaeo_css test... 17:35:05 INFO - TEST-INFO | started process 2445 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpjb8Si_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:35:07 INFO - PID 2445 | 2017-04-28 17:35:07.756 plugin-container[2446:33298] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 17:35:07 INFO - PID 2445 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:35:07 INFO - PID 2445 | 2017-04-28 17:35:07.757 plugin-container[2446:33298] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 17:35:07 INFO - PID 2445 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:35:07 INFO - PID 2445 | 2017-04-28 17:35:07.757 plugin-container[2446:33298] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:35:17 INFO - PID 2445 | RSS: Main: 251416576 17:35:17 INFO - PID 2445 | 17:38:22 INFO - PID 2445 | Cycle 1(1): loaded http://localhost:58923/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58923/tests/dromaeo/cssquery-ext.html) 17:38:23 INFO - PID 2445 | RSS: Main: 254455808 17:38:23 INFO - PID 2445 | 17:40:06 INFO - PID 2445 | ************************* 17:40:06 INFO - PID 2445 | A coding exception was thrown and uncaught in a Task. 17:40:06 INFO - PID 2445 | 17:40:06 ERROR - PID 2445 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:40:06 INFO - PID 2445 | Full stack: 17:40:06 INFO - PID 2445 | ************************* 17:40:06 INFO - PID 2445 | ************************* 17:40:06 INFO - PID 2445 | A coding exception was thrown and uncaught in a Task. 17:40:06 INFO - PID 2445 | 17:40:06 ERROR - PID 2445 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:40:06 INFO - PID 2445 | Full stack: 17:40:06 INFO - PID 2445 | ************************* 17:40:06 INFO - PID 2445 | ************************* 17:40:06 INFO - PID 2445 | A coding exception was thrown and uncaught in a Task. 17:40:06 INFO - PID 2445 | 17:40:06 ERROR - PID 2445 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:40:06 INFO - PID 2445 | Full stack: 17:40:06 INFO - PID 2445 | ************************* 17:40:06 INFO - PID 2445 | ************************* 17:40:06 INFO - PID 2445 | A coding exception was thrown and uncaught in a Task. 17:40:06 INFO - PID 2445 | 17:40:06 ERROR - PID 2445 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:40:06 INFO - PID 2445 | Full stack: 17:40:06 INFO - PID 2445 | ************************* 17:41:25 INFO - PID 2445 | Cycle 1(1): loaded http://localhost:58923/tests/dromaeo/cssquery-ext.html (next: http://localhost:58923/tests/dromaeo/cssquery-jquery.html) 17:41:26 INFO - PID 2445 | RSS: Main: 260616192 17:41:26 INFO - PID 2445 | 17:44:28 INFO - PID 2445 | Cycle 1(1): loaded http://localhost:58923/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58923/tests/dromaeo/cssquery-mootools.html) 17:44:28 INFO - PID 2445 | RSS: Main: 269991936 17:44:28 INFO - PID 2445 | 17:47:30 INFO - PID 2445 | Cycle 1(1): loaded http://localhost:58923/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58923/tests/dromaeo/cssquery-prototype.html) 17:47:31 INFO - PID 2445 | RSS: Main: 263540736 17:47:31 INFO - PID 2445 | 17:50:34 INFO - PID 2445 | Cycle 1(1): loaded http://localhost:58923/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58923/tests/dromaeo/cssquery-yui.html) 17:50:34 INFO - PID 2445 | RSS: Main: 272711680 17:50:34 INFO - PID 2445 | 17:53:36 INFO - PID 2445 | Cycle 1(1): loaded http://localhost:58923/tests/dromaeo/cssquery-yui.html (next: http://localhost:58923/tests/dromaeo/cssquery-dojo.html) 17:53:36 INFO - PID 2445 | RSS: Main: 267354112 17:53:36 INFO - PID 2445 | 17:53:36 INFO - PID 2445 | __start_tp_report 17:53:36 INFO - PID 2445 | _x_x_mozilla_page_load 17:53:36 INFO - PID 2445 | _x_x_mozilla_page_load_details 17:53:36 INFO - PID 2445 | |i|pagename|runs| 17:53:36 INFO - PID 2445 | |0;dojo.html;3418.6581341865817;3521.3837578423786;3553.271579326238;3555.2000799820044;3579.9821000895;4773.4987826278175;6119.449249567538;6149.969250153748;6168.9383106168925;6183.258009038916;4977.278294647274;6099.551912188685;6151.8769624607485;6246.625202487842;6253.374662533755;5383.16560933056;5401.648892821973;5421.349438067417;5438.428964958682;5439.891202175954;4964.503549645043;5549.528290095347;5560.86097847553;5567.053600887859;5576.832695019136;4315.762633055197;5336.279602253685;5400.513953744143;5445.128779395317;5507.669539827623;5478.561715062785;5510.91733623996;5534.557235421156;5534.916976245359;5537.501624853782;5360.249565060894;5433.75023744541;5455.1271796512765;5458.072127738294;5502.2296878437055;5362.248691373809;6141.692915354259;6163.722632481549;6243.313235544087;6255.718492667841;6443.9355606443805;6568.080468734381;6663.433608143314;6670.09953656255;6689.297623749533;5785.27684039495;6614.669266536702;6792.524523283372;6792.694328755218;6799.1840979082335;6175.938240617626;6290.654014029226;6290.716917738713;6307.684615769193;6321.683915804191;6290.591111577733;6628.734850606018;6740.898886516707;6754;6876;5288.7091209983055;6351.333110023474;6471.352864713491;6522.608643481406;6539.771108011197;6595.175603049619;6711.328867113347;6775.1531058617675;6775.186977562724;6790.11728475305;6640.136782218281;6643.435307998874;6657.367550082734;6663.766768163091;6672.499562532732;5420.810271640474;6455.160829092188;6585.83535411609;6613;6684.064231007663;5274.340707411574;5327.307450031549;5354.036273470812;5362;5378.892422151535;4668.813247470063;4694.201985662446;4703.670743047954;4721.220998535203;4722.763861806896;6204.565680402418;6207.689615519206;6252.062190671436;6354.983202687547;6356.141920840627;5335.306410166653;5610.4670056344585;5934.287885453687;6717.596944183365;6802.727890884408;6293.181886354744;6312.084747711556;6315.242170939517;6320.494360451153;6324.08300796382;4883.487233840467;5925.200097986716;5948.702564871739;5952.791652292149;5982.820515384546;5345;5737.483626473638;5744.425557444222;6924.3421874921805;6959.060526828814;6741.157355330583;6754.358335958076;6761.661916904037;6779.220389655253;6784.694688739118;5395.70323632204;6888.242293347627;6911.5853048817235;6927.515073944977;6945.340192681687;5796.59423840344;6343.9365606343345;6437.195350581177;6521.445677117498;6544.869102618016;5950.780090081609;6756.932430675631;6768.458523318024;6773;6782.1861376635115;6221.875562488634;6351.269603995414;6405.679716014088;6413.230412350548;6576.901346479903;6393.041043843461;6624.138861947916;6632.966835165793;6639.568428052161;6645.700943457459;5623.831285061455;6227;6314.55798094129;6315.4947604192475;6422.454091402283;6502.804915852532;6578.375054369827;6586.1438013058;6609.702563384563;6629.337066293332;6396.168498095218;6411.326810684811;6429.421352078149;6439.903401449075;6447.838804029937 17:53:36 INFO - PID 2445 | |1;ext.html;815.3151352863596;834.8079941613427;1176.4235524592946;1239.1016513028062;1264.917780344278;36751;37751.81124094379;37803.62196378035;37826.43260351097;37917.24165516688;38028.429573556416;38146;38186.42720359197;38201.61798382016;38327.041823954416;7916.366690664748;8064;8281.337493000545;8550.40147189697;8559.358048146383;8529.061803201674;8544;8616.439931404439;8637.956810215941;8639.784005399884;7391.963040184818;8589.055203927563;8656.43733157346;8658.480491170518;8659.523726195057;8598.312135029213;8611.526366049897;8633.050364459905;8638.568071596395;8646.351523635722;8391.916080839175;8426.241638252526;8471.788205294855;8476.406651534395;8477.23704866565;37060.62939370599;37208.06979825499;37209;37221.627783722084;37235.81382093072;3127.687231276877;3611.368010598135;3621.764585301947;3637.2179981303884;3663.981680091609;30760.923367682022;30866.537001944987;30870.919517816994;30887.691123088705;30887.69112308893;3118.688131186886;3174.7301479374282;3189.266468712186;3197.376511580243;3207.374561960395;231122;277595;278373;278603.85584576795;279615;45230;47213.76393118081;47621;47622.80942976384;49688;47088;48747.512524875005;49187.75406123018;49919.50080499221;49925.750371248636;14144.504942327176;14208.93432992509;14278.286085695674;14280.785788213185;14285.57143285703;10695.732606684895;10734;11382.487788049557;11583.189176757545;11585.6524304271;12971;13001.739965200642;13107.737845243042;13209.801852972214;13263.071584989151;4682.859514214579;5363.410024897258;5487.5609951203805;5756.194132821408;5802.680852553066;857.7169534053747;885.6811547842772;1026.3380119822673;1060.8249638809664;1072.4262519552003;19103.235870565022;24562.263132106065;24587.51757878253;24911.750882490942;25116.874415628172;1120.3501968858043;1127.425013243252;1135.27909777292;1151.3897634253858;1155.3356819828632;12562.30907300089;12723.872761272454;12725.045621578234;12743.235405875677;12744.553940612219;325481;326461;326737;327200.3639981785;327372;53792.73103634535;53966.46033539614;53975.460245397044;54081.45918540764;54138.72930635322;1469.045120671572;1485.6434455730764;1523.2840564934463;1524.695060987807;1540.5070377479324;22240.221592244194;24243.636345455187;24335.391615209053;24407.51184976326;24544.1409550672;32032.5195122078;37818.62181378151;38035;38041;39901.40147897842;242301.36547952148;274624;284655;285042;285307.8673033191;34891;35040.82479587586;36054.8197259012;36648.81675591605;36718.44922326221;44609.10781784411;44643.776781115885;45849.31226031679;46142.538574615166;46272.7686361566;30514.23714407069;30826.68799840066;31343.84328078345;31555;31867;30499.695003049685;30565;30882.53676194904;31450.685493144774;31450.685493144774;37365.81317093397;37711.24577508489;37789.62210377971;37827.43258851174;37842.243155137294;30432.391352173276;30794.538081929237;31554.684453155176;32664.673353266164;32921.847735329146;19907.905065221552;22640.320790376314;22961.770382296632;25008.62487062659;25016.999320026996 17:53:36 INFO - PID 2445 | |2;jquery.html;431.2108840821297;437.48595400404514;439.5538528393681;454.3162540376733;457.51046380373015;19226.711599326005;19807.801921980776;21750.56498870022;21920;22010;21643.67534486984;22569.435764105907;23216.41958951027;23261;23344.416389590227;5546.223528705985;5841.802430501737;5938.10928360745;6167.074938759177;6172.938270617304;5905.4094590541035;6160.6611636359985;6215.5338349623735;6227.1282020517165;6227.688615569226;5975.774966131954;6071.210742603455;6153.600015998968;6166.3525329840395;6179.7837075702355;6069.484093852028;6098.085287206933;6144.907826382608;6160.44555989963;6161.3838616138255;4663.790129444184;5389.595780316492;5400.62195646301;5447.863803404907;5500.917486237709;22704.88647556768;26925.730742692518;27503.48730819804;27889.16332510028;28601.141965741062;1910.2836436336374;2170.7178066851366;2171.4462811983003;2171.6742488626674;2180.160638154306;17668.204930778145;17678.381256656085;17943;18218.089095545303;18447.16987735555;2137.6045431595203;2169.1215057901577;2185.6612225104977;2188.2888061379954;2189.6058709432295;131541.6845831539;133251;133628;134970.3251483746;136171;12336.938315308365;12719.427625756864;12741.426635801226;12750.426230819636;12844.229346239068;16332.510024699279;16429.342826287055;16441.588960276087;16459.83540164583;16496.587585310463;8712;8935.597898094602;8936.41913275648;9025.41334813235;9061.54692265384;7175.533590316717;8454.323654107657;8484.533350665773;8593.140685931357;8601.655933762704;6497.577657452251;7773.961130194313;7954.840903181904;7957.960210199028;7960.4825686330205;2185.497335612786;2200.163937703662;2201.5376770878297;2202.284257616281;2394.305651361086;970.9757256068655;973.454865275448;979.3634137810337;1003.9598416063421;1024.574801457387;18051.729224061648;19388.806111938982;20498.38504844857;21070.683939740917;21202;939.178219058324;1010.015235145727;1022.325265324882;1039.428314427062;1047.0576481166859;10755.300905441121;10771.946140269405;10786.083182929538;10826;10844.783104337868;518074;554370;558433;577511;580248;135611.21943902766;136187.6381236195;136524;138065;139850;1220.664317312746;1231.8398608181058;1260.2690439545042;1261.8233447317566;1264.367816091954;18139.45581632553;18217;18265.634687305912;18295;18748.156332964776;58689.4131058701;59811.40188598058;60115.39884601098;60254.070781860646;60729.17812465633;84128;84286.57856710677;85114.57442712747;86154.56922715346;86895;8684.219734954193;8736.078062826167;8799.956000219958;9126.269898408244;9157.31320150978;14258.358373873409;14469.348879300667;14698.110484645442;14712.264386780404;14855.777163342775;11456.3698996556;12000.819987700017;12281;12408.937955310526;12511.249325040526;10530.21023423231;11355.54577816878;11607.535698571963;11650.126240532163;11762.70593235176;10181.84727229107;11939.22395044354;12497.500099996261;12647.241165530098;12761.93619031899;7517.548947063194;8756.51839148853;8918.509481978554;9050.049744776703;9082.219393693324;11047.889521104686;11707.414629268673;12252.448639811051;12313.56902508408;12328.876711233132 17:53:36 INFO - PID 2445 | |3;mootools.html;1343.0732794371884;1393.6585536543546;1422.3315041930296;1469.5224052183044;1477.9630509237268;11155.721106972329;11218;11763.11776616754;11850.585229516968;11888;11436.37099959504;11687.29876207426;11737;11750.11874109441;11759.294442333445;2497.5504409206337;2546.401595625027;2554.067765265683;2555.987220063897;2562.128876182098;2477.2568229531157;2526.835755675875;2528.3931856354434;2532.645429639852;2533.8606376649277;2484.776370126697;2487.3781554611346;2508.673872396586;2533.328667903007;2539.4667119904843;2459.8069936080988;2484.3292311075998;2511.9120830771017;2514.509670614231;2521.8865151068244;2392.9760702392928;2491.389609545655;2499.825012249143;2500.712418071927;2506.323292710976;9784.266180036526;11558.768824623545;11594.304341739438;11669.299842009506;11672.35802030888;6556.377144171296;6732.2257940336995;6767.120274364351;6806.183258009021;6806.6256355900405;3977.8209980550946;4276.850310239158;4356.172327257811;4359.629431498326;4371.366151907955;1263.033779158944;1272.4083301264957;1278.673938145767;1310.3317308172805;1312.3044786263297;15948.20258987046;16025.519234422985;16264.18679066042;16377.181140942905;16702.916485417496;5503.889922201533;5570.498655121059;5714.171445140431;5720.342160651495;5743.885122297531;11666.824997625043;11706.414679266003;11822.34977076252;11834.289942603471;11843.28940263587;6553.2136143663065;6578.901316480256;6590.703418346186;6598.901016484757;6605.801825945133;5096.923546146811;5950.523958083343;6227.595206311576;6240.812775616739;6251;4269.146170765859;4393.20922234001;4394.2969124939855;4412.7352358857925;4414.196984914603;1163.1567113842566;1250.2061191143507;1276.8403949506312;1292.7996160595123;1317.881390674844;783.1111688233896;806.1374329467413;806.8749343851713;814.9470284431493;825.6078362777632;6101.664408457577;6147.569670123138;6322.652254126067;6344.635903280817;6382.20222472191;518.6343627742433;588.364566268429;602.8010756450361;603.387561624951;614.1954040207343;3994.2211268802303;4132.669386449077;4198.9370159447635;4355.237833379146;4378.2994720845145;14602.34289456977;14997.775033374508;15025.774613380809;15037.248137593077;15075.170865602278;14242.359093840594;14681.265936703123;14987.925060374628;15118.697626047417;15178.392864285304;7482.027336446336;8239.505629662239;8333.166683331618;8400.873986890201;8438.156184381636;6276.74893004293;6717.395434410926;7001.544899581511;7023.578585284899;7080.185778635523;11089.833652495057;12953.870461295643;13056.086073974731;13168;13356.732865342834;13207.405666744828;13225.867741322463;13437.059405841497;13491.932540337235;13762.65593360134;9228.031056738946;9241.306901982243;9408.106229908148;9417.623295068395;9427.481488518197;10508.159347252355;10955.34267943926;10976;11039.944800275947;11069.83395249088;8910.540212731035;9027.36808423404;9032.954835226044;9085.54572271397;9111.498867562348;8779.20987111163;8793.560321984003;8805.867911981197;8918.10818918103;9074.773130671787;7956.562389068657;8148.5518296494265;8235.83528329442;8242.546659933761;8255.958720206361;5452.509274165344;5494.423085576117;5800.680962546931;5800.854978625568;5834.533237340917;6058.303295120942;6201.751929922752;6243;6289.245290565162;6312.968435157794 17:53:36 INFO - PID 2445 | |4;prototype.html;381.3707382818351;404.658063935974;407.5740850810903;411.0258686912017;415.54705371145445;6079.483243924261;6144.784932527363;6147.47746441553;6196.969015154924;6208.317085120639;5879.970600146993;6008.819735407934;6026.608270462417;6042.939570604292;6054.394560543943;3809.2191100824266;4403.8770113620985;4413.227685155101;4414.911701765963;4417.3815665806815;4076.857309994151;4288.721233119837;4381.802818873159;4384.298512238027;4407.757573333465;4340.717853339539;4341.50072741634;4345.891352716176;4347.500037495697;4356.433663623725;3726.2547490502006;4374.409454723619;4377.868663940087;4380.890477738066;4455.952851079994;3180.4574781231086;3498.8978471781306;3658.8716647266738;3740.4015357542935;3753.9624603753887;5845.649261044351;5858.062709966385;5901.557383196277;5906;5924.911126333109;5179.456157103487;5213.244079608474;5223.474154945397;5247.606429517763;5255.02781985334;6207.906881396782;6394.808155755335;6462.48300135988;6488.967555162241;6492.577982431127;4240.215560121387;4261.2542805009;4267.978660106711;4272.957270427318;4297.914041719179;5599.832005039855;6168.907466388007;6818.4886133540185;6826.726930922757;6919.47439184699;3516.349475347069;4225.450691410097;4286.635635970915;4295.8496452624;4297.304318286334;3988.3219852625125;4066.2883995300704;4366.519682834885;4382.780860956939;4395.922998865299;5021.221710634857;5127.948720512822;5171.914187791603;5177.741112944338;5183.766730497136;6341.714622841891;6468.6442245676935;6474.510862501651;6486.902696459557;6491.285958544557;1482.9258537073104;1489.7988771515923;1491.3736230782881;1495.446684726658;1499.6250937265684;853.5945425922637;936.6534382278464;981.8625392445064;982.6511588386163;986.6448078691665;6199.628022318675;6202.224721909762;6230;6235.314115447388;6239.500839932794;5610.148650945178;5612.5229355504425;6447.484841062346;6509.707063182168;6544.934550654528;5212.244224587414;5284.630075894727;5297.602679798953;6179.752809887555;6264.843378915472;3473.965260347364;3522.295540891832;3543.5039094526787;3565.5186549815444;3590.784552926833;6521.315261897527;6810.944303632945;6987.475939304572;7007.649617519206;7022.297770223039;6786.932130678729;6990.720371185197;6991.720331186797;7005.929940700527;7022.332878376546;6059.424354686386;6408.231012278463;6956.791296261019;7072.823179420556;7086.539374940612;6524.510661700297;6722.495812813961;6793.830154246183;6806.285340039422;6871.553349032297;6437.969924812008;6640.568363056386;6679.332066793282;6699.732010719516;6710.16122984627;6434.420902118832;6845.589264644137;6957.9304206959305;7025.648717564203;7046.753363632249;4321.913561728685;4322.227886566493;4323.718958267703;4330.783460826883;4364.9127017460105;5672.7730890763905;6265.404786545271;6375.203099612549;6877.828054298682;6882.208546017272;6512.706928188148;6548.345165483413;6565.441937435371;6571.408573228432;6591.934080659324;5759.424057594375;5822.679752613647;6283.214598175228;6602.207735071822;6628.370304821035;6272.278687950761;6391.2330520337855;6405.263394709482;6446.323136070832;6460.192475940507;5475.479829416199;6615.933840661724;6634.237062737654;6635.303293154149;6651.037943806686;6049;6109.419605137505;6408;6412.563225974287;6436.613803171825 17:53:36 INFO - PID 2445 | |5;yui.html;830.2942498875955;844.7001314533337;847.9703210387634;875.6409871952496;886.2776836877943;12710.983121350293;14813.407463701438;15317.157556334398;16905.40831070913;17170.82829171708;14211.21838298893;15791.210439478038;16898.493045208663;18100.913945163265;18159.909200453978;1003.4045867071374;1025.6153942271649;1025.9487025648689;1028.0644613401805;1028.1671845804922;941.8257622339855;986.2011770465946;1010.2877471382694;1026.2149455666422;1029.526417847791;1054.4780333734811;1066.4134725900763;1066.903978641922;1067.0769784136705;1068.476446541197;1050.8686414198226;1063.8191507443676;1064.084886997182;1064.2177999170603;1065.579096256982;776.7087342246657;781.2851241114373;781.9765407037798;782.4405550031697;782.6478084861778;13781.586552403443;16390.590235244093;17454.30182792687;17484.38804641844;17513.211905464286;16319.63365312035;16635.50093497197;16843.83156168435;16855.83144168555;16889.408870689465;13667.658308542266;14028.71942561143;14091.36588853504;14201.928990354982;14209.573712788633;3391.7286617070577;3397.371486275047;3429.9142521437166;3512.367773800715;3559.2703495783303;113258;117868;119604;120077;120550.39724801319;13248.867511324956;13636.113652612548;13672.794908076386;13694.93152534231;13703.314834258446;24566.140185093434;24715.5056898861;25093.247202583585;25204.99180032778;25272.494550108895;6828.9317106829285;7061.682224299919;7683.6926522939575;8020.879686804703;8096.878546821802;3923.1761330120426;4013.4381186633896;4020.7386519876113;4023.114914718757;4023.4769479967417;4214.388913607571;4258.787060646955;4382.539833317455;4396.714213576107;4400.251957167289;939.056248470283;953.3136141977765;963.5712108111964;973.245734555725;975.5902520941222;621.5183232994375;646.7510008646611;648.7080813633884;668.6857177126743;673.4982438083659;11083.833742493869;12072.215306005082;12188.756224875453;12203.511859525519;12324.383780810924;649.5810202419412;653.2846533046306;662.9337066293332;664.6942406493067;682.3142741544815;4385.429894113745;5431.375391829911;5618.85952851182;5699.974004679115;5731.971340143356;112150;115951;117980;118748.8125118755;118805;80608;83392.33215335659;83810.58094709487;84231.15768842355;90250;51940.740296298274;77762.44475110466;79625;80129.59935200287;80783;9761.9023809761;12656;12753;12765.8085128725;12784.936075319563;34932.301353973286;35887.102822429646;38112.618873810905;39490.40764388594;39663.2067358657;73131.26868731245;74764.25235747574;75316.62341688256;75387.24612753802;75643;16784.328626855277;16975.405860794814;17130.743038854678;17250.482485525456;17274.740878886576;17912.731309030634;18181;18334.449966501026;18374.908125459286;18509.35217267389;13491.05562610608;16285.755713664541;16453;17058.147092645566;17090.230939607995;16421.835781642032;16814.495565133064;16900.32398704038;17203.569910752332;17257.223424945656;16304;16363.509094727176;16452.83547164561;16648;16801.579960501087;9132.771680708036;11792;11941.16411851162;12056.216345937486;12078.03375729957;13097.345132743516;13184.472621095048;13232.603021909357;13237.735245295233;13302.201867887958 17:53:36 INFO - PID 2445 | __end_tp_report 17:53:36 INFO - PID 2445 | __start_cc_report 17:53:36 INFO - PID 2445 | _x_x_mozilla_cycle_collect,421 17:53:36 INFO - PID 2445 | __end_cc_report 17:53:36 INFO - PID 2445 | __startTimestamp1493427216729__endTimestamp 17:53:36 INFO - PID 2445 | 17:53:36 INFO - PID 2445 | ------- Summary: start ------- 17:53:36 INFO - PID 2445 | Number of tests: 6 17:53:36 INFO - PID 2445 | 17:53:36 INFO - PID 2445 | [#0] dojo.html Cycles:165 Average:6046.92 Median:6293.18 stddev:747.53 (11.9%) stddev-sans-first:720.83 17:53:36 INFO - PID 2445 | Values: 3418.7 3521.4 3553.3 3555.2 3580.0 4773.5 6119.4 6150.0 6168.9 6183.3 4977.3 6099.6 6151.9 6246.6 6253.4 5383.2 5401.6 5421.3 5438.4 5439.9 4964.5 5549.5 5560.9 5567.1 5576.8 4315.8 5336.3 5400.5 5445.1 5507.7 5478.6 5510.9 5534.6 5534.9 5537.5 5360.2 5433.8 5455.1 5458.1 5502.2 5362.2 6141.7 6163.7 6243.3 6255.7 6443.9 6568.1 6663.4 6670.1 6689.3 5785.3 6614.7 6792.5 6792.7 6799.2 6175.9 6290.7 6290.7 6307.7 6321.7 6290.6 6628.7 6740.9 6754.0 6876.0 5288.7 6351.3 6471.4 6522.6 6539.8 6595.2 6711.3 6775.2 6775.2 6790.1 6640.1 6643.4 6657.4 6663.8 6672.5 5420.8 6455.2 6585.8 6613.0 6684.1 5274.3 5327.3 5354.0 5362.0 5378.9 4668.8 4694.2 4703.7 4721.2 4722.8 6204.6 6207.7 6252.1 6355.0 6356.1 5335.3 5610.5 5934.3 6717.6 6802.7 6293.2 6312.1 6315.2 6320.5 6324.1 4883.5 5925.2 5948.7 5952.8 5982.8 5345.0 5737.5 5744.4 6924.3 6959.1 6741.2 6754.4 6761.7 6779.2 6784.7 5395.7 6888.2 6911.6 6927.5 6945.3 5796.6 6343.9 6437.2 6521.4 6544.9 5950.8 6756.9 6768.5 6773.0 6782.2 6221.9 6351.3 6405.7 6413.2 6576.9 6393.0 6624.1 6633.0 6639.6 6645.7 5623.8 6227.0 6314.6 6315.5 6422.5 6502.8 6578.4 6586.1 6609.7 6629.3 6396.2 6411.3 6429.4 6439.9 6447.8 17:53:36 INFO - PID 2445 | 17:53:36 INFO - PID 2445 | [#1] ext.html Cycles:180 Average:44322.18 Median:327286.18 stddev:76395.05 (23.3%) stddev-sans-first:76539.52 17:53:36 INFO - PID 2445 | Values: 815.3 834.8 1176.4 1239.1 1264.9 36751.0 37751.8 37803.6 37826.4 37917.2 38028.4 38146.0 38186.4 38201.6 38327.0 7916.4 8064.0 8281.3 8550.4 8559.4 8529.1 8544.0 8616.4 8638.0 8639.8 7392.0 8589.1 8656.4 8658.5 8659.5 8598.3 8611.5 8633.1 8638.6 8646.4 8391.9 8426.2 8471.8 8476.4 8477.2 37060.6 37208.1 37209.0 37221.6 37235.8 3127.7 3611.4 3621.8 3637.2 3664.0 30760.9 30866.5 30870.9 30887.7 30887.7 3118.7 3174.7 3189.3 3197.4 3207.4 231122.0 277595.0 278373.0 278603.9 279615.0 45230.0 47213.8 47621.0 47622.8 49688.0 47088.0 48747.5 49187.8 49919.5 49925.8 14144.5 14208.9 14278.3 14280.8 14285.6 10695.7 10734.0 11382.5 11583.2 11585.7 12971.0 13001.7 13107.7 13209.8 13263.1 4682.9 5363.4 5487.6 5756.2 5802.7 857.7 885.7 1026.3 1060.8 1072.4 19103.2 24562.3 24587.5 24911.8 25116.9 1120.4 1127.4 1135.3 1151.4 1155.3 12562.3 12723.9 12725.0 12743.2 12744.6 325481.0 326461.0 326737.0 327200.4 327372.0 53792.7 53966.5 53975.5 54081.5 54138.7 1469.0 1485.6 1523.3 1524.7 1540.5 22240.2 24243.6 24335.4 24407.5 24544.1 32032.5 37818.6 38035.0 38041.0 39901.4 242301.4 274624.0 284655.0 285042.0 285307.9 34891.0 35040.8 36054.8 36648.8 36718.4 44609.1 44643.8 45849.3 46142.5 46272.8 30514.2 30826.7 31343.8 31555.0 31867.0 30499.7 30565.0 30882.5 31450.7 31450.7 37365.8 37711.2 37789.6 37827.4 37842.2 30432.4 30794.5 31554.7 32664.7 32921.8 19907.9 22640.3 22961.8 25008.6 25017.0 17:53:36 INFO - PID 2445 | 17:53:36 INFO - PID 2445 | [#2] jquery.html Cycles:180 Average:35698.12 Median:12054.80 stddev:94240.17 (781.8%) stddev-sans-first:94467.33 17:53:36 INFO - PID 2445 | Values: 431.2 437.5 439.6 454.3 457.5 19226.7 19807.8 21750.6 21920.0 22010.0 21643.7 22569.4 23216.4 23261.0 23344.4 5546.2 5841.8 5938.1 6167.1 6172.9 5905.4 6160.7 6215.5 6227.1 6227.7 5975.8 6071.2 6153.6 6166.4 6179.8 6069.5 6098.1 6144.9 6160.4 6161.4 4663.8 5389.6 5400.6 5447.9 5500.9 22704.9 26925.7 27503.5 27889.2 28601.1 1910.3 2170.7 2171.4 2171.7 2180.2 17668.2 17678.4 17943.0 18218.1 18447.2 2137.6 2169.1 2185.7 2188.3 2189.6 131541.7 133251.0 133628.0 134970.3 136171.0 12336.9 12719.4 12741.4 12750.4 12844.2 16332.5 16429.3 16441.6 16459.8 16496.6 8712.0 8935.6 8936.4 9025.4 9061.5 7175.5 8454.3 8484.5 8593.1 8601.7 6497.6 7774.0 7954.8 7958.0 7960.5 2185.5 2200.2 2201.5 2202.3 2394.3 971.0 973.5 979.4 1004.0 1024.6 18051.7 19388.8 20498.4 21070.7 21202.0 939.2 1010.0 1022.3 1039.4 1047.1 10755.3 10771.9 10786.1 10826.0 10844.8 518074.0 554370.0 558433.0 577511.0 580248.0 135611.2 136187.6 136524.0 138065.0 139850.0 1220.7 1231.8 1260.3 1261.8 1264.4 18139.5 18217.0 18265.6 18295.0 18748.2 58689.4 59811.4 60115.4 60254.1 60729.2 84128.0 84286.6 85114.6 86154.6 86895.0 8684.2 8736.1 8800.0 9126.3 9157.3 14258.4 14469.3 14698.1 14712.3 14855.8 11456.4 12000.8 12281.0 12408.9 12511.2 10530.2 11355.5 11607.5 11650.1 11762.7 10181.8 11939.2 12497.5 12647.2 12761.9 7517.5 8756.5 8918.5 9050.0 9082.2 11047.9 11707.4 12252.4 12313.6 12328.9 17:53:36 INFO - PID 2445 | 17:53:36 INFO - PID 2445 | [#3] mootools.html Cycles:180 Average:7046.13 Median:4063.45 stddev:4443.20 (109.3%) stddev-sans-first:4434.99 17:53:36 INFO - PID 2445 | Values: 1343.1 1393.7 1422.3 1469.5 1478.0 11155.7 11218.0 11763.1 11850.6 11888.0 11436.4 11687.3 11737.0 11750.1 11759.3 2497.6 2546.4 2554.1 2556.0 2562.1 2477.3 2526.8 2528.4 2532.6 2533.9 2484.8 2487.4 2508.7 2533.3 2539.5 2459.8 2484.3 2511.9 2514.5 2521.9 2393.0 2491.4 2499.8 2500.7 2506.3 9784.3 11558.8 11594.3 11669.3 11672.4 6556.4 6732.2 6767.1 6806.2 6806.6 3977.8 4276.9 4356.2 4359.6 4371.4 1263.0 1272.4 1278.7 1310.3 1312.3 15948.2 16025.5 16264.2 16377.2 16702.9 5503.9 5570.5 5714.2 5720.3 5743.9 11666.8 11706.4 11822.3 11834.3 11843.3 6553.2 6578.9 6590.7 6598.9 6605.8 5096.9 5950.5 6227.6 6240.8 6251.0 4269.1 4393.2 4394.3 4412.7 4414.2 1163.2 1250.2 1276.8 1292.8 1317.9 783.1 806.1 806.9 814.9 825.6 6101.7 6147.6 6322.7 6344.6 6382.2 518.6 588.4 602.8 603.4 614.2 3994.2 4132.7 4198.9 4355.2 4378.3 14602.3 14997.8 15025.8 15037.2 15075.2 14242.4 14681.3 14987.9 15118.7 15178.4 7482.0 8239.5 8333.2 8400.9 8438.2 6276.7 6717.4 7001.5 7023.6 7080.2 11089.8 12953.9 13056.1 13168.0 13356.7 13207.4 13225.9 13437.1 13491.9 13762.7 9228.0 9241.3 9408.1 9417.6 9427.5 10508.2 10955.3 10976.0 11039.9 11069.8 8910.5 9027.4 9033.0 9085.5 9111.5 8779.2 8793.6 8805.9 8918.1 9074.8 7956.6 8148.6 8235.8 8242.5 8256.0 5452.5 5494.4 5800.7 5800.9 5834.5 6058.3 6201.8 6243.0 6289.2 6313.0 17:53:36 INFO - PID 2445 | 17:53:36 INFO - PID 2445 | [#4] prototype.html Cycles:180 Average:5248.06 Median:6056.91 stddev:1684.56 (27.8%) stddev-sans-first:1649.21 17:53:36 INFO - PID 2445 | Values: 381.4 404.7 407.6 411.0 415.5 6079.5 6144.8 6147.5 6197.0 6208.3 5880.0 6008.8 6026.6 6042.9 6054.4 3809.2 4403.9 4413.2 4414.9 4417.4 4076.9 4288.7 4381.8 4384.3 4407.8 4340.7 4341.5 4345.9 4347.5 4356.4 3726.3 4374.4 4377.9 4380.9 4456.0 3180.5 3498.9 3658.9 3740.4 3754.0 5845.6 5858.1 5901.6 5906.0 5924.9 5179.5 5213.2 5223.5 5247.6 5255.0 6207.9 6394.8 6462.5 6489.0 6492.6 4240.2 4261.3 4268.0 4273.0 4297.9 5599.8 6168.9 6818.5 6826.7 6919.5 3516.3 4225.5 4286.6 4295.8 4297.3 3988.3 4066.3 4366.5 4382.8 4395.9 5021.2 5127.9 5171.9 5177.7 5183.8 6341.7 6468.6 6474.5 6486.9 6491.3 1482.9 1489.8 1491.4 1495.4 1499.6 853.6 936.7 981.9 982.7 986.6 6199.6 6202.2 6230.0 6235.3 6239.5 5610.1 5612.5 6447.5 6509.7 6544.9 5212.2 5284.6 5297.6 6179.8 6264.8 3474.0 3522.3 3543.5 3565.5 3590.8 6521.3 6810.9 6987.5 7007.6 7022.3 6786.9 6990.7 6991.7 7005.9 7022.3 6059.4 6408.2 6956.8 7072.8 7086.5 6524.5 6722.5 6793.8 6806.3 6871.6 6438.0 6640.6 6679.3 6699.7 6710.2 6434.4 6845.6 6957.9 7025.6 7046.8 4321.9 4322.2 4323.7 4330.8 4364.9 5672.8 6265.4 6375.2 6877.8 6882.2 6512.7 6548.3 6565.4 6571.4 6591.9 5759.4 5822.7 6283.2 6602.2 6628.4 6272.3 6391.2 6405.3 6446.3 6460.2 5475.5 6615.9 6634.2 6635.3 6651.0 6049.0 6109.4 6408.0 6412.6 6436.6 17:53:36 INFO - PID 2445 | 17:53:36 INFO - PID 2445 | [#5] yui.html Cycles:180 Average:21949.12 Median:17364.52 stddev:30960.40 (178.3%) stddev-sans-first:31006.64 17:53:36 INFO - PID 2445 | Values: 830.3 844.7 848.0 875.6 886.3 12711.0 14813.4 15317.2 16905.4 17170.8 14211.2 15791.2 16898.5 18100.9 18159.9 1003.4 1025.6 1025.9 1028.1 1028.2 941.8 986.2 1010.3 1026.2 1029.5 1054.5 1066.4 1066.9 1067.1 1068.5 1050.9 1063.8 1064.1 1064.2 1065.6 776.7 781.3 782.0 782.4 782.6 13781.6 16390.6 17454.3 17484.4 17513.2 16319.6 16635.5 16843.8 16855.8 16889.4 13667.7 14028.7 14091.4 14201.9 14209.6 3391.7 3397.4 3429.9 3512.4 3559.3 113258.0 117868.0 119604.0 120077.0 120550.4 13248.9 13636.1 13672.8 13694.9 13703.3 24566.1 24715.5 25093.2 25205.0 25272.5 6828.9 7061.7 7683.7 8020.9 8096.9 3923.2 4013.4 4020.7 4023.1 4023.5 4214.4 4258.8 4382.5 4396.7 4400.3 939.1 953.3 963.6 973.2 975.6 621.5 646.8 648.7 668.7 673.5 11083.8 12072.2 12188.8 12203.5 12324.4 649.6 653.3 662.9 664.7 682.3 4385.4 5431.4 5618.9 5700.0 5732.0 112150.0 115951.0 117980.0 118748.8 118805.0 80608.0 83392.3 83810.6 84231.2 90250.0 51940.7 77762.4 79625.0 80129.6 80783.0 9761.9 12656.0 12753.0 12765.8 12784.9 34932.3 35887.1 38112.6 39490.4 39663.2 73131.3 74764.3 75316.6 75387.2 75643.0 16784.3 16975.4 17130.7 17250.5 17274.7 17912.7 18181.0 18334.4 18374.9 18509.4 13491.1 16285.8 16453.0 17058.1 17090.2 16421.8 16814.5 16900.3 17203.6 17257.2 16304.0 16363.5 16452.8 16648.0 16801.6 9132.8 11792.0 11941.2 12056.2 12078.0 13097.3 13184.5 13232.6 13237.7 13302.2 17:53:36 INFO - PID 2445 | -------- Summary: end -------- 17:53:36 INFO - PID 2445 | 17:53:37 INFO - TEST-INFO | 2445: exit 0 17:53:37 INFO - TEST-OK | dromaeo_css | took 1115781ms 17:53:37 INFO - TEST-START | kraken 17:53:37 INFO - operating with platform_type : mac_ 17:53:37 INFO - Initialising browser for kraken test... 17:53:37 INFO - TEST-INFO | started process 2450 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpaeKwn1/profile http://localhost:58923/getInfo.html) 17:53:39 INFO - PID 2450 | 2017-04-28 17:53:39.829 plugin-container[2451:35404] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x433f, name = 'com.apple.tsm.portname' 17:53:39 INFO - PID 2450 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:53:39 INFO - PID 2450 | 2017-04-28 17:53:39.832 plugin-container[2451:35404] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9347, name = 'com.apple.CFPasteboardClient' 17:53:39 INFO - PID 2450 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:53:39 INFO - PID 2450 | 2017-04-28 17:53:39.832 plugin-container[2451:35404] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:53:40 INFO - PID 2450 | __metrics Screen width/height:1600/1200 17:53:40 INFO - PID 2450 | colorDepth:24 17:53:40 INFO - PID 2450 | Browser inner width/height: 1024/689 17:53:40 INFO - PID 2450 | __metrics 17:53:40 ERROR - PID 2450 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 17:53:41 INFO - TEST-INFO | 2450: exit 0 17:53:41 INFO - Browser initialized. 17:53:41 INFO - Running cycle 1/1 for kraken test... 17:53:41 INFO - TEST-INFO | started process 2452 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpaeKwn1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:53:43 INFO - PID 2452 | 2017-04-28 17:53:43.397 plugin-container[2453:35533] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 17:53:43 INFO - PID 2452 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:53:43 INFO - PID 2452 | 2017-04-28 17:53:43.398 plugin-container[2453:35533] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a03, name = 'com.apple.CFPasteboardClient' 17:53:43 INFO - PID 2452 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:53:43 INFO - PID 2452 | 2017-04-28 17:53:43.398 plugin-container[2453:35533] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:53:53 INFO - PID 2452 | RSS: Main: 251334656 17:53:53 INFO - PID 2452 | 17:53:56 INFO - PID 2452 | Cycle 1(1): loaded http://localhost:58923/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58923/tests/kraken/driver.html?testName=audio-beat-detection) 17:53:57 INFO - PID 2452 | RSS: Main: 259313664 17:53:57 INFO - PID 2452 | 17:53:59 INFO - PID 2452 | Cycle 1(1): loaded http://localhost:58923/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58923/tests/kraken/driver.html?testName=audio-dft) 17:54:00 INFO - PID 2452 | RSS: Main: 266399744 17:54:00 INFO - PID 2452 | 17:54:03 INFO - PID 2452 | Cycle 1(1): loaded http://localhost:58923/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58923/tests/kraken/driver.html?testName=audio-fft) 17:54:04 INFO - PID 2452 | RSS: Main: 262737920 17:54:04 INFO - PID 2452 | 17:54:06 INFO - PID 2452 | Cycle 1(1): loaded http://localhost:58923/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58923/tests/kraken/driver.html?testName=audio-oscillator) 17:54:07 INFO - PID 2452 | RSS: Main: 263741440 17:54:07 INFO - PID 2452 | 17:54:09 INFO - PID 2452 | Cycle 1(1): loaded http://localhost:58923/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58923/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:54:09 INFO - PID 2452 | RSS: Main: 264179712 17:54:09 INFO - PID 2452 | 17:54:12 INFO - PID 2452 | Cycle 1(1): loaded http://localhost:58923/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58923/tests/kraken/driver.html?testName=imaging-darkroom) 17:54:13 INFO - PID 2452 | RSS: Main: 270176256 17:54:13 INFO - PID 2452 | 17:54:16 INFO - PID 2452 | Cycle 1(1): loaded http://localhost:58923/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58923/tests/kraken/driver.html?testName=imaging-desaturate) 17:54:16 INFO - PID 2452 | RSS: Main: 271859712 17:54:16 INFO - PID 2452 | 17:54:19 INFO - PID 2452 | Cycle 1(1): loaded http://localhost:58923/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58923/tests/kraken/driver.html?testName=json-parse-financial) 17:54:20 INFO - PID 2452 | RSS: Main: 271364096 17:54:20 INFO - PID 2452 | 17:54:21 INFO - PID 2452 | Cycle 1(1): loaded http://localhost:58923/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58923/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:54:22 INFO - PID 2452 | RSS: Main: 271433728 17:54:22 INFO - PID 2452 | 17:54:24 INFO - PID 2452 | Cycle 1(1): loaded http://localhost:58923/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58923/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:54:25 INFO - PID 2452 | RSS: Main: 271462400 17:54:25 INFO - PID 2452 | 17:54:27 INFO - PID 2452 | Cycle 1(1): loaded http://localhost:58923/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58923/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:54:27 INFO - PID 2452 | RSS: Main: 270995456 17:54:27 INFO - PID 2452 | 17:54:30 INFO - PID 2452 | Cycle 1(1): loaded http://localhost:58923/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58923/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:54:31 INFO - PID 2452 | RSS: Main: 271306752 17:54:31 INFO - PID 2452 | 17:54:34 INFO - PID 2452 | Cycle 1(1): loaded http://localhost:58923/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58923/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:54:35 INFO - PID 2452 | RSS: Main: 271392768 17:54:35 INFO - PID 2452 | 17:54:37 INFO - PID 2452 | Cycle 1(1): loaded http://localhost:58923/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58923/tests/kraken/driver.html?testName=ai-astar) 17:54:37 INFO - PID 2452 | RSS: Main: 273117184 17:54:37 INFO - PID 2452 | 17:54:37 INFO - PID 2452 | __start_tp_report 17:54:37 INFO - PID 2452 | _x_x_mozilla_page_load 17:54:37 INFO - PID 2452 | _x_x_mozilla_page_load_details 17:54:37 INFO - PID 2452 | |i|pagename|runs| 17:54:37 INFO - PID 2452 | |0;ai-astar;101;115;118;147;173;125;115;115;114;114 17:54:37 INFO - PID 2452 | |1;audio-beat-detection;152;115;114;154;123;112;113;112;142;143 17:54:37 INFO - PID 2452 | |2;audio-dft;198;203;203;211;215;223;196;198;196;198 17:54:37 INFO - PID 2452 | |3;audio-fft;79;58;63;86;60;53;95;87;76;50 17:54:37 INFO - PID 2452 | |4;audio-oscillator;76;69;77;64;102;105;105;103;55;108 17:54:37 INFO - PID 2452 | |5;imaging-gaussian-blur;91;91;89;89;90;96;89;92;93;89 17:54:37 INFO - PID 2452 | |6;imaging-darkroom;96;100;97;97;98;97;98;98;97;97 17:54:37 INFO - PID 2452 | |7;imaging-desaturate;93;109;152;95;91;92;105;95;91;118 17:54:37 INFO - PID 2452 | |8;json-parse-financial;49;49;51;50;49;50;51;51;52;59 17:54:37 INFO - PID 2452 | |9;json-stringify-tinderbox;61;82;83;85;91;62;55;59;60;57 17:54:37 INFO - PID 2452 | |10;stanford-crypto-aes;83;80;84;83;84;83;82;83;84;81 17:54:37 INFO - PID 2452 | |11;stanford-crypto-ccm;153;163;168;157;142;156;161;161;191;169 17:54:37 INFO - PID 2452 | |12;stanford-crypto-pbkdf2;185;186;182;189;199;226;216;199;179;185 17:54:37 INFO - PID 2452 | |13;stanford-crypto-sha256-iterative;68;90;94;96;82;68;67;75;87;75 17:54:37 INFO - PID 2452 | __end_tp_report 17:54:37 INFO - PID 2452 | __start_cc_report 17:54:37 INFO - PID 2452 | _x_x_mozilla_cycle_collect,1001 17:54:37 INFO - PID 2452 | __end_cc_report 17:54:37 INFO - PID 2452 | __startTimestamp1493427277500__endTimestamp 17:54:37 INFO - PID 2452 | 17:54:37 INFO - PID 2452 | ------- Summary: start ------- 17:54:37 INFO - PID 2452 | Number of tests: 14 17:54:37 INFO - PID 2452 | 17:54:37 INFO - PID 2452 | [#0] ai-astar Cycles:10 Average:123.70 Median:116.50 stddev:20.92 (18.0%) stddev-sans-first:20.51 17:54:37 INFO - PID 2452 | Values: 101.0 115.0 118.0 147.0 173.0 125.0 115.0 115.0 114.0 114.0 17:54:37 INFO - PID 2452 | 17:54:37 INFO - PID 2452 | [#1] audio-beat-detection Cycles:10 Average:128.00 Median:132.50 stddev:17.64 (13.3%) stddev-sans-first:16.43 17:54:37 INFO - PID 2452 | Values: 152.0 115.0 114.0 154.0 123.0 112.0 113.0 112.0 142.0 143.0 17:54:37 INFO - PID 2452 | 17:54:37 INFO - PID 2452 | [#2] audio-dft Cycles:10 Average:204.10 Median:203.00 stddev:9.24 (4.6%) stddev-sans-first:9.54 17:54:37 INFO - PID 2452 | Values: 198.0 203.0 203.0 211.0 215.0 223.0 196.0 198.0 196.0 198.0 17:54:37 INFO - PID 2452 | 17:54:37 INFO - PID 2452 | [#3] audio-fft Cycles:10 Average:70.70 Median:77.50 stddev:15.86 (20.5%) stddev-sans-first:16.54 17:54:37 INFO - PID 2452 | Values: 79.0 58.0 63.0 86.0 60.0 53.0 95.0 87.0 76.0 50.0 17:54:37 INFO - PID 2452 | 17:54:37 INFO - PID 2452 | [#4] audio-oscillator Cycles:10 Average:86.40 Median:59.50 stddev:20.18 (33.9%) stddev-sans-first:21.05 17:54:37 INFO - PID 2452 | Values: 76.0 69.0 77.0 64.0 102.0 105.0 105.0 103.0 55.0 108.0 17:54:37 INFO - PID 2452 | 17:54:37 INFO - PID 2452 | [#5] imaging-gaussian-blur Cycles:10 Average:90.90 Median:91.00 stddev:2.28 (2.5%) stddev-sans-first:2.42 17:54:37 INFO - PID 2452 | Values: 91.0 91.0 89.0 89.0 90.0 96.0 89.0 92.0 93.0 89.0 17:54:37 INFO - PID 2452 | 17:54:37 INFO - PID 2452 | [#6] imaging-darkroom Cycles:10 Average:97.50 Median:97.00 stddev:1.08 (1.1%) stddev-sans-first:1.00 17:54:37 INFO - PID 2452 | Values: 96.0 100.0 97.0 97.0 98.0 97.0 98.0 98.0 97.0 97.0 17:54:37 INFO - PID 2452 | 17:54:37 INFO - PID 2452 | [#7] imaging-desaturate Cycles:10 Average:104.10 Median:91.50 stddev:19.12 (20.9%) stddev-sans-first:19.86 17:54:37 INFO - PID 2452 | Values: 93.0 109.0 152.0 95.0 91.0 92.0 105.0 95.0 91.0 118.0 17:54:37 INFO - PID 2452 | 17:54:37 INFO - PID 2452 | [#8] json-parse-financial Cycles:10 Average:51.10 Median:51.00 stddev:2.96 (5.8%) stddev-sans-first:3.04 17:54:37 INFO - PID 2452 | Values: 49.0 49.0 51.0 50.0 49.0 50.0 51.0 51.0 52.0 59.0 17:54:37 INFO - PID 2452 | 17:54:37 INFO - PID 2452 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:72.00 stddev:13.89 (19.3%) stddev-sans-first:14.39 17:54:37 INFO - PID 2452 | Values: 61.0 82.0 83.0 85.0 91.0 62.0 55.0 59.0 60.0 57.0 17:54:37 INFO - PID 2452 | 17:54:37 INFO - PID 2452 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:1.34 (1.6%) stddev-sans-first:1.41 17:54:37 INFO - PID 2452 | Values: 83.0 80.0 84.0 83.0 84.0 83.0 82.0 83.0 84.0 81.0 17:54:37 INFO - PID 2452 | 17:54:37 INFO - PID 2452 | [#11] stanford-crypto-ccm Cycles:10 Average:162.10 Median:162.00 stddev:12.78 (7.9%) stddev-sans-first:13.13 17:54:37 INFO - PID 2452 | Values: 153.0 163.0 168.0 157.0 142.0 156.0 161.0 161.0 191.0 169.0 17:54:37 INFO - PID 2452 | 17:54:37 INFO - PID 2452 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.60 Median:194.00 stddev:15.54 (8.0%) stddev-sans-first:16.09 17:54:37 INFO - PID 2452 | Values: 185.0 186.0 182.0 189.0 199.0 226.0 216.0 199.0 179.0 185.0 17:54:37 INFO - PID 2452 | 17:54:37 INFO - PID 2452 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.20 Median:84.50 stddev:11.11 (13.2%) stddev-sans-first:10.88 17:54:37 INFO - PID 2452 | Values: 68.0 90.0 94.0 96.0 82.0 68.0 67.0 75.0 87.0 75.0 17:54:37 INFO - PID 2452 | -------- Summary: end -------- 17:54:37 INFO - PID 2452 | 17:54:38 INFO - TEST-INFO | 2452: exit 0 17:54:38 INFO - TEST-OK | kraken | took 61156ms 17:54:38 INFO - SUITE-END | took 1176s 17:54:38 INFO - Completed test suite (00:19:37) 17:54:38 INFO - javascript benchmark 17:54:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7834.72708233893, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3418.6581341865817, 3521.3837578423786, 3553.271579326238, 3555.2000799820044, 3579.9821000895, 4773.4987826278175, 6119.449249567538, 6149.969250153748, 6168.9383106168925, 6183.258009038916, 4977.278294647274, 6099.551912188685, 6151.8769624607485, 6246.625202487842, 6253.374662533755, 5383.16560933056, 5401.648892821973, 5421.349438067417, 5438.428964958682, 5439.891202175954, 4964.503549645043, 5549.528290095347, 5560.86097847553, 5567.053600887859, 5576.832695019136, 4315.762633055197, 5336.279602253685, 5400.513953744143, 5445.128779395317, 5507.669539827623, 5478.561715062785, 5510.91733623996, 5534.557235421156, 5534.916976245359, 5537.501624853782, 5360.249565060894, 5433.75023744541, 5455.1271796512765, 5458.072127738294, 5502.2296878437055, 5362.248691373809, 6141.692915354259, 6163.722632481549, 6243.313235544087, 6255.718492667841, 6443.9355606443805, 6568.080468734381, 6663.433608143314, 6670.09953656255, 6689.297623749533, 5785.27684039495, 6614.669266536702, 6792.524523283372, 6792.694328755218, 6799.1840979082335, 6175.938240617626, 6290.654014029226, 6290.716917738713, 6307.684615769193, 6321.683915804191, 6290.591111577733, 6628.734850606018, 6740.898886516707, 6754.0, 6876.0, 5288.7091209983055, 6351.333110023474, 6471.352864713491, 6522.608643481406, 6539.771108011197, 6595.175603049619, 6711.328867113347, 6775.1531058617675, 6775.186977562724, 6790.11728475305, 6640.136782218281, 6643.435307998874, 6657.367550082734, 6663.766768163091, 6672.499562532732, 5420.810271640474, 6455.160829092188, 6585.83535411609, 6613.0, 6684.064231007663, 5274.340707411574, 5327.307450031549, 5354.036273470812, 5362.0, 5378.892422151535, 4668.813247470063, 4694.201985662446, 4703.670743047954, 4721.220998535203, 4722.763861806896, 6204.565680402418, 6207.689615519206, 6252.062190671436, 6354.983202687547, 6356.141920840627, 5335.306410166653, 5610.4670056344585, 5934.287885453687, 6717.596944183365, 6802.727890884408, 6293.181886354744, 6312.084747711556, 6315.242170939517, 6320.494360451153, 6324.08300796382, 4883.487233840467, 5925.200097986716, 5948.702564871739, 5952.791652292149, 5982.820515384546, 5345.0, 5737.483626473638, 5744.425557444222, 6924.3421874921805, 6959.060526828814, 6741.157355330583, 6754.358335958076, 6761.661916904037, 6779.220389655253, 6784.694688739118, 5395.70323632204, 6888.242293347627, 6911.5853048817235, 6927.515073944977, 6945.340192681687, 5796.59423840344, 6343.9365606343345, 6437.195350581177, 6521.445677117498, 6544.869102618016, 5950.780090081609, 6756.932430675631, 6768.458523318024, 6773.0, 6782.1861376635115, 6221.875562488634, 6351.269603995414, 6405.679716014088, 6413.230412350548, 6576.901346479903, 6393.041043843461, 6624.138861947916, 6632.966835165793, 6639.568428052161, 6645.700943457459, 5623.831285061455, 6227.0, 6314.55798094129, 6315.4947604192475, 6422.454091402283, 6502.804915852532, 6578.375054369827, 6586.1438013058, 6609.702563384563, 6629.337066293332, 6396.168498095218, 6411.326810684811, 6429.421352078149, 6439.903401449075, 6447.838804029937], "value": 6001.959010262459, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [815.3151352863596, 834.8079941613427, 1176.4235524592946, 1239.1016513028062, 1264.917780344278, 36751.0, 37751.81124094379, 37803.62196378035, 37826.43260351097, 37917.24165516688, 38028.429573556416, 38146.0, 38186.42720359197, 38201.61798382016, 38327.041823954416, 7916.366690664748, 8064.0, 8281.337493000545, 8550.40147189697, 8559.358048146383, 8529.061803201674, 8544.0, 8616.439931404439, 8637.956810215941, 8639.784005399884, 7391.963040184818, 8589.055203927563, 8656.43733157346, 8658.480491170518, 8659.523726195057, 8598.312135029213, 8611.526366049897, 8633.050364459905, 8638.568071596395, 8646.351523635722, 8391.916080839175, 8426.241638252526, 8471.788205294855, 8476.406651534395, 8477.23704866565, 37060.62939370599, 37208.06979825499, 37209.0, 37221.627783722084, 37235.81382093072, 3127.687231276877, 3611.368010598135, 3621.764585301947, 3637.2179981303884, 3663.981680091609, 30760.923367682022, 30866.537001944987, 30870.919517816994, 30887.691123088705, 30887.69112308893, 3118.688131186886, 3174.7301479374282, 3189.266468712186, 3197.376511580243, 3207.374561960395, 231122.0, 277595.0, 278373.0, 278603.85584576795, 279615.0, 45230.0, 47213.76393118081, 47621.0, 47622.80942976384, 49688.0, 47088.0, 48747.512524875005, 49187.75406123018, 49919.50080499221, 49925.750371248636, 14144.504942327176, 14208.93432992509, 14278.286085695674, 14280.785788213185, 14285.57143285703, 10695.732606684895, 10734.0, 11382.487788049557, 11583.189176757545, 11585.6524304271, 12971.0, 13001.739965200642, 13107.737845243042, 13209.801852972214, 13263.071584989151, 4682.859514214579, 5363.410024897258, 5487.5609951203805, 5756.194132821408, 5802.680852553066, 857.7169534053747, 885.6811547842772, 1026.3380119822673, 1060.8249638809664, 1072.4262519552003, 19103.235870565022, 24562.263132106065, 24587.51757878253, 24911.750882490942, 25116.874415628172, 1120.3501968858043, 1127.425013243252, 1135.27909777292, 1151.3897634253858, 1155.3356819828632, 12562.30907300089, 12723.872761272454, 12725.045621578234, 12743.235405875677, 12744.553940612219, 325481.0, 326461.0, 326737.0, 327200.3639981785, 327372.0, 53792.73103634535, 53966.46033539614, 53975.460245397044, 54081.45918540764, 54138.72930635322, 1469.045120671572, 1485.6434455730764, 1523.2840564934463, 1524.695060987807, 1540.5070377479324, 22240.221592244194, 24243.636345455187, 24335.391615209053, 24407.51184976326, 24544.1409550672, 32032.5195122078, 37818.62181378151, 38035.0, 38041.0, 39901.40147897842, 242301.36547952148, 274624.0, 284655.0, 285042.0, 285307.8673033191, 34891.0, 35040.82479587586, 36054.8197259012, 36648.81675591605, 36718.44922326221, 44609.10781784411, 44643.776781115885, 45849.31226031679, 46142.538574615166, 46272.7686361566, 30514.23714407069, 30826.68799840066, 31343.84328078345, 31555.0, 31867.0, 30499.695003049685, 30565.0, 30882.53676194904, 31450.685493144774, 31450.685493144774, 37365.81317093397, 37711.24577508489, 37789.62210377971, 37827.43258851174, 37842.243155137294, 30432.391352173276, 30794.538081929237, 31554.684453155176, 32664.673353266164, 32921.847735329146, 19907.905065221552, 22640.320790376314, 22961.770382296632, 25008.62487062659, 25016.999320026996], "value": 17514.4765121653, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.2108840821297, 437.48595400404514, 439.5538528393681, 454.3162540376733, 457.51046380373015, 19226.711599326005, 19807.801921980776, 21750.56498870022, 21920.0, 22010.0, 21643.67534486984, 22569.435764105907, 23216.41958951027, 23261.0, 23344.416389590227, 5546.223528705985, 5841.802430501737, 5938.10928360745, 6167.074938759177, 6172.938270617304, 5905.4094590541035, 6160.6611636359985, 6215.5338349623735, 6227.1282020517165, 6227.688615569226, 5975.774966131954, 6071.210742603455, 6153.600015998968, 6166.3525329840395, 6179.7837075702355, 6069.484093852028, 6098.085287206933, 6144.907826382608, 6160.44555989963, 6161.3838616138255, 4663.790129444184, 5389.595780316492, 5400.62195646301, 5447.863803404907, 5500.917486237709, 22704.88647556768, 26925.730742692518, 27503.48730819804, 27889.16332510028, 28601.141965741062, 1910.2836436336374, 2170.7178066851366, 2171.4462811983003, 2171.6742488626674, 2180.160638154306, 17668.204930778145, 17678.381256656085, 17943.0, 18218.089095545303, 18447.16987735555, 2137.6045431595203, 2169.1215057901577, 2185.6612225104977, 2188.2888061379954, 2189.6058709432295, 131541.6845831539, 133251.0, 133628.0, 134970.3251483746, 136171.0, 12336.938315308365, 12719.427625756864, 12741.426635801226, 12750.426230819636, 12844.229346239068, 16332.510024699279, 16429.342826287055, 16441.588960276087, 16459.83540164583, 16496.587585310463, 8712.0, 8935.597898094602, 8936.41913275648, 9025.41334813235, 9061.54692265384, 7175.533590316717, 8454.323654107657, 8484.533350665773, 8593.140685931357, 8601.655933762704, 6497.577657452251, 7773.961130194313, 7954.840903181904, 7957.960210199028, 7960.4825686330205, 2185.497335612786, 2200.163937703662, 2201.5376770878297, 2202.284257616281, 2394.305651361086, 970.9757256068655, 973.454865275448, 979.3634137810337, 1003.9598416063421, 1024.574801457387, 18051.729224061648, 19388.806111938982, 20498.38504844857, 21070.683939740917, 21202.0, 939.178219058324, 1010.015235145727, 1022.325265324882, 1039.428314427062, 1047.0576481166859, 10755.300905441121, 10771.946140269405, 10786.083182929538, 10826.0, 10844.783104337868, 518074.0, 554370.0, 558433.0, 577511.0, 580248.0, 135611.21943902766, 136187.6381236195, 136524.0, 138065.0, 139850.0, 1220.664317312746, 1231.8398608181058, 1260.2690439545042, 1261.8233447317566, 1264.367816091954, 18139.45581632553, 18217.0, 18265.634687305912, 18295.0, 18748.156332964776, 58689.4131058701, 59811.40188598058, 60115.39884601098, 60254.070781860646, 60729.17812465633, 84128.0, 84286.57856710677, 85114.57442712747, 86154.56922715346, 86895.0, 8684.219734954193, 8736.078062826167, 8799.956000219958, 9126.269898408244, 9157.31320150978, 14258.358373873409, 14469.348879300667, 14698.110484645442, 14712.264386780404, 14855.777163342775, 11456.3698996556, 12000.819987700017, 12281.0, 12408.937955310526, 12511.249325040526, 10530.21023423231, 11355.54577816878, 11607.535698571963, 11650.126240532163, 11762.70593235176, 10181.84727229107, 11939.22395044354, 12497.500099996261, 12647.241165530098, 12761.93619031899, 7517.548947063194, 8756.51839148853, 8918.509481978554, 9050.049744776703, 9082.219393693324, 11047.889521104686, 11707.414629268673, 12252.448639811051, 12313.56902508408, 12328.876711233132], "value": 10467.217477260128, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1343.0732794371884, 1393.6585536543546, 1422.3315041930296, 1469.5224052183044, 1477.9630509237268, 11155.721106972329, 11218.0, 11763.11776616754, 11850.585229516968, 11888.0, 11436.37099959504, 11687.29876207426, 11737.0, 11750.11874109441, 11759.294442333445, 2497.5504409206337, 2546.401595625027, 2554.067765265683, 2555.987220063897, 2562.128876182098, 2477.2568229531157, 2526.835755675875, 2528.3931856354434, 2532.645429639852, 2533.8606376649277, 2484.776370126697, 2487.3781554611346, 2508.673872396586, 2533.328667903007, 2539.4667119904843, 2459.8069936080988, 2484.3292311075998, 2511.9120830771017, 2514.509670614231, 2521.8865151068244, 2392.9760702392928, 2491.389609545655, 2499.825012249143, 2500.712418071927, 2506.323292710976, 9784.266180036526, 11558.768824623545, 11594.304341739438, 11669.299842009506, 11672.35802030888, 6556.377144171296, 6732.2257940336995, 6767.120274364351, 6806.183258009021, 6806.6256355900405, 3977.8209980550946, 4276.850310239158, 4356.172327257811, 4359.629431498326, 4371.366151907955, 1263.033779158944, 1272.4083301264957, 1278.673938145767, 1310.3317308172805, 1312.3044786263297, 15948.20258987046, 16025.519234422985, 16264.18679066042, 16377.181140942905, 16702.916485417496, 5503.889922201533, 5570.498655121059, 5714.171445140431, 5720.342160651495, 5743.885122297531, 11666.824997625043, 11706.414679266003, 11822.34977076252, 11834.289942603471, 11843.28940263587, 6553.2136143663065, 6578.901316480256, 6590.703418346186, 6598.901016484757, 6605.801825945133, 5096.923546146811, 5950.523958083343, 6227.595206311576, 6240.812775616739, 6251.0, 4269.146170765859, 4393.20922234001, 4394.2969124939855, 4412.7352358857925, 4414.196984914603, 1163.1567113842566, 1250.2061191143507, 1276.8403949506312, 1292.7996160595123, 1317.881390674844, 783.1111688233896, 806.1374329467413, 806.8749343851713, 814.9470284431493, 825.6078362777632, 6101.664408457577, 6147.569670123138, 6322.652254126067, 6344.635903280817, 6382.20222472191, 518.6343627742433, 588.364566268429, 602.8010756450361, 603.387561624951, 614.1954040207343, 3994.2211268802303, 4132.669386449077, 4198.9370159447635, 4355.237833379146, 4378.2994720845145, 14602.34289456977, 14997.775033374508, 15025.774613380809, 15037.248137593077, 15075.170865602278, 14242.359093840594, 14681.265936703123, 14987.925060374628, 15118.697626047417, 15178.392864285304, 7482.027336446336, 8239.505629662239, 8333.166683331618, 8400.873986890201, 8438.156184381636, 6276.74893004293, 6717.395434410926, 7001.544899581511, 7023.578585284899, 7080.185778635523, 11089.833652495057, 12953.870461295643, 13056.086073974731, 13168.0, 13356.732865342834, 13207.405666744828, 13225.867741322463, 13437.059405841497, 13491.932540337235, 13762.65593360134, 9228.031056738946, 9241.306901982243, 9408.106229908148, 9417.623295068395, 9427.481488518197, 10508.159347252355, 10955.34267943926, 10976.0, 11039.944800275947, 11069.83395249088, 8910.540212731035, 9027.36808423404, 9032.954835226044, 9085.54572271397, 9111.498867562348, 8779.20987111163, 8793.560321984003, 8805.867911981197, 8918.10818918103, 9074.773130671787, 7956.562389068657, 8148.5518296494265, 8235.83528329442, 8242.546659933761, 8255.958720206361, 5452.509274165344, 5494.423085576117, 5800.680962546931, 5800.854978625568, 5834.533237340917, 6058.303295120942, 6201.751929922752, 6243.0, 6289.245290565162, 6312.968435157794], "value": 5297.086321467989, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.3707382818351, 404.658063935974, 407.5740850810903, 411.0258686912017, 415.54705371145445, 6079.483243924261, 6144.784932527363, 6147.47746441553, 6196.969015154924, 6208.317085120639, 5879.970600146993, 6008.819735407934, 6026.608270462417, 6042.939570604292, 6054.394560543943, 3809.2191100824266, 4403.8770113620985, 4413.227685155101, 4414.911701765963, 4417.3815665806815, 4076.857309994151, 4288.721233119837, 4381.802818873159, 4384.298512238027, 4407.757573333465, 4340.717853339539, 4341.50072741634, 4345.891352716176, 4347.500037495697, 4356.433663623725, 3726.2547490502006, 4374.409454723619, 4377.868663940087, 4380.890477738066, 4455.952851079994, 3180.4574781231086, 3498.8978471781306, 3658.8716647266738, 3740.4015357542935, 3753.9624603753887, 5845.649261044351, 5858.062709966385, 5901.557383196277, 5906.0, 5924.911126333109, 5179.456157103487, 5213.244079608474, 5223.474154945397, 5247.606429517763, 5255.02781985334, 6207.906881396782, 6394.808155755335, 6462.48300135988, 6488.967555162241, 6492.577982431127, 4240.215560121387, 4261.2542805009, 4267.978660106711, 4272.957270427318, 4297.914041719179, 5599.832005039855, 6168.907466388007, 6818.4886133540185, 6826.726930922757, 6919.47439184699, 3516.349475347069, 4225.450691410097, 4286.635635970915, 4295.8496452624, 4297.304318286334, 3988.3219852625125, 4066.2883995300704, 4366.519682834885, 4382.780860956939, 4395.922998865299, 5021.221710634857, 5127.948720512822, 5171.914187791603, 5177.741112944338, 5183.766730497136, 6341.714622841891, 6468.6442245676935, 6474.510862501651, 6486.902696459557, 6491.285958544557, 1482.9258537073104, 1489.7988771515923, 1491.3736230782881, 1495.446684726658, 1499.6250937265684, 853.5945425922637, 936.6534382278464, 981.8625392445064, 982.6511588386163, 986.6448078691665, 6199.628022318675, 6202.224721909762, 6230.0, 6235.314115447388, 6239.500839932794, 5610.148650945178, 5612.5229355504425, 6447.484841062346, 6509.707063182168, 6544.934550654528, 5212.244224587414, 5284.630075894727, 5297.602679798953, 6179.752809887555, 6264.843378915472, 3473.965260347364, 3522.295540891832, 3543.5039094526787, 3565.5186549815444, 3590.784552926833, 6521.315261897527, 6810.944303632945, 6987.475939304572, 7007.649617519206, 7022.297770223039, 6786.932130678729, 6990.720371185197, 6991.720331186797, 7005.929940700527, 7022.332878376546, 6059.424354686386, 6408.231012278463, 6956.791296261019, 7072.823179420556, 7086.539374940612, 6524.510661700297, 6722.495812813961, 6793.830154246183, 6806.285340039422, 6871.553349032297, 6437.969924812008, 6640.568363056386, 6679.332066793282, 6699.732010719516, 6710.16122984627, 6434.420902118832, 6845.589264644137, 6957.9304206959305, 7025.648717564203, 7046.753363632249, 4321.913561728685, 4322.227886566493, 4323.718958267703, 4330.783460826883, 4364.9127017460105, 5672.7730890763905, 6265.404786545271, 6375.203099612549, 6877.828054298682, 6882.208546017272, 6512.706928188148, 6548.345165483413, 6565.441937435371, 6571.408573228432, 6591.934080659324, 5759.424057594375, 5822.679752613647, 6283.214598175228, 6602.207735071822, 6628.370304821035, 6272.278687950761, 6391.2330520337855, 6405.263394709482, 6446.323136070832, 6460.192475940507, 5475.479829416199, 6615.933840661724, 6634.237062737654, 6635.303293154149, 6651.037943806686, 6049.0, 6109.419605137505, 6408.0, 6412.563225974287, 6436.613803171825], "value": 4717.415743600586, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [830.2942498875955, 844.7001314533337, 847.9703210387634, 875.6409871952496, 886.2776836877943, 12710.983121350293, 14813.407463701438, 15317.157556334398, 16905.40831070913, 17170.82829171708, 14211.21838298893, 15791.210439478038, 16898.493045208663, 18100.913945163265, 18159.909200453978, 1003.4045867071374, 1025.6153942271649, 1025.9487025648689, 1028.0644613401805, 1028.1671845804922, 941.8257622339855, 986.2011770465946, 1010.2877471382694, 1026.2149455666422, 1029.526417847791, 1054.4780333734811, 1066.4134725900763, 1066.903978641922, 1067.0769784136705, 1068.476446541197, 1050.8686414198226, 1063.8191507443676, 1064.084886997182, 1064.2177999170603, 1065.579096256982, 776.7087342246657, 781.2851241114373, 781.9765407037798, 782.4405550031697, 782.6478084861778, 13781.586552403443, 16390.590235244093, 17454.30182792687, 17484.38804641844, 17513.211905464286, 16319.63365312035, 16635.50093497197, 16843.83156168435, 16855.83144168555, 16889.408870689465, 13667.658308542266, 14028.71942561143, 14091.36588853504, 14201.928990354982, 14209.573712788633, 3391.7286617070577, 3397.371486275047, 3429.9142521437166, 3512.367773800715, 3559.2703495783303, 113258.0, 117868.0, 119604.0, 120077.0, 120550.39724801319, 13248.867511324956, 13636.113652612548, 13672.794908076386, 13694.93152534231, 13703.314834258446, 24566.140185093434, 24715.5056898861, 25093.247202583585, 25204.99180032778, 25272.494550108895, 6828.9317106829285, 7061.682224299919, 7683.6926522939575, 8020.879686804703, 8096.878546821802, 3923.1761330120426, 4013.4381186633896, 4020.7386519876113, 4023.114914718757, 4023.4769479967417, 4214.388913607571, 4258.787060646955, 4382.539833317455, 4396.714213576107, 4400.251957167289, 939.056248470283, 953.3136141977765, 963.5712108111964, 973.245734555725, 975.5902520941222, 621.5183232994375, 646.7510008646611, 648.7080813633884, 668.6857177126743, 673.4982438083659, 11083.833742493869, 12072.215306005082, 12188.756224875453, 12203.511859525519, 12324.383780810924, 649.5810202419412, 653.2846533046306, 662.9337066293332, 664.6942406493067, 682.3142741544815, 4385.429894113745, 5431.375391829911, 5618.85952851182, 5699.974004679115, 5731.971340143356, 112150.0, 115951.0, 117980.0, 118748.8125118755, 118805.0, 80608.0, 83392.33215335659, 83810.58094709487, 84231.15768842355, 90250.0, 51940.740296298274, 77762.44475110466, 79625.0, 80129.59935200287, 80783.0, 9761.9023809761, 12656.0, 12753.0, 12765.8085128725, 12784.936075319563, 34932.301353973286, 35887.102822429646, 38112.618873810905, 39490.40764388594, 39663.2067358657, 73131.26868731245, 74764.25235747574, 75316.62341688256, 75387.24612753802, 75643.0, 16784.328626855277, 16975.405860794814, 17130.743038854678, 17250.482485525456, 17274.740878886576, 17912.731309030634, 18181.0, 18334.449966501026, 18374.908125459286, 18509.35217267389, 13491.05562610608, 16285.755713664541, 16453.0, 17058.147092645566, 17090.230939607995, 16421.835781642032, 16814.495565133064, 16900.32398704038, 17203.569910752332, 17257.223424945656, 16304.0, 16363.509094727176, 16452.83547164561, 16648.0, 16801.579960501087, 9132.771680708036, 11792.0, 11941.16411851162, 12056.216345937486, 12078.03375729957, 13097.345132743516, 13184.472621095048, 13232.603021909357, 13237.735245295233, 13302.201867887958], "value": 8411.023966149498, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 115.0, 118.0, 147.0, 173.0, 125.0, 115.0, 115.0, 114.0, 114.0], "value": 123.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 115.0, 114.0, 154.0, 123.0, 112.0, 113.0, 112.0, 142.0, 143.0], "value": 128.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 203.0, 203.0, 211.0, 215.0, 223.0, 196.0, 198.0, 196.0, 198.0], "value": 204.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 63.0, 86.0, 60.0, 53.0, 95.0, 87.0, 76.0, 50.0], "value": 70.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 69.0, 77.0, 64.0, 102.0, 105.0, 105.0, 103.0, 55.0, 108.0], "value": 86.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 89.0, 89.0, 90.0, 96.0, 89.0, 92.0, 93.0, 89.0], "value": 90.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 100.0, 97.0, 97.0, 98.0, 97.0, 98.0, 98.0, 97.0, 97.0], "value": 97.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 109.0, 152.0, 95.0, 91.0, 92.0, 105.0, 95.0, 91.0, 118.0], "value": 104.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 51.0, 50.0, 49.0, 50.0, 51.0, 51.0, 52.0, 59.0], "value": 51.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 82.0, 83.0, 85.0, 91.0, 62.0, 55.0, 59.0, 60.0, 57.0], "value": 69.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 84.0, 83.0, 84.0, 83.0, 82.0, 83.0, 84.0, 81.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 163.0, 168.0, 157.0, 142.0, 156.0, 161.0, 161.0, 191.0, 169.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 182.0, 189.0, 199.0, 226.0, 216.0, 199.0, 179.0, 185.0], "value": 194.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 90.0, 94.0, 96.0, 82.0, 68.0, 67.0, 75.0, 87.0, 75.0], "value": 80.2, "unit": "score"}]}]} 17:54:38 INFO - Return code: 0 17:54:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:54:38 ERROR - # TBPL SUCCESS # 17:54:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:54:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:54:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:54:38 INFO - 2017-04-28 17:54:38.858 screenresolution[2457:35921] starting screenresolution argv=screenresolution get 17:54:38 INFO - 2017-04-28 17:54:38.861 screenresolution[2457:35921] Display 0: 1600x1200x32@60 17:54:38 INFO - 2017-04-28 17:54:38.866 screenresolution[2458:35924] starting screenresolution argv=screenresolution list 17:54:38 INFO - Available Modes on Display 0 17:54:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:54:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:54:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:54:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:54:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:54:39 INFO - Intel Iris: 17:54:39 INFO - Chipset Model: Intel Iris 17:54:39 INFO - Type: GPU 17:54:39 INFO - Bus: Built-In 17:54:39 INFO - VRAM (Dynamic, Max): 1536 MB 17:54:39 INFO - Vendor: Intel (0x8086) 17:54:39 INFO - Device ID: 0x0a2e 17:54:39 INFO - Revision ID: 0x0009 17:54:39 INFO - Displays: 17:54:39 INFO - Display: 17:54:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:54:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:54:39 INFO - Display Serial Number: 1600x1200 60 17:54:39 INFO - Main Display: Yes 17:54:39 INFO - Mirror: Off 17:54:39 INFO - Online: Yes 17:54:39 INFO - Rotation: Supported 17:54:39 INFO - Return code: 0 17:54:39 INFO - Running post-action listener: _resource_record_post_action 17:54:39 INFO - [mozharness: 2017-04-29 00:54:39.106356Z] Finished run-tests step (success) 17:54:39 INFO - Running post-run listener: _resource_record_post_run 17:54:39 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 1466368; Write bytes: 509524992; Read time: 10; Write time: 1730 17:54:39 INFO - TinderboxPrint: CPU usage
54.3% 17:54:39 INFO - TinderboxPrint: I/O read bytes / time
1,466,368 / 10 17:54:39 INFO - TinderboxPrint: I/O write bytes / time
509,524,992 / 1,730 17:54:39 INFO - TinderboxPrint: CPU idle
2,190.4 (45.7%) 17:54:39 INFO - TinderboxPrint: CPU system
968.0 (20.2%) 17:54:39 INFO - TinderboxPrint: CPU user
1,631.4 (34.1%) 17:54:39 INFO - TinderboxPrint: Swap in / out
209,694,720 / 0 17:54:39 INFO - install - Wall time: 20s; CPU: 55.0%; Read bytes: 208151040; Write bytes: 207656960; Read time: 16125; Write time: 443 17:54:39 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 520192; Write bytes: 294614016; Read time: 4; Write time: 1256 17:54:39 INFO - Running post-run listener: _upload_blobber_files 17:54:39 INFO - Blob upload gear active. 17:54:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:54:39 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 17:54:39 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'] 17:54:39 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 17:54:39 INFO - (blobuploader) - INFO - Open directory for files ... 17:54:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:54:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:54:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:54:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:54:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:54:41 INFO - (blobuploader) - INFO - Done attempting. 17:54:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:54:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:54:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:54:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:54:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:54:42 INFO - (blobuploader) - INFO - Done attempting. 17:54:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:54:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:54:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:54:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:54:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:54:43 INFO - (blobuploader) - INFO - Done attempting. 17:54:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:54:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:54:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:54:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:54:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:54:45 INFO - (blobuploader) - INFO - Done attempting. 17:54:45 INFO - (blobuploader) - INFO - Iteration through files over. 17:54:45 INFO - Return code: 0 17:54:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:54:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:54:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c62d92d983d338448e8128ff435602ee0c174def99f825fdd7d9beb375c35e750e2a4be8d29512e0ec8a6baa9a309e5c8fe9534f84e9871ca6a77e8f8e2b2951", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b93c2a47cf1c45d4e67e7bdeb6e9c12e87d2fdd2cac7544af9db899a12b307e1642611413a07882f99d5778c483e9b5b19f6bb66c0514cb2fc8ef3d618ba84e4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a03d4f1041f9ababfaebc60e0c4d531f056a79d60b5d9532d3cf910b5c3745510e0ba7b4bc94ee9cbd5822e9e989d7a723845b6cd2679b6d4d2f5c21fe49a09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5189a5787e1b0883bbd8c1a024380cc088245e94b9ef9070b348aebd38bdfab9e64c673dc52780777d4ab737b1bf91e1a9b2a954a78bc0d1bca774b87084e662"} 17:54:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:54:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:54:45 INFO - Contents: 17:54:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c62d92d983d338448e8128ff435602ee0c174def99f825fdd7d9beb375c35e750e2a4be8d29512e0ec8a6baa9a309e5c8fe9534f84e9871ca6a77e8f8e2b2951", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b93c2a47cf1c45d4e67e7bdeb6e9c12e87d2fdd2cac7544af9db899a12b307e1642611413a07882f99d5778c483e9b5b19f6bb66c0514cb2fc8ef3d618ba84e4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a03d4f1041f9ababfaebc60e0c4d531f056a79d60b5d9532d3cf910b5c3745510e0ba7b4bc94ee9cbd5822e9e989d7a723845b6cd2679b6d4d2f5c21fe49a09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5189a5787e1b0883bbd8c1a024380cc088245e94b9ef9070b348aebd38bdfab9e64c673dc52780777d4ab737b1bf91e1a9b2a954a78bc0d1bca774b87084e662"} 17:54:45 INFO - Running post-run listener: copy_logs_to_upload_dir 17:54:45 INFO - Copying logs to upload dir... 17:54:45 INFO - mkdir: /builds/slave/test/build/upload/logs 17:54:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.122884 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-04-28 17:54:45.980374) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 17:54:45.984465) ========= 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.2k5DDSdgi2/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.eRPt6WYJX3/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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/c62d92d983d338448e8128ff435602ee0c174def99f825fdd7d9beb375c35e750e2a4be8d29512e0ec8a6baa9a309e5c8fe9534f84e9871ca6a77e8f8e2b2951", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b93c2a47cf1c45d4e67e7bdeb6e9c12e87d2fdd2cac7544af9db899a12b307e1642611413a07882f99d5778c483e9b5b19f6bb66c0514cb2fc8ef3d618ba84e4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a03d4f1041f9ababfaebc60e0c4d531f056a79d60b5d9532d3cf910b5c3745510e0ba7b4bc94ee9cbd5822e9e989d7a723845b6cd2679b6d4d2f5c21fe49a09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5189a5787e1b0883bbd8c1a024380cc088245e94b9ef9070b348aebd38bdfab9e64c673dc52780777d4ab737b1bf91e1a9b2a954a78bc0d1bca774b87084e662"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011084 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c62d92d983d338448e8128ff435602ee0c174def99f825fdd7d9beb375c35e750e2a4be8d29512e0ec8a6baa9a309e5c8fe9534f84e9871ca6a77e8f8e2b2951", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b93c2a47cf1c45d4e67e7bdeb6e9c12e87d2fdd2cac7544af9db899a12b307e1642611413a07882f99d5778c483e9b5b19f6bb66c0514cb2fc8ef3d618ba84e4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a03d4f1041f9ababfaebc60e0c4d531f056a79d60b5d9532d3cf910b5c3745510e0ba7b4bc94ee9cbd5822e9e989d7a723845b6cd2679b6d4d2f5c21fe49a09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5189a5787e1b0883bbd8c1a024380cc088245e94b9ef9070b348aebd38bdfab9e64c673dc52780777d4ab737b1bf91e1a9b2a954a78bc0d1bca774b87084e662"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 17:54:46.020757) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:54:46.021139) ========= 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.2k5DDSdgi2/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.eRPt6WYJX3/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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.005157 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:54:46.070270) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 17:54:46.070650) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 17:54:46.071062) ========= ========= Total master_lag: 0.19 =========