builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0386 starttime: 1493425045.49 results: success (0) buildid: 20170428170344 builduid: 8d21c10fc463406fbd5f5e1641b772a4 revision: b3b32894d9326d147238d9f071e1814ab3fdc850 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 17:17:25.492868) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 17:17:25.493400) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 17:17:25.493686) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 17:17:25.518855) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:17:25.519151) ========= 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.9iHntS28gD/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.XLRCNY6gWC/Listeners TMPDIR=/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/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:17:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.26M=0.001s 2017-04-28 17:17:25 (8.26 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122613 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:17:25.666113) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:17:25.666493) ========= 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.9iHntS28gD/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.XLRCNY6gWC/Listeners TMPDIR=/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/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.023343 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:17:25.715153) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:17:25.715504) ========= 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.9iHntS28gD/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.XLRCNY6gWC/Listeners TMPDIR=/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/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:17:25,811 truncating revision to first 12 chars 2017-04-28 17:17:25,811 Setting DEBUG logging. 2017-04-28 17:17:25,811 attempt 1/10 2017-04-28 17:17:25,811 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:17:26,103 unpacking tar archive at: mozilla-central-b3b32894d932/testing/mozharness/ program finished with exit code 0 elapsedTime=0.561943 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:17:26.300931) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 17:17:26.301230) ========= script_repo_revision: b3b32894d9326d147238d9f071e1814ab3fdc850 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 17:17:26.301621) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 17:17:26.301887) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 17:17:26.322184) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-04-28 17:17:26.322503) ========= /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.9iHntS28gD/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.XLRCNY6gWC/Listeners TMPDIR=/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/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:17:26 INFO - MultiFileLogger online at 20170428 17:17:26 in /builds/slave/test 17:17:26 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:17:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:17:26 INFO - {'append_to_log': False, 17:17:26 INFO - 'base_work_dir': '/builds/slave/test', 17:17:26 INFO - 'blob_upload_branch': 'Firefox', 17:17:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:17:26 INFO - 'branch': 'Firefox', 17:17:26 INFO - 'buildbot_json_path': 'buildprops.json', 17:17:26 INFO - 'config_files': ('talos/mac_config.py',), 17:17:26 INFO - 'default_actions': ('clobber', 17:17:26 INFO - 'read-buildbot-config', 17:17:26 INFO - 'download-and-extract', 17:17:26 INFO - 'populate-webroot', 17:17:26 INFO - 'create-virtualenv', 17:17:26 INFO - 'install', 17:17:26 INFO - 'run-tests'), 17:17:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:17:26 INFO - 'download_minidump_stackwalk': True, 17:17:26 INFO - 'download_symbols': 'ondemand', 17:17:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:17:26 INFO - 'tooltool.py': '/tools/tooltool.py', 17:17:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:17:26 INFO - '/tools/misc-python/virtualenv.py')}, 17:17:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:17:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:17:26 INFO - 'gecko_profile': False, 17:17:26 INFO - 'gecko_profile_interval': 0, 17:17:26 INFO - 'installer_path': 'installer.exe', 17:17:26 INFO - 'log_level': 'info', 17:17:26 INFO - 'log_name': 'talos', 17:17:26 INFO - 'log_to_console': True, 17:17:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:17:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:17:26 INFO - 'opt_config_files': (), 17:17:26 INFO - 'pip_index': False, 17:17:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:17:26 INFO - 'cmd': ('bash', 17:17:26 INFO - '-c', 17:17:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:17:26 INFO - 'enabled': True, 17:17:26 INFO - 'halt_on_failure': False, 17:17:26 INFO - 'name': 'check_screen_resolution'},), 17:17:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:17:26 INFO - 'cmd': ('bash', 17:17:26 INFO - '-c', 17:17:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:17:26 INFO - 'enabled': True, 17:17:26 INFO - 'halt_on_failure': False, 17:17:26 INFO - 'name': 'check_screen_resolution'},), 17:17:26 INFO - 'run_cmd_checks_enabled': True, 17:17:26 INFO - 'suite': 'dromaeojs-e10s', 17:17:26 INFO - 'system_bits': '32', 17:17:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:17:26 INFO - 'title': 't-yosemite-r7-0386', 17:17:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:17:26 INFO - 'use_talos_json': True, 17:17:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:17:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:17:26 INFO - 'work_dir': 'build'} 17:17:26 INFO - [mozharness: 2017-04-29 00:17:26.537374Z] Running clobber step. 17:17:26 INFO - Running pre-action listener: _resource_record_pre_action 17:17:26 INFO - Running main action method: clobber 17:17:26 INFO - rmtree: /builds/slave/test/build 17:17:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:17:30 INFO - Running post-action listener: _resource_record_post_action 17:17:30 INFO - [mozharness: 2017-04-29 00:17:30.150269Z] Finished clobber step (success) 17:17:30 INFO - [mozharness: 2017-04-29 00:17:30.150543Z] Running read-buildbot-config step. 17:17:30 INFO - Running pre-action listener: _resource_record_pre_action 17:17:30 INFO - Running main action method: read_buildbot_config 17:17:30 INFO - Using buildbot properties: 17:17:30 INFO - { 17:17:30 INFO - "project": "", 17:17:30 INFO - "product": "firefox", 17:17:30 INFO - "script_repo_revision": "production", 17:17:30 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 17:17:30 INFO - "repository": "", 17:17:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 17:17:30 INFO - "buildid": "20170428170344", 17:17:30 INFO - "stage_platform": "macosx64", 17:17:30 INFO - "basedir": "/builds/slave/test", 17:17:30 INFO - "buildnumber": 17, 17:17:30 INFO - "platform": "yosemite_r7", 17:17:30 INFO - "mozci_request": { 17:17:30 INFO - "priority": 0, 17:17:30 INFO - "type": "trigger_all_talos_jobs", 17:17:30 INFO - "times": 6 17:17:30 INFO - }, 17:17:30 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 17:17:30 INFO - "slavebuilddir": "test", 17:17:30 INFO - "branch": "mozilla-central", 17:17:30 INFO - "revision": "b3b32894d9326d147238d9f071e1814ab3fdc850", 17:17:30 INFO - "slavename": "t-yosemite-r7-0386", 17:17:30 INFO - "builduid": "8d21c10fc463406fbd5f5e1641b772a4", 17:17:30 INFO - "repo_path": "mozilla-central" 17:17:30 INFO - } 17:17:30 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg. 17:17:30 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:17:30 INFO - Running post-action listener: _resource_record_post_action 17:17:30 INFO - [mozharness: 2017-04-29 00:17:30.157201Z] Finished read-buildbot-config step (success) 17:17:30 INFO - [mozharness: 2017-04-29 00:17:30.157422Z] Running download-and-extract step. 17:17:30 INFO - Running pre-action listener: _resource_record_pre_action 17:17:30 INFO - Running main action method: download_and_extract 17:17:30 INFO - mkdir: /builds/slave/test/build/tests 17:17: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:17:30 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.test_packages.json 17:17:30 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:17:30 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:17:30 INFO - Downloaded 1325 bytes. 17:17:30 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:17:30 INFO - Using the following test package requirements: 17:17:30 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:17:30 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 17:17:30 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:17:30 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:17:30 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 17:17:30 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:17:30 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 17:17:30 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:17:30 INFO - u'jsshell-mac.zip'], 17:17:30 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:17:30 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 17:17:30 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:17:30 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:17:30 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 17:17:30 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:17:30 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 17:17:30 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:17:30 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 17:17:30 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:17:30 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 17:17:30 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:17: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:17: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:17: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:17:31 INFO - Content-Length response header: 52698163 17:17:31 INFO - Bytes received: 52698163 17:17:47 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:17:47 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:17:47 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:17:47 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:17:48 INFO - Content-Length response header: 52698163 17:17:48 INFO - Bytes received: 52698163 17:18:03 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:18:03 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:18:03 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:18:04 INFO - Content-Length response header: 14408809 17:18:04 INFO - Bytes received: 14408809 17:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:18:04 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg 17:18:04 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:18:04 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:18:06 INFO - Downloaded 71219323 bytes. 17:18:06 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:18:06 INFO - mkdir: /builds/slave/test/properties 17:18:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:18:06 INFO - Writing to file /builds/slave/test/properties/build_url 17:18:06 INFO - Contents: 17:18:06 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg 17:18:07 INFO - Running post-action listener: _resource_record_post_action 17:18:07 INFO - Running post-action listener: set_extra_try_arguments 17:18:07 INFO - [mozharness: 2017-04-29 00:18:07.053996Z] Finished download-and-extract step (success) 17:18:07 INFO - [mozharness: 2017-04-29 00:18:07.054114Z] Running populate-webroot step. 17:18:07 INFO - Running pre-action listener: _resource_record_pre_action 17:18:07 INFO - Running main action method: populate_webroot 17:18:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:18:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:18:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:18:07 INFO - '--tppagecycles', 17:18:07 INFO - '7'], 17:18:07 INFO - 'tests': ['tsvgm']}}, 17:18:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:18:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:18:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:18:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:18:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:18:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:18:07 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:18:07 INFO - 'talos_options': ['--disable-e10s'], 17:18:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:18:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:18:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:18:07 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:18:07 INFO - 'talos_options': ['--disable-e10s'], 17:18:07 INFO - 'tests': ['damp', 'tps']}, 17:18:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:18:07 INFO - 'tests': ['damp', 'tps']}, 17:18:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:18:07 INFO - 'tests': ['dromaeo_dom']}, 17:18:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:18:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:18:07 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:18:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:18:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:18:07 INFO - 'tests': ['a11yr', 17:18:07 INFO - 'ts_paint', 17:18:07 INFO - 'tpaint', 17:18:07 INFO - 'sessionrestore', 17:18:07 INFO - 'sessionrestore_no_auto_restore', 17:18:07 INFO - 'tabpaint']}, 17:18:07 INFO - 'other-e10s': {'tests': ['a11yr', 17:18:07 INFO - 'ts_paint', 17:18:07 INFO - 'tpaint', 17:18:07 INFO - 'sessionrestore', 17:18:07 INFO - 'sessionrestore_no_auto_restore', 17:18:07 INFO - 'tabpaint']}, 17:18:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:18:07 INFO - 'ts_paint', 17:18:07 INFO - 'tpaint', 17:18:07 INFO - 'sessionrestore', 17:18:07 INFO - 'sessionrestore_no_auto_restore', 17:18:07 INFO - 'tabpaint']}, 17:18:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:18:07 INFO - 'ts_paint', 17:18:07 INFO - 'tpaint', 17:18:07 INFO - 'sessionrestore', 17:18:07 INFO - 'sessionrestore_no_auto_restore', 17:18:07 INFO - 'tabpaint']}, 17:18:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:18:07 INFO - 'tests': ['a11yr', 17:18:07 INFO - 'ts_paint', 17:18:07 INFO - 'tpaint', 17:18:07 INFO - 'sessionrestore', 17:18:07 INFO - 'sessionrestore_no_auto_restore', 17:18:07 INFO - 'tabpaint']}, 17:18:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:18:07 INFO - 'tests': ['a11yr', 17:18:07 INFO - 'ts_paint', 17:18:07 INFO - 'tpaint', 17:18:07 INFO - 'sessionrestore', 17:18:07 INFO - 'sessionrestore_no_auto_restore', 17:18:07 INFO - 'tabpaint']}, 17:18:07 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 17:18:07 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 17:18:07 INFO - 'bloom_basic_ref']}, 17:18:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:18:07 INFO - 'tests': ['tsvgx', 17:18:07 INFO - 'tsvgr_opacity', 17:18:07 INFO - 'tart', 17:18:07 INFO - 'tscrollx', 17:18:07 INFO - 'cart', 17:18:07 INFO - 'tsvg_static']}, 17:18:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:18:07 INFO - 'tsvgr_opacity', 17:18:07 INFO - 'tart', 17:18:07 INFO - 'tscrollx', 17:18:07 INFO - 'cart', 17:18:07 INFO - 'tsvg_static']}, 17:18:07 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:18:07 INFO - 'talos_options': ['--disable-e10s'], 17:18:07 INFO - 'tests': ['tp5o']}, 17:18:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:18:07 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:18:07 INFO - 'talos_options': ['--disable-e10s', 17:18:07 INFO - '--xperf_path', 17:18:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:18:07 INFO - 'tests': ['tp5n']}, 17:18:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:18:07 INFO - 'talos_options': ['--xperf_path', 17:18:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:18:07 INFO - 'tests': ['tp5n']}}, 17:18:07 INFO - 'talos.zip': {'path': '', 17:18:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:18:07 INFO - Running post-action listener: _resource_record_post_action 17:18:07 INFO - [mozharness: 2017-04-29 00:18:07.073364Z] Finished populate-webroot step (success) 17:18:07 INFO - [mozharness: 2017-04-29 00:18:07.073475Z] Running create-virtualenv step. 17:18:07 INFO - Running pre-action listener: _resource_record_pre_action 17:18:07 INFO - Running main action method: create_virtualenv 17:18:07 INFO - Creating virtualenv /builds/slave/test/build/venv 17:18: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:18:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:18:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:18:07 INFO - Using real prefix '/tools/python27' 17:18:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:18:07 INFO - Installing distribute.............................................................................................................................................................................................done. 17:18:10 INFO - Installing pip.................done. 17:18:10 INFO - Return code: 0 17:18:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:18:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:18:11 INFO - Reading from file tmpfile_stdout 17:18:11 INFO - Output received: 17:18: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:18:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:18: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:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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:18:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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 0x104855b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104858768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc982caaab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104633d30>, '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 0x104559db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104628be8>, '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.9iHntS28gD/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.XLRCNY6gWC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/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:18: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:18: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:18:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9iHntS28gD/Render', 17:18:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:18:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:18:11 INFO - 'HOME': '/Users/cltbld', 17:18:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:18:11 INFO - 'LOGNAME': 'cltbld', 17:18:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:11 INFO - 'MOZ_NO_REMOTE': '1', 17:18:11 INFO - 'NO_EM_RESTART': '1', 17:18:11 INFO - 'PAGER': '/bin/cat', 17:18:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:18:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:11 INFO - 'PWD': '/builds/slave/test', 17:18:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:18:11 INFO - 'SHELL': '/bin/bash', 17:18:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XLRCNY6gWC/Listeners', 17:18:11 INFO - 'TMPDIR': '/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/', 17:18:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:18:11 INFO - 'USER': 'cltbld', 17:18:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:18:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:18:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:11 INFO - 'XPC_FLAGS': '0x0', 17:18:11 INFO - 'XPC_SERVICE_NAME': '0', 17:18:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:18:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:11 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:18:11 INFO - Cleaning up... 17:18:11 INFO - Return code: 0 17:18:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:18: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:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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:18:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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', '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 0x104855b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104858768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc982caaab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104633d30>, '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 0x104559db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104628be8>, '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.9iHntS28gD/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.XLRCNY6gWC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/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:18: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', 'psutil>=3.1.1'] in /builds/slave/test/build 17:18: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 psutil>=3.1.1 17:18:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9iHntS28gD/Render', 17:18:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:18:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:18:11 INFO - 'HOME': '/Users/cltbld', 17:18:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:18:11 INFO - 'LOGNAME': 'cltbld', 17:18:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:11 INFO - 'MOZ_NO_REMOTE': '1', 17:18:11 INFO - 'NO_EM_RESTART': '1', 17:18:11 INFO - 'PAGER': '/bin/cat', 17:18:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:18:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:11 INFO - 'PWD': '/builds/slave/test', 17:18:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:18:11 INFO - 'SHELL': '/bin/bash', 17:18:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XLRCNY6gWC/Listeners', 17:18:11 INFO - 'TMPDIR': '/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/', 17:18:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:18:11 INFO - 'USER': 'cltbld', 17:18:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:18:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:18:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:11 INFO - 'XPC_FLAGS': '0x0', 17:18:11 INFO - 'XPC_SERVICE_NAME': '0', 17:18:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:18:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:11 INFO - Downloading/unpacking psutil>=3.1.1 17:18:11 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:18:11 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:18:11 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:18:11 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:18:11 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:18:11 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:18:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:18:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:18:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:18:15 INFO - Installing collected packages: psutil 17:18:15 INFO - Running setup.py install for psutil 17:18:15 INFO - building 'psutil._psutil_osx' extension 17:18: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:18: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_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 17:18: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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 17:18:15 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:18:15 INFO - building 'psutil._psutil_posix' extension 17:18:15 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:18:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:18:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:18:15 INFO - ^ 17:18:15 INFO - 1 warning generated. 17:18:15 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:18:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:18:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:18:15 INFO - Successfully installed psutil 17:18:15 INFO - Cleaning up... 17:18:16 INFO - Return code: 0 17:18:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:18: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:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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:18:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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 0x104855b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104858768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc982caaab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104633d30>, '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 0x104559db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104628be8>, '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.9iHntS28gD/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.XLRCNY6gWC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/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:18: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:18: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:18:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9iHntS28gD/Render', 17:18:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:18:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:18:16 INFO - 'HOME': '/Users/cltbld', 17:18:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:18:16 INFO - 'LOGNAME': 'cltbld', 17:18:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:16 INFO - 'MOZ_NO_REMOTE': '1', 17:18:16 INFO - 'NO_EM_RESTART': '1', 17:18:16 INFO - 'PAGER': '/bin/cat', 17:18:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:18:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:16 INFO - 'PWD': '/builds/slave/test', 17:18:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:18:16 INFO - 'SHELL': '/bin/bash', 17:18:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XLRCNY6gWC/Listeners', 17:18:16 INFO - 'TMPDIR': '/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/', 17:18:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:18:16 INFO - 'USER': 'cltbld', 17:18:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:18:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:18:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:16 INFO - 'XPC_FLAGS': '0x0', 17:18:16 INFO - 'XPC_SERVICE_NAME': '0', 17:18:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:18:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:18: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:18: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:18: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:18: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:18: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:18: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:18:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:18:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:18: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:18:19 INFO - Installing collected packages: mozsystemmonitor 17:18:19 INFO - Running setup.py install for mozsystemmonitor 17:18:19 INFO - Successfully installed mozsystemmonitor 17:18:19 INFO - Cleaning up... 17:18:19 INFO - Return code: 0 17:18:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:18: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:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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:18:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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 0x104855b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104858768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc982caaab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104633d30>, '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 0x104559db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104628be8>, '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.9iHntS28gD/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.XLRCNY6gWC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/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:18: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:18: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:18:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9iHntS28gD/Render', 17:18:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:18:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:18:19 INFO - 'HOME': '/Users/cltbld', 17:18:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:18:19 INFO - 'LOGNAME': 'cltbld', 17:18:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:19 INFO - 'MOZ_NO_REMOTE': '1', 17:18:19 INFO - 'NO_EM_RESTART': '1', 17:18:19 INFO - 'PAGER': '/bin/cat', 17:18:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:18:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:19 INFO - 'PWD': '/builds/slave/test', 17:18:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:18:19 INFO - 'SHELL': '/bin/bash', 17:18:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XLRCNY6gWC/Listeners', 17:18:19 INFO - 'TMPDIR': '/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/', 17:18:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:18:19 INFO - 'USER': 'cltbld', 17:18:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:18:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:18:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:19 INFO - 'XPC_FLAGS': '0x0', 17:18:19 INFO - 'XPC_SERVICE_NAME': '0', 17:18:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:18:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:19 INFO - Downloading/unpacking jsonschema==2.5.1 17:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:18:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:18: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:18: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:18: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:18: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:18: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:18: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:18:22 INFO - Downloading functools32-3.2.3-2.tar.gz 17:18:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:18:22 INFO - warning: no files found matching '*.txt' 17:18:22 INFO - no previously-included directories found matching 'build' 17:18:22 INFO - no previously-included directories found matching 'dist' 17:18:22 INFO - no previously-included directories found matching '.git*' 17:18:22 INFO - Installing collected packages: jsonschema, functools32 17:18:22 INFO - Running setup.py install for functools32 17:18:22 INFO - warning: no files found matching '*.txt' 17:18:22 INFO - no previously-included directories found matching 'build' 17:18:22 INFO - no previously-included directories found matching 'dist' 17:18:22 INFO - no previously-included directories found matching '.git*' 17:18:22 INFO - Successfully installed jsonschema functools32 17:18:22 INFO - Cleaning up... 17:18:22 INFO - Return code: 0 17:18:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:18:22 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:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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:18:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:23 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 0x104855b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104858768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc982caaab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104633d30>, '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 0x104559db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104628be8>, '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.9iHntS28gD/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.XLRCNY6gWC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/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:18:23 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:18:23 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:18:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9iHntS28gD/Render', 17:18:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:18:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:18:23 INFO - 'HOME': '/Users/cltbld', 17:18:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:18:23 INFO - 'LOGNAME': 'cltbld', 17:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:23 INFO - 'MOZ_NO_REMOTE': '1', 17:18:23 INFO - 'NO_EM_RESTART': '1', 17:18:23 INFO - 'PAGER': '/bin/cat', 17:18:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:23 INFO - 'PWD': '/builds/slave/test', 17:18:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:18:23 INFO - 'SHELL': '/bin/bash', 17:18:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XLRCNY6gWC/Listeners', 17:18:23 INFO - 'TMPDIR': '/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/', 17:18:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:18:23 INFO - 'USER': 'cltbld', 17:18:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:18:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:23 INFO - 'XPC_FLAGS': '0x0', 17:18:23 INFO - 'XPC_SERVICE_NAME': '0', 17:18:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:18:24 INFO - Cleaning up... 17:18:24 INFO - Return code: 0 17:18:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:18: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:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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 0x104855b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104858768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc982caaab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104633d30>, '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 0x104559db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104628be8>, '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.9iHntS28gD/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.XLRCNY6gWC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/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:18: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:18: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:18:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9iHntS28gD/Render', 17:18:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:18:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:18:24 INFO - 'HOME': '/Users/cltbld', 17:18:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:18:24 INFO - 'LOGNAME': 'cltbld', 17:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:24 INFO - 'MOZ_NO_REMOTE': '1', 17:18:24 INFO - 'NO_EM_RESTART': '1', 17:18:24 INFO - 'PAGER': '/bin/cat', 17:18:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:24 INFO - 'PWD': '/builds/slave/test', 17:18:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:18:24 INFO - 'SHELL': '/bin/bash', 17:18:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XLRCNY6gWC/Listeners', 17:18:24 INFO - 'TMPDIR': '/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/', 17:18:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:18:24 INFO - 'USER': 'cltbld', 17:18:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:18:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:24 INFO - 'XPC_FLAGS': '0x0', 17:18:24 INFO - 'XPC_SERVICE_NAME': '0', 17:18:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:24 INFO - Downloading/unpacking blobuploader==1.2.4 17:18:24 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:18:24 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:18:24 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:18:24 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:18:24 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:18:24 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:18:27 INFO - Downloading blobuploader-1.2.4.tar.gz 17:18:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:18:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:18:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:18: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:18: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:18: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:18: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:18: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:18: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:18:28 INFO - Downloading docopt-0.6.1.tar.gz 17:18:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:18:28 INFO - Installing collected packages: blobuploader, requests, docopt 17:18:28 INFO - Running setup.py install for blobuploader 17:18:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:18:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:18:28 INFO - Running setup.py install for requests 17:18:29 INFO - Running setup.py install for docopt 17:18:29 INFO - Successfully installed blobuploader requests docopt 17:18:29 INFO - Cleaning up... 17:18:29 INFO - Return code: 0 17:18:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:18: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:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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:18:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:29 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 0x104855b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104858768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc982caaab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104633d30>, '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 0x104559db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104628be8>, '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.9iHntS28gD/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.XLRCNY6gWC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/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:18:29 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:18:29 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:18:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9iHntS28gD/Render', 17:18:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:18:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:18:29 INFO - 'HOME': '/Users/cltbld', 17:18:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:18:29 INFO - 'LOGNAME': 'cltbld', 17:18:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:29 INFO - 'MOZ_NO_REMOTE': '1', 17:18:29 INFO - 'NO_EM_RESTART': '1', 17:18:29 INFO - 'PAGER': '/bin/cat', 17:18:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:18:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:29 INFO - 'PWD': '/builds/slave/test', 17:18:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:18:29 INFO - 'SHELL': '/bin/bash', 17:18:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XLRCNY6gWC/Listeners', 17:18:29 INFO - 'TMPDIR': '/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/', 17:18:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:18:29 INFO - 'USER': 'cltbld', 17:18:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:18:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:18:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:29 INFO - 'XPC_FLAGS': '0x0', 17:18:29 INFO - 'XPC_SERVICE_NAME': '0', 17:18:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:18:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:18:29 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-051Z1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:18:30 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-2MEhqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:18:30 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-7n8_21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:18:30 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-6m3mW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:18:30 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-LdFEoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:18:30 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-RntREr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:18:30 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-mVTfW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:18:30 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-pOhIA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:18:30 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-LdM4pG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:18:30 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-SlGcpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:18:30 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-Ac2M8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:18:31 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-CqqGwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:18:31 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-QamUye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:18:31 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-SC2oOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:31 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-TaP11I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:18:31 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-7ZbHsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:18:31 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-x7A7rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:18:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:18:31 INFO - Running setup.py install for manifestparser 17:18:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:18:31 INFO - Running setup.py install for mozcrash 17:18:31 INFO - Running setup.py install for mozdebug 17:18:32 INFO - Running setup.py install for mozdevice 17:18:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:18:32 INFO - Running setup.py install for mozfile 17:18:32 INFO - Running setup.py install for mozhttpd 17:18:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:18:32 INFO - Running setup.py install for mozinfo 17:18:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:18:32 INFO - Running setup.py install for mozInstall 17:18:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:18:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:18:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:18:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:18:32 INFO - Running setup.py install for mozleak 17:18:32 INFO - Running setup.py install for mozlog 17:18:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:18:33 INFO - Running setup.py install for moznetwork 17:18:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:18:33 INFO - Running setup.py install for mozprocess 17:18:33 INFO - Running setup.py install for mozprofile 17:18:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:18:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:18:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:18:33 INFO - Running setup.py install for mozrunner 17:18:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:18:33 INFO - Running setup.py install for mozscreenshot 17:18:33 INFO - Running setup.py install for moztest 17:18:34 INFO - Running setup.py install for mozversion 17:18:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:18:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:18:34 INFO - Cleaning up... 17:18:34 INFO - Return code: 0 17:18:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:18: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:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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 0x104855b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104858768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc982caaab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104633d30>, '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 0x104559db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104628be8>, '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.9iHntS28gD/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.XLRCNY6gWC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/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:18: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:18: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:18:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9iHntS28gD/Render', 17:18:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:18:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:18:34 INFO - 'HOME': '/Users/cltbld', 17:18:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:18:34 INFO - 'LOGNAME': 'cltbld', 17:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:34 INFO - 'MOZ_NO_REMOTE': '1', 17:18:34 INFO - 'NO_EM_RESTART': '1', 17:18:34 INFO - 'PAGER': '/bin/cat', 17:18:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:34 INFO - 'PWD': '/builds/slave/test', 17:18:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:18:34 INFO - 'SHELL': '/bin/bash', 17:18:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XLRCNY6gWC/Listeners', 17:18:34 INFO - 'TMPDIR': '/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/', 17:18:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:18:34 INFO - 'USER': 'cltbld', 17:18:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:18:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:34 INFO - 'XPC_FLAGS': '0x0', 17:18:34 INFO - 'XPC_SERVICE_NAME': '0', 17:18:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:18:34 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-7e5p3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:18:34 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:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:18:34 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-UAqFtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:18:34 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:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:18:34 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-2LIZlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:18:34 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:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:18:34 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-Tu5Gno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:18:34 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:18:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:18:34 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-WfpojH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:18: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:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:18:35 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-9XSz5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:18: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:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:18:35 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-AmhNAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:18: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:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:18:35 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-WZ2F28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:18:35 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:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:18:35 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-WGqo0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:18:35 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:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:18:35 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-y1SvSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:18:35 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:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:18:35 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-GZW2Co-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:18:35 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:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:18:35 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-J3MtkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:18:35 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:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:18:35 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-P8EjI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:18:35 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:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:18:35 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-RYcGtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:18: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:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:36 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-1TuYQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:18: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:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:18:36 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-j8IaWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:18: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:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:18:36 INFO - Running setup.py (path:/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/pip-71Mi7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:18:36 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:18:36 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:18:36 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:18:36 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:18:36 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:18:36 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:18:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:18:36 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:18:36 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:18:36 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:18:36 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:18:36 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:18:36 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:18:39 INFO - Downloading blessings-1.6.tar.gz 17:18:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:18:39 INFO - Installing collected packages: blessings 17:18:39 INFO - Running setup.py install for blessings 17:18:39 INFO - Successfully installed blessings 17:18:39 INFO - Cleaning up... 17:18:39 INFO - Return code: 0 17:18:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:18:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:18:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:18:39 INFO - Reading from file tmpfile_stdout 17:18:39 INFO - Current package versions: 17:18:39 INFO - blessings == 1.6 17:18:39 INFO - blobuploader == 1.2.4 17:18:39 INFO - docopt == 0.6.1 17:18:39 INFO - functools32 == 3.2.3-2 17:18:39 INFO - jsonschema == 2.5.1 17:18:39 INFO - manifestparser == 1.1 17:18:39 INFO - mozInstall == 1.12 17:18:39 INFO - mozcrash == 1.0 17:18:39 INFO - mozdebug == 0.1 17:18:39 INFO - mozdevice == 0.50 17:18:39 INFO - mozfile == 1.2 17:18:39 INFO - mozhttpd == 0.7 17:18:39 INFO - mozinfo == 0.9 17:18:39 INFO - mozleak == 0.1 17:18:39 INFO - mozlog == 3.4 17:18:39 INFO - moznetwork == 0.27 17:18:39 INFO - mozprocess == 0.25 17:18:39 INFO - mozprofile == 0.28 17:18:39 INFO - mozrunner == 6.13 17:18:39 INFO - mozscreenshot == 0.1 17:18:39 INFO - mozsystemmonitor == 0.3 17:18:39 INFO - moztest == 0.8 17:18:39 INFO - mozversion == 1.4 17:18:39 INFO - psutil == 3.1.1 17:18:39 INFO - requests == 1.2.3 17:18:39 INFO - wsgiref == 0.1.2 17:18:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:18:39 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:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:39 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:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:39 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 0x104855b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104858768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc982caaab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104633d30>, '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 0x104559db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104628be8>, '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.9iHntS28gD/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.XLRCNY6gWC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/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:18:39 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:18:39 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:18:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9iHntS28gD/Render', 17:18:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:18:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:18:39 INFO - 'HOME': '/Users/cltbld', 17:18:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:18:39 INFO - 'LOGNAME': 'cltbld', 17:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:39 INFO - 'MOZ_NO_REMOTE': '1', 17:18:39 INFO - 'NO_EM_RESTART': '1', 17:18:39 INFO - 'PAGER': '/bin/cat', 17:18:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:39 INFO - 'PWD': '/builds/slave/test', 17:18:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:18:39 INFO - 'SHELL': '/bin/bash', 17:18:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XLRCNY6gWC/Listeners', 17:18:39 INFO - 'TMPDIR': '/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/', 17:18:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:18:39 INFO - 'USER': 'cltbld', 17:18:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:18:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:39 INFO - 'XPC_FLAGS': '0x0', 17:18:39 INFO - 'XPC_SERVICE_NAME': '0', 17:18:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:39 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:18:39 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:18:39 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:18:39 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:18:39 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:18:39 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:18:39 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:18:39 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:18:39 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:18:39 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:18:39 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:18:39 INFO - Cleaning up... 17:18:39 INFO - Return code: 0 17:18:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:18:39 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:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:39 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:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:39 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 0x104855b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104858768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc982caaab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104633d30>, '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 0x104559db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104628be8>, '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.9iHntS28gD/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.XLRCNY6gWC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/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:18:39 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:18:39 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:18:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9iHntS28gD/Render', 17:18:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:18:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:18:39 INFO - 'HOME': '/Users/cltbld', 17:18:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:18:39 INFO - 'LOGNAME': 'cltbld', 17:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:39 INFO - 'MOZ_NO_REMOTE': '1', 17:18:39 INFO - 'NO_EM_RESTART': '1', 17:18:39 INFO - 'PAGER': '/bin/cat', 17:18:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:39 INFO - 'PWD': '/builds/slave/test', 17:18:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:18:39 INFO - 'SHELL': '/bin/bash', 17:18:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XLRCNY6gWC/Listeners', 17:18:39 INFO - 'TMPDIR': '/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/', 17:18:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:18:39 INFO - 'USER': 'cltbld', 17:18:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:18:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:39 INFO - 'XPC_FLAGS': '0x0', 17:18:39 INFO - 'XPC_SERVICE_NAME': '0', 17:18:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:18:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:18:40 INFO - Cleaning up... 17:18:40 INFO - Return code: 0 17:18:40 INFO - Running post-action listener: _resource_record_post_action 17:18:40 INFO - Running post-action listener: _start_resource_monitoring 17:18:40 INFO - Starting resource monitoring. 17:18:40 INFO - [mozharness: 2017-04-29 00:18:40.252583Z] Finished create-virtualenv step (success) 17:18:40 INFO - [mozharness: 2017-04-29 00:18:40.253631Z] Running install step. 17:18:40 INFO - Running pre-action listener: _resource_record_pre_action 17:18:40 INFO - Running main action method: install 17:18:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:18:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:18:40 INFO - Reading from file tmpfile_stdout 17:18:40 INFO - Detecting whether we're running mozinstall >=1.0... 17:18:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:18:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:18:40 INFO - Reading from file tmpfile_stdout 17:18:40 INFO - Output received: 17:18:40 INFO - Usage: mozinstall [options] installer 17:18:40 INFO - Options: 17:18:40 INFO - -h, --help show this help message and exit 17:18:40 INFO - -d DEST, --destination=DEST 17:18:40 INFO - Directory to install application into. [default: 17:18:40 INFO - "/builds/slave/test"] 17:18:40 INFO - --app=APP Application being installed. [default: firefox] 17:18:40 INFO - mkdir: /builds/slave/test/build/application 17:18:40 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:18:40 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:19:00 INFO - Reading from file tmpfile_stdout 17:19:00 INFO - Output received: 17:19:00 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:19:00 INFO - Running post-action listener: _resource_record_post_action 17:19:00 INFO - [mozharness: 2017-04-29 00:19:00.348659Z] Finished install step (success) 17:19:00 INFO - [mozharness: 2017-04-29 00:19:00.348789Z] Running run-tests step. 17:19:00 INFO - Running pre-action listener: _resource_record_pre_action 17:19:00 INFO - Running main action method: run_tests 17:19:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:19:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:19:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:19:00 INFO - 2017-04-28 17:19:00.363 screenresolution[2883:39659] starting screenresolution argv=screenresolution get 17:19:00 INFO - 2017-04-28 17:19:00.366 screenresolution[2883:39659] Display 0: 1600x1200x32@60 17:19:00 INFO - 2017-04-28 17:19:00.371 screenresolution[2884:39661] starting screenresolution argv=screenresolution list 17:19:00 INFO - Available Modes on Display 0 17:19:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:19:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:19:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:19:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:19:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:19:00 INFO - Intel Iris: 17:19:00 INFO - Chipset Model: Intel Iris 17:19:00 INFO - Type: GPU 17:19:00 INFO - Bus: Built-In 17:19:00 INFO - VRAM (Dynamic, Max): 1536 MB 17:19:00 INFO - Vendor: Intel (0x8086) 17:19:00 INFO - Device ID: 0x0a2e 17:19:00 INFO - Revision ID: 0x0009 17:19:00 INFO - Displays: 17:19:00 INFO - Display: 17:19:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:19:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:19:00 INFO - Display Serial Number: 1600x1200 60 17:19:00 INFO - Main Display: Yes 17:19:00 INFO - Mirror: Off 17:19:00 INFO - Online: Yes 17:19:00 INFO - Rotation: Supported 17:19:00 INFO - Return code: 0 17:19:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:19:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:19:00 INFO - Python 2.7.3 17:19:00 INFO - Return code: 0 17:19:00 INFO - grabbing minidump binary from tooltool 17:19:00 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:19:00 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 0x104633d30>, '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 0x104559db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104628be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:19:00 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:19:00 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:19:00 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:19:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:19:00 INFO - Return code: 0 17:19:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:19:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:19:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:19:00 INFO - ENV: RUST_BACKTRACE is now 1 17:19:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:19:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:19:00 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-0386', '--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:19:00 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-0386 --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:19:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9iHntS28gD/Render', 17:19:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:19:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:19:00 INFO - 'HOME': '/Users/cltbld', 17:19:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:19:00 INFO - 'LOGNAME': 'cltbld', 17:19:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:19:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:19:00 INFO - 'MOZ_NO_REMOTE': '1', 17:19:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:19:00 INFO - 'NO_EM_RESTART': '1', 17:19:00 INFO - 'PAGER': '/bin/cat', 17:19:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:19:00 INFO - 'PWD': '/builds/slave/test', 17:19:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:19:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:19:00 INFO - 'RUST_BACKTRACE': '1', 17:19:00 INFO - 'SHELL': '/bin/bash', 17:19:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XLRCNY6gWC/Listeners', 17:19:00 INFO - 'TMPDIR': '/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/', 17:19:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:19:00 INFO - 'USER': 'cltbld', 17:19:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:19:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:19:00 INFO - 'XPC_FLAGS': '0x0', 17:19:00 INFO - 'XPC_SERVICE_NAME': '0', 17:19:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:19:00 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-0386', '--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:19:00 INFO - mozversion application_buildid: 20170428075320 17:19:00 INFO - mozversion application_changeset: b3b32894d9326d147238d9f071e1814ab3fdc850 17:19:00 INFO - mozversion application_display_name: Nightly 17:19:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:19:00 INFO - mozversion application_name: Firefox 17:19:00 INFO - mozversion application_remotingname: firefox 17:19:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:19:00 INFO - mozversion application_vendor: Mozilla 17:19:00 INFO - mozversion application_version: 55.0a1 17:19:00 INFO - mozversion platform_buildid: 20170428075320 17:19:00 INFO - mozversion platform_changeset: b3b32894d9326d147238d9f071e1814ab3fdc850 17:19:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:19:00 INFO - mozversion platform_version: 55.0a1 17:19:00 INFO - using testdate: 1493425140 17:19:00 INFO - actual date: 1493425140 17:19:00 INFO - starting webserver on 'localhost:61460' 17:19:00 INFO - SUITE-START | Running 2 tests 17:19:00 INFO - TEST-START | dromaeo_css 17:19:00 INFO - operating with platform_type : mac_ 17:19:00 INFO - Initialising browser for dromaeo_css test... 17:19:00 INFO - TEST-INFO | started process 2894 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/tmpklEg64/profile http://localhost:61460/getInfo.html) 17:19:03 INFO - PID 2894 | 2017-04-28 17:19:03.513 plugin-container[2896:39830] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c47, name = 'com.apple.tsm.portname' 17:19:03 INFO - PID 2894 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:19:03 INFO - PID 2894 | 2017-04-28 17:19:03.516 plugin-container[2896:39830] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9f0b, name = 'com.apple.CFPasteboardClient' 17:19:03 INFO - PID 2894 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:19:03 INFO - PID 2894 | 2017-04-28 17:19:03.517 plugin-container[2896:39830] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:19:03 INFO - PID 2894 | __metrics Screen width/height:1600/1200 17:19:03 INFO - PID 2894 | colorDepth:24 17:19:03 INFO - PID 2894 | Browser inner width/height: 1024/689 17:19:03 INFO - PID 2894 | __metrics 17:19:03 ERROR - PID 2894 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 17:19:04 INFO - TEST-INFO | 2894: exit 0 17:19:04 INFO - Browser initialized. 17:19:04 INFO - Running cycle 1/1 for dromaeo_css test... 17:19:04 INFO - TEST-INFO | started process 2897 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/tmpklEg64/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:19:06 INFO - PID 2897 | 2017-04-28 17:19:06.866 plugin-container[2898:39970] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x953f, name = 'com.apple.tsm.portname' 17:19:06 INFO - PID 2897 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:19:06 INFO - PID 2897 | 2017-04-28 17:19:06.867 plugin-container[2898:39970] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0f, name = 'com.apple.CFPasteboardClient' 17:19:06 INFO - PID 2897 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:19:06 INFO - PID 2897 | 2017-04-28 17:19:06.867 plugin-container[2898:39970] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:19:17 INFO - PID 2897 | RSS: Main: 251678720 17:19:17 INFO - PID 2897 | 17:22:21 INFO - PID 2897 | Cycle 1(1): loaded http://localhost:61460/tests/dromaeo/cssquery-dojo.html (next: http://localhost:61460/tests/dromaeo/cssquery-ext.html) 17:22:22 INFO - PID 2897 | RSS: Main: 254550016 17:22:22 INFO - PID 2897 | 17:24:05 INFO - PID 2897 | ************************* 17:24:05 INFO - PID 2897 | A coding exception was thrown and uncaught in a Task. 17:24:05 INFO - PID 2897 | 17:24:05 ERROR - PID 2897 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:24:05 INFO - PID 2897 | Full stack: 17:24:05 INFO - PID 2897 | ************************* 17:24:05 INFO - PID 2897 | ************************* 17:24:05 INFO - PID 2897 | A coding exception was thrown and uncaught in a Task. 17:24:05 INFO - PID 2897 | 17:24:05 ERROR - PID 2897 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:24:05 INFO - PID 2897 | Full stack: 17:24:05 INFO - PID 2897 | ************************* 17:24:05 INFO - PID 2897 | ************************* 17:24:05 INFO - PID 2897 | A coding exception was thrown and uncaught in a Task. 17:24:05 INFO - PID 2897 | 17:24:05 ERROR - PID 2897 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:24:05 INFO - PID 2897 | Full stack: 17:24:05 INFO - PID 2897 | ************************* 17:24:05 INFO - PID 2897 | ************************* 17:24:05 INFO - PID 2897 | A coding exception was thrown and uncaught in a Task. 17:24:05 INFO - PID 2897 | 17:24:05 ERROR - PID 2897 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:24:05 INFO - PID 2897 | Full stack: 17:24:05 INFO - PID 2897 | ************************* 17:25:24 INFO - PID 2897 | Cycle 1(1): loaded http://localhost:61460/tests/dromaeo/cssquery-ext.html (next: http://localhost:61460/tests/dromaeo/cssquery-jquery.html) 17:25:25 INFO - PID 2897 | RSS: Main: 261246976 17:25:25 INFO - PID 2897 | 17:28:27 INFO - PID 2897 | Cycle 1(1): loaded http://localhost:61460/tests/dromaeo/cssquery-jquery.html (next: http://localhost:61460/tests/dromaeo/cssquery-mootools.html) 17:28:27 INFO - PID 2897 | RSS: Main: 270385152 17:28:27 INFO - PID 2897 | 17:31:29 INFO - PID 2897 | Cycle 1(1): loaded http://localhost:61460/tests/dromaeo/cssquery-mootools.html (next: http://localhost:61460/tests/dromaeo/cssquery-prototype.html) 17:31:30 INFO - PID 2897 | RSS: Main: 262823936 17:31:30 INFO - PID 2897 | 17:34:33 INFO - PID 2897 | Cycle 1(1): loaded http://localhost:61460/tests/dromaeo/cssquery-prototype.html (next: http://localhost:61460/tests/dromaeo/cssquery-yui.html) 17:34:33 INFO - PID 2897 | RSS: Main: 271998976 17:34:33 INFO - PID 2897 | 17:37:35 INFO - PID 2897 | Cycle 1(1): loaded http://localhost:61460/tests/dromaeo/cssquery-yui.html (next: http://localhost:61460/tests/dromaeo/cssquery-dojo.html) 17:37:35 INFO - PID 2897 | RSS: Main: 266620928 17:37:35 INFO - PID 2897 | 17:37:35 INFO - PID 2897 | __start_tp_report 17:37:35 INFO - PID 2897 | _x_x_mozilla_page_load 17:37:35 INFO - PID 2897 | _x_x_mozilla_page_load_details 17:37:35 INFO - PID 2897 | |i|pagename|runs| 17:37:35 INFO - PID 2897 | |0;dojo.html;3019.71312725291;3443.690067893889;3611.368010598146;3642.5446819147605;3668.706503479722;5470.425605311445;5842.328132264791;6139.539534534916;6190.380961903813;6271.3728627137325;5316.883454474565;6132.845047373393;6175.382461753822;6188.721507532161;6191.257049154108;4192.601702838233;4423.601875831175;4946.703197808125;5388.43421440749;5389.353277606692;4561.6806823522365;5581.888362232753;5582.245482965616;5582.581306402016;5597;4139.3583994480905;4792.448868380146;5413.918791218135;5447.836564903059;5537.307836520435;5492.340919089735;5511.366192887829;5521.171824226358;5537.750801213955;5555.194496797982;4810.63920205986;5163.096458119851;5439.129739241742;5443.646162999393;5473.397926228112;5570.125767419667;6129.022607377584;6149.354317796612;6277.843053923642;6302.149209856657;6519.087327774116;6569.507286953498;6645.169353830771;6657.966710166466;6695.430888374494;6782.830429239309;6786.59280443175;6802.4217941475035;6806.489513286523;6826;6265.467435267962;6315.400036996524;6327.778527751507;6349.492040636738;6354.491640668735;6717.596944183267;6813.046173535709;6839.076724642209;6915.377616014583;6973.163220413481;6342.778002769881;6465.418112369909;6521.9673901630185;6543.738250470023;6630;6616.536842421081;6733;6753.08833307507;6773.424258937947;6783.423409010191;6636.83407914806;6652.567583107082;6662.333766623299;6675.065490831287;6682.164729408824;6423.74305027803;6516.771912983023;6527.379898909596;6613.338666133444;6704.161979752531;4818.759062046954;5296.152615581488;5334.386545547234;5363.356397232357;5366.087765079946;4710.599599034052;4710.9764451177525;4717.905641887143;4752.7861246244;4773.7374444405195;6039.577229593974;6266.310705822356;6308.495320374359;6315.400036996478;6346.143270658402;6534.640594767334;6653.833654158588;6759;6811.25076241613;6835.350641689031;6394.744210231539;6413.262474815456;6413.615183089029;6420.6147631142285;6429.646369449725;5927.407259274038;6017.217761691039;6023.186869772612;6039.5470339723815;6041.486473649701;6778.627175505395;6877.209120951155;6944.201416836926;6985.755498557526;7046.894296585555;6782.830429239309;6783.287754785873;6785.219699734396;6805.93194068053;6810.9318906810295;6888.0356750056035;6950.8609827804175;6985.7205711772995;6993.510454268356;6997.545159564612;6405.679716014274;6509.218893732783;6510.641914694737;6675.399214070757;6685.09751183584;5668.489835914787;6816;6820.522563420513;6835.658217089026;6857.245702972768;6290.402411770874;6357.4596159326975;6580.440662543738;6599.934000659932;6605.471562275103;6312.6528040956355;6465.353464653497;6595.142631457879;6609.074729537772;6621.768238111836;6263.3736626337;6336.714847831767;6402.6158430494315;6428.61428314284;6447.838804029937;6504;6507.707153178213;6596.637184954873;6616.470682345497;6618.2719900811835;6346.968265158829;6347.174867267226;6349.206349206349;6356.713947872265;6363.872722545616 17:37:35 INFO - PID 2897 | |1;ext.html;810.6109067647528;833.4041160570193;978.3591747405447;1158.3918442817526;1286.6976260578767;36863.815680921594;37224.62775372245;37231.62768372322;37232.44151337732;37302.69440569581;36965.81517092417;37115.81442092793;37255.62744372562;37265.627343726555;37372.62627373725;7161.355478006978;7904.2886140247365;8245.051819040827;8487.321014318839;8508.872366914502;6522.706478208492;8513.957430212871;8517.914820851774;8521.616527256258;8544.829103417927;7039.472039597025;8440.957795211047;8525;8526.829463410728;8528.360372972053;8455.281301089415;8478.364122690791;8509.276711479532;8521.659133634646;8530.616122274512;7591.3926885849;7759.224077592252;8225.917740822635;8280.213379728915;8312.002559692875;36633.63366366329;36798.63201368006;36864.63135368639;36893.07767305839;36914.261714765555;3634.4730014148063;3636.7272454566014;3682.723795715332;3683.852645894161;3685.5761587417524;27390.589141162898;27486.0379886703;30098.69901300981;30406;30504.237394065327;3094;3125.484295091307;3148.732357749594;3150.6061742282213;3159.368126374711;309856;311151;311170;314801;316332;38530.80734596309;39283;46988.060238795035;47592.7620361896;47787.76106119447;49325.75337123363;49646.50353496491;49782;49827.75086124619;49855.750721246884;14385.921055920848;14415.351309191112;14515.92742036283;14534.345954432076;14535.709285814224;11610.303381797119;11715.531378744754;11725.475688160484;11829.645110646694;11860.88139118615;13507.864921350858;13530.323483825769;13549.864501355058;13558.457661693421;13699.794503082461;6102.572819902653;6174.44430001293;6199;6203.410675985774;6221.813345599639;992.4243938515643;1009.4498498318434;1014.8731408573929;1035.9533820978074;1060.7189094889861;21675.67486487704;23207.3037808866;24160.275191744277;24455.755442445705;24469.63295550568;1118.2116607791488;1142.8400023996646;1157.6506036037795;1162.7151347919644;1170.3153655111855;10342.689719308433;12030.218035827818;12334.629961101182;12408.441620127116;12466.626001219978;325690;327877.3606131954;328467;329210.78681345034;329858;53335.73332133392;53357.66605834808;53651.92696146055;53728;53734;1498.572906721579;1529;1566.8903176777744;1568.725473042213;1575.141547856421;19490.707639385706;23558;23717.525649486568;24103.397415064763;24130.155444559357;37418.06454838651;37508.43737343996;37534.43698344472;37657.81171094127;37723.850376459115;293662;294026;295077;295411;296266;32279.193020174684;33655.15862103467;33718;33727.66272337245;33814.830925845214;42468.57531424646;42898.35652465153;44351.556484436034;44483.777581111885;44639.33041004323;29727.81088756512;29770.404591908475;30503;30541;30965.91619293314;24185.63721544143;30823;30936.0719178416;31071.378572427973;31344.05967820969;37255.627443725214;37263.813680931424;37419.251614968096;37473.81263093667;37565.624343756215;25224.74775252224;29583.85208073946;30649.387012260075;31451.685483144876;31488.527672084478;24093.51812963766;24152.792360381558;24274;24541.631875521525;24546.263612091665 17:37:35 INFO - PID 2897 | |2;jquery.html;346.14329534402356;372.8024147201984;431.75390027684233;433.75059340878965;435.92153412385755;21261.787382126175;21433.67849482259;21848.235311764092;22213;22409.663855042167;22694.546109077808;22917.19789807357;23243.186488472908;23510.17714379997;23795.286141415785;5822.359540450547;5873.177755114288;6406.743730250784;6442;6447.484201263887;6302.55882088254;6748.763793267237;7094.077769889907;7177.820554486128;7184.856302873939;6905.861882762341;7139.85720285594;7146.499745017851;7149.285071492835;7183.928160718378;7145.35691787739;7212.386947109502;7212.567245965259;7229.963850180768;7239.457040721941;6361.332060133665;7012.614306213156;7051.964740176318;7066.434685225169;7068.0104785330095;28871.42257154845;29760.851195743882;29814.701852981627;29876.70123298761;29996.400071998654;2395.724491683461;2429.283361408371;2445.6209287560455;2447.8164137689746;2450.6936632920883;15938.920305398515;18321.992290424023;19216.519587010298;19586.866101423846;19863;2250.6961560189493;2290.2213247495765;2364;2372.1223147435558;2403.831731778776;152352;153496;156592;159426.4057359423;160635.99999999884;23263.302100937;24795.5040899181;24902.37744056413;25039;25047.37381565439;42115.7894210527;42258.78870605689;42280;42427.363589546185;42454.57545424568;8544.273736732448;10086.899131008742;10283.12593429567;10496.630747766194;11481.196316257781;7297.233790452032;8747.737567872973;8800.47197168172;9131.086891310815;9189.586468608928;9513.19360788569;9682.75793105164;11118.777624447466;11518.769624607461;11827.88172118285;3695.3902606069696;4319.827206911751;4408.515063343029;4683.508231635629;4960.950390496048;938.1978408460805;978.1490103609763;978.7504186432415;984.7488890332919;1025.887152413234;21444.785552144593;21933.670994935088;21937.890310548344;21997.780022199575;22099.005544750526;1013.6300250408548;1029.809485245232;1039.953202105907;1060.188955449082;1060.5227647558474;10033.949830250947;10571.577136914591;11092.778144437067;11451.541938322374;11517.136214783925;466649;469278.6536067366;471351;486904;561239.9791516667;123778;126516.36741816232;126595;126691.36654316669;130125.34937325252;1192.0582739635763;1225.7793597152597;1226.45422786859;1230.0712961713848;1279.705667696435;20481.590368192254;21602.675959860928;22531;22837.31488055361;22958.885205573864;40338;54369.45630543644;54843;55002;57845.710771445876;74002.51994959963;74225.257747424;75342.62328688322;75609.24390756243;75821;8994.640214391351;9098.727038188865;9123.042080581708;9150.725478235663;9231.35380523357;10908.61819836302;12355.57910840265;14336.211508366723;14756.852431475978;15081.944263901421;11090.140382154044;12275.140740148105;12358.938205308916;12377.257364558156;12482.438290277141;11573.942130289295;11673.533058677558;11817.82273265919;11896.76206475883;12005.099617528895;12184.390780461119;12237.510499580274;12424.440900159334;12471.875281247072;12516.937415312865;9036.502992335485;9058.773530661523;9129.5891684873;9204.401713888576;9270.72187834366;11445.198836081394;12100.636980890587;12363.93818030904;12388.81416778731;12427.937860311002 17:37:35 INFO - PID 2897 | |3;mootools.html;1408.7605107131787;1439.8704116629501;1464.0264224290847;1466.2302291297067;1472.5716055426235;11438;11468.311901285928;11788.646340609774;11912.463939122728;11939.403029848505;10984.670459886196;11123.27698699584;11127.332360058403;11138.164637652168;11178.882111788816;2455.9631605525888;2496.463260399014;2498.6376975338567;2503.4993001399703;2504.724480307165;2417.3110663460916;2476.8142389320874;2476.8761561921924;2479.38015496126;2479.789217916479;2472.81453890958;2487.763662452064;2517.307740371394;2520.1305549585454;2526.9620955685677;2442.9755702442926;2473.0478765675166;2486.9378265543414;2495.6381324707995;2501.249625112459;2444.9022039118413;2455.5211733711753;2458.520588485246;2532.7214006459276;2539.9238022859345;10294.227932905062;11626.244294120856;11704.297742135414;11717.765644687144;11718.23831450953;6526.151600291979;6710.899336509908;6773.458123350169;6786.558873673245;6813.6593170341785;4033.3748269018347;4291.570842915715;4306.289462238727;4362.280223763075;4450.376947227358;1247.7192631657895;1268.644779461743;1311.8884894783955;1313.7175507265983;1316.9144005639698;16280.348786048544;16655;16759.748603770953;16789.496315110566;16938.49184524466;5127.359080114986;5445.428230035868;5707.773968152424;5732.885342293131;5740.253767010262;11633.6509904703;11795.29228246308;11863.110266729856;11864.703382415337;11885.881141188478;6572.539922205496;6587.011948207807;6588.439982601532;6590.505712071614;6609.933900661028;6007.88854062;6057.061155520813;6203.379662033761;6216.658083805343;6216.813495595139;3698.6116457772087;3793.943090853584;4229.851955181553;4321.65426765858;4472.434647873219;1143.2454579977175;1180.598596477202;1278.4502663854632;1297.7015286483972;1297.7080156964607;786.6420778545748;798.8641930871765;814.8185131559263;815.6288888555692;843.717354686187;5419;5509.944900550943;6155.4767844732805;6204.627722336674;6307.432331090224;567.1278404699291;586.0886321769603;608.8660494691161;611.0681211153027;616.3220457496807;3872.8063596820048;4164.8125834337525;4275.144971005811;4385.802638881258;4392.516823149451;10544.683659490227;14585.708285834224;14683.853161468462;15105.773413398807;15137.621559460882;14987.250637468083;15069.623259418382;15150.621234469227;15307.61730956735;15333.386664533517;8300.584970751439;8595.3553483489;8645.394822362374;8698.260647845003;8820.647174113092;6919.135108111486;7087.220405755466;7151.678174482056;7189.71241150369;7225.096862892138;13139.014573906805;13205.867941320848;13284.202947823162;13463.663408414868;13594.592162235149;13677.589672309847;13706.588802335946;13867.79198312006;14079.718405631626;14121.2233327168;9284.257259419366;9550.570224340061;9551.044895510393;9560.521973901416;9570.186534144676;10319.122874555747;10408.063274305348;10597.311174773615;10670;10785.838212426977;8834.204921557091;9057.501837398742;9248.398854074732;9317.39436936597;9337.71986840396;7596.582187979714;8760.60577274037;8941.195292423714;8993.550322483981;9012.774680633036;8056.395770317133;8134.959325203336;8205.589720513832;8206.179382061746;8217.5480348579;4948.134076536664;5977.940220597912;5979.910301345571;6171.321154673072;6246.500279977682;5390.892182156414;5645.463680950304;5653.575981801464;6028.939710602838;6208.3791620839365 17:37:35 INFO - PID 2897 | |4;prototype.html;336.6599734268388;386.4570278758344;403.72344943713574;407.42959856201315;414.2502071251035;5867.237259156314;6165.19852419186;6319.936800631992;6447.54867159299;6474.67626618669;5854.590178687494;6107.328193898667;6119.082137679339;6274.654893980829;6300.21247344082;4629.65277604181;4717.9292310615365;4785.377900872891;4791.425028996526;4837.758112094399;4653.162430762478;4782.306565547993;4783.354247176639;4802.759862006903;4827.179379505493;4747.620190384761;4755.262934245197;4763.690360126598;4770.666053376265;4782.473927867932;4602.05657840142;4768.690035147704;4775.5701986821;4791.3531673224015;4809.110314591811;3386.9491957620658;3578.3022310649435;3817.503724515795;3973.8807835764974;4227.3447615619625;4969.378827646544;5258.868528286824;6146.569740118193;6177.845553861144;6206.813795586139;5052.898942021139;5423.511883930465;5655.095184770417;5662.207290979266;5716.28546431696;6120.296165940929;6259.741816873802;6801.625910574917;6804.387605115563;6809.3190680932;4035.6973227008093;4829.937413768966;4836.500684787692;4851.951480485185;4884.877878053042;5416.0792665247;6575.816353056448;6650.800475985679;6948.583085014865;7124.857502849965;4292.527821939584;4931.235658472942;4935.185694360463;4940.20956646942;4956.157453232959;4522.389477420506;4562.24722920721;5035.219540971156;5044.924326135111;5049.419316778544;5591.496765291144;5628.549716022709;5632.070708333079;5659;5666.348369937427;6180.81457556274;6207.317195108534;6778.864422711518;6797;6814.829629259309;1580.8143892080939;1645.1856331115935;1670.106493026225;1707.6670049340507;1712.9400470983455;984.17329443268;1043.4782608695652;1100.8991008991009;1151.2344291046527;1160.1067178272851;5627.803026894039;5772.018756811352;6364.77723279683;6389.872202555923;6401.935980640227;6834.359753659185;6932.584044957319;6986.930130698628;6989.20431827263;7021.719131234796;4805.687630304089;6317.241930968221;6388.272678218178;6408.775692850728;6410.45511131559;3035.2411897025745;3590.982045089758;3594.8741794037082;3641.7632853864416;3658.3780757270797;6607.174103237096;6953;7100.644967751592;7224.963875180695;7266.091738532684;5937.643741375445;6794.8641027180165;7157.24848890859;7196.712131514785;7209.134903811576;5760.8271751847515;7195.495445983826;7296.306850849161;7340.229275926058;7398.3341499265325;5974.462298393166;6653.334666533308;6669.899951500828;7099.290070993066;7185.461090418135;5490.80782172622;6600.438962688226;6861.862762744817;6876.17485901695;6904.06686127885;5840.627452548562;6397.360263973752;7274.854502910018;7283.672234749555;7301.890471642823;4339.240632889295;4405.876501492099;4413.360062790814;4416.381706561148;4424.84513042042;5747.396523364986;6170.568060235741;7106.360427561544;7139.178994415709;7152.177499587614;6396.48828093742;6702.765403210864;6730.562513436611;6738.66306684654;6745.763898263537;6738.7304507819135;6744.595324280559;6747.257801641914;6748.93251067483;6835.69239384219;6299.496040316855;6335.65153916539;6485.708143133476;6557.311482294291;6593.670316484253;5839.649621022752;6096.603720758137;6717.361850624183;6750.628715420699;6757.425618822455;5924.348321684697;6178.845528861814;6361.8727625448155;6543.378379053982;6582.736690532325 17:37:35 INFO - PID 2897 | |5;yui.html;764.9273319034692;842.2083241752756;846.6359465429863;865.7835541114721;879.995600022;16417.425390111333;16925.23836427362;17126.743098853494;18637.347692830754;19107;17840.286388544475;18187.27250909962;18299.35952241672;18302.542436439096;18406;980.5734505490135;986.6152200641719;990.1336330710628;990.6087095597235;994.820932232198;979.0503211884461;989.2580564576567;993.0417147452707;993.3791380387258;995.6117114325419;1014.0974532665933;1032.2619327181064;1032.3444612670971;1037.1754455208127;1040.8230600797845;1018.4602160854722;1020.3673722292226;1022.5449674894675;1027.250107421579;1037.6990672704906;751.6204316820025;767.7428061599371;776.5496012312901;783.3693876429472;783.6865253898429;16558.751618725608;16674.739706873832;16685.24916378766;16829;16864.494065178063;16908.746368804477;17213.655726885518;17333.7399939001;17420.738688919675;17672.469825905115;14024.929875350557;14029.508967186099;14238.644033899132;14333;14356;3438.638942910983;3517;3518.47222916562;3523.2072783623735;3524;130277.92637625812;130764;130974;132122.33938830244;133693.3315333427;13277.269750163641;13323.200607963554;13483.662908427368;13514.59456216315;13650.590482285548;25311.62032569513;25344;25585.74414255871;25723.099691510706;25941.74058259431;7120.964395177991;7168.892466613005;7195.064641596664;7198.820029499199;7225.819354516179;3836.3861782114727;3916.432117343026;3924.5682974872743;3929.7445666031617;3929.8231579578987;4300.98926752213;4329.826806927687;4343.261645520269;4387.736735795863;4388.561143885586;895.923846473044;903.3089686389917;908.7410088124852;913.0914739833775;927.823713494434;661.9371159739817;671.6943790575276;678.9864202716017;679.0968012543306;698.0192829075157;10008.49957502122;10185.796284074277;11033.448327583588;12029.338386388657;12053.939730301468;663.8008597420851;669.3440428380214;670.6847781542765;683.0198664915862;692.4564217089661;4504.594586487166;4814.229723244264;5358;5375.973120134452;5610.635308704921;113231;113421.432892835;115838.84161158449;116688;118770.8430204956;71791.78801101215;86750.13249867421;99326.02021939354;101730;101957.4706379405;76419.9999999989;77142.22857771463;84733.57633211918;84769.57615211884;86478;9647.807043859224;13033.413496392875;13033.869661303266;13062.281574513492;13070.346482675637;38088.42867356937;38972.220555589294;39210.60789392069;39897.2020559593;41027.384589231784;71797.6410117946;73055;73724.63137684492;74130.62934685507;74244;16336.754948675542;16925.407610733564;17059.48821535356;17105.401310954057;17151.91424042872;17885.642287154446;18275.177617007;18312.816871831645;18376;18798.53003674919;16388.098654574114;16590.419335323204;16888.493345199662;17009.489715308562;17225.483235502954;16167.919160404123;16806;17029.23368448398;17150.313987440364;17474.03892785909;16022.679546408774;16824.57938551546;16909.900856444292;16959.745603815707;17010.574735631708;11604.88395116038;11787.941060294643;12096.879031209928;12227;12249.938750306192;12883.871161288267;13246.072774905664;13600.931995340356;14126.78809817833;14180.220087895264 17:37:35 INFO - PID 2897 | __end_tp_report 17:37:35 INFO - PID 2897 | __start_cc_report 17:37:35 INFO - PID 2897 | _x_x_mozilla_cycle_collect,422 17:37:35 INFO - PID 2897 | __end_cc_report 17:37:35 INFO - PID 2897 | __startTimestamp1493426255785__endTimestamp 17:37:35 INFO - PID 2897 | 17:37:35 INFO - PID 2897 | ------- Summary: start ------- 17:37:35 INFO - PID 2897 | Number of tests: 6 17:37:35 INFO - PID 2897 | 17:37:35 INFO - PID 2897 | [#0] dojo.html Cycles:165 Average:6127.51 Median:6394.74 stddev:802.55 (12.6%) stddev-sans-first:767.09 17:37:35 INFO - PID 2897 | Values: 3019.7 3443.7 3611.4 3642.5 3668.7 5470.4 5842.3 6139.5 6190.4 6271.4 5316.9 6132.8 6175.4 6188.7 6191.3 4192.6 4423.6 4946.7 5388.4 5389.4 4561.7 5581.9 5582.2 5582.6 5597.0 4139.4 4792.4 5413.9 5447.8 5537.3 5492.3 5511.4 5521.2 5537.8 5555.2 4810.6 5163.1 5439.1 5443.6 5473.4 5570.1 6129.0 6149.4 6277.8 6302.1 6519.1 6569.5 6645.2 6658.0 6695.4 6782.8 6786.6 6802.4 6806.5 6826.0 6265.5 6315.4 6327.8 6349.5 6354.5 6717.6 6813.0 6839.1 6915.4 6973.2 6342.8 6465.4 6522.0 6543.7 6630.0 6616.5 6733.0 6753.1 6773.4 6783.4 6636.8 6652.6 6662.3 6675.1 6682.2 6423.7 6516.8 6527.4 6613.3 6704.2 4818.8 5296.2 5334.4 5363.4 5366.1 4710.6 4711.0 4717.9 4752.8 4773.7 6039.6 6266.3 6308.5 6315.4 6346.1 6534.6 6653.8 6759.0 6811.3 6835.4 6394.7 6413.3 6413.6 6420.6 6429.6 5927.4 6017.2 6023.2 6039.5 6041.5 6778.6 6877.2 6944.2 6985.8 7046.9 6782.8 6783.3 6785.2 6805.9 6810.9 6888.0 6950.9 6985.7 6993.5 6997.5 6405.7 6509.2 6510.6 6675.4 6685.1 5668.5 6816.0 6820.5 6835.7 6857.2 6290.4 6357.5 6580.4 6599.9 6605.5 6312.7 6465.4 6595.1 6609.1 6621.8 6263.4 6336.7 6402.6 6428.6 6447.8 6504.0 6507.7 6596.6 6616.5 6618.3 6347.0 6347.2 6349.2 6356.7 6363.9 17:37:35 INFO - PID 2897 | 17:37:35 INFO - PID 2897 | [#1] ext.html Cycles:180 Average:45736.60 Median:329534.39 stddev:81999.22 (24.9%) stddev-sans-first:82159.87 17:37:35 INFO - PID 2897 | Values: 810.6 833.4 978.4 1158.4 1286.7 36863.8 37224.6 37231.6 37232.4 37302.7 36965.8 37115.8 37255.6 37265.6 37372.6 7161.4 7904.3 8245.1 8487.3 8508.9 6522.7 8514.0 8517.9 8521.6 8544.8 7039.5 8441.0 8525.0 8526.8 8528.4 8455.3 8478.4 8509.3 8521.7 8530.6 7591.4 7759.2 8225.9 8280.2 8312.0 36633.6 36798.6 36864.6 36893.1 36914.3 3634.5 3636.7 3682.7 3683.9 3685.6 27390.6 27486.0 30098.7 30406.0 30504.2 3094.0 3125.5 3148.7 3150.6 3159.4 309856.0 311151.0 311170.0 314801.0 316332.0 38530.8 39283.0 46988.1 47592.8 47787.8 49325.8 49646.5 49782.0 49827.8 49855.8 14385.9 14415.4 14515.9 14534.3 14535.7 11610.3 11715.5 11725.5 11829.6 11860.9 13507.9 13530.3 13549.9 13558.5 13699.8 6102.6 6174.4 6199.0 6203.4 6221.8 992.4 1009.4 1014.9 1036.0 1060.7 21675.7 23207.3 24160.3 24455.8 24469.6 1118.2 1142.8 1157.7 1162.7 1170.3 10342.7 12030.2 12334.6 12408.4 12466.6 325690.0 327877.4 328467.0 329210.8 329858.0 53335.7 53357.7 53651.9 53728.0 53734.0 1498.6 1529.0 1566.9 1568.7 1575.1 19490.7 23558.0 23717.5 24103.4 24130.2 37418.1 37508.4 37534.4 37657.8 37723.9 293662.0 294026.0 295077.0 295411.0 296266.0 32279.2 33655.2 33718.0 33727.7 33814.8 42468.6 42898.4 44351.6 44483.8 44639.3 29727.8 29770.4 30503.0 30541.0 30965.9 24185.6 30823.0 30936.1 31071.4 31344.1 37255.6 37263.8 37419.3 37473.8 37565.6 25224.7 29583.9 30649.4 31451.7 31488.5 24093.5 24152.8 24274.0 24541.6 24546.3 17:37:35 INFO - PID 2897 | 17:37:35 INFO - PID 2897 | [#2] jquery.html Cycles:180 Average:35383.76 Median:2437.45 stddev:84164.08 (3453.0%) stddev-sans-first:84359.07 17:37:35 INFO - PID 2897 | Values: 346.1 372.8 431.8 433.8 435.9 21261.8 21433.7 21848.2 22213.0 22409.7 22694.5 22917.2 23243.2 23510.2 23795.3 5822.4 5873.2 6406.7 6442.0 6447.5 6302.6 6748.8 7094.1 7177.8 7184.9 6905.9 7139.9 7146.5 7149.3 7183.9 7145.4 7212.4 7212.6 7230.0 7239.5 6361.3 7012.6 7052.0 7066.4 7068.0 28871.4 29760.9 29814.7 29876.7 29996.4 2395.7 2429.3 2445.6 2447.8 2450.7 15938.9 18322.0 19216.5 19586.9 19863.0 2250.7 2290.2 2364.0 2372.1 2403.8 152352.0 153496.0 156592.0 159426.4 160636.0 23263.3 24795.5 24902.4 25039.0 25047.4 42115.8 42258.8 42280.0 42427.4 42454.6 8544.3 10086.9 10283.1 10496.6 11481.2 7297.2 8747.7 8800.5 9131.1 9189.6 9513.2 9682.8 11118.8 11518.8 11827.9 3695.4 4319.8 4408.5 4683.5 4961.0 938.2 978.1 978.8 984.7 1025.9 21444.8 21933.7 21937.9 21997.8 22099.0 1013.6 1029.8 1040.0 1060.2 1060.5 10033.9 10571.6 11092.8 11451.5 11517.1 466649.0 469278.7 471351.0 486904.0 561240.0 123778.0 126516.4 126595.0 126691.4 130125.3 1192.1 1225.8 1226.5 1230.1 1279.7 20481.6 21602.7 22531.0 22837.3 22958.9 40338.0 54369.5 54843.0 55002.0 57845.7 74002.5 74225.3 75342.6 75609.2 75821.0 8994.6 9098.7 9123.0 9150.7 9231.4 10908.6 12355.6 14336.2 14756.9 15081.9 11090.1 12275.1 12358.9 12377.3 12482.4 11573.9 11673.5 11817.8 11896.8 12005.1 12184.4 12237.5 12424.4 12471.9 12516.9 9036.5 9058.8 9129.6 9204.4 9270.7 11445.2 12100.6 12363.9 12388.8 12427.9 17:37:35 INFO - PID 2897 | 17:37:35 INFO - PID 2897 | [#3] mootools.html Cycles:180 Average:7053.00 Median:3746.28 stddev:4491.10 (119.9%) stddev-sans-first:4483.67 17:37:35 INFO - PID 2897 | Values: 1408.8 1439.9 1464.0 1466.2 1472.6 11438.0 11468.3 11788.6 11912.5 11939.4 10984.7 11123.3 11127.3 11138.2 11178.9 2456.0 2496.5 2498.6 2503.5 2504.7 2417.3 2476.8 2476.9 2479.4 2479.8 2472.8 2487.8 2517.3 2520.1 2527.0 2443.0 2473.0 2486.9 2495.6 2501.2 2444.9 2455.5 2458.5 2532.7 2539.9 10294.2 11626.2 11704.3 11717.8 11718.2 6526.2 6710.9 6773.5 6786.6 6813.7 4033.4 4291.6 4306.3 4362.3 4450.4 1247.7 1268.6 1311.9 1313.7 1316.9 16280.3 16655.0 16759.7 16789.5 16938.5 5127.4 5445.4 5707.8 5732.9 5740.3 11633.7 11795.3 11863.1 11864.7 11885.9 6572.5 6587.0 6588.4 6590.5 6609.9 6007.9 6057.1 6203.4 6216.7 6216.8 3698.6 3793.9 4229.9 4321.7 4472.4 1143.2 1180.6 1278.5 1297.7 1297.7 786.6 798.9 814.8 815.6 843.7 5419.0 5509.9 6155.5 6204.6 6307.4 567.1 586.1 608.9 611.1 616.3 3872.8 4164.8 4275.1 4385.8 4392.5 10544.7 14585.7 14683.9 15105.8 15137.6 14987.3 15069.6 15150.6 15307.6 15333.4 8300.6 8595.4 8645.4 8698.3 8820.6 6919.1 7087.2 7151.7 7189.7 7225.1 13139.0 13205.9 13284.2 13463.7 13594.6 13677.6 13706.6 13867.8 14079.7 14121.2 9284.3 9550.6 9551.0 9560.5 9570.2 10319.1 10408.1 10597.3 10670.0 10785.8 8834.2 9057.5 9248.4 9317.4 9337.7 7596.6 8760.6 8941.2 8993.6 9012.8 8056.4 8135.0 8205.6 8206.2 8217.5 4948.1 5977.9 5979.9 6171.3 6246.5 5390.9 5645.5 5653.6 6028.9 6208.4 17:37:35 INFO - PID 2897 | 17:37:35 INFO - PID 2897 | [#4] prototype.html Cycles:180 Average:5459.66 Median:6101.97 stddev:1677.63 (27.5%) stddev-sans-first:1637.67 17:37:35 INFO - PID 2897 | Values: 336.7 386.5 403.7 407.4 414.3 5867.2 6165.2 6319.9 6447.5 6474.7 5854.6 6107.3 6119.1 6274.7 6300.2 4629.7 4717.9 4785.4 4791.4 4837.8 4653.2 4782.3 4783.4 4802.8 4827.2 4747.6 4755.3 4763.7 4770.7 4782.5 4602.1 4768.7 4775.6 4791.4 4809.1 3386.9 3578.3 3817.5 3973.9 4227.3 4969.4 5258.9 6146.6 6177.8 6206.8 5052.9 5423.5 5655.1 5662.2 5716.3 6120.3 6259.7 6801.6 6804.4 6809.3 4035.7 4829.9 4836.5 4852.0 4884.9 5416.1 6575.8 6650.8 6948.6 7124.9 4292.5 4931.2 4935.2 4940.2 4956.2 4522.4 4562.2 5035.2 5044.9 5049.4 5591.5 5628.5 5632.1 5659.0 5666.3 6180.8 6207.3 6778.9 6797.0 6814.8 1580.8 1645.2 1670.1 1707.7 1712.9 984.2 1043.5 1100.9 1151.2 1160.1 5627.8 5772.0 6364.8 6389.9 6401.9 6834.4 6932.6 6986.9 6989.2 7021.7 4805.7 6317.2 6388.3 6408.8 6410.5 3035.2 3591.0 3594.9 3641.8 3658.4 6607.2 6953.0 7100.6 7225.0 7266.1 5937.6 6794.9 7157.2 7196.7 7209.1 5760.8 7195.5 7296.3 7340.2 7398.3 5974.5 6653.3 6669.9 7099.3 7185.5 5490.8 6600.4 6861.9 6876.2 6904.1 5840.6 6397.4 7274.9 7283.7 7301.9 4339.2 4405.9 4413.4 4416.4 4424.8 5747.4 6170.6 7106.4 7139.2 7152.2 6396.5 6702.8 6730.6 6738.7 6745.8 6738.7 6744.6 6747.3 6748.9 6835.7 6299.5 6335.7 6485.7 6557.3 6593.7 5839.6 6096.6 6717.4 6750.6 6757.4 5924.3 6178.8 6361.9 6543.4 6582.7 17:37:35 INFO - PID 2897 | 17:37:35 INFO - PID 2897 | [#5] yui.html Cycles:180 Average:22890.90 Median:18344.41 stddev:32841.59 (179.0%) stddev-sans-first:32891.69 17:37:35 INFO - PID 2897 | Values: 764.9 842.2 846.6 865.8 880.0 16417.4 16925.2 17126.7 18637.3 19107.0 17840.3 18187.3 18299.4 18302.5 18406.0 980.6 986.6 990.1 990.6 994.8 979.1 989.3 993.0 993.4 995.6 1014.1 1032.3 1032.3 1037.2 1040.8 1018.5 1020.4 1022.5 1027.3 1037.7 751.6 767.7 776.5 783.4 783.7 16558.8 16674.7 16685.2 16829.0 16864.5 16908.7 17213.7 17333.7 17420.7 17672.5 14024.9 14029.5 14238.6 14333.0 14356.0 3438.6 3517.0 3518.5 3523.2 3524.0 130277.9 130764.0 130974.0 132122.3 133693.3 13277.3 13323.2 13483.7 13514.6 13650.6 25311.6 25344.0 25585.7 25723.1 25941.7 7121.0 7168.9 7195.1 7198.8 7225.8 3836.4 3916.4 3924.6 3929.7 3929.8 4301.0 4329.8 4343.3 4387.7 4388.6 895.9 903.3 908.7 913.1 927.8 661.9 671.7 679.0 679.1 698.0 10008.5 10185.8 11033.4 12029.3 12053.9 663.8 669.3 670.7 683.0 692.5 4504.6 4814.2 5358.0 5376.0 5610.6 113231.0 113421.4 115838.8 116688.0 118770.8 71791.8 86750.1 99326.0 101730.0 101957.5 76420.0 77142.2 84733.6 84769.6 86478.0 9647.8 13033.4 13033.9 13062.3 13070.3 38088.4 38972.2 39210.6 39897.2 41027.4 71797.6 73055.0 73724.6 74130.6 74244.0 16336.8 16925.4 17059.5 17105.4 17151.9 17885.6 18275.2 18312.8 18376.0 18798.5 16388.1 16590.4 16888.5 17009.5 17225.5 16167.9 16806.0 17029.2 17150.3 17474.0 16022.7 16824.6 16909.9 16959.7 17010.6 11604.9 11787.9 12096.9 12227.0 12249.9 12883.9 13246.1 13600.9 14126.8 14180.2 17:37:35 INFO - PID 2897 | -------- Summary: end -------- 17:37:35 INFO - PID 2897 | 17:37:36 INFO - TEST-INFO | 2897: exit 0 17:37:36 INFO - TEST-OK | dromaeo_css | took 1115495ms 17:37:36 INFO - TEST-START | kraken 17:37:36 INFO - operating with platform_type : mac_ 17:37:36 INFO - Initialising browser for kraken test... 17:37:36 INFO - TEST-INFO | started process 2902 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/tmpnvYisZ/profile http://localhost:61460/getInfo.html) 17:37:38 INFO - PID 2902 | 2017-04-28 17:37:38.888 plugin-container[2903:42197] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 17:37:38 INFO - PID 2902 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:37:38 INFO - PID 2902 | 2017-04-28 17:37:38.892 plugin-container[2903:42197] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x971b, name = 'com.apple.CFPasteboardClient' 17:37:38 INFO - PID 2902 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:37:38 INFO - PID 2902 | 2017-04-28 17:37:38.892 plugin-container[2903:42197] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:37:39 INFO - PID 2902 | __metrics Screen width/height:1600/1200 17:37:39 INFO - PID 2902 | colorDepth:24 17:37:39 INFO - PID 2902 | Browser inner width/height: 1024/689 17:37:39 INFO - PID 2902 | __metrics 17:37:39 ERROR - PID 2902 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 17:37:40 INFO - TEST-INFO | 2902: exit 0 17:37:40 INFO - Browser initialized. 17:37:40 INFO - Running cycle 1/1 for kraken test... 17:37:40 INFO - TEST-INFO | started process 2904 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/T/tmpnvYisZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:37:42 INFO - PID 2904 | 2017-04-28 17:37:42.472 plugin-container[2905:42317] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x953f, name = 'com.apple.tsm.portname' 17:37:42 INFO - PID 2904 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:37:42 INFO - PID 2904 | 2017-04-28 17:37:42.472 plugin-container[2905:42317] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0f, name = 'com.apple.CFPasteboardClient' 17:37:42 INFO - PID 2904 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:37:42 INFO - PID 2904 | 2017-04-28 17:37:42.472 plugin-container[2905:42317] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:37:52 INFO - PID 2904 | RSS: Main: 251813888 17:37:52 INFO - PID 2904 | 17:37:55 INFO - PID 2904 | Cycle 1(1): loaded http://localhost:61460/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:61460/tests/kraken/driver.html?testName=audio-beat-detection) 17:37:56 INFO - PID 2904 | RSS: Main: 259829760 17:37:56 INFO - PID 2904 | 17:37:59 INFO - PID 2904 | Cycle 1(1): loaded http://localhost:61460/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:61460/tests/kraken/driver.html?testName=audio-dft) 17:37:59 INFO - PID 2904 | RSS: Main: 266534912 17:37:59 INFO - PID 2904 | 17:38:03 INFO - PID 2904 | Cycle 1(1): loaded http://localhost:61460/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:61460/tests/kraken/driver.html?testName=audio-fft) 17:38:04 INFO - PID 2904 | RSS: Main: 262725632 17:38:04 INFO - PID 2904 | 17:38:05 INFO - PID 2904 | Cycle 1(1): loaded http://localhost:61460/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:61460/tests/kraken/driver.html?testName=audio-oscillator) 17:38:06 INFO - PID 2904 | RSS: Main: 263544832 17:38:06 INFO - PID 2904 | 17:38:08 INFO - PID 2904 | Cycle 1(1): loaded http://localhost:61460/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:61460/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:38:09 INFO - PID 2904 | RSS: Main: 265281536 17:38:09 INFO - PID 2904 | 17:38:12 INFO - PID 2904 | Cycle 1(1): loaded http://localhost:61460/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:61460/tests/kraken/driver.html?testName=imaging-darkroom) 17:38:12 INFO - PID 2904 | RSS: Main: 271089664 17:38:12 INFO - PID 2904 | 17:38:16 INFO - PID 2904 | Cycle 1(1): loaded http://localhost:61460/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:61460/tests/kraken/driver.html?testName=imaging-desaturate) 17:38:16 INFO - PID 2904 | RSS: Main: 272048128 17:38:16 INFO - PID 2904 | 17:38:19 INFO - PID 2904 | Cycle 1(1): loaded http://localhost:61460/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:61460/tests/kraken/driver.html?testName=json-parse-financial) 17:38:20 INFO - PID 2904 | RSS: Main: 271892480 17:38:20 INFO - PID 2904 | 17:38:21 INFO - PID 2904 | Cycle 1(1): loaded http://localhost:61460/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:61460/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:38:22 INFO - PID 2904 | RSS: Main: 271716352 17:38:22 INFO - PID 2904 | 17:38:24 INFO - PID 2904 | Cycle 1(1): loaded http://localhost:61460/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:61460/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:38:24 INFO - PID 2904 | RSS: Main: 272007168 17:38:24 INFO - PID 2904 | 17:38:26 INFO - PID 2904 | Cycle 1(1): loaded http://localhost:61460/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:61460/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:38:27 INFO - PID 2904 | RSS: Main: 271527936 17:38:27 INFO - PID 2904 | 17:38:30 INFO - PID 2904 | Cycle 1(1): loaded http://localhost:61460/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:61460/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:38:31 INFO - PID 2904 | RSS: Main: 271581184 17:38:31 INFO - PID 2904 | 17:38:34 INFO - PID 2904 | Cycle 1(1): loaded http://localhost:61460/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:61460/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:38:35 INFO - PID 2904 | RSS: Main: 271577088 17:38:35 INFO - PID 2904 | 17:38:37 INFO - PID 2904 | Cycle 1(1): loaded http://localhost:61460/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:61460/tests/kraken/driver.html?testName=ai-astar) 17:38:37 INFO - PID 2904 | RSS: Main: 273289216 17:38:37 INFO - PID 2904 | 17:38:37 INFO - PID 2904 | __start_tp_report 17:38:37 INFO - PID 2904 | _x_x_mozilla_page_load 17:38:37 INFO - PID 2904 | _x_x_mozilla_page_load_details 17:38:37 INFO - PID 2904 | |i|pagename|runs| 17:38:37 INFO - PID 2904 | |0;ai-astar;134;96;164;169;170;115;114;112;112;171 17:38:37 INFO - PID 2904 | |1;audio-beat-detection;184;144;147;148;106;112;107;112;138;132 17:38:37 INFO - PID 2904 | |2;audio-dft;197;211;214;273;262;279;239;198;196;195 17:38:37 INFO - PID 2904 | |3;audio-fft;76;57;59;89;62;59;58;59;81;62 17:38:37 INFO - PID 2904 | |4;audio-oscillator;95;84;84;71;71;70;93;101;104;122 17:38:37 INFO - PID 2904 | |5;imaging-gaussian-blur;89;109;88;88;88;89;107;96;89;90 17:38:37 INFO - PID 2904 | |6;imaging-darkroom;97;99;96;100;152;96;96;109;125;151 17:38:37 INFO - PID 2904 | |7;imaging-desaturate;90;95;91;91;93;89;99;93;88;91 17:38:37 INFO - PID 2904 | |8;json-parse-financial;51;50;49;70;74;75;63;52;51;51 17:38:37 INFO - PID 2904 | |9;json-stringify-tinderbox;55;64;71;59;66;63;56;59;70;59 17:38:37 INFO - PID 2904 | |10;stanford-crypto-aes;81;85;83;84;84;84;83;84;83;83 17:38:37 INFO - PID 2904 | |11;stanford-crypto-ccm;158;134;158;157;140;140;142;158;190;140 17:38:37 INFO - PID 2904 | |12;stanford-crypto-pbkdf2;216;186;183;187;252;187;184;206;224;170 17:38:37 INFO - PID 2904 | |13;stanford-crypto-sha256-iterative;69;71;84;99;100;63;60;98;98;98 17:38:37 INFO - PID 2904 | __end_tp_report 17:38:37 INFO - PID 2904 | __start_cc_report 17:38:37 INFO - PID 2904 | _x_x_mozilla_cycle_collect,1011 17:38:37 INFO - PID 2904 | __end_cc_report 17:38:37 INFO - PID 2904 | __startTimestamp1493426317266__endTimestamp 17:38:37 INFO - PID 2904 | 17:38:37 INFO - PID 2904 | ------- Summary: start ------- 17:38:37 INFO - PID 2904 | Number of tests: 14 17:38:37 INFO - PID 2904 | 17:38:37 INFO - PID 2904 | [#0] ai-astar Cycles:10 Average:135.70 Median:166.50 stddev:29.69 (17.8%) stddev-sans-first:31.49 17:38:37 INFO - PID 2904 | Values: 134.0 96.0 164.0 169.0 170.0 115.0 114.0 112.0 112.0 171.0 17:38:37 INFO - PID 2904 | 17:38:37 INFO - PID 2904 | [#1] audio-beat-detection Cycles:10 Average:133.00 Median:141.00 stddev:24.62 (17.5%) stddev-sans-first:17.91 17:38:37 INFO - PID 2904 | Values: 184.0 144.0 147.0 148.0 106.0 112.0 107.0 112.0 138.0 132.0 17:38:37 INFO - PID 2904 | 17:38:37 INFO - PID 2904 | [#2] audio-dft Cycles:10 Average:226.40 Median:226.50 stddev:33.89 (15.0%) stddev-sans-first:34.23 17:38:37 INFO - PID 2904 | Values: 197.0 211.0 214.0 273.0 262.0 279.0 239.0 198.0 196.0 195.0 17:38:37 INFO - PID 2904 | 17:38:37 INFO - PID 2904 | [#3] audio-fft Cycles:10 Average:66.20 Median:62.00 stddev:11.44 (18.4%) stddev-sans-first:11.57 17:38:37 INFO - PID 2904 | Values: 76.0 57.0 59.0 89.0 62.0 59.0 58.0 59.0 81.0 62.0 17:38:37 INFO - PID 2904 | 17:38:37 INFO - PID 2904 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:77.50 stddev:16.89 (21.8%) stddev-sans-first:17.79 17:38:37 INFO - PID 2904 | Values: 95.0 84.0 84.0 71.0 71.0 70.0 93.0 101.0 104.0 122.0 17:38:37 INFO - PID 2904 | 17:38:37 INFO - PID 2904 | [#5] imaging-gaussian-blur Cycles:10 Average:93.30 Median:89.00 stddev:8.11 (9.1%) stddev-sans-first:8.45 17:38:37 INFO - PID 2904 | Values: 89.0 109.0 88.0 88.0 88.0 89.0 107.0 96.0 89.0 90.0 17:38:37 INFO - PID 2904 | 17:38:37 INFO - PID 2904 | [#6] imaging-darkroom Cycles:10 Average:112.10 Median:96.00 stddev:22.62 (23.6%) stddev-sans-first:23.32 17:38:37 INFO - PID 2904 | Values: 97.0 99.0 96.0 100.0 152.0 96.0 96.0 109.0 125.0 151.0 17:38:37 INFO - PID 2904 | 17:38:37 INFO - PID 2904 | [#7] imaging-desaturate Cycles:10 Average:92.00 Median:92.00 stddev:3.20 (3.5%) stddev-sans-first:3.31 17:38:37 INFO - PID 2904 | Values: 90.0 95.0 91.0 91.0 93.0 89.0 99.0 93.0 88.0 91.0 17:38:37 INFO - PID 2904 | 17:38:37 INFO - PID 2904 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:57.50 stddev:10.74 (18.7%) stddev-sans-first:11.04 17:38:37 INFO - PID 2904 | Values: 51.0 50.0 49.0 70.0 74.0 75.0 63.0 52.0 51.0 51.0 17:38:37 INFO - PID 2904 | 17:38:37 INFO - PID 2904 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:63.50 stddev:5.55 (8.7%) stddev-sans-first:5.24 17:38:37 INFO - PID 2904 | Values: 55.0 64.0 71.0 59.0 66.0 63.0 56.0 59.0 70.0 59.0 17:38:37 INFO - PID 2904 | 17:38:37 INFO - PID 2904 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:84.00 stddev:1.07 (1.3%) stddev-sans-first:0.71 17:38:37 INFO - PID 2904 | Values: 81.0 85.0 83.0 84.0 84.0 84.0 83.0 84.0 83.0 83.0 17:38:37 INFO - PID 2904 | 17:38:37 INFO - PID 2904 | [#11] stanford-crypto-ccm Cycles:10 Average:151.70 Median:157.50 stddev:16.44 (10.4%) stddev-sans-first:17.28 17:38:37 INFO - PID 2904 | Values: 158.0 134.0 158.0 157.0 140.0 140.0 142.0 158.0 190.0 140.0 17:38:37 INFO - PID 2904 | 17:38:37 INFO - PID 2904 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.50 Median:196.50 stddev:24.83 (12.6%) stddev-sans-first:25.61 17:38:37 INFO - PID 2904 | Values: 216.0 186.0 183.0 187.0 252.0 187.0 184.0 206.0 224.0 170.0 17:38:37 INFO - PID 2904 | 17:38:37 INFO - PID 2904 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:84.00 Median:91.00 stddev:16.60 (18.2%) stddev-sans-first:16.70 17:38:37 INFO - PID 2904 | Values: 69.0 71.0 84.0 99.0 100.0 63.0 60.0 98.0 98.0 98.0 17:38:37 INFO - PID 2904 | -------- Summary: end -------- 17:38:37 INFO - PID 2904 | 17:38:38 INFO - TEST-INFO | 2904: exit 0 17:38:38 INFO - TEST-OK | kraken | took 61896ms 17:38:38 INFO - SUITE-END | took 1177s 17:38:38 INFO - Completed test suite (00:19:37) 17:38:38 INFO - javascript benchmark 17:38:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8063.907771708257, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3019.71312725291, 3443.690067893889, 3611.368010598146, 3642.5446819147605, 3668.706503479722, 5470.425605311445, 5842.328132264791, 6139.539534534916, 6190.380961903813, 6271.3728627137325, 5316.883454474565, 6132.845047373393, 6175.382461753822, 6188.721507532161, 6191.257049154108, 4192.601702838233, 4423.601875831175, 4946.703197808125, 5388.43421440749, 5389.353277606692, 4561.6806823522365, 5581.888362232753, 5582.245482965616, 5582.581306402016, 5597.0, 4139.3583994480905, 4792.448868380146, 5413.918791218135, 5447.836564903059, 5537.307836520435, 5492.340919089735, 5511.366192887829, 5521.171824226358, 5537.750801213955, 5555.194496797982, 4810.63920205986, 5163.096458119851, 5439.129739241742, 5443.646162999393, 5473.397926228112, 5570.125767419667, 6129.022607377584, 6149.354317796612, 6277.843053923642, 6302.149209856657, 6519.087327774116, 6569.507286953498, 6645.169353830771, 6657.966710166466, 6695.430888374494, 6782.830429239309, 6786.59280443175, 6802.4217941475035, 6806.489513286523, 6826.0, 6265.467435267962, 6315.400036996524, 6327.778527751507, 6349.492040636738, 6354.491640668735, 6717.596944183267, 6813.046173535709, 6839.076724642209, 6915.377616014583, 6973.163220413481, 6342.778002769881, 6465.418112369909, 6521.9673901630185, 6543.738250470023, 6630.0, 6616.536842421081, 6733.0, 6753.08833307507, 6773.424258937947, 6783.423409010191, 6636.83407914806, 6652.567583107082, 6662.333766623299, 6675.065490831287, 6682.164729408824, 6423.74305027803, 6516.771912983023, 6527.379898909596, 6613.338666133444, 6704.161979752531, 4818.759062046954, 5296.152615581488, 5334.386545547234, 5363.356397232357, 5366.087765079946, 4710.599599034052, 4710.9764451177525, 4717.905641887143, 4752.7861246244, 4773.7374444405195, 6039.577229593974, 6266.310705822356, 6308.495320374359, 6315.400036996478, 6346.143270658402, 6534.640594767334, 6653.833654158588, 6759.0, 6811.25076241613, 6835.350641689031, 6394.744210231539, 6413.262474815456, 6413.615183089029, 6420.6147631142285, 6429.646369449725, 5927.407259274038, 6017.217761691039, 6023.186869772612, 6039.5470339723815, 6041.486473649701, 6778.627175505395, 6877.209120951155, 6944.201416836926, 6985.755498557526, 7046.894296585555, 6782.830429239309, 6783.287754785873, 6785.219699734396, 6805.93194068053, 6810.9318906810295, 6888.0356750056035, 6950.8609827804175, 6985.7205711772995, 6993.510454268356, 6997.545159564612, 6405.679716014274, 6509.218893732783, 6510.641914694737, 6675.399214070757, 6685.09751183584, 5668.489835914787, 6816.0, 6820.522563420513, 6835.658217089026, 6857.245702972768, 6290.402411770874, 6357.4596159326975, 6580.440662543738, 6599.934000659932, 6605.471562275103, 6312.6528040956355, 6465.353464653497, 6595.142631457879, 6609.074729537772, 6621.768238111836, 6263.3736626337, 6336.714847831767, 6402.6158430494315, 6428.61428314284, 6447.838804029937, 6504.0, 6507.707153178213, 6596.637184954873, 6616.470682345497, 6618.2719900811835, 6346.968265158829, 6347.174867267226, 6349.206349206349, 6356.713947872265, 6363.872722545616], "value": 6070.028262168253, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [810.6109067647528, 833.4041160570193, 978.3591747405447, 1158.3918442817526, 1286.6976260578767, 36863.815680921594, 37224.62775372245, 37231.62768372322, 37232.44151337732, 37302.69440569581, 36965.81517092417, 37115.81442092793, 37255.62744372562, 37265.627343726555, 37372.62627373725, 7161.355478006978, 7904.2886140247365, 8245.051819040827, 8487.321014318839, 8508.872366914502, 6522.706478208492, 8513.957430212871, 8517.914820851774, 8521.616527256258, 8544.829103417927, 7039.472039597025, 8440.957795211047, 8525.0, 8526.829463410728, 8528.360372972053, 8455.281301089415, 8478.364122690791, 8509.276711479532, 8521.659133634646, 8530.616122274512, 7591.3926885849, 7759.224077592252, 8225.917740822635, 8280.213379728915, 8312.002559692875, 36633.63366366329, 36798.63201368006, 36864.63135368639, 36893.07767305839, 36914.261714765555, 3634.4730014148063, 3636.7272454566014, 3682.723795715332, 3683.852645894161, 3685.5761587417524, 27390.589141162898, 27486.0379886703, 30098.69901300981, 30406.0, 30504.237394065327, 3094.0, 3125.484295091307, 3148.732357749594, 3150.6061742282213, 3159.368126374711, 309856.0, 311151.0, 311170.0, 314801.0, 316332.0, 38530.80734596309, 39283.0, 46988.060238795035, 47592.7620361896, 47787.76106119447, 49325.75337123363, 49646.50353496491, 49782.0, 49827.75086124619, 49855.750721246884, 14385.921055920848, 14415.351309191112, 14515.92742036283, 14534.345954432076, 14535.709285814224, 11610.303381797119, 11715.531378744754, 11725.475688160484, 11829.645110646694, 11860.88139118615, 13507.864921350858, 13530.323483825769, 13549.864501355058, 13558.457661693421, 13699.794503082461, 6102.572819902653, 6174.44430001293, 6199.0, 6203.410675985774, 6221.813345599639, 992.4243938515643, 1009.4498498318434, 1014.8731408573929, 1035.9533820978074, 1060.7189094889861, 21675.67486487704, 23207.3037808866, 24160.275191744277, 24455.755442445705, 24469.63295550568, 1118.2116607791488, 1142.8400023996646, 1157.6506036037795, 1162.7151347919644, 1170.3153655111855, 10342.689719308433, 12030.218035827818, 12334.629961101182, 12408.441620127116, 12466.626001219978, 325690.0, 327877.3606131954, 328467.0, 329210.78681345034, 329858.0, 53335.73332133392, 53357.66605834808, 53651.92696146055, 53728.0, 53734.0, 1498.572906721579, 1529.0, 1566.8903176777744, 1568.725473042213, 1575.141547856421, 19490.707639385706, 23558.0, 23717.525649486568, 24103.397415064763, 24130.155444559357, 37418.06454838651, 37508.43737343996, 37534.43698344472, 37657.81171094127, 37723.850376459115, 293662.0, 294026.0, 295077.0, 295411.0, 296266.0, 32279.193020174684, 33655.15862103467, 33718.0, 33727.66272337245, 33814.830925845214, 42468.57531424646, 42898.35652465153, 44351.556484436034, 44483.777581111885, 44639.33041004323, 29727.81088756512, 29770.404591908475, 30503.0, 30541.0, 30965.91619293314, 24185.63721544143, 30823.0, 30936.0719178416, 31071.378572427973, 31344.05967820969, 37255.627443725214, 37263.813680931424, 37419.251614968096, 37473.81263093667, 37565.624343756215, 25224.74775252224, 29583.85208073946, 30649.387012260075, 31451.685483144876, 31488.527672084478, 24093.51812963766, 24152.792360381558, 24274.0, 24541.631875521525, 24546.263612091665], "value": 17450.179368311005, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.14329534402356, 372.8024147201984, 431.75390027684233, 433.75059340878965, 435.92153412385755, 21261.787382126175, 21433.67849482259, 21848.235311764092, 22213.0, 22409.663855042167, 22694.546109077808, 22917.19789807357, 23243.186488472908, 23510.17714379997, 23795.286141415785, 5822.359540450547, 5873.177755114288, 6406.743730250784, 6442.0, 6447.484201263887, 6302.55882088254, 6748.763793267237, 7094.077769889907, 7177.820554486128, 7184.856302873939, 6905.861882762341, 7139.85720285594, 7146.499745017851, 7149.285071492835, 7183.928160718378, 7145.35691787739, 7212.386947109502, 7212.567245965259, 7229.963850180768, 7239.457040721941, 6361.332060133665, 7012.614306213156, 7051.964740176318, 7066.434685225169, 7068.0104785330095, 28871.42257154845, 29760.851195743882, 29814.701852981627, 29876.70123298761, 29996.400071998654, 2395.724491683461, 2429.283361408371, 2445.6209287560455, 2447.8164137689746, 2450.6936632920883, 15938.920305398515, 18321.992290424023, 19216.519587010298, 19586.866101423846, 19863.0, 2250.6961560189493, 2290.2213247495765, 2364.0, 2372.1223147435558, 2403.831731778776, 152352.0, 153496.0, 156592.0, 159426.4057359423, 160635.99999999884, 23263.302100937, 24795.5040899181, 24902.37744056413, 25039.0, 25047.37381565439, 42115.7894210527, 42258.78870605689, 42280.0, 42427.363589546185, 42454.57545424568, 8544.273736732448, 10086.899131008742, 10283.12593429567, 10496.630747766194, 11481.196316257781, 7297.233790452032, 8747.737567872973, 8800.47197168172, 9131.086891310815, 9189.586468608928, 9513.19360788569, 9682.75793105164, 11118.777624447466, 11518.769624607461, 11827.88172118285, 3695.3902606069696, 4319.827206911751, 4408.515063343029, 4683.508231635629, 4960.950390496048, 938.1978408460805, 978.1490103609763, 978.7504186432415, 984.7488890332919, 1025.887152413234, 21444.785552144593, 21933.670994935088, 21937.890310548344, 21997.780022199575, 22099.005544750526, 1013.6300250408548, 1029.809485245232, 1039.953202105907, 1060.188955449082, 1060.5227647558474, 10033.949830250947, 10571.577136914591, 11092.778144437067, 11451.541938322374, 11517.136214783925, 466649.0, 469278.6536067366, 471351.0, 486904.0, 561239.9791516667, 123778.0, 126516.36741816232, 126595.0, 126691.36654316669, 130125.34937325252, 1192.0582739635763, 1225.7793597152597, 1226.45422786859, 1230.0712961713848, 1279.705667696435, 20481.590368192254, 21602.675959860928, 22531.0, 22837.31488055361, 22958.885205573864, 40338.0, 54369.45630543644, 54843.0, 55002.0, 57845.710771445876, 74002.51994959963, 74225.257747424, 75342.62328688322, 75609.24390756243, 75821.0, 8994.640214391351, 9098.727038188865, 9123.042080581708, 9150.725478235663, 9231.35380523357, 10908.61819836302, 12355.57910840265, 14336.211508366723, 14756.852431475978, 15081.944263901421, 11090.140382154044, 12275.140740148105, 12358.938205308916, 12377.257364558156, 12482.438290277141, 11573.942130289295, 11673.533058677558, 11817.82273265919, 11896.76206475883, 12005.099617528895, 12184.390780461119, 12237.510499580274, 12424.440900159334, 12471.875281247072, 12516.937415312865, 9036.502992335485, 9058.773530661523, 9129.5891684873, 9204.401713888576, 9270.72187834366, 11445.198836081394, 12100.636980890587, 12363.93818030904, 12388.81416778731, 12427.937860311002], "value": 11670.85203584322, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1408.7605107131787, 1439.8704116629501, 1464.0264224290847, 1466.2302291297067, 1472.5716055426235, 11438.0, 11468.311901285928, 11788.646340609774, 11912.463939122728, 11939.403029848505, 10984.670459886196, 11123.27698699584, 11127.332360058403, 11138.164637652168, 11178.882111788816, 2455.9631605525888, 2496.463260399014, 2498.6376975338567, 2503.4993001399703, 2504.724480307165, 2417.3110663460916, 2476.8142389320874, 2476.8761561921924, 2479.38015496126, 2479.789217916479, 2472.81453890958, 2487.763662452064, 2517.307740371394, 2520.1305549585454, 2526.9620955685677, 2442.9755702442926, 2473.0478765675166, 2486.9378265543414, 2495.6381324707995, 2501.249625112459, 2444.9022039118413, 2455.5211733711753, 2458.520588485246, 2532.7214006459276, 2539.9238022859345, 10294.227932905062, 11626.244294120856, 11704.297742135414, 11717.765644687144, 11718.23831450953, 6526.151600291979, 6710.899336509908, 6773.458123350169, 6786.558873673245, 6813.6593170341785, 4033.3748269018347, 4291.570842915715, 4306.289462238727, 4362.280223763075, 4450.376947227358, 1247.7192631657895, 1268.644779461743, 1311.8884894783955, 1313.7175507265983, 1316.9144005639698, 16280.348786048544, 16655.0, 16759.748603770953, 16789.496315110566, 16938.49184524466, 5127.359080114986, 5445.428230035868, 5707.773968152424, 5732.885342293131, 5740.253767010262, 11633.6509904703, 11795.29228246308, 11863.110266729856, 11864.703382415337, 11885.881141188478, 6572.539922205496, 6587.011948207807, 6588.439982601532, 6590.505712071614, 6609.933900661028, 6007.88854062, 6057.061155520813, 6203.379662033761, 6216.658083805343, 6216.813495595139, 3698.6116457772087, 3793.943090853584, 4229.851955181553, 4321.65426765858, 4472.434647873219, 1143.2454579977175, 1180.598596477202, 1278.4502663854632, 1297.7015286483972, 1297.7080156964607, 786.6420778545748, 798.8641930871765, 814.8185131559263, 815.6288888555692, 843.717354686187, 5419.0, 5509.944900550943, 6155.4767844732805, 6204.627722336674, 6307.432331090224, 567.1278404699291, 586.0886321769603, 608.8660494691161, 611.0681211153027, 616.3220457496807, 3872.8063596820048, 4164.8125834337525, 4275.144971005811, 4385.802638881258, 4392.516823149451, 10544.683659490227, 14585.708285834224, 14683.853161468462, 15105.773413398807, 15137.621559460882, 14987.250637468083, 15069.623259418382, 15150.621234469227, 15307.61730956735, 15333.386664533517, 8300.584970751439, 8595.3553483489, 8645.394822362374, 8698.260647845003, 8820.647174113092, 6919.135108111486, 7087.220405755466, 7151.678174482056, 7189.71241150369, 7225.096862892138, 13139.014573906805, 13205.867941320848, 13284.202947823162, 13463.663408414868, 13594.592162235149, 13677.589672309847, 13706.588802335946, 13867.79198312006, 14079.718405631626, 14121.2233327168, 9284.257259419366, 9550.570224340061, 9551.044895510393, 9560.521973901416, 9570.186534144676, 10319.122874555747, 10408.063274305348, 10597.311174773615, 10670.0, 10785.838212426977, 8834.204921557091, 9057.501837398742, 9248.398854074732, 9317.39436936597, 9337.71986840396, 7596.582187979714, 8760.60577274037, 8941.195292423714, 8993.550322483981, 9012.774680633036, 8056.395770317133, 8134.959325203336, 8205.589720513832, 8206.179382061746, 8217.5480348579, 4948.134076536664, 5977.940220597912, 5979.910301345571, 6171.321154673072, 6246.500279977682, 5390.892182156414, 5645.463680950304, 5653.575981801464, 6028.939710602838, 6208.3791620839365], "value": 5290.112656691908, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.6599734268388, 386.4570278758344, 403.72344943713574, 407.42959856201315, 414.2502071251035, 5867.237259156314, 6165.19852419186, 6319.936800631992, 6447.54867159299, 6474.67626618669, 5854.590178687494, 6107.328193898667, 6119.082137679339, 6274.654893980829, 6300.21247344082, 4629.65277604181, 4717.9292310615365, 4785.377900872891, 4791.425028996526, 4837.758112094399, 4653.162430762478, 4782.306565547993, 4783.354247176639, 4802.759862006903, 4827.179379505493, 4747.620190384761, 4755.262934245197, 4763.690360126598, 4770.666053376265, 4782.473927867932, 4602.05657840142, 4768.690035147704, 4775.5701986821, 4791.3531673224015, 4809.110314591811, 3386.9491957620658, 3578.3022310649435, 3817.503724515795, 3973.8807835764974, 4227.3447615619625, 4969.378827646544, 5258.868528286824, 6146.569740118193, 6177.845553861144, 6206.813795586139, 5052.898942021139, 5423.511883930465, 5655.095184770417, 5662.207290979266, 5716.28546431696, 6120.296165940929, 6259.741816873802, 6801.625910574917, 6804.387605115563, 6809.3190680932, 4035.6973227008093, 4829.937413768966, 4836.500684787692, 4851.951480485185, 4884.877878053042, 5416.0792665247, 6575.816353056448, 6650.800475985679, 6948.583085014865, 7124.857502849965, 4292.527821939584, 4931.235658472942, 4935.185694360463, 4940.20956646942, 4956.157453232959, 4522.389477420506, 4562.24722920721, 5035.219540971156, 5044.924326135111, 5049.419316778544, 5591.496765291144, 5628.549716022709, 5632.070708333079, 5659.0, 5666.348369937427, 6180.81457556274, 6207.317195108534, 6778.864422711518, 6797.0, 6814.829629259309, 1580.8143892080939, 1645.1856331115935, 1670.106493026225, 1707.6670049340507, 1712.9400470983455, 984.17329443268, 1043.4782608695652, 1100.8991008991009, 1151.2344291046527, 1160.1067178272851, 5627.803026894039, 5772.018756811352, 6364.77723279683, 6389.872202555923, 6401.935980640227, 6834.359753659185, 6932.584044957319, 6986.930130698628, 6989.20431827263, 7021.719131234796, 4805.687630304089, 6317.241930968221, 6388.272678218178, 6408.775692850728, 6410.45511131559, 3035.2411897025745, 3590.982045089758, 3594.8741794037082, 3641.7632853864416, 3658.3780757270797, 6607.174103237096, 6953.0, 7100.644967751592, 7224.963875180695, 7266.091738532684, 5937.643741375445, 6794.8641027180165, 7157.24848890859, 7196.712131514785, 7209.134903811576, 5760.8271751847515, 7195.495445983826, 7296.306850849161, 7340.229275926058, 7398.3341499265325, 5974.462298393166, 6653.334666533308, 6669.899951500828, 7099.290070993066, 7185.461090418135, 5490.80782172622, 6600.438962688226, 6861.862762744817, 6876.17485901695, 6904.06686127885, 5840.627452548562, 6397.360263973752, 7274.854502910018, 7283.672234749555, 7301.890471642823, 4339.240632889295, 4405.876501492099, 4413.360062790814, 4416.381706561148, 4424.84513042042, 5747.396523364986, 6170.568060235741, 7106.360427561544, 7139.178994415709, 7152.177499587614, 6396.48828093742, 6702.765403210864, 6730.562513436611, 6738.66306684654, 6745.763898263537, 6738.7304507819135, 6744.595324280559, 6747.257801641914, 6748.93251067483, 6835.69239384219, 6299.496040316855, 6335.65153916539, 6485.708143133476, 6557.311482294291, 6593.670316484253, 5839.649621022752, 6096.603720758137, 6717.361850624183, 6750.628715420699, 6757.425618822455, 5924.348321684697, 6178.845528861814, 6361.8727625448155, 6543.378379053982, 6582.736690532325], "value": 4936.223377204637, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [764.9273319034692, 842.2083241752756, 846.6359465429863, 865.7835541114721, 879.995600022, 16417.425390111333, 16925.23836427362, 17126.743098853494, 18637.347692830754, 19107.0, 17840.286388544475, 18187.27250909962, 18299.35952241672, 18302.542436439096, 18406.0, 980.5734505490135, 986.6152200641719, 990.1336330710628, 990.6087095597235, 994.820932232198, 979.0503211884461, 989.2580564576567, 993.0417147452707, 993.3791380387258, 995.6117114325419, 1014.0974532665933, 1032.2619327181064, 1032.3444612670971, 1037.1754455208127, 1040.8230600797845, 1018.4602160854722, 1020.3673722292226, 1022.5449674894675, 1027.250107421579, 1037.6990672704906, 751.6204316820025, 767.7428061599371, 776.5496012312901, 783.3693876429472, 783.6865253898429, 16558.751618725608, 16674.739706873832, 16685.24916378766, 16829.0, 16864.494065178063, 16908.746368804477, 17213.655726885518, 17333.7399939001, 17420.738688919675, 17672.469825905115, 14024.929875350557, 14029.508967186099, 14238.644033899132, 14333.0, 14356.0, 3438.638942910983, 3517.0, 3518.47222916562, 3523.2072783623735, 3524.0, 130277.92637625812, 130764.0, 130974.0, 132122.33938830244, 133693.3315333427, 13277.269750163641, 13323.200607963554, 13483.662908427368, 13514.59456216315, 13650.590482285548, 25311.62032569513, 25344.0, 25585.74414255871, 25723.099691510706, 25941.74058259431, 7120.964395177991, 7168.892466613005, 7195.064641596664, 7198.820029499199, 7225.819354516179, 3836.3861782114727, 3916.432117343026, 3924.5682974872743, 3929.7445666031617, 3929.8231579578987, 4300.98926752213, 4329.826806927687, 4343.261645520269, 4387.736735795863, 4388.561143885586, 895.923846473044, 903.3089686389917, 908.7410088124852, 913.0914739833775, 927.823713494434, 661.9371159739817, 671.6943790575276, 678.9864202716017, 679.0968012543306, 698.0192829075157, 10008.49957502122, 10185.796284074277, 11033.448327583588, 12029.338386388657, 12053.939730301468, 663.8008597420851, 669.3440428380214, 670.6847781542765, 683.0198664915862, 692.4564217089661, 4504.594586487166, 4814.229723244264, 5358.0, 5375.973120134452, 5610.635308704921, 113231.0, 113421.432892835, 115838.84161158449, 116688.0, 118770.8430204956, 71791.78801101215, 86750.13249867421, 99326.02021939354, 101730.0, 101957.4706379405, 76419.9999999989, 77142.22857771463, 84733.57633211918, 84769.57615211884, 86478.0, 9647.807043859224, 13033.413496392875, 13033.869661303266, 13062.281574513492, 13070.346482675637, 38088.42867356937, 38972.220555589294, 39210.60789392069, 39897.2020559593, 41027.384589231784, 71797.6410117946, 73055.0, 73724.63137684492, 74130.62934685507, 74244.0, 16336.754948675542, 16925.407610733564, 17059.48821535356, 17105.401310954057, 17151.91424042872, 17885.642287154446, 18275.177617007, 18312.816871831645, 18376.0, 18798.53003674919, 16388.098654574114, 16590.419335323204, 16888.493345199662, 17009.489715308562, 17225.483235502954, 16167.919160404123, 16806.0, 17029.23368448398, 17150.313987440364, 17474.03892785909, 16022.679546408774, 16824.57938551546, 16909.900856444292, 16959.745603815707, 17010.574735631708, 11604.88395116038, 11787.941060294643, 12096.879031209928, 12227.0, 12249.938750306192, 12883.871161288267, 13246.072774905664, 13600.931995340356, 14126.78809817833, 14180.220087895264], "value": 8517.043157172626, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1587.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 96.0, 164.0, 169.0, 170.0, 115.0, 114.0, 112.0, 112.0, 171.0], "value": 135.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 144.0, 147.0, 148.0, 106.0, 112.0, 107.0, 112.0, 138.0, 132.0], "value": 133.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 211.0, 214.0, 273.0, 262.0, 279.0, 239.0, 198.0, 196.0, 195.0], "value": 226.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 57.0, 59.0, 89.0, 62.0, 59.0, 58.0, 59.0, 81.0, 62.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 84.0, 84.0, 71.0, 71.0, 70.0, 93.0, 101.0, 104.0, 122.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 109.0, 88.0, 88.0, 88.0, 89.0, 107.0, 96.0, 89.0, 90.0], "value": 93.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 99.0, 96.0, 100.0, 152.0, 96.0, 96.0, 109.0, 125.0, 151.0], "value": 112.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 95.0, 91.0, 91.0, 93.0, 89.0, 99.0, 93.0, 88.0, 91.0], "value": 92.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 49.0, 70.0, 74.0, 75.0, 63.0, 52.0, 51.0, 51.0], "value": 58.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 64.0, 71.0, 59.0, 66.0, 63.0, 56.0, 59.0, 70.0, 59.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 85.0, 83.0, 84.0, 84.0, 84.0, 83.0, 84.0, 83.0, 83.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 134.0, 158.0, 157.0, 140.0, 140.0, 142.0, 158.0, 190.0, 140.0], "value": 151.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [216.0, 186.0, 183.0, 187.0, 252.0, 187.0, 184.0, 206.0, 224.0, 170.0], "value": 199.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 84.0, 99.0, 100.0, 63.0, 60.0, 98.0, 98.0, 98.0], "value": 84.0, "unit": "score"}]}]} 17:38:38 INFO - Return code: 0 17:38:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:38:38 ERROR - # TBPL SUCCESS # 17:38:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:38:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:38:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:38:38 INFO - 2017-04-28 17:38:38.589 screenresolution[2909:42708] starting screenresolution argv=screenresolution get 17:38:38 INFO - 2017-04-28 17:38:38.591 screenresolution[2909:42708] Display 0: 1600x1200x32@60 17:38:38 INFO - 2017-04-28 17:38:38.597 screenresolution[2910:42711] starting screenresolution argv=screenresolution list 17:38:38 INFO - Available Modes on Display 0 17:38:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:38:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:38:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:38:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:38:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:38:38 INFO - Intel Iris: 17:38:38 INFO - Chipset Model: Intel Iris 17:38:38 INFO - Type: GPU 17:38:38 INFO - Bus: Built-In 17:38:38 INFO - VRAM (Dynamic, Max): 1536 MB 17:38:38 INFO - Vendor: Intel (0x8086) 17:38:38 INFO - Device ID: 0x0a2e 17:38:38 INFO - Revision ID: 0x0009 17:38:38 INFO - Displays: 17:38:38 INFO - Display: 17:38:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:38:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:38:38 INFO - Display Serial Number: 1600x1200 60 17:38:38 INFO - Main Display: Yes 17:38:38 INFO - Mirror: Off 17:38:38 INFO - Online: Yes 17:38:38 INFO - Rotation: Supported 17:38:38 INFO - Return code: 0 17:38:38 INFO - Running post-action listener: _resource_record_post_action 17:38:38 INFO - [mozharness: 2017-04-29 00:38:38.842895Z] Finished run-tests step (success) 17:38:38 INFO - Running post-run listener: _resource_record_post_run 17:38:38 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 315392; Write bytes: 513676288; Read time: 3; Write time: 1658 17:38:38 INFO - TinderboxPrint: CPU usage
54.0% 17:38:38 INFO - TinderboxPrint: I/O read bytes / time
315,392 / 3 17:38:38 INFO - TinderboxPrint: I/O write bytes / time
513,676,288 / 1,658 17:38:38 INFO - TinderboxPrint: CPU idle
2,204.1 (46.0%) 17:38:38 INFO - TinderboxPrint: CPU system
960.1 (20.0%) 17:38:38 INFO - TinderboxPrint: CPU user
1,629.5 (34.0%) 17:38:38 INFO - TinderboxPrint: Swap in / out
208,478,208 / 0 17:38:38 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209779200; Write bytes: 209735680; Read time: 16136; Write time: 473 17:38:38 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 225280; Write bytes: 302687232; Read time: 2; Write time: 1177 17:38:39 INFO - Running post-run listener: _upload_blobber_files 17:38:39 INFO - Blob upload gear active. 17:38:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:38: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:38: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:38: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:38:39 INFO - (blobuploader) - INFO - Open directory for files ... 17:38:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:38:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:38:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:38:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:38:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:38:40 INFO - (blobuploader) - INFO - Done attempting. 17:38:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:38:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:38:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:38:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:38:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:38:41 INFO - (blobuploader) - INFO - Done attempting. 17:38:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:38:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:38:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:38:42 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:38:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:38:42 INFO - (blobuploader) - INFO - Done attempting. 17:38:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:38:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:38:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:38:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:38:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:38:44 INFO - (blobuploader) - INFO - Done attempting. 17:38:44 INFO - (blobuploader) - INFO - Iteration through files over. 17:38:44 INFO - Return code: 0 17:38:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:38:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:38:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bab061083d94b5cd2f36382c4c8c62f2dc209ed90d9340dd94fbdc04537ca45c8291d885955a9f9b831d57ed88eae7367c150c5b1467ea51192db98f9014270e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/558bff7ee785de6751ab435284181a316cab017b23b1a0742accb6ac88eab8b66a22bd5dd88147346d0e8c2706938f68bc6371459d422212d86409d94fb90661", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a43a31a434026986b07ef76305fa275ce5faad2661a9f38e8946212da713db98c605043c1451747309ca2384dcd3ecbf9c05d62a2448637f69c0ac763e03bc58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c9006fd826db37e77810be2788f004e24dd2cf50bc27b3ae4c8c11250b6acad04987c08ad5ae41855940c2f5cd22de5ad87273874ea7fb64350a437ec43b255"} 17:38:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:38:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:38:44 INFO - Contents: 17:38:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bab061083d94b5cd2f36382c4c8c62f2dc209ed90d9340dd94fbdc04537ca45c8291d885955a9f9b831d57ed88eae7367c150c5b1467ea51192db98f9014270e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/558bff7ee785de6751ab435284181a316cab017b23b1a0742accb6ac88eab8b66a22bd5dd88147346d0e8c2706938f68bc6371459d422212d86409d94fb90661", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a43a31a434026986b07ef76305fa275ce5faad2661a9f38e8946212da713db98c605043c1451747309ca2384dcd3ecbf9c05d62a2448637f69c0ac763e03bc58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c9006fd826db37e77810be2788f004e24dd2cf50bc27b3ae4c8c11250b6acad04987c08ad5ae41855940c2f5cd22de5ad87273874ea7fb64350a437ec43b255"} 17:38:44 INFO - Running post-run listener: copy_logs_to_upload_dir 17:38:44 INFO - Copying logs to upload dir... 17:38:44 INFO - mkdir: /builds/slave/test/build/upload/logs 17:38:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.064537 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-04-28 17:38:44.440051) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 17:38:44.444090) ========= 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.9iHntS28gD/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.XLRCNY6gWC/Listeners TMPDIR=/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/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/bab061083d94b5cd2f36382c4c8c62f2dc209ed90d9340dd94fbdc04537ca45c8291d885955a9f9b831d57ed88eae7367c150c5b1467ea51192db98f9014270e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/558bff7ee785de6751ab435284181a316cab017b23b1a0742accb6ac88eab8b66a22bd5dd88147346d0e8c2706938f68bc6371459d422212d86409d94fb90661", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a43a31a434026986b07ef76305fa275ce5faad2661a9f38e8946212da713db98c605043c1451747309ca2384dcd3ecbf9c05d62a2448637f69c0ac763e03bc58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c9006fd826db37e77810be2788f004e24dd2cf50bc27b3ae4c8c11250b6acad04987c08ad5ae41855940c2f5cd22de5ad87273874ea7fb64350a437ec43b255"} 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.011546 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/bab061083d94b5cd2f36382c4c8c62f2dc209ed90d9340dd94fbdc04537ca45c8291d885955a9f9b831d57ed88eae7367c150c5b1467ea51192db98f9014270e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/558bff7ee785de6751ab435284181a316cab017b23b1a0742accb6ac88eab8b66a22bd5dd88147346d0e8c2706938f68bc6371459d422212d86409d94fb90661", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a43a31a434026986b07ef76305fa275ce5faad2661a9f38e8946212da713db98c605043c1451747309ca2384dcd3ecbf9c05d62a2448637f69c0ac763e03bc58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c9006fd826db37e77810be2788f004e24dd2cf50bc27b3ae4c8c11250b6acad04987c08ad5ae41855940c2f5cd22de5ad87273874ea7fb64350a437ec43b255"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 17:38:44.481496) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:38:44.481829) ========= 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.9iHntS28gD/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.XLRCNY6gWC/Listeners TMPDIR=/var/folders/rx/3trszfh567qfgj3yl9jd_ztc00000w/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.005442 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:38:44.530376) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 17:38:44.530724) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 17:38:44.531038) ========= ========= Total master_lag: 0.20 =========