builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0109 starttime: 1491688844.34 results: success (0) buildid: 20170408134622 builduid: c4430090cac946768aa502dc34df59e3 revision: 21c4aca1ae6046f4b90b001badcabee97f543820 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-08 15:00:44.337370) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-08 15:00:44.337903) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-08 15:00:44.338532) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-08 15:00:44.465084) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 15:00:44.465440) ========= 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.gFlqRGTZdH/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.zkAfTWTsWZ/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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-08 15:00:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.53M=0.001s 2017-04-08 15:00:45 (9.53 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.455629 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 15:00:44.945267) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 15:00:44.945587) ========= 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.gFlqRGTZdH/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.zkAfTWTsWZ/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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.027803 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 15:00:44.997133) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-08 15:00:44.997751) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 21c4aca1ae6046f4b90b001badcabee97f543820 --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 21c4aca1ae6046f4b90b001badcabee97f543820 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gFlqRGTZdH/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.zkAfTWTsWZ/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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-08 15:00:45,196 truncating revision to first 12 chars 2017-04-08 15:00:45,196 Setting DEBUG logging. 2017-04-08 15:00:45,196 attempt 1/10 2017-04-08 15:00:45,196 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/21c4aca1ae60?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-08 15:00:46,008 unpacking tar archive at: mozilla-central-21c4aca1ae60/testing/mozharness/ program finished with exit code 0 elapsedTime=1.080501 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-08 15:00:46.103262) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-08 15:00:46.103575) ========= script_repo_revision: 21c4aca1ae6046f4b90b001badcabee97f543820 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-08 15:00:46.104031) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-08 15:00:46.104328) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-08 15:00:46.124859) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-04-08 15:00:46.125329) ========= /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.gFlqRGTZdH/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.zkAfTWTsWZ/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 15:00:46 INFO - MultiFileLogger online at 20170408 15:00:46 in /builds/slave/test 15:00:46 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 15:00:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:00:46 INFO - {'append_to_log': False, 15:00:46 INFO - 'base_work_dir': '/builds/slave/test', 15:00:46 INFO - 'blob_upload_branch': 'Firefox', 15:00:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:00:46 INFO - 'branch': 'Firefox', 15:00:46 INFO - 'buildbot_json_path': 'buildprops.json', 15:00:46 INFO - 'config_files': ('talos/mac_config.py',), 15:00:46 INFO - 'default_actions': ('clobber', 15:00:46 INFO - 'read-buildbot-config', 15:00:46 INFO - 'download-and-extract', 15:00:46 INFO - 'populate-webroot', 15:00:46 INFO - 'create-virtualenv', 15:00:46 INFO - 'install', 15:00:46 INFO - 'run-tests'), 15:00:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:00:46 INFO - 'download_minidump_stackwalk': True, 15:00:46 INFO - 'download_symbols': 'ondemand', 15:00:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:00:46 INFO - 'tooltool.py': '/tools/tooltool.py', 15:00:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:00:46 INFO - '/tools/misc-python/virtualenv.py')}, 15:00:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:00:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:00:46 INFO - 'gecko_profile': False, 15:00:46 INFO - 'gecko_profile_interval': 0, 15:00:46 INFO - 'installer_path': 'installer.exe', 15:00:46 INFO - 'log_level': 'info', 15:00:46 INFO - 'log_name': 'talos', 15:00:46 INFO - 'log_to_console': True, 15:00:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:00:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:00:46 INFO - 'opt_config_files': (), 15:00:46 INFO - 'pip_index': False, 15:00:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:00:46 INFO - 'cmd': ('bash', 15:00:46 INFO - '-c', 15:00:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:00:46 INFO - 'enabled': True, 15:00:46 INFO - 'halt_on_failure': False, 15:00:46 INFO - 'name': 'check_screen_resolution'},), 15:00:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:00:46 INFO - 'cmd': ('bash', 15:00:46 INFO - '-c', 15:00:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:00:46 INFO - 'enabled': True, 15:00:46 INFO - 'halt_on_failure': False, 15:00:46 INFO - 'name': 'check_screen_resolution'},), 15:00:46 INFO - 'run_cmd_checks_enabled': True, 15:00:46 INFO - 'suite': 'dromaeojs-e10s', 15:00:46 INFO - 'system_bits': '32', 15:00:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:00:46 INFO - 'title': 't-yosemite-r7-0109', 15:00:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:00:46 INFO - 'use_talos_json': True, 15:00:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:00:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:00:46 INFO - 'work_dir': 'build'} 15:00:46 INFO - [mozharness: 2017-04-08 22:00:46.435260Z] Running clobber step. 15:00:46 INFO - Running pre-action listener: _resource_record_pre_action 15:00:46 INFO - Running main action method: clobber 15:00:46 INFO - rmtree: /builds/slave/test/build 15:00:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:00:48 INFO - Running post-action listener: _resource_record_post_action 15:00:48 INFO - [mozharness: 2017-04-08 22:00:48.984818Z] Finished clobber step (success) 15:00:48 INFO - [mozharness: 2017-04-08 22:00:48.985037Z] Running read-buildbot-config step. 15:00:48 INFO - Running pre-action listener: _resource_record_pre_action 15:00:48 INFO - Running main action method: read_buildbot_config 15:00:48 INFO - Using buildbot properties: 15:00:48 INFO - { 15:00:48 INFO - "project": "", 15:00:48 INFO - "product": "firefox", 15:00:48 INFO - "script_repo_revision": "production", 15:00:48 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 15:00:48 INFO - "repository": "", 15:00:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 15:00:48 INFO - "buildid": "20170408134622", 15:00:48 INFO - "pgo_build": "False", 15:00:48 INFO - "basedir": "/builds/slave/test", 15:00:48 INFO - "buildnumber": 191, 15:00:48 INFO - "slavename": "t-yosemite-r7-0109", 15:00:48 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 15:00:48 INFO - "platform": "yosemite_r7", 15:00:48 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:00:48 INFO - "branch": "mozilla-central", 15:00:48 INFO - "repo_path": "mozilla-central", 15:00:48 INFO - "revision": "21c4aca1ae6046f4b90b001badcabee97f543820", 15:00:48 INFO - "stage_platform": "macosx64", 15:00:48 INFO - "builduid": "c4430090cac946768aa502dc34df59e3", 15:00:48 INFO - "slavebuilddir": "test" 15:00:48 INFO - } 15:00:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/Mlo30LLeShOu8bdpsVgAFA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 15:00:48 INFO - Running post-action listener: _resource_record_post_action 15:00:48 INFO - [mozharness: 2017-04-08 22:00:48.990823Z] Finished read-buildbot-config step (success) 15:00:48 INFO - [mozharness: 2017-04-08 22:00:48.991003Z] Running download-and-extract step. 15:00:48 INFO - Running pre-action listener: _resource_record_pre_action 15:00:48 INFO - Running main action method: download_and_extract 15:00:48 INFO - mkdir: /builds/slave/test/build/tests 15:00:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:00:48 INFO - trying https://queue.taskcluster.net/v1/task/Mlo30LLeShOu8bdpsVgAFA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 15:00:48 INFO - Downloading https://queue.taskcluster.net/v1/task/Mlo30LLeShOu8bdpsVgAFA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 15:00:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Mlo30LLeShOu8bdpsVgAFA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 15:00:50 INFO - Downloaded 1325 bytes. 15:00:50 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 15:00:50 INFO - Using the following test package requirements: 15:00:50 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:00:50 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 15:00:50 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 15:00:50 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:00:50 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 15:00:50 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:00:50 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 15:00:50 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:00:50 INFO - u'jsshell-mac.zip'], 15:00:50 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:00:50 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 15:00:50 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 15:00:50 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:00:50 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 15:00:50 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:00:50 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 15:00:50 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:00:50 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 15:00:50 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:00:50 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 15:00:50 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:00:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mlo30LLeShOu8bdpsVgAFA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 15:00:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mlo30LLeShOu8bdpsVgAFA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:00:50 INFO - Fetch https://queue.taskcluster.net/v1/task/Mlo30LLeShOu8bdpsVgAFA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 15:00:52 INFO - Expected file size: 52521677 15:00:52 INFO - Obtained file size: 52521677 15:01:08 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 15:01:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mlo30LLeShOu8bdpsVgAFA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 15:01:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mlo30LLeShOu8bdpsVgAFA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:01:08 INFO - Fetch https://queue.taskcluster.net/v1/task/Mlo30LLeShOu8bdpsVgAFA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 15:01:10 INFO - Expected file size: 52521677 15:01:10 INFO - Obtained file size: 52521677 15:01:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Mlo30LLeShOu8bdpsVgAFA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 15:01:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Mlo30LLeShOu8bdpsVgAFA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:01:26 INFO - Fetch https://queue.taskcluster.net/v1/task/Mlo30LLeShOu8bdpsVgAFA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 15:01:27 INFO - Expected file size: 14404129 15:01:27 INFO - Obtained file size: 14404129 15:01:27 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')]} 15:01:27 INFO - trying https://queue.taskcluster.net/v1/task/Mlo30LLeShOu8bdpsVgAFA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:01:27 INFO - Downloading https://queue.taskcluster.net/v1/task/Mlo30LLeShOu8bdpsVgAFA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 15:01:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Mlo30LLeShOu8bdpsVgAFA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 15:01:29 INFO - Downloaded 70900475 bytes. 15:01:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Mlo30LLeShOu8bdpsVgAFA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:01:29 INFO - mkdir: /builds/slave/test/properties 15:01:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:01:29 INFO - Writing to file /builds/slave/test/properties/build_url 15:01:29 INFO - Contents: 15:01:29 INFO - build_url:https://queue.taskcluster.net/v1/task/Mlo30LLeShOu8bdpsVgAFA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:01:30 INFO - Running post-action listener: _resource_record_post_action 15:01:30 INFO - Running post-action listener: set_extra_try_arguments 15:01:30 INFO - [mozharness: 2017-04-08 22:01:30.459923Z] Finished download-and-extract step (success) 15:01:30 INFO - [mozharness: 2017-04-08 22:01:30.460023Z] Running populate-webroot step. 15:01:30 INFO - Running pre-action listener: _resource_record_pre_action 15:01:30 INFO - Running main action method: populate_webroot 15:01:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:01:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:01:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:01:30 INFO - '--tppagecycles', 15:01:30 INFO - '7'], 15:01:30 INFO - 'tests': ['tsvgm']}}, 15:01:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:01:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:01:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:01:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:01:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:01:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:01:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:01:30 INFO - 'talos_options': ['--disable-e10s'], 15:01:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:01:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:01:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:01:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:01:30 INFO - 'talos_options': ['--disable-e10s'], 15:01:30 INFO - 'tests': ['damp', 'tps']}, 15:01:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:01:30 INFO - 'tests': ['damp', 'tps']}, 15:01:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:01:30 INFO - 'tests': ['dromaeo_dom']}, 15:01:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:01:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:01:30 INFO - 'tests': ['basic_compositor_video']}, 15:01:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:01:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:01:30 INFO - 'tests': ['a11yr', 15:01:30 INFO - 'ts_paint', 15:01:30 INFO - 'tpaint', 15:01:30 INFO - 'sessionrestore', 15:01:30 INFO - 'sessionrestore_no_auto_restore', 15:01:30 INFO - 'tabpaint']}, 15:01:30 INFO - 'other-e10s': {'tests': ['a11yr', 15:01:30 INFO - 'ts_paint', 15:01:30 INFO - 'tpaint', 15:01:30 INFO - 'sessionrestore', 15:01:30 INFO - 'sessionrestore_no_auto_restore', 15:01:30 INFO - 'tabpaint']}, 15:01:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:01:30 INFO - 'ts_paint', 15:01:30 INFO - 'tpaint', 15:01:30 INFO - 'sessionrestore', 15:01:30 INFO - 'sessionrestore_no_auto_restore', 15:01:30 INFO - 'tabpaint']}, 15:01:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:01:30 INFO - 'ts_paint', 15:01:30 INFO - 'tpaint', 15:01:30 INFO - 'sessionrestore', 15:01:30 INFO - 'sessionrestore_no_auto_restore', 15:01:30 INFO - 'tabpaint']}, 15:01:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:01:30 INFO - 'tests': ['a11yr', 15:01:30 INFO - 'ts_paint', 15:01:30 INFO - 'tpaint', 15:01:30 INFO - 'sessionrestore', 15:01:30 INFO - 'sessionrestore_no_auto_restore', 15:01:30 INFO - 'tabpaint']}, 15:01:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:01:30 INFO - 'tests': ['a11yr', 15:01:30 INFO - 'ts_paint', 15:01:30 INFO - 'tpaint', 15:01:30 INFO - 'sessionrestore', 15:01:30 INFO - 'sessionrestore_no_auto_restore', 15:01:30 INFO - 'tabpaint']}, 15:01:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:01:30 INFO - 'tests': ['tsvgx', 15:01:30 INFO - 'tsvgr_opacity', 15:01:30 INFO - 'tart', 15:01:30 INFO - 'tscrollx', 15:01:30 INFO - 'cart', 15:01:30 INFO - 'tsvg_static']}, 15:01:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:01:30 INFO - 'tsvgr_opacity', 15:01:30 INFO - 'tart', 15:01:30 INFO - 'tscrollx', 15:01:30 INFO - 'cart', 15:01:30 INFO - 'tsvg_static']}, 15:01:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:01:30 INFO - 'talos_options': ['--disable-e10s'], 15:01:30 INFO - 'tests': ['tp5o']}, 15:01:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:01:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:01:30 INFO - 'talos_options': ['--disable-e10s', 15:01:30 INFO - '--xperf_path', 15:01:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:01:30 INFO - 'tests': ['tp5n']}, 15:01:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:01:30 INFO - 'talos_options': ['--xperf_path', 15:01:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:01:30 INFO - 'tests': ['tp5n']}}, 15:01:30 INFO - 'talos.zip': {'path': '', 15:01:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:01:30 INFO - Running post-action listener: _resource_record_post_action 15:01:30 INFO - [mozharness: 2017-04-08 22:01:30.478359Z] Finished populate-webroot step (success) 15:01:30 INFO - [mozharness: 2017-04-08 22:01:30.478494Z] Running create-virtualenv step. 15:01:30 INFO - Running pre-action listener: _resource_record_pre_action 15:01:30 INFO - Running main action method: create_virtualenv 15:01:30 INFO - Creating virtualenv /builds/slave/test/build/venv 15:01:30 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 15:01:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:01:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:01:30 INFO - Using real prefix '/tools/python27' 15:01:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:01:31 INFO - Installing distribute.............................................................................................................................................................................................done. 15:01:34 INFO - Installing pip.................done. 15:01:34 INFO - Return code: 0 15:01:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:01:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:01:34 INFO - Reading from file tmpfile_stdout 15:01:34 INFO - Output received: 15:01:34 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) 15:01:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:01: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')]} 15:01:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01: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')]} 15:01:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:34 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 0x1070acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1e1c4d4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e8ad30>, '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 0x106db1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e7fbe8>, '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.gFlqRGTZdH/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.zkAfTWTsWZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 15:01:34 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 15:01:34 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 15:01:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gFlqRGTZdH/Render', 15:01:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:34 INFO - 'HOME': '/Users/cltbld', 15:01:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:34 INFO - 'LOGNAME': 'cltbld', 15:01:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:34 INFO - 'MOZ_NO_REMOTE': '1', 15:01:34 INFO - 'NO_EM_RESTART': '1', 15:01:34 INFO - 'PAGER': '/bin/cat', 15:01:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:34 INFO - 'PWD': '/builds/slave/test', 15:01:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:34 INFO - 'SHELL': '/bin/bash', 15:01:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zkAfTWTsWZ/Listeners', 15:01:34 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 15:01:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:34 INFO - 'USER': 'cltbld', 15:01:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:34 INFO - 'XPC_FLAGS': '0x0', 15:01:34 INFO - 'XPC_SERVICE_NAME': '0', 15:01:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:34 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 15:01:34 INFO - Cleaning up... 15:01:34 INFO - Return code: 0 15:01:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:01: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')]} 15:01:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01: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')]} 15:01:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:34 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 0x1070acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1e1c4d4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e8ad30>, '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 0x106db1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e7fbe8>, '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.gFlqRGTZdH/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.zkAfTWTsWZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 15:01:34 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 15:01:34 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 15:01:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gFlqRGTZdH/Render', 15:01:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:34 INFO - 'HOME': '/Users/cltbld', 15:01:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:34 INFO - 'LOGNAME': 'cltbld', 15:01:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:34 INFO - 'MOZ_NO_REMOTE': '1', 15:01:34 INFO - 'NO_EM_RESTART': '1', 15:01:34 INFO - 'PAGER': '/bin/cat', 15:01:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:34 INFO - 'PWD': '/builds/slave/test', 15:01:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:34 INFO - 'SHELL': '/bin/bash', 15:01:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zkAfTWTsWZ/Listeners', 15:01:34 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 15:01:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:34 INFO - 'USER': 'cltbld', 15:01:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:34 INFO - 'XPC_FLAGS': '0x0', 15:01:34 INFO - 'XPC_SERVICE_NAME': '0', 15:01:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:35 INFO - Downloading/unpacking psutil>=3.1.1 15:01:35 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 15:01:35 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 15:01:35 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 15:01:35 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 15:01:35 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 15:01:35 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 15:01:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:01:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:01:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:01:39 INFO - Installing collected packages: psutil 15:01:39 INFO - Running setup.py install for psutil 15:01:39 INFO - building 'psutil._psutil_osx' extension 15:01:39 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 15:01:39 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 15:01:39 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 15:01:40 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 15:01:40 INFO - building 'psutil._psutil_posix' extension 15:01:40 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 15:01:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:01:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:01:40 INFO - ^ 15:01:40 INFO - 1 warning generated. 15:01:40 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 15:01:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:01:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:01:40 INFO - Successfully installed psutil 15:01:40 INFO - Cleaning up... 15:01:40 INFO - Return code: 0 15:01:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:01:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1070acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1e1c4d4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e8ad30>, '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 0x106db1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e7fbe8>, '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.gFlqRGTZdH/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.zkAfTWTsWZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 15:01:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:01:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:01:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gFlqRGTZdH/Render', 15:01:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:40 INFO - 'HOME': '/Users/cltbld', 15:01:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:40 INFO - 'LOGNAME': 'cltbld', 15:01:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:40 INFO - 'MOZ_NO_REMOTE': '1', 15:01:40 INFO - 'NO_EM_RESTART': '1', 15:01:40 INFO - 'PAGER': '/bin/cat', 15:01:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:40 INFO - 'PWD': '/builds/slave/test', 15:01:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:40 INFO - 'SHELL': '/bin/bash', 15:01:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zkAfTWTsWZ/Listeners', 15:01:40 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 15:01:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:40 INFO - 'USER': 'cltbld', 15:01:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:40 INFO - 'XPC_FLAGS': '0x0', 15:01:40 INFO - 'XPC_SERVICE_NAME': '0', 15:01:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:01:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:01:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:01:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:01:43 INFO - Installing collected packages: mozsystemmonitor 15:01:43 INFO - Running setup.py install for mozsystemmonitor 15:01:43 INFO - Successfully installed mozsystemmonitor 15:01:43 INFO - Cleaning up... 15:01:43 INFO - Return code: 0 15:01:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:01:43 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')]} 15:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:43 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')]} 15:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:43 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 0x1070acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1e1c4d4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e8ad30>, '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 0x106db1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e7fbe8>, '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.gFlqRGTZdH/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.zkAfTWTsWZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 15:01:43 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 15:01:43 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 15:01:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gFlqRGTZdH/Render', 15:01:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:43 INFO - 'HOME': '/Users/cltbld', 15:01:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:43 INFO - 'LOGNAME': 'cltbld', 15:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:43 INFO - 'MOZ_NO_REMOTE': '1', 15:01:43 INFO - 'NO_EM_RESTART': '1', 15:01:43 INFO - 'PAGER': '/bin/cat', 15:01:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:43 INFO - 'PWD': '/builds/slave/test', 15:01:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:43 INFO - 'SHELL': '/bin/bash', 15:01:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zkAfTWTsWZ/Listeners', 15:01:43 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 15:01:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:43 INFO - 'USER': 'cltbld', 15:01:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:43 INFO - 'XPC_FLAGS': '0x0', 15:01:43 INFO - 'XPC_SERVICE_NAME': '0', 15:01:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:43 INFO - Downloading/unpacking jsonschema==2.5.1 15:01:43 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 15:01:43 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 15:01:43 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 15:01:43 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 15:01:43 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 15:01:43 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 15:01:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:01:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:01:46 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 15:01:46 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 15:01:46 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 15:01:46 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 15:01:46 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 15:01:46 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 15:01:46 INFO - Downloading functools32-3.2.3-2.tar.gz 15:01:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:01:46 INFO - warning: no files found matching '*.txt' 15:01:47 INFO - no previously-included directories found matching 'build' 15:01:47 INFO - no previously-included directories found matching 'dist' 15:01:47 INFO - no previously-included directories found matching '.git*' 15:01:47 INFO - Installing collected packages: jsonschema, functools32 15:01:47 INFO - Running setup.py install for functools32 15:01:47 INFO - warning: no files found matching '*.txt' 15:01:47 INFO - no previously-included directories found matching 'build' 15:01:47 INFO - no previously-included directories found matching 'dist' 15:01:47 INFO - no previously-included directories found matching '.git*' 15:01:47 INFO - Successfully installed jsonschema functools32 15:01:47 INFO - Cleaning up... 15:01:47 INFO - Return code: 0 15:01:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:01:47 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')]} 15:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:47 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')]} 15:01:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:47 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 0x1070acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1e1c4d4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e8ad30>, '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 0x106db1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e7fbe8>, '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.gFlqRGTZdH/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.zkAfTWTsWZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 15:01:47 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 15:01:47 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 15:01:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gFlqRGTZdH/Render', 15:01:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:47 INFO - 'HOME': '/Users/cltbld', 15:01:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:47 INFO - 'LOGNAME': 'cltbld', 15:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:47 INFO - 'MOZ_NO_REMOTE': '1', 15:01:47 INFO - 'NO_EM_RESTART': '1', 15:01:47 INFO - 'PAGER': '/bin/cat', 15:01:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:47 INFO - 'PWD': '/builds/slave/test', 15:01:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:47 INFO - 'SHELL': '/bin/bash', 15:01:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zkAfTWTsWZ/Listeners', 15:01:47 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 15:01:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:47 INFO - 'USER': 'cltbld', 15:01:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:47 INFO - 'XPC_FLAGS': '0x0', 15:01:47 INFO - 'XPC_SERVICE_NAME': '0', 15:01:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:01:47 INFO - Cleaning up... 15:01:47 INFO - Return code: 0 15:01:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:01:47 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')]} 15:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:47 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')]} 15:01:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:47 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 0x1070acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1e1c4d4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e8ad30>, '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 0x106db1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e7fbe8>, '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.gFlqRGTZdH/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.zkAfTWTsWZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 15:01:47 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 15:01:47 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 15:01:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gFlqRGTZdH/Render', 15:01:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:47 INFO - 'HOME': '/Users/cltbld', 15:01:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:47 INFO - 'LOGNAME': 'cltbld', 15:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:47 INFO - 'MOZ_NO_REMOTE': '1', 15:01:47 INFO - 'NO_EM_RESTART': '1', 15:01:47 INFO - 'PAGER': '/bin/cat', 15:01:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:47 INFO - 'PWD': '/builds/slave/test', 15:01:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:47 INFO - 'SHELL': '/bin/bash', 15:01:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zkAfTWTsWZ/Listeners', 15:01:47 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 15:01:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:47 INFO - 'USER': 'cltbld', 15:01:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:47 INFO - 'XPC_FLAGS': '0x0', 15:01:47 INFO - 'XPC_SERVICE_NAME': '0', 15:01:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:47 INFO - Downloading/unpacking blobuploader==1.2.4 15:01:47 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 15:01:47 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 15:01:47 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 15:01:47 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 15:01:47 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 15:01:47 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 15:01:50 INFO - Downloading blobuploader-1.2.4.tar.gz 15:01:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:01:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:01:50 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 15:01:50 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 15:01:50 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 15:01:50 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 15:01:50 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 15:01:50 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 15:01:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:01:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:01:51 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 15:01:51 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 15:01:51 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 15:01:51 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 15:01:51 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 15:01:51 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 15:01:51 INFO - Downloading docopt-0.6.1.tar.gz 15:01:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:01:51 INFO - Installing collected packages: blobuploader, requests, docopt 15:01:51 INFO - Running setup.py install for blobuploader 15:01:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:01:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:01:51 INFO - Running setup.py install for requests 15:01:52 INFO - Running setup.py install for docopt 15:01:52 INFO - Successfully installed blobuploader requests docopt 15:01:52 INFO - Cleaning up... 15:01:52 INFO - Return code: 0 15:01:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:52 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 0x1070acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1e1c4d4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e8ad30>, '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 0x106db1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e7fbe8>, '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.gFlqRGTZdH/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.zkAfTWTsWZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 15:01:52 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 15:01:52 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 15:01:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gFlqRGTZdH/Render', 15:01:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:52 INFO - 'HOME': '/Users/cltbld', 15:01:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:52 INFO - 'LOGNAME': 'cltbld', 15:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:52 INFO - 'MOZ_NO_REMOTE': '1', 15:01:52 INFO - 'NO_EM_RESTART': '1', 15:01:52 INFO - 'PAGER': '/bin/cat', 15:01:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:52 INFO - 'PWD': '/builds/slave/test', 15:01:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:52 INFO - 'SHELL': '/bin/bash', 15:01:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zkAfTWTsWZ/Listeners', 15:01:52 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 15:01:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:52 INFO - 'USER': 'cltbld', 15:01:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:52 INFO - 'XPC_FLAGS': '0x0', 15:01:52 INFO - 'XPC_SERVICE_NAME': '0', 15:01:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:01:53 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-awKycA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:01:53 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-7wGPmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:01:53 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-WHcjn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:01:53 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-FHM8j3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:01:53 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-ZHrkAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:01:53 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-F0IqHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:01:53 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-aA8TYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:01:53 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-4f8YaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:01:53 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-Mre3U8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:01:53 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-cC29ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:01:54 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-p7fw_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:01:54 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-iZ8__X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:01:54 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-iqJkcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:01:54 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-HPi7AO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:54 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-Mm5d_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:01:54 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-mmDjZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:01:54 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-l1zml9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:01:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:01:54 INFO - Running setup.py install for manifestparser 15:01:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:01:54 INFO - Running setup.py install for mozcrash 15:01:55 INFO - Running setup.py install for mozdebug 15:01:55 INFO - Running setup.py install for mozdevice 15:01:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:01:55 INFO - Running setup.py install for mozfile 15:01:55 INFO - Running setup.py install for mozhttpd 15:01:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:01:55 INFO - Running setup.py install for mozinfo 15:01:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:01:55 INFO - Running setup.py install for mozInstall 15:01:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:01:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:01:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:01:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:01:55 INFO - Running setup.py install for mozleak 15:01:56 INFO - Running setup.py install for mozlog 15:01:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:01:56 INFO - Running setup.py install for moznetwork 15:01:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:01:56 INFO - Running setup.py install for mozprocess 15:01:56 INFO - Running setup.py install for mozprofile 15:01:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:01:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:01:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:01:56 INFO - Running setup.py install for mozrunner 15:01:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:01:56 INFO - Running setup.py install for mozscreenshot 15:01:57 INFO - Running setup.py install for moztest 15:01:57 INFO - Running setup.py install for mozversion 15:01:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:01:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:01:57 INFO - Cleaning up... 15:01:57 INFO - Return code: 0 15:01:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:57 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 0x1070acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1e1c4d4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e8ad30>, '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 0x106db1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e7fbe8>, '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.gFlqRGTZdH/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.zkAfTWTsWZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 15:01:57 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 15:01:57 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 15:01:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gFlqRGTZdH/Render', 15:01:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:01:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:01:57 INFO - 'HOME': '/Users/cltbld', 15:01:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:01:57 INFO - 'LOGNAME': 'cltbld', 15:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:57 INFO - 'MOZ_NO_REMOTE': '1', 15:01:57 INFO - 'NO_EM_RESTART': '1', 15:01:57 INFO - 'PAGER': '/bin/cat', 15:01:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:57 INFO - 'PWD': '/builds/slave/test', 15:01:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:01:57 INFO - 'SHELL': '/bin/bash', 15:01:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zkAfTWTsWZ/Listeners', 15:01:57 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 15:01:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:01:57 INFO - 'USER': 'cltbld', 15:01:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:01:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:57 INFO - 'XPC_FLAGS': '0x0', 15:01:57 INFO - 'XPC_SERVICE_NAME': '0', 15:01:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:01:57 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-9Xkc_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:01:57 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)) 15:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:01:57 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-2pgzZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:01:57 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)) 15:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:01:57 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-3mFBtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:01:57 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)) 15:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:01:57 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-OSVPn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:01:57 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)) 15:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:01:57 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-PmcQXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:01:58 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)) 15:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:01:58 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-orNR8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:01:58 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)) 15:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:01:58 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-e9SeUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:01:58 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)) 15:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:01:58 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-BT0YPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:01:58 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)) 15:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:01:58 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-tqoxEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:01:58 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)) 15:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:01:58 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-ARhxUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:01:58 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)) 15:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:01:58 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-2FsgH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:01:58 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)) 15:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:01:58 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-yApNKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:01:58 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)) 15:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:01:58 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-xNBkXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:01:58 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)) 15:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:01:58 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-6bU1OT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:01:59 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)) 15:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:59 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-8CCXRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:59 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)) 15:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:01:59 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-6sR53I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:01:59 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)) 15:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:01:59 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-xkiuC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:01:59 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)) 15:01:59 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)) 15:01:59 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)) 15:01:59 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)) 15:01:59 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)) 15:01:59 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)) 15:01:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:01:59 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 15:01:59 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 15:01:59 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 15:01:59 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 15:01:59 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 15:01:59 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 15:02:01 INFO - Downloading blessings-1.6.tar.gz 15:02:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:02:02 INFO - Installing collected packages: blessings 15:02:02 INFO - Running setup.py install for blessings 15:02:02 INFO - Successfully installed blessings 15:02:02 INFO - Cleaning up... 15:02:02 INFO - Return code: 0 15:02:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:02:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:02:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:02:02 INFO - Reading from file tmpfile_stdout 15:02:02 INFO - Current package versions: 15:02:02 INFO - blessings == 1.6 15:02:02 INFO - blobuploader == 1.2.4 15:02:02 INFO - docopt == 0.6.1 15:02:02 INFO - functools32 == 3.2.3-2 15:02:02 INFO - jsonschema == 2.5.1 15:02:02 INFO - manifestparser == 1.1 15:02:02 INFO - mozInstall == 1.12 15:02:02 INFO - mozcrash == 1.0 15:02:02 INFO - mozdebug == 0.1 15:02:02 INFO - mozdevice == 0.50 15:02:02 INFO - mozfile == 1.2 15:02:02 INFO - mozhttpd == 0.7 15:02:02 INFO - mozinfo == 0.9 15:02:02 INFO - mozleak == 0.1 15:02:02 INFO - mozlog == 3.4 15:02:02 INFO - moznetwork == 0.27 15:02:02 INFO - mozprocess == 0.25 15:02:02 INFO - mozprofile == 0.28 15:02:02 INFO - mozrunner == 6.13 15:02:02 INFO - mozscreenshot == 0.1 15:02:02 INFO - mozsystemmonitor == 0.3 15:02:02 INFO - moztest == 0.8 15:02:02 INFO - mozversion == 1.4 15:02:02 INFO - psutil == 3.1.1 15:02:02 INFO - requests == 1.2.3 15:02:02 INFO - wsgiref == 0.1.2 15:02:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:02 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 0x1070acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1e1c4d4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e8ad30>, '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 0x106db1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e7fbe8>, '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.gFlqRGTZdH/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.zkAfTWTsWZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 15:02:02 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 15:02:02 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 15:02:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gFlqRGTZdH/Render', 15:02:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:02:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:02:02 INFO - 'HOME': '/Users/cltbld', 15:02:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:02:02 INFO - 'LOGNAME': 'cltbld', 15:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:02 INFO - 'MOZ_NO_REMOTE': '1', 15:02:02 INFO - 'NO_EM_RESTART': '1', 15:02:02 INFO - 'PAGER': '/bin/cat', 15:02:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:02 INFO - 'PWD': '/builds/slave/test', 15:02:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:02:02 INFO - 'SHELL': '/bin/bash', 15:02:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zkAfTWTsWZ/Listeners', 15:02:02 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 15:02:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:02:02 INFO - 'USER': 'cltbld', 15:02:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:02:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:02 INFO - 'XPC_FLAGS': '0x0', 15:02:02 INFO - 'XPC_SERVICE_NAME': '0', 15:02:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:02 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)) 15:02:02 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)) 15:02:02 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)) 15:02:02 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)) 15:02:02 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)) 15:02:02 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)) 15:02:02 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)) 15:02:02 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)) 15:02:02 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)) 15:02:02 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)) 15:02:02 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)) 15:02:02 INFO - Cleaning up... 15:02:02 INFO - Return code: 0 15:02:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1070acb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070af768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1e1c4d4b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e8ad30>, '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 0x106db1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e7fbe8>, '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.gFlqRGTZdH/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.zkAfTWTsWZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 15:02:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:02:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:02:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gFlqRGTZdH/Render', 15:02:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:02:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:02:02 INFO - 'HOME': '/Users/cltbld', 15:02:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:02:02 INFO - 'LOGNAME': 'cltbld', 15:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:02 INFO - 'MOZ_NO_REMOTE': '1', 15:02:02 INFO - 'NO_EM_RESTART': '1', 15:02:02 INFO - 'PAGER': '/bin/cat', 15:02:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:02 INFO - 'PWD': '/builds/slave/test', 15:02:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:02:02 INFO - 'SHELL': '/bin/bash', 15:02:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zkAfTWTsWZ/Listeners', 15:02:02 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 15:02:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:02:02 INFO - 'USER': 'cltbld', 15:02:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:02:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:02 INFO - 'XPC_FLAGS': '0x0', 15:02:02 INFO - 'XPC_SERVICE_NAME': '0', 15:02:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:02:03 INFO - Cleaning up... 15:02:03 INFO - Return code: 0 15:02:03 INFO - Running post-action listener: _resource_record_post_action 15:02:03 INFO - Running post-action listener: _start_resource_monitoring 15:02:03 INFO - Starting resource monitoring. 15:02:03 INFO - [mozharness: 2017-04-08 22:02:03.187189Z] Finished create-virtualenv step (success) 15:02:03 INFO - [mozharness: 2017-04-08 22:02:03.188209Z] Running install step. 15:02:03 INFO - Running pre-action listener: _resource_record_pre_action 15:02:03 INFO - Running main action method: install 15:02:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:02:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:02:03 INFO - Reading from file tmpfile_stdout 15:02:03 INFO - Detecting whether we're running mozinstall >=1.0... 15:02:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:02:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:02:03 INFO - Reading from file tmpfile_stdout 15:02:03 INFO - Output received: 15:02:03 INFO - Usage: mozinstall [options] installer 15:02:03 INFO - Options: 15:02:03 INFO - -h, --help show this help message and exit 15:02:03 INFO - -d DEST, --destination=DEST 15:02:03 INFO - Directory to install application into. [default: 15:02:03 INFO - "/builds/slave/test"] 15:02:03 INFO - --app=APP Application being installed. [default: firefox] 15:02:03 INFO - mkdir: /builds/slave/test/build/application 15:02:03 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'] 15:02:03 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 15:02:23 INFO - Reading from file tmpfile_stdout 15:02:23 INFO - Output received: 15:02:23 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:02:23 INFO - Running post-action listener: _resource_record_post_action 15:02:23 INFO - [mozharness: 2017-04-08 22:02:23.317944Z] Finished install step (success) 15:02:23 INFO - [mozharness: 2017-04-08 22:02:23.318086Z] Running run-tests step. 15:02:23 INFO - Running pre-action listener: _resource_record_pre_action 15:02:23 INFO - Running main action method: run_tests 15:02:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:02:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:02:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:02:23 INFO - 2017-04-08 15:02:23.332 screenresolution[1649:13415] starting screenresolution argv=screenresolution get 15:02:23 INFO - 2017-04-08 15:02:23.335 screenresolution[1649:13415] Display 0: 1600x1200x32@60 15:02:23 INFO - 2017-04-08 15:02:23.341 screenresolution[1650:13417] starting screenresolution argv=screenresolution list 15:02:23 INFO - Available Modes on Display 0 15:02:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:02:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:02:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:02:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:02:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:02:23 INFO - Intel Iris: 15:02:23 INFO - Chipset Model: Intel Iris 15:02:23 INFO - Type: GPU 15:02:23 INFO - Bus: Built-In 15:02:23 INFO - VRAM (Dynamic, Max): 1536 MB 15:02:23 INFO - Vendor: Intel (0x8086) 15:02:23 INFO - Device ID: 0x0a2e 15:02:23 INFO - Revision ID: 0x0009 15:02:23 INFO - Displays: 15:02:23 INFO - Display: 15:02:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:02:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:02:23 INFO - Display Serial Number: 1600x1200 60 15:02:23 INFO - Main Display: Yes 15:02:23 INFO - Mirror: Off 15:02:23 INFO - Online: Yes 15:02:23 INFO - Rotation: Supported 15:02:23 INFO - Return code: 0 15:02:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:02:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:02:23 INFO - Python 2.7.3 15:02:23 INFO - Return code: 0 15:02:23 INFO - grabbing minidump binary from tooltool 15:02: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')]} 15:02:23 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 0x106e8ad30>, '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 0x106db1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e7fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:02:23 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 15:02:23 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 15:02:23 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 15:02:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:02:23 INFO - Return code: 0 15:02:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:02:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:02:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:02:23 INFO - ENV: RUST_BACKTRACE is now 1 15:02:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:02:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:02:23 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://queue.taskcluster.net/v1/task/Mlo30LLeShOu8bdpsVgAFA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0109', '--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 15:02:23 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://queue.taskcluster.net/v1/task/Mlo30LLeShOu8bdpsVgAFA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0109 --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 15:02:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gFlqRGTZdH/Render', 15:02:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:02:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:02:23 INFO - 'HOME': '/Users/cltbld', 15:02:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:02:23 INFO - 'LOGNAME': 'cltbld', 15:02:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:02:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:02:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:23 INFO - 'MOZ_NO_REMOTE': '1', 15:02:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:02:23 INFO - 'NO_EM_RESTART': '1', 15:02:23 INFO - 'PAGER': '/bin/cat', 15:02:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:02:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:23 INFO - 'PWD': '/builds/slave/test', 15:02:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:02:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:02:23 INFO - 'RUST_BACKTRACE': '1', 15:02:23 INFO - 'SHELL': '/bin/bash', 15:02:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zkAfTWTsWZ/Listeners', 15:02:23 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 15:02:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:02:23 INFO - 'USER': 'cltbld', 15:02:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:02:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:02:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:23 INFO - 'XPC_FLAGS': '0x0', 15:02:23 INFO - 'XPC_SERVICE_NAME': '0', 15:02:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:02:23 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://queue.taskcluster.net/v1/task/Mlo30LLeShOu8bdpsVgAFA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0109', '--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 15:02:23 INFO - mozversion application_buildid: 20170408134622 15:02:23 INFO - mozversion application_changeset: 21c4aca1ae6046f4b90b001badcabee97f543820 15:02:23 INFO - mozversion application_display_name: Nightly 15:02:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:02:23 INFO - mozversion application_name: Firefox 15:02:23 INFO - mozversion application_remotingname: firefox 15:02:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:02:23 INFO - mozversion application_vendor: Mozilla 15:02:23 INFO - mozversion application_version: 55.0a1 15:02:23 INFO - mozversion platform_buildid: 20170408134622 15:02:23 INFO - mozversion platform_changeset: 21c4aca1ae6046f4b90b001badcabee97f543820 15:02:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:02:23 INFO - mozversion platform_version: 55.0a1 15:02:23 INFO - using testdate: 1491688943 15:02:23 INFO - actual date: 1491688943 15:02:23 INFO - starting webserver on 'localhost:49249' 15:02:23 INFO - SUITE-START | Running 2 tests 15:02:23 INFO - TEST-START | dromaeo_css 15:02:23 INFO - operating with platform_type : mac_ 15:02:23 INFO - Initialising browser for dromaeo_css test... 15:02:23 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/tmpnAb8Bd/profile http://localhost:49249/getInfo.html) 15:02:27 INFO - PID 1660 | 2017-04-08 15:02:27.171 plugin-container[1662:13606] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 15:02:27 INFO - PID 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:02:27 INFO - PID 1660 | 2017-04-08 15:02:27.173 plugin-container[1662:13606] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 15:02:27 INFO - PID 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:02:27 INFO - PID 1660 | 2017-04-08 15:02:27.173 plugin-container[1662:13606] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:02:27 INFO - PID 1660 | __metrics Screen width/height:1600/1200 15:02:27 INFO - PID 1660 | colorDepth:24 15:02:27 INFO - PID 1660 | Browser inner width/height: 1024/689 15:02:27 INFO - PID 1660 | __metrics 15:02:27 ERROR - PID 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 15:02:28 INFO - TEST-INFO | 1660: exit 0 15:02:28 INFO - Browser initialized. 15:02:28 INFO - Running cycle 1/1 for dromaeo_css test... 15:02:28 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/tmpnAb8Bd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:02:30 INFO - PID 1664 | 2017-04-08 15:02:30.705 plugin-container[1665:13744] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.tsm.portname' 15:02:30 INFO - PID 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:02:30 INFO - PID 1664 | 2017-04-08 15:02:30.705 plugin-container[1665:13744] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4423, name = 'com.apple.CFPasteboardClient' 15:02:30 INFO - PID 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:02:30 INFO - PID 1664 | 2017-04-08 15:02:30.705 plugin-container[1665:13744] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:02:40 INFO - PID 1664 | RSS: Main: 233562112 15:02:40 INFO - PID 1664 | 15:05:44 INFO - PID 1664 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49249/tests/dromaeo/cssquery-ext.html) 15:05:45 INFO - PID 1664 | RSS: Main: 251887616 15:05:45 INFO - PID 1664 | 15:07:28 INFO - PID 1664 | ************************* 15:07:28 INFO - PID 1664 | A coding exception was thrown and uncaught in a Task. 15:07:28 INFO - PID 1664 | 15:07:28 ERROR - PID 1664 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:07:28 INFO - PID 1664 | Full stack: 15:07:28 INFO - PID 1664 | ************************* 15:07:28 INFO - PID 1664 | ************************* 15:07:28 INFO - PID 1664 | A coding exception was thrown and uncaught in a Task. 15:07:28 INFO - PID 1664 | 15:07:28 ERROR - PID 1664 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:07:28 INFO - PID 1664 | Full stack: 15:07:28 INFO - PID 1664 | ************************* 15:07:28 INFO - PID 1664 | ************************* 15:07:28 INFO - PID 1664 | A coding exception was thrown and uncaught in a Task. 15:07:28 INFO - PID 1664 | 15:07:28 ERROR - PID 1664 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:07:28 INFO - PID 1664 | Full stack: 15:07:28 INFO - PID 1664 | ************************* 15:07:28 INFO - PID 1664 | ************************* 15:07:28 INFO - PID 1664 | A coding exception was thrown and uncaught in a Task. 15:07:28 INFO - PID 1664 | 15:07:28 ERROR - PID 1664 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:07:28 INFO - PID 1664 | Full stack: 15:07:28 INFO - PID 1664 | ************************* 15:08:47 INFO - PID 1664 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-ext.html (next: http://localhost:49249/tests/dromaeo/cssquery-jquery.html) 15:08:48 INFO - PID 1664 | RSS: Main: 262709248 15:08:48 INFO - PID 1664 | 15:11:50 INFO - PID 1664 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49249/tests/dromaeo/cssquery-mootools.html) 15:11:50 INFO - PID 1664 | RSS: Main: 275017728 15:11:50 INFO - PID 1664 | 15:14:52 INFO - PID 1664 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49249/tests/dromaeo/cssquery-prototype.html) 15:14:53 INFO - PID 1664 | RSS: Main: 267677696 15:14:53 INFO - PID 1664 | 15:17:56 INFO - PID 1664 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49249/tests/dromaeo/cssquery-yui.html) 15:17:56 INFO - PID 1664 | RSS: Main: 277491712 15:17:56 INFO - PID 1664 | 15:20:58 INFO - PID 1664 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-yui.html (next: http://localhost:49249/tests/dromaeo/cssquery-dojo.html) 15:20:59 INFO - PID 1664 | RSS: Main: 271167488 15:20:59 INFO - PID 1664 | 15:20:59 INFO - PID 1664 | __start_tp_report 15:20:59 INFO - PID 1664 | _x_x_mozilla_page_load 15:20:59 INFO - PID 1664 | _x_x_mozilla_page_load_details 15:20:59 INFO - PID 1664 | |i|pagename|runs| 15:20:59 INFO - PID 1664 | |0;dojo.html;3507.9824600877;3514.876979305723;3540.185757275828;3567.4470457079146;3573.0531409176574;6046.274447066347;6141.170941922839;6147.569670123094;6195.287541932679;6212.875742485147;4706.69406488578;6049.032154855224;6079.179310793042;6099.420555047274;6170.290416602092;4139.19285739281;5382.192671099347;5418.241446197536;5443.700596467193;5478;4375.299952007679;5335.759890804904;5377.4084850666395;5398.352197736277;5445.782168713246;5376.381716102659;5410.215518749759;5426.538744206747;5451.809186678467;5482.259894914196;5303;5346.117890548055;5378.596605254622;5405.702686352289;5416.91874621881;5326.067938110815;5329.946700532983;5354.598405119632;5363.865903352408;5373;5899.911501327483;6018.6689732064715;6134.969325153345;6138.9693051534905;6142.600730952474;6394.200724909387;6424.164858568403;6468.74125034998;6477.0608261802245;6488.578242414275;5184.222366645034;5468;6627.569208001464;6640.501962352843;6648;6307.621542707452;6310.747570097236;6313.337099604567;6322.787024541466;6338.778142764981;6513.2509761377105;6616.933830661728;6685.832854178684;6750.696218670171;6778.3221677831825;5130.692158470503;6356.713947872357;6418.390252925965;6442.098106265126;6454.677266136674;6116.8776624468155;6423.614583125028;6426.2931077581425;6542.411182993554;6628.204615446178;4886.486918873538;5100.719460429712;5323.574114070865;6453.257875344301;6502.057201705727;5334.226537152169;6288.402601752826;6464.838379040561;6465.1595292611655;6486.254080780771;5278.5249327560705;5293.814716484982;5309.840704778863;5311.229871668586;5353.732313384316;4688.835890743808;4693.55411235932;4702.459217190067;4704.153252414599;4715.693479923794;6072.149899014142;6141.731496609813;6186.443220110122;6254.9687251563455;6269.965455699758;6042.395760423922;6150.815475535741;6537;6560.737570497126;6588.703508342136;6264.561480696399;6280.2777680566405;6304.590201636879;6337.302896681362;6340.3342649022115;5680.261565996477;5733.483986441241;5741.483266506035;5749.367569567345;5831.329397119385;6642.070110184578;6736.494762892705;6749.763758268437;6757.3242675732035;6789.762358317435;6560.376764207393;6587.80236592903;6593.637349945799;6597.60414375139;6607.537472376887;5930.466258036625;6506.902396464152;6707.564008339442;6740;6757.189137303555;6387.648679322682;6452.709628066842;6492.091107245084;6522.05430212626;6546.869062618816;5327.573794096385;6469.676516174267;6477.708503117276;6484.157059582224;6486.318936511599;6280.748770049329;6312.116303717575;6316.778912738032;6352.428281454691;6381.425671689571;6303.558750887394;6344.206974128234;6347.5556711029785;6353.618782873043;6373.171487706569;6137.018077107641;6300.8658441480975;6348.301686814354;6358.586691865014;6363.300036996019;6314.526410519321;6332;6345.7144428499905;6354.936450635434;6371.13989611415;6278.623282603058;6317.4630156437215;6327.240731112296;6349.904751428825;6354.173957385695 15:20:59 INFO - PID 1664 | |1;ext.html;714.7819914925946;793.8888555602215;825.3067423364373;1269.688926213078;1273.6370134511667;36914.261714765686;38057.429138562875;38091.80954095226;38263.85208443748;38265;37866.86399408015;38222;38270.4259436108;38316.61683383166;38539.843804685835;7864.685412583504;8053.557054362008;8325.167483251687;8531.402801803877;8561.785955351135;8375.706850260241;8451.070382257947;8469.95765021177;8479.152084791502;8515.489070655749;8426.831463370729;8487.872681909776;8497.95751021244;8504.659813607479;8509.404341696083;7366.963165184166;7440.25597440257;7577.81055473612;8448.915510844874;8486.108958559385;8313.12712165226;8329.791755206108;8368.456050356708;8389.95805020971;8390.622421991025;37240.44139337912;37384.62615373866;37420;37432.81821045215;37511;3597.3344931187553;3614.4036234021355;3643.9635603644156;3652.9223878955772;3698.056995466166;30787;30817.845910770528;30892;30896.691033089606;30903.536446953312;3036.377542603761;3060.9540856887165;3067.9539806902912;3070.8003979741247;3073.1702440340982;208611;213870;243454;269777;271146.4426778673;47379.5262047382;47505;47525.76237118861;47529.5247047532;47764.52235477601;48608;48976.02047959092;49140.52578422653;49252.50747492551;49369.753151234734;14117.294135293194;14175.71648567023;14293.142411455347;14312.998090133591;14354;11677.88322116768;11713.355765432812;11773.293602383885;11784.057275417947;11796.46915888787;13210.603681889559;13330.866691333156;13340.933295333656;13347.399367028507;13412.597622071353;5849.151872978395;5894.17481552583;5918.615290006136;5928.762849486058;5934.7922822701;949.2927768812141;986.9605215791431;1036.5542816588938;1059.5338051257422;1087.798757229915;21933.232336868452;22122.115115395525;23069.88465057664;23620.173293934975;23970.640440393407;1123.6067376418189;1126.8704099028553;1129.7232178116415;1158.4207896051973;1167.9474423650956;8437.270359576272;10653.520591573399;12298.877011229952;12350.814737778941;12422.006239500999;303871;374493.2550674513;374558;374570;375227.7431677054;52762;52846;53041.7347913258;53067;53336.73331633394;1494.9103053816589;1495.7980672609276;1548.4657793061376;1551.8292987771335;1559.5399357189656;23664.053437862294;23819.880900595384;23965.76034239705;23971.400714981566;24008.51982960296;38363.616363836;38375.84872453831;38475.42286865755;38484.230315394096;38582.035449112875;319805.2126611763;322021;324951;325320;325570;33788.49317260194;33942;34096.48855267123;34808.12979675528;34970.650293497754;43463.9134021652;45645.31532026956;45833.312500313186;46033.539664602926;46037.53962460333;29396.853015734785;30232.84883575568;30530;30912.536311955788;31166;30242.84878575593;30456.695433045385;30766.53850192204;30963.91626293069;31045.844770776002;35360;36195.63804362028;36257.64325318846;36701.44947825732;36771.44842827306;25408;30201.546976795806;30565;31073.378532429677;31245.062648120595;21863.67204491902;22882.42793930165;23906.40233994164;24190;24192.63711044371 15:20:59 INFO - PID 1664 | |2;jquery.html;413.56782162640076;423.0244804941389;429.91186806704627;440.3856620015079;446.6248351384836;18373.632527349444;19988.001199880022;21315.68026479604;22424.990875410604;22442;21584.8920755396;23048.539029219406;23320.883395582998;23383.64924526129;23550.5289894202;6202.565820392586;6454.967725161391;6456.06387073874;6460.903086453707;6469.514786391016;6844.2129155147295;7201.459890508207;7243.89134162988;7264.237255088219;7273.018142550741;6924.23833378328;7160.534565253268;7212.495125341228;7226.132864056294;7230.023946767198;7009.614471204081;7248.6375681215995;7295.270472952662;7332.670029848643;7355.485116041906;7091.89362159568;7147.89278160828;7153.105861767279;7167.677454514559;7175.210726820045;29957.101286961428;30456;30460.93386731454;30566.84716576403;30943.91696290619;2223.5108276179217;2256.4810093678548;2350.6003979323386;2360.4098975256015;2375.2280508834697;18936.43190704281;18991.33530326446;19306.71039934402;19489.80510194894;19581.706274405897;2287.954240915189;2363.6690863279155;2366.136360228504;2371.359732872115;2379.1316169598144;114422.42788786003;147791.04820849263;156952;162451;164773.352266477;24005.51988960246;24954.5009099817;25693.74306256951;26457;26565.601515977276;42382.78808605937;42411.363829542584;43085.35371969423;43186.568134318884;43194;11297;11414.201005929504;11431.828522572168;11546;11657.30056196614;8774.612693653173;8826.382153249338;8958.10418958099;9110.86333704995;9156.267498600097;9541.618335266512;10611.893881061245;11032.834507482394;11748.060155187564;11843.763124737628;4154.750714957112;4845.2799256264225;4990.351254336913;5011.890249995042;5026.79892804291;961.4327546747453;961.4663861556763;971.8104969531015;989.5794287427815;1004.1866088468364;21517;21966.011529480893;22014.00936957841;22024;22024.339269821932;897.3763234552055;923.6397804856111;997.6209040564539;1023.9657945475124;1035.11497669493;10094.697159085239;10258.743531411625;10759.977802108788;11204.337418660965;11370.602028928948;711277;720986;730606;736788;737022;131720;144196;146898;155863;157576;1169.9649010529697;1172.2966220267942;1187.7565099154826;1188.964331070052;1195.9043276537857;18566.721499177795;19132.904335478233;19144.808551914302;19179;19189.232430702614;55355.44644553664;57516.71241643765;63904.68047659732;64812.67593662001;64940.35059649343;69886.65056674888;87480;88268;88919;89636;10083.798324033332;12578;13157.079004469595;13207.339633018119;13222.735545289233;13933.930330348283;14015.299235038412;14098.577042688325;14368.425262989782;14502.492412765503;10153.54309056109;11910.642680719593;12052;12254.816177757162;12333.260004399765;10360.326578772658;10809.945950270197;11036.448177591248;11105.611303604335;11349.602763903555;11109.944450277697;12049.216800907912;12263.202891812003;12423.62729118128;12434.067444941846;8669.91330086691;8784.956075219583;10519.368837869752;12704.745905081661;12883.484660613845;10630.946845265724;12060.698482537655;12112.576059837864;12280.815787763013;12320.199187052813 15:20:59 INFO - PID 1664 | |3;mootools.html;1350.6960933789899;1416.730821143982;1420.4176287722037;1433.4266293482613;1445.5446534341681;11502.884971150286;11677.649670509876;11895.583654572092;11912.64262072138;12153.392330383489;11707.063434925207;11768.235064720788;11942.940285298582;11950.282983021025;11951;2478.6901637295337;2526.1537384976054;2535.467551814121;2535.6307593899364;2542.377117606189;2448.608222684371;2480.9875950620312;2498.0632262901413;2528.8872895925824;2535.4295283561237;2457.606782914734;2502.737212592679;2510.698716154064;2513.2334637935423;2515.107136966378;2428.368624157723;2478.615814548748;2490.663760392342;2504.136073054793;2521.5713328733978;2416.8429052111733;2500.8749562521984;2503.7621425964503;2507.2352932355625;2539.2509209783157;11749.588764393206;11882.821757673642;11966.880331196664;11994.580189693406;12000;6545.280019197884;6744.123263975701;6773.221079575863;6784.491163162783;6787.762428314985;3952.486176797027;4174.791260436966;4197.496300443966;4235.915281694349;4257.701960862741;1213.5449206547544;1223.4861358229564;1225.307701148857;1269.3843485909326;1273.433322171634;14573.927130364385;15502.992305500107;16298.10360430176;16378.75431868511;16416.507504774876;5510.889782204334;5619.269494965628;5797.391273916262;5856.443637854397;5868.2664666916635;12342.506299748089;12388.56640017595;12413.627591172099;12446.564370246997;12470.937645311715;6437.485001199892;6477.481801455872;6542.6401547914365;6542.738290468423;6547.083408322838;6026.728797204137;6107.816765497042;6173.876522469525;6175.197224360804;6195.81412557624;4407.669424793154;4518.525554816697;4519;4554.521775213555;4562.996140849074;1283.4096315694699;1307.7123032932739;1309.8559158492558;1323.2589749740175;1325.1254172246272;786.8701664225339;788.4599049651007;809.6801763303462;819.0826274572516;832.063928080909;6006.331347125734;6053.182820319289;6228.781992630326;6252.570550779164;6273.12176295319;590.5895402695171;592.3247497852452;600.3396264109444;601.9247594050744;610.3713175429315;3530.894073177809;4195.098053918422;4268.338407546835;4275.315949448073;4350.521442641307;14829.036112652642;15471.071735695668;15474;15531.145786981824;15541.222938853238;14544.781828272584;15071;15401.306941187673;15418.614534636723;15429.45996890126;10624.521896514676;10820.837687434538;10856.78286434267;10864.619738309122;10904.563817447213;5516.724163791714;5556.861078473071;6357.7139028742895;6968.79093627192;7014.088168538057;12819;13273.269970151734;13479.3934272956;13646.044776865525;13669.863301366859;13690.726185476435;13737.519186828413;13776.242306672828;13883.791743124064;14069.507567235098;10602.09882160025;10667.51996160159;10763.461826908466;10825;10840.94579527129;10628.627998020032;10736.46317684097;10764.3541387517;10847.783044339227;10849;9043.32175086858;9137.451752894847;9203.504776991344;9258;9287.071292870929;8970.058143894797;8981.506017168856;8989.46063236208;9062.365634405529;9182.494962776844;8200.466969646954;8293.83412331738;8313.251807337369;8317.376196785144;8318.916810832055;5982.850428739316;6082.939170608237;6160.106784516131;6163.660998645118;6195.659238741912;5852.502537284378;6049.364816694359;6180.072989051679;6290.591111577916;6326.683665816783 15:20:59 INFO - PID 1664 | |4;prototype.html;345.22669220945085;396.6251891962097;398.565563535746;410.6037673644932;415.56158253043037;5751.597388182829;5933.940660593398;6093;6094.481969032638;6251.843703907404;4775.8806029849275;5131.871703207422;5970.34326224115;6028.246469191351;6065.909011364833;4307.203167414023;4449.265871131276;4449.532799056101;4484.349769283452;4496.235639941209;4262.424572682695;4410.64714822815;4460.933086003713;4462.553744625544;4493.887652808689;4430.158269928719;4436.157130145262;4445.977770111145;4452.398926144978;4494.325851122325;3503;4232.492100947875;4413.337999300131;4458.933116003279;4481.574250446202;3824.521934758155;3832.405977073558;3833.7731925783482;3846.307664620367;3853.653171214576;4776.880577985544;5876.647401155944;5901.203337549418;5918.537655471554;5921.141434491975;3931.5085614298214;5242.423333433319;5290.709011004393;5301.496357845998;5351.277577527062;5490.80782172622;6277.748890044393;6284.905726414107;6447.677616119222;6449.322821103763;3641.5266015417824;3745.4569087482437;4330.437043184366;4346.6522678185665;4354.586314300168;5837.387074357174;6283.994560870285;6453.806385808433;6599;6993.335633114846;4224.7253928495165;4410.184115938561;4426.712263702849;4436.26801577736;4461.7992190351515;4459.420275364247;4473.261911784519;4480.775961201992;4489.595936365743;4499.460064792246;5008.974955125274;5255.789768409298;5283.418823929364;5342.061865973777;5342.385625653022;6518.28298887122;6520.510961677893;6527.3472652734345;6553.148090748172;6600.930567286235;1437.8705916467359;1512.3194562446943;1532.524917275648;1538.9153596552296;1542.8302886682457;875.711015364928;904.9954550448996;921.4010892919522;953.5565961827783;969.2488321550713;5874.559408044413;6178.907316390258;6216.378362163748;6226.40849119333;6234.2830574484515;5281.894362112736;6656.500762442836;6660.533762636569;6668.499862510331;6716.0113749382035;5429.077056900336;6077.392260773887;6078.696065196723;6148.661823599656;6178.7219575119225;2761.7100204478243;3478.4086705260165;3485.7734247273847;3489.668481494254;3508.9122771930397;5724.856878578069;6462.868997925344;6787.355201255873;6792.898106528406;6834.726610935606;5583.860403489864;6717.294684058202;6800.353966373186;6807.081044059088;6826.556273842184;5776.393478684678;5969.582129250911;6496.6426846522945;6598.340165983459;6846.828829279209;5846.473817356458;6402.815479136375;6406.391392817675;6746.460283177432;6760.763373281911;5363.0882749931825;6062.272527296753;6543.345665433419;6565.638889861103;6625.337466253336;6866.690998904961;6898.137273031836;6908.930910690829;6924.169099708067;7008.439324854102;4166.541680415091;4281.379200015918;4299.398084268268;4313.352997050342;4327.697061205811;6176;6549.836254093686;6601.636909969806;6620.867582648417;6667.566608170453;4981.626378021735;5683.460071293221;5856.765729370777;5947.851303717442;6374;6320.62076275425;6385.87228255423;6418.454431373386;6420.839479013062;6423.0863389507995;4665.906681866411;5549.694766787866;6035.336113027475;6321.1782468278825;6354.3963323484195;5928.822135335947;6397.456216221487;6415.743370265323;6423.775167869102;6447.290798012309;5651.463111004448;5687.033204355353;6247.187865577446;6272.905906411499;6293.496520278458 15:20:59 INFO - PID 1664 | |5;yui.html;818.9508629482228;819.4591569564088;840.3907167303705;861.8279140369096;867.8611422172454;14000.369983350749;14603.123812571253;16300;16727.749083763752;16739.665206695874;16618.418355357564;16957.745633815473;17301.480955571355;17322.393716219936;17323.740143897852;985.1281615770024;993.7217579077869;1009.3136667066392;1012.9696109116701;1016.0905989139716;992.5087081894472;1009.217856161477;1010.1767059846238;1010.4240582867768;1016.7204018894789;1076.860008198933;1082.9891701083006;1089.2375337263907;1090.8145615245428;1091.0562363555507;1057.4395570347729;1080.0009990758595;1080.481368942904;1081.291753901196;1081.7025318037524;791.7070683846956;801.9238172373615;803.634346372405;803.8271771569141;805.3798575097201;16770.832291677172;16854.66290674192;17031.14844257782;17076.146192690318;17112.657746845118;16892.324307027706;17155.742663860052;17376.391826286144;17531.211095500734;17542.824571754245;13919.58241252754;13920.37358318878;13925.651858703613;14079.507217247346;14249.216293103875;3524.859005639771;3538.5399898013093;3560.4334092998997;3560.839762210707;3561.28774245152;117229.41385293104;118603.40698296539;118700.40649796696;119438;122024;12023.458944347525;13141.408636611375;13178.341082946006;13218.867811321956;13382.197068175941;24690.876545617157;24929.252122436355;25674.101406450685;25925.740742592334;26017.73982260191;7392.852142957111;7671.578063206465;8534.103919088531;8847.778805529784;8892.911070889339;4804.159272127364;4865.318855360252;4876.804927802919;4917.9016419672125;4927.655064145547;4258.68059895509;4388.956110438919;4422;4423.203823311835;4432.734035957853;866.4931015355961;891.9554022298859;898.2140626951417;900.0819164452353;902.0258121229057;636.2587585462976;648.1088503307951;651.9804405867832;657.4510283912987;688.7899190746871;11405.600803971822;11592.594259200887;11815.468303926344;11839.822402663967;11858.110641701734;651.0754728285846;655.308649374914;662.8409181796334;669.2003056347716;685.7085738561092;4391.385206071152;5441.863953401196;5495.560355171577;5605.7197140142825;5607.158926161109;94720.57919131081;98313;99721;101463;102131.97868021224;83498;83597.58201208955;83691;84266;84356;76778.23221767711;78722.6063869677;78742.60628696934;79389.20610793933;80094;9066.22937050358;10853.565857365616;11268.943655281671;11287;11315.472411224378;39456;40098.79703608897;40396.79801601091;40852.387214191214;41069.38395924004;52645.7367713159;53473.197902032276;53718.194227087406;53730.85076596892;54218.91562168813;14048.719025619226;16111.516654500383;16865.07242101696;16905.91547042257;16953.576160596083;15428.382864685736;16997.405090822256;18131;18251.908740456212;18617.720734189268;16482.75275870887;16904.15479226009;17000.914995424944;17178.828211717722;17277.481675549752;16350.509484715478;16450.259738311564;16980;17057.232424540678;17181.656366872343;15900.68198636044;16058.839411605735;16284.267207975432;16324.102174380523;16412.17939103016;10834.295770774874;11029.558817647205;11296.887031129583;11324.773504530029;11776;10595;12641.304728240035;12723.618291451272;12746.10987615088;12796.680082998 15:20:59 INFO - PID 1664 | __end_tp_report 15:20:59 INFO - PID 1664 | __start_cc_report 15:20:59 INFO - PID 1664 | _x_x_mozilla_cycle_collect,421 15:20:59 INFO - PID 1664 | __end_cc_report 15:20:59 INFO - PID 1664 | __startTimestamp1491690059050__endTimestamp 15:20:59 INFO - PID 1664 | 15:20:59 INFO - PID 1664 | ------- Summary: start ------- 15:20:59 INFO - PID 1664 | Number of tests: 6 15:20:59 INFO - PID 1664 | 15:20:59 INFO - PID 1664 | [#0] dojo.html Cycles:165 Average:5967.76 Median:6288.40 stddev:714.57 (11.4%) stddev-sans-first:690.21 15:20:59 INFO - PID 1664 | Values: 3508.0 3514.9 3540.2 3567.4 3573.1 6046.3 6141.2 6147.6 6195.3 6212.9 4706.7 6049.0 6079.2 6099.4 6170.3 4139.2 5382.2 5418.2 5443.7 5478.0 4375.3 5335.8 5377.4 5398.4 5445.8 5376.4 5410.2 5426.5 5451.8 5482.3 5303.0 5346.1 5378.6 5405.7 5416.9 5326.1 5329.9 5354.6 5363.9 5373.0 5899.9 6018.7 6135.0 6139.0 6142.6 6394.2 6424.2 6468.7 6477.1 6488.6 5184.2 5468.0 6627.6 6640.5 6648.0 6307.6 6310.7 6313.3 6322.8 6338.8 6513.3 6616.9 6685.8 6750.7 6778.3 5130.7 6356.7 6418.4 6442.1 6454.7 6116.9 6423.6 6426.3 6542.4 6628.2 4886.5 5100.7 5323.6 6453.3 6502.1 5334.2 6288.4 6464.8 6465.2 6486.3 5278.5 5293.8 5309.8 5311.2 5353.7 4688.8 4693.6 4702.5 4704.2 4715.7 6072.1 6141.7 6186.4 6255.0 6270.0 6042.4 6150.8 6537.0 6560.7 6588.7 6264.6 6280.3 6304.6 6337.3 6340.3 5680.3 5733.5 5741.5 5749.4 5831.3 6642.1 6736.5 6749.8 6757.3 6789.8 6560.4 6587.8 6593.6 6597.6 6607.5 5930.5 6506.9 6707.6 6740.0 6757.2 6387.6 6452.7 6492.1 6522.1 6546.9 5327.6 6469.7 6477.7 6484.2 6486.3 6280.7 6312.1 6316.8 6352.4 6381.4 6303.6 6344.2 6347.6 6353.6 6373.2 6137.0 6300.9 6348.3 6358.6 6363.3 6314.5 6332.0 6345.7 6354.9 6371.1 6278.6 6317.5 6327.2 6349.9 6354.2 15:20:59 INFO - PID 1664 | 15:20:59 INFO - PID 1664 | [#1] ext.html Cycles:180 Average:45674.36 Median:19478.67 stddev:82482.39 (423.4%) stddev-sans-first:82644.70 15:20:59 INFO - PID 1664 | Values: 714.8 793.9 825.3 1269.7 1273.6 36914.3 38057.4 38091.8 38263.9 38265.0 37866.9 38222.0 38270.4 38316.6 38539.8 7864.7 8053.6 8325.2 8531.4 8561.8 8375.7 8451.1 8470.0 8479.2 8515.5 8426.8 8487.9 8498.0 8504.7 8509.4 7367.0 7440.3 7577.8 8448.9 8486.1 8313.1 8329.8 8368.5 8390.0 8390.6 37240.4 37384.6 37420.0 37432.8 37511.0 3597.3 3614.4 3644.0 3652.9 3698.1 30787.0 30817.8 30892.0 30896.7 30903.5 3036.4 3061.0 3068.0 3070.8 3073.2 208611.0 213870.0 243454.0 269777.0 271146.4 47379.5 47505.0 47525.8 47529.5 47764.5 48608.0 48976.0 49140.5 49252.5 49369.8 14117.3 14175.7 14293.1 14313.0 14354.0 11677.9 11713.4 11773.3 11784.1 11796.5 13210.6 13330.9 13340.9 13347.4 13412.6 5849.2 5894.2 5918.6 5928.8 5934.8 949.3 987.0 1036.6 1059.5 1087.8 21933.2 22122.1 23069.9 23620.2 23970.6 1123.6 1126.9 1129.7 1158.4 1167.9 8437.3 10653.5 12298.9 12350.8 12422.0 303871.0 374493.3 374558.0 374570.0 375227.7 52762.0 52846.0 53041.7 53067.0 53336.7 1494.9 1495.8 1548.5 1551.8 1559.5 23664.1 23819.9 23965.8 23971.4 24008.5 38363.6 38375.8 38475.4 38484.2 38582.0 319805.2 322021.0 324951.0 325320.0 325570.0 33788.5 33942.0 34096.5 34808.1 34970.7 43463.9 45645.3 45833.3 46033.5 46037.5 29396.9 30232.8 30530.0 30912.5 31166.0 30242.8 30456.7 30766.5 30963.9 31045.8 35360.0 36195.6 36257.6 36701.4 36771.4 25408.0 30201.5 30565.0 31073.4 31245.1 21863.7 22882.4 23906.4 24190.0 24192.6 15:20:59 INFO - PID 1664 | 15:20:59 INFO - PID 1664 | [#2] jquery.html Cycles:180 Average:42978.22 Median:23352.27 stddev:121143.65 (518.8%) stddev-sans-first:121441.33 15:20:59 INFO - PID 1664 | Values: 413.6 423.0 429.9 440.4 446.6 18373.6 19988.0 21315.7 22425.0 22442.0 21584.9 23048.5 23320.9 23383.6 23550.5 6202.6 6455.0 6456.1 6460.9 6469.5 6844.2 7201.5 7243.9 7264.2 7273.0 6924.2 7160.5 7212.5 7226.1 7230.0 7009.6 7248.6 7295.3 7332.7 7355.5 7091.9 7147.9 7153.1 7167.7 7175.2 29957.1 30456.0 30460.9 30566.8 30943.9 2223.5 2256.5 2350.6 2360.4 2375.2 18936.4 18991.3 19306.7 19489.8 19581.7 2288.0 2363.7 2366.1 2371.4 2379.1 114422.4 147791.0 156952.0 162451.0 164773.4 24005.5 24954.5 25693.7 26457.0 26565.6 42382.8 42411.4 43085.4 43186.6 43194.0 11297.0 11414.2 11431.8 11546.0 11657.3 8774.6 8826.4 8958.1 9110.9 9156.3 9541.6 10611.9 11032.8 11748.1 11843.8 4154.8 4845.3 4990.4 5011.9 5026.8 961.4 961.5 971.8 989.6 1004.2 21517.0 21966.0 22014.0 22024.0 22024.3 897.4 923.6 997.6 1024.0 1035.1 10094.7 10258.7 10760.0 11204.3 11370.6 711277.0 720986.0 730606.0 736788.0 737022.0 131720.0 144196.0 146898.0 155863.0 157576.0 1170.0 1172.3 1187.8 1189.0 1195.9 18566.7 19132.9 19144.8 19179.0 19189.2 55355.4 57516.7 63904.7 64812.7 64940.4 69886.7 87480.0 88268.0 88919.0 89636.0 10083.8 12578.0 13157.1 13207.3 13222.7 13933.9 14015.3 14098.6 14368.4 14502.5 10153.5 11910.6 12052.0 12254.8 12333.3 10360.3 10809.9 11036.4 11105.6 11349.6 11109.9 12049.2 12263.2 12423.6 12434.1 8669.9 8785.0 10519.4 12704.7 12883.5 10630.9 12060.7 12112.6 12280.8 12320.2 15:20:59 INFO - PID 1664 | 15:20:59 INFO - PID 1664 | [#3] mootools.html Cycles:180 Average:7247.68 Median:2514.17 stddev:4609.21 (183.3%) stddev-sans-first:4600.84 15:20:59 INFO - PID 1664 | Values: 1350.7 1416.7 1420.4 1433.4 1445.5 11502.9 11677.6 11895.6 11912.6 12153.4 11707.1 11768.2 11942.9 11950.3 11951.0 2478.7 2526.2 2535.5 2535.6 2542.4 2448.6 2481.0 2498.1 2528.9 2535.4 2457.6 2502.7 2510.7 2513.2 2515.1 2428.4 2478.6 2490.7 2504.1 2521.6 2416.8 2500.9 2503.8 2507.2 2539.3 11749.6 11882.8 11966.9 11994.6 12000.0 6545.3 6744.1 6773.2 6784.5 6787.8 3952.5 4174.8 4197.5 4235.9 4257.7 1213.5 1223.5 1225.3 1269.4 1273.4 14573.9 15503.0 16298.1 16378.8 16416.5 5510.9 5619.3 5797.4 5856.4 5868.3 12342.5 12388.6 12413.6 12446.6 12470.9 6437.5 6477.5 6542.6 6542.7 6547.1 6026.7 6107.8 6173.9 6175.2 6195.8 4407.7 4518.5 4519.0 4554.5 4563.0 1283.4 1307.7 1309.9 1323.3 1325.1 786.9 788.5 809.7 819.1 832.1 6006.3 6053.2 6228.8 6252.6 6273.1 590.6 592.3 600.3 601.9 610.4 3530.9 4195.1 4268.3 4275.3 4350.5 14829.0 15471.1 15474.0 15531.1 15541.2 14544.8 15071.0 15401.3 15418.6 15429.5 10624.5 10820.8 10856.8 10864.6 10904.6 5516.7 5556.9 6357.7 6968.8 7014.1 12819.0 13273.3 13479.4 13646.0 13669.9 13690.7 13737.5 13776.2 13883.8 14069.5 10602.1 10667.5 10763.5 10825.0 10840.9 10628.6 10736.5 10764.4 10847.8 10849.0 9043.3 9137.5 9203.5 9258.0 9287.1 8970.1 8981.5 8989.5 9062.4 9182.5 8200.5 8293.8 8313.3 8317.4 8318.9 5982.9 6082.9 6160.1 6163.7 6195.7 5852.5 6049.4 6180.1 6290.6 6326.7 15:20:59 INFO - PID 1664 | 15:20:59 INFO - PID 1664 | [#4] prototype.html Cycles:180 Average:5162.48 Median:5875.60 stddev:1622.82 (27.6%) stddev-sans-first:1586.58 15:20:59 INFO - PID 1664 | Values: 345.2 396.6 398.6 410.6 415.6 5751.6 5933.9 6093.0 6094.5 6251.8 4775.9 5131.9 5970.3 6028.2 6065.9 4307.2 4449.3 4449.5 4484.3 4496.2 4262.4 4410.6 4460.9 4462.6 4493.9 4430.2 4436.2 4446.0 4452.4 4494.3 3503.0 4232.5 4413.3 4458.9 4481.6 3824.5 3832.4 3833.8 3846.3 3853.7 4776.9 5876.6 5901.2 5918.5 5921.1 3931.5 5242.4 5290.7 5301.5 5351.3 5490.8 6277.7 6284.9 6447.7 6449.3 3641.5 3745.5 4330.4 4346.7 4354.6 5837.4 6284.0 6453.8 6599.0 6993.3 4224.7 4410.2 4426.7 4436.3 4461.8 4459.4 4473.3 4480.8 4489.6 4499.5 5009.0 5255.8 5283.4 5342.1 5342.4 6518.3 6520.5 6527.3 6553.1 6600.9 1437.9 1512.3 1532.5 1538.9 1542.8 875.7 905.0 921.4 953.6 969.2 5874.6 6178.9 6216.4 6226.4 6234.3 5281.9 6656.5 6660.5 6668.5 6716.0 5429.1 6077.4 6078.7 6148.7 6178.7 2761.7 3478.4 3485.8 3489.7 3508.9 5724.9 6462.9 6787.4 6792.9 6834.7 5583.9 6717.3 6800.4 6807.1 6826.6 5776.4 5969.6 6496.6 6598.3 6846.8 5846.5 6402.8 6406.4 6746.5 6760.8 5363.1 6062.3 6543.3 6565.6 6625.3 6866.7 6898.1 6908.9 6924.2 7008.4 4166.5 4281.4 4299.4 4313.4 4327.7 6176.0 6549.8 6601.6 6620.9 6667.6 4981.6 5683.5 5856.8 5947.9 6374.0 6320.6 6385.9 6418.5 6420.8 6423.1 4665.9 5549.7 6035.3 6321.2 6354.4 5928.8 6397.5 6415.7 6423.8 6447.3 5651.5 5687.0 6247.2 6272.9 6293.5 15:20:59 INFO - PID 1664 | 15:20:59 INFO - PID 1664 | [#5] yui.html Cycles:180 Average:21072.06 Median:17323.07 stddev:28977.07 (167.3%) stddev-sans-first:29018.45 15:20:59 INFO - PID 1664 | Values: 819.0 819.5 840.4 861.8 867.9 14000.4 14603.1 16300.0 16727.7 16739.7 16618.4 16957.7 17301.5 17322.4 17323.7 985.1 993.7 1009.3 1013.0 1016.1 992.5 1009.2 1010.2 1010.4 1016.7 1076.9 1083.0 1089.2 1090.8 1091.1 1057.4 1080.0 1080.5 1081.3 1081.7 791.7 801.9 803.6 803.8 805.4 16770.8 16854.7 17031.1 17076.1 17112.7 16892.3 17155.7 17376.4 17531.2 17542.8 13919.6 13920.4 13925.7 14079.5 14249.2 3524.9 3538.5 3560.4 3560.8 3561.3 117229.4 118603.4 118700.4 119438.0 122024.0 12023.5 13141.4 13178.3 13218.9 13382.2 24690.9 24929.3 25674.1 25925.7 26017.7 7392.9 7671.6 8534.1 8847.8 8892.9 4804.2 4865.3 4876.8 4917.9 4927.7 4258.7 4389.0 4422.0 4423.2 4432.7 866.5 892.0 898.2 900.1 902.0 636.3 648.1 652.0 657.5 688.8 11405.6 11592.6 11815.5 11839.8 11858.1 651.1 655.3 662.8 669.2 685.7 4391.4 5441.9 5495.6 5605.7 5607.2 94720.6 98313.0 99721.0 101463.0 102132.0 83498.0 83597.6 83691.0 84266.0 84356.0 76778.2 78722.6 78742.6 79389.2 80094.0 9066.2 10853.6 11268.9 11287.0 11315.5 39456.0 40098.8 40396.8 40852.4 41069.4 52645.7 53473.2 53718.2 53730.9 54218.9 14048.7 16111.5 16865.1 16905.9 16953.6 15428.4 16997.4 18131.0 18251.9 18617.7 16482.8 16904.2 17000.9 17178.8 17277.5 16350.5 16450.3 16980.0 17057.2 17181.7 15900.7 16058.8 16284.3 16324.1 16412.2 10834.3 11029.6 11296.9 11324.8 11776.0 10595.0 12641.3 12723.6 12746.1 12796.7 15:20:59 INFO - PID 1664 | -------- Summary: end -------- 15:20:59 INFO - PID 1664 | 15:20:59 INFO - TEST-INFO | 1664: exit 0 15:20:59 INFO - TEST-OK | dromaeo_css | took 1115735ms 15:20:59 INFO - TEST-START | kraken 15:20:59 INFO - operating with platform_type : mac_ 15:20:59 INFO - Initialising browser for kraken test... 15:20:59 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/tmpUEB7YU/profile http://localhost:49249/getInfo.html) 15:21:02 INFO - PID 1671 | 2017-04-08 15:21:02.465 plugin-container[1672:15978] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8937, name = 'com.apple.tsm.portname' 15:21:02 INFO - PID 1671 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:21:02 INFO - PID 1671 | 2017-04-08 15:21:02.468 plugin-container[1672:15978] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 15:21:02 INFO - PID 1671 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:21:02 INFO - PID 1671 | 2017-04-08 15:21:02.468 plugin-container[1672:15978] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:21:02 INFO - PID 1671 | __metrics Screen width/height:1600/1200 15:21:02 INFO - PID 1671 | colorDepth:24 15:21:02 INFO - PID 1671 | Browser inner width/height: 1024/689 15:21:02 INFO - PID 1671 | __metrics 15:21:02 ERROR - PID 1671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 15:21:03 INFO - TEST-INFO | 1671: exit 0 15:21:03 INFO - Browser initialized. 15:21:03 INFO - Running cycle 1/1 for kraken test... 15:21:03 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/tmpUEB7YU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:21:06 INFO - PID 1673 | 2017-04-08 15:21:06.350 plugin-container[1674:16101] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x474f, name = 'com.apple.tsm.portname' 15:21:06 INFO - PID 1673 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:21:06 INFO - PID 1673 | 2017-04-08 15:21:06.351 plugin-container[1674:16101] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x441f, name = 'com.apple.CFPasteboardClient' 15:21:06 INFO - PID 1673 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:21:06 INFO - PID 1673 | 2017-04-08 15:21:06.351 plugin-container[1674:16101] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:21:16 INFO - PID 1673 | RSS: Main: 233345024 15:21:16 INFO - PID 1673 | 15:21:19 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection) 15:21:20 INFO - PID 1673 | RSS: Main: 248520704 15:21:20 INFO - PID 1673 | 15:21:22 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-dft) 15:21:23 INFO - PID 1673 | RSS: Main: 257064960 15:21:23 INFO - PID 1673 | 15:21:27 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-fft) 15:21:27 INFO - PID 1673 | RSS: Main: 259334144 15:21:27 INFO - PID 1673 | 15:21:29 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator) 15:21:30 INFO - PID 1673 | RSS: Main: 260268032 15:21:30 INFO - PID 1673 | 15:21:32 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:21:33 INFO - PID 1673 | RSS: Main: 261922816 15:21:33 INFO - PID 1673 | 15:21:36 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom) 15:21:37 INFO - PID 1673 | RSS: Main: 267960320 15:21:37 INFO - PID 1673 | 15:21:40 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate) 15:21:41 INFO - PID 1673 | RSS: Main: 267837440 15:21:41 INFO - PID 1673 | 15:21:44 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial) 15:21:45 INFO - PID 1673 | RSS: Main: 267567104 15:21:45 INFO - PID 1673 | 15:21:46 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:21:47 INFO - PID 1673 | RSS: Main: 267542528 15:21:47 INFO - PID 1673 | 15:21:49 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:21:49 INFO - PID 1673 | RSS: Main: 267587584 15:21:49 INFO - PID 1673 | 15:21:52 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:21:52 INFO - PID 1673 | RSS: Main: 267776000 15:21:52 INFO - PID 1673 | 15:21:55 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:21:56 INFO - PID 1673 | RSS: Main: 268312576 15:21:56 INFO - PID 1673 | 15:22:00 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:22:00 INFO - PID 1673 | RSS: Main: 265060352 15:22:00 INFO - PID 1673 | 15:22:02 INFO - PID 1673 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49249/tests/kraken/driver.html?testName=ai-astar) 15:22:02 INFO - PID 1673 | RSS: Main: 268156928 15:22:02 INFO - PID 1673 | 15:22:02 INFO - PID 1673 | __start_tp_report 15:22:02 INFO - PID 1673 | _x_x_mozilla_page_load 15:22:02 INFO - PID 1673 | _x_x_mozilla_page_load_details 15:22:02 INFO - PID 1673 | |i|pagename|runs| 15:22:02 INFO - PID 1673 | |0;ai-astar;108;121;101;188;105;181;184;163;120;122 15:22:02 INFO - PID 1673 | |1;audio-beat-detection;148;120;117;161;155;164;121;150;177;165 15:22:02 INFO - PID 1673 | |2;audio-dft;221;218;219;233;214;206;214;215;210;212 15:22:02 INFO - PID 1673 | |3;audio-fft;90;59;59;88;68;89;95;80;75;58 15:22:02 INFO - PID 1673 | |4;audio-oscillator;103;109;113;72;73;95;127;107;75;88 15:22:02 INFO - PID 1673 | |5;imaging-gaussian-blur;94;135;92;98;88;141;143;92;93;92 15:22:02 INFO - PID 1673 | |6;imaging-darkroom;101;102;99;113;106;125;152;164;122;100 15:22:02 INFO - PID 1673 | |7;imaging-desaturate;109;130;105;110;155;123;107;103;156;115 15:22:02 INFO - PID 1673 | |8;json-parse-financial;52;52;52;53;53;55;52;52;54;56 15:22:02 INFO - PID 1673 | |9;json-stringify-tinderbox;59;64;58;67;60;59;59;57;59;57 15:22:02 INFO - PID 1673 | |10;stanford-crypto-aes;88;88;89;79;109;117;77;102;79;118 15:22:02 INFO - PID 1673 | |11;stanford-crypto-ccm;149;146;146;158;138;172;173;134;227;185 15:22:02 INFO - PID 1673 | |12;stanford-crypto-pbkdf2;199;196;229;243;260;261;191;197;194;195 15:22:02 INFO - PID 1673 | |13;stanford-crypto-sha256-iterative;70;71;72;70;70;69;85;85;63;92 15:22:02 INFO - PID 1673 | __end_tp_report 15:22:02 INFO - PID 1673 | __start_cc_report 15:22:02 INFO - PID 1673 | _x_x_mozilla_cycle_collect,1020 15:22:02 INFO - PID 1673 | __end_cc_report 15:22:02 INFO - PID 1673 | __startTimestamp1491690122756__endTimestamp 15:22:02 INFO - PID 1673 | 15:22:02 INFO - PID 1673 | ------- Summary: start ------- 15:22:02 INFO - PID 1673 | Number of tests: 14 15:22:02 INFO - PID 1673 | 15:22:02 INFO - PID 1673 | [#0] ai-astar Cycles:10 Average:139.30 Median:142.50 stddev:35.43 (24.9%) stddev-sans-first:35.73 15:22:02 INFO - PID 1673 | Values: 108.0 121.0 101.0 188.0 105.0 181.0 184.0 163.0 120.0 122.0 15:22:02 INFO - PID 1673 | 15:22:02 INFO - PID 1673 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:158.00 stddev:21.30 (13.5%) stddev-sans-first:22.59 15:22:02 INFO - PID 1673 | Values: 148.0 120.0 117.0 161.0 155.0 164.0 121.0 150.0 177.0 165.0 15:22:02 INFO - PID 1673 | 15:22:02 INFO - PID 1673 | [#2] audio-dft Cycles:10 Average:216.20 Median:216.50 stddev:7.36 (3.4%) stddev-sans-first:7.60 15:22:02 INFO - PID 1673 | Values: 221.0 218.0 219.0 233.0 214.0 206.0 214.0 215.0 210.0 212.0 15:22:02 INFO - PID 1673 | 15:22:02 INFO - PID 1673 | [#3] audio-fft Cycles:10 Average:76.10 Median:84.00 stddev:14.35 (17.1%) stddev-sans-first:14.31 15:22:02 INFO - PID 1673 | Values: 90.0 59.0 59.0 88.0 68.0 89.0 95.0 80.0 75.0 58.0 15:22:02 INFO - PID 1673 | 15:22:02 INFO - PID 1673 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:72.50 stddev:18.86 (26.0%) stddev-sans-first:19.84 15:22:02 INFO - PID 1673 | Values: 103.0 109.0 113.0 72.0 73.0 95.0 127.0 107.0 75.0 88.0 15:22:02 INFO - PID 1673 | 15:22:02 INFO - PID 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:106.80 Median:92.00 stddev:22.89 (24.9%) stddev-sans-first:23.81 15:22:02 INFO - PID 1673 | Values: 94.0 135.0 92.0 98.0 88.0 141.0 143.0 92.0 93.0 92.0 15:22:02 INFO - PID 1673 | 15:22:02 INFO - PID 1673 | [#6] imaging-darkroom Cycles:10 Average:118.40 Median:123.50 stddev:22.94 (18.6%) stddev-sans-first:23.45 15:22:02 INFO - PID 1673 | Values: 101.0 102.0 99.0 113.0 106.0 125.0 152.0 164.0 122.0 100.0 15:22:02 INFO - PID 1673 | 15:22:02 INFO - PID 1673 | [#7] imaging-desaturate Cycles:10 Average:121.30 Median:119.00 stddev:19.84 (16.7%) stddev-sans-first:20.54 15:22:02 INFO - PID 1673 | Values: 109.0 130.0 105.0 110.0 155.0 123.0 107.0 103.0 156.0 115.0 15:22:02 INFO - PID 1673 | 15:22:02 INFO - PID 1673 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:1.45 (2.7%) stddev-sans-first:1.48 15:22:02 INFO - PID 1673 | Values: 52.0 52.0 52.0 53.0 53.0 55.0 52.0 52.0 54.0 56.0 15:22:02 INFO - PID 1673 | 15:22:02 INFO - PID 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:59.00 stddev:3.18 (5.4%) stddev-sans-first:3.35 15:22:02 INFO - PID 1673 | Values: 59.0 64.0 58.0 67.0 60.0 59.0 59.0 57.0 59.0 57.0 15:22:02 INFO - PID 1673 | 15:22:02 INFO - PID 1673 | [#10] stanford-crypto-aes Cycles:10 Average:94.60 Median:79.00 stddev:15.73 (19.9%) stddev-sans-first:16.50 15:22:02 INFO - PID 1673 | Values: 88.0 88.0 89.0 79.0 109.0 117.0 77.0 102.0 79.0 118.0 15:22:02 INFO - PID 1673 | 15:22:02 INFO - PID 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:162.80 Median:165.00 stddev:27.94 (16.9%) stddev-sans-first:29.18 15:22:02 INFO - PID 1673 | Values: 149.0 146.0 146.0 158.0 138.0 172.0 173.0 134.0 227.0 185.0 15:22:02 INFO - PID 1673 | 15:22:02 INFO - PID 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:216.50 Median:214.00 stddev:28.78 (13.5%) stddev-sans-first:29.82 15:22:02 INFO - PID 1673 | Values: 199.0 196.0 229.0 243.0 260.0 261.0 191.0 197.0 194.0 195.0 15:22:02 INFO - PID 1673 | 15:22:02 INFO - PID 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.70 Median:71.50 stddev:9.24 (12.9%) stddev-sans-first:9.64 15:22:02 INFO - PID 1673 | Values: 70.0 71.0 72.0 70.0 70.0 69.0 85.0 85.0 63.0 92.0 15:22:02 INFO - PID 1673 | -------- Summary: end -------- 15:22:02 INFO - PID 1673 | 15:22:03 INFO - TEST-INFO | 1673: exit 0 15:22:03 INFO - TEST-OK | kraken | took 64174ms 15:22:03 INFO - SUITE-END | took 1179s 15:22:03 INFO - Completed test suite (00:19:39) 15:22:03 INFO - javascript benchmark 15:22:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8001.641369578892, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3507.9824600877, 3514.876979305723, 3540.185757275828, 3567.4470457079146, 3573.0531409176574, 6046.274447066347, 6141.170941922839, 6147.569670123094, 6195.287541932679, 6212.875742485147, 4706.69406488578, 6049.032154855224, 6079.179310793042, 6099.420555047274, 6170.290416602092, 4139.19285739281, 5382.192671099347, 5418.241446197536, 5443.700596467193, 5478.0, 4375.299952007679, 5335.759890804904, 5377.4084850666395, 5398.352197736277, 5445.782168713246, 5376.381716102659, 5410.215518749759, 5426.538744206747, 5451.809186678467, 5482.259894914196, 5303.0, 5346.117890548055, 5378.596605254622, 5405.702686352289, 5416.91874621881, 5326.067938110815, 5329.946700532983, 5354.598405119632, 5363.865903352408, 5373.0, 5899.911501327483, 6018.6689732064715, 6134.969325153345, 6138.9693051534905, 6142.600730952474, 6394.200724909387, 6424.164858568403, 6468.74125034998, 6477.0608261802245, 6488.578242414275, 5184.222366645034, 5468.0, 6627.569208001464, 6640.501962352843, 6648.0, 6307.621542707452, 6310.747570097236, 6313.337099604567, 6322.787024541466, 6338.778142764981, 6513.2509761377105, 6616.933830661728, 6685.832854178684, 6750.696218670171, 6778.3221677831825, 5130.692158470503, 6356.713947872357, 6418.390252925965, 6442.098106265126, 6454.677266136674, 6116.8776624468155, 6423.614583125028, 6426.2931077581425, 6542.411182993554, 6628.204615446178, 4886.486918873538, 5100.719460429712, 5323.574114070865, 6453.257875344301, 6502.057201705727, 5334.226537152169, 6288.402601752826, 6464.838379040561, 6465.1595292611655, 6486.254080780771, 5278.5249327560705, 5293.814716484982, 5309.840704778863, 5311.229871668586, 5353.732313384316, 4688.835890743808, 4693.55411235932, 4702.459217190067, 4704.153252414599, 4715.693479923794, 6072.149899014142, 6141.731496609813, 6186.443220110122, 6254.9687251563455, 6269.965455699758, 6042.395760423922, 6150.815475535741, 6537.0, 6560.737570497126, 6588.703508342136, 6264.561480696399, 6280.2777680566405, 6304.590201636879, 6337.302896681362, 6340.3342649022115, 5680.261565996477, 5733.483986441241, 5741.483266506035, 5749.367569567345, 5831.329397119385, 6642.070110184578, 6736.494762892705, 6749.763758268437, 6757.3242675732035, 6789.762358317435, 6560.376764207393, 6587.80236592903, 6593.637349945799, 6597.60414375139, 6607.537472376887, 5930.466258036625, 6506.902396464152, 6707.564008339442, 6740.0, 6757.189137303555, 6387.648679322682, 6452.709628066842, 6492.091107245084, 6522.05430212626, 6546.869062618816, 5327.573794096385, 6469.676516174267, 6477.708503117276, 6484.157059582224, 6486.318936511599, 6280.748770049329, 6312.116303717575, 6316.778912738032, 6352.428281454691, 6381.425671689571, 6303.558750887394, 6344.206974128234, 6347.5556711029785, 6353.618782873043, 6373.171487706569, 6137.018077107641, 6300.8658441480975, 6348.301686814354, 6358.586691865014, 6363.300036996019, 6314.526410519321, 6332.0, 6345.7144428499905, 6354.936450635434, 6371.13989611415, 6278.623282603058, 6317.4630156437215, 6327.240731112296, 6349.904751428825, 6354.173957385695], "value": 5925.209421253507, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.7819914925946, 793.8888555602215, 825.3067423364373, 1269.688926213078, 1273.6370134511667, 36914.261714765686, 38057.429138562875, 38091.80954095226, 38263.85208443748, 38265.0, 37866.86399408015, 38222.0, 38270.4259436108, 38316.61683383166, 38539.843804685835, 7864.685412583504, 8053.557054362008, 8325.167483251687, 8531.402801803877, 8561.785955351135, 8375.706850260241, 8451.070382257947, 8469.95765021177, 8479.152084791502, 8515.489070655749, 8426.831463370729, 8487.872681909776, 8497.95751021244, 8504.659813607479, 8509.404341696083, 7366.963165184166, 7440.25597440257, 7577.81055473612, 8448.915510844874, 8486.108958559385, 8313.12712165226, 8329.791755206108, 8368.456050356708, 8389.95805020971, 8390.622421991025, 37240.44139337912, 37384.62615373866, 37420.0, 37432.81821045215, 37511.0, 3597.3344931187553, 3614.4036234021355, 3643.9635603644156, 3652.9223878955772, 3698.056995466166, 30787.0, 30817.845910770528, 30892.0, 30896.691033089606, 30903.536446953312, 3036.377542603761, 3060.9540856887165, 3067.9539806902912, 3070.8003979741247, 3073.1702440340982, 208611.0, 213870.0, 243454.0, 269777.0, 271146.4426778673, 47379.5262047382, 47505.0, 47525.76237118861, 47529.5247047532, 47764.52235477601, 48608.0, 48976.02047959092, 49140.52578422653, 49252.50747492551, 49369.753151234734, 14117.294135293194, 14175.71648567023, 14293.142411455347, 14312.998090133591, 14354.0, 11677.88322116768, 11713.355765432812, 11773.293602383885, 11784.057275417947, 11796.46915888787, 13210.603681889559, 13330.866691333156, 13340.933295333656, 13347.399367028507, 13412.597622071353, 5849.151872978395, 5894.17481552583, 5918.615290006136, 5928.762849486058, 5934.7922822701, 949.2927768812141, 986.9605215791431, 1036.5542816588938, 1059.5338051257422, 1087.798757229915, 21933.232336868452, 22122.115115395525, 23069.88465057664, 23620.173293934975, 23970.640440393407, 1123.6067376418189, 1126.8704099028553, 1129.7232178116415, 1158.4207896051973, 1167.9474423650956, 8437.270359576272, 10653.520591573399, 12298.877011229952, 12350.814737778941, 12422.006239500999, 303871.0, 374493.2550674513, 374558.0, 374570.0, 375227.7431677054, 52762.0, 52846.0, 53041.7347913258, 53067.0, 53336.73331633394, 1494.9103053816589, 1495.7980672609276, 1548.4657793061376, 1551.8292987771335, 1559.5399357189656, 23664.053437862294, 23819.880900595384, 23965.76034239705, 23971.400714981566, 24008.51982960296, 38363.616363836, 38375.84872453831, 38475.42286865755, 38484.230315394096, 38582.035449112875, 319805.2126611763, 322021.0, 324951.0, 325320.0, 325570.0, 33788.49317260194, 33942.0, 34096.48855267123, 34808.12979675528, 34970.650293497754, 43463.9134021652, 45645.31532026956, 45833.312500313186, 46033.539664602926, 46037.53962460333, 29396.853015734785, 30232.84883575568, 30530.0, 30912.536311955788, 31166.0, 30242.84878575593, 30456.695433045385, 30766.53850192204, 30963.91626293069, 31045.844770776002, 35360.0, 36195.63804362028, 36257.64325318846, 36701.44947825732, 36771.44842827306, 25408.0, 30201.546976795806, 30565.0, 31073.378532429677, 31245.062648120595, 21863.67204491902, 22882.42793930165, 23906.40233994164, 24190.0, 24192.63711044371], "value": 17451.346796201033, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.56782162640076, 423.0244804941389, 429.91186806704627, 440.3856620015079, 446.6248351384836, 18373.632527349444, 19988.001199880022, 21315.68026479604, 22424.990875410604, 22442.0, 21584.8920755396, 23048.539029219406, 23320.883395582998, 23383.64924526129, 23550.5289894202, 6202.565820392586, 6454.967725161391, 6456.06387073874, 6460.903086453707, 6469.514786391016, 6844.2129155147295, 7201.459890508207, 7243.89134162988, 7264.237255088219, 7273.018142550741, 6924.23833378328, 7160.534565253268, 7212.495125341228, 7226.132864056294, 7230.023946767198, 7009.614471204081, 7248.6375681215995, 7295.270472952662, 7332.670029848643, 7355.485116041906, 7091.89362159568, 7147.89278160828, 7153.105861767279, 7167.677454514559, 7175.210726820045, 29957.101286961428, 30456.0, 30460.93386731454, 30566.84716576403, 30943.91696290619, 2223.5108276179217, 2256.4810093678548, 2350.6003979323386, 2360.4098975256015, 2375.2280508834697, 18936.43190704281, 18991.33530326446, 19306.71039934402, 19489.80510194894, 19581.706274405897, 2287.954240915189, 2363.6690863279155, 2366.136360228504, 2371.359732872115, 2379.1316169598144, 114422.42788786003, 147791.04820849263, 156952.0, 162451.0, 164773.352266477, 24005.51988960246, 24954.5009099817, 25693.74306256951, 26457.0, 26565.601515977276, 42382.78808605937, 42411.363829542584, 43085.35371969423, 43186.568134318884, 43194.0, 11297.0, 11414.201005929504, 11431.828522572168, 11546.0, 11657.30056196614, 8774.612693653173, 8826.382153249338, 8958.10418958099, 9110.86333704995, 9156.267498600097, 9541.618335266512, 10611.893881061245, 11032.834507482394, 11748.060155187564, 11843.763124737628, 4154.750714957112, 4845.2799256264225, 4990.351254336913, 5011.890249995042, 5026.79892804291, 961.4327546747453, 961.4663861556763, 971.8104969531015, 989.5794287427815, 1004.1866088468364, 21517.0, 21966.011529480893, 22014.00936957841, 22024.0, 22024.339269821932, 897.3763234552055, 923.6397804856111, 997.6209040564539, 1023.9657945475124, 1035.11497669493, 10094.697159085239, 10258.743531411625, 10759.977802108788, 11204.337418660965, 11370.602028928948, 711277.0, 720986.0, 730606.0, 736788.0, 737022.0, 131720.0, 144196.0, 146898.0, 155863.0, 157576.0, 1169.9649010529697, 1172.2966220267942, 1187.7565099154826, 1188.964331070052, 1195.9043276537857, 18566.721499177795, 19132.904335478233, 19144.808551914302, 19179.0, 19189.232430702614, 55355.44644553664, 57516.71241643765, 63904.68047659732, 64812.67593662001, 64940.35059649343, 69886.65056674888, 87480.0, 88268.0, 88919.0, 89636.0, 10083.798324033332, 12578.0, 13157.079004469595, 13207.339633018119, 13222.735545289233, 13933.930330348283, 14015.299235038412, 14098.577042688325, 14368.425262989782, 14502.492412765503, 10153.54309056109, 11910.642680719593, 12052.0, 12254.816177757162, 12333.260004399765, 10360.326578772658, 10809.945950270197, 11036.448177591248, 11105.611303604335, 11349.602763903555, 11109.944450277697, 12049.216800907912, 12263.202891812003, 12423.62729118128, 12434.067444941846, 8669.91330086691, 8784.956075219583, 10519.368837869752, 12704.745905081661, 12883.484660613845, 10630.946845265724, 12060.698482537655, 12112.576059837864, 12280.815787763013, 12320.199187052813], "value": 12108.300757473804, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.6960933789899, 1416.730821143982, 1420.4176287722037, 1433.4266293482613, 1445.5446534341681, 11502.884971150286, 11677.649670509876, 11895.583654572092, 11912.64262072138, 12153.392330383489, 11707.063434925207, 11768.235064720788, 11942.940285298582, 11950.282983021025, 11951.0, 2478.6901637295337, 2526.1537384976054, 2535.467551814121, 2535.6307593899364, 2542.377117606189, 2448.608222684371, 2480.9875950620312, 2498.0632262901413, 2528.8872895925824, 2535.4295283561237, 2457.606782914734, 2502.737212592679, 2510.698716154064, 2513.2334637935423, 2515.107136966378, 2428.368624157723, 2478.615814548748, 2490.663760392342, 2504.136073054793, 2521.5713328733978, 2416.8429052111733, 2500.8749562521984, 2503.7621425964503, 2507.2352932355625, 2539.2509209783157, 11749.588764393206, 11882.821757673642, 11966.880331196664, 11994.580189693406, 12000.0, 6545.280019197884, 6744.123263975701, 6773.221079575863, 6784.491163162783, 6787.762428314985, 3952.486176797027, 4174.791260436966, 4197.496300443966, 4235.915281694349, 4257.701960862741, 1213.5449206547544, 1223.4861358229564, 1225.307701148857, 1269.3843485909326, 1273.433322171634, 14573.927130364385, 15502.992305500107, 16298.10360430176, 16378.75431868511, 16416.507504774876, 5510.889782204334, 5619.269494965628, 5797.391273916262, 5856.443637854397, 5868.2664666916635, 12342.506299748089, 12388.56640017595, 12413.627591172099, 12446.564370246997, 12470.937645311715, 6437.485001199892, 6477.481801455872, 6542.6401547914365, 6542.738290468423, 6547.083408322838, 6026.728797204137, 6107.816765497042, 6173.876522469525, 6175.197224360804, 6195.81412557624, 4407.669424793154, 4518.525554816697, 4519.0, 4554.521775213555, 4562.996140849074, 1283.4096315694699, 1307.7123032932739, 1309.8559158492558, 1323.2589749740175, 1325.1254172246272, 786.8701664225339, 788.4599049651007, 809.6801763303462, 819.0826274572516, 832.063928080909, 6006.331347125734, 6053.182820319289, 6228.781992630326, 6252.570550779164, 6273.12176295319, 590.5895402695171, 592.3247497852452, 600.3396264109444, 601.9247594050744, 610.3713175429315, 3530.894073177809, 4195.098053918422, 4268.338407546835, 4275.315949448073, 4350.521442641307, 14829.036112652642, 15471.071735695668, 15474.0, 15531.145786981824, 15541.222938853238, 14544.781828272584, 15071.0, 15401.306941187673, 15418.614534636723, 15429.45996890126, 10624.521896514676, 10820.837687434538, 10856.78286434267, 10864.619738309122, 10904.563817447213, 5516.724163791714, 5556.861078473071, 6357.7139028742895, 6968.79093627192, 7014.088168538057, 12819.0, 13273.269970151734, 13479.3934272956, 13646.044776865525, 13669.863301366859, 13690.726185476435, 13737.519186828413, 13776.242306672828, 13883.791743124064, 14069.507567235098, 10602.09882160025, 10667.51996160159, 10763.461826908466, 10825.0, 10840.94579527129, 10628.627998020032, 10736.46317684097, 10764.3541387517, 10847.783044339227, 10849.0, 9043.32175086858, 9137.451752894847, 9203.504776991344, 9258.0, 9287.071292870929, 8970.058143894797, 8981.506017168856, 8989.46063236208, 9062.365634405529, 9182.494962776844, 8200.466969646954, 8293.83412331738, 8313.251807337369, 8317.376196785144, 8318.916810832055, 5982.850428739316, 6082.939170608237, 6160.106784516131, 6163.660998645118, 6195.659238741912, 5852.502537284378, 6049.364816694359, 6180.072989051679, 6290.591111577916, 6326.683665816783], "value": 5398.862101220364, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.22669220945085, 396.6251891962097, 398.565563535746, 410.6037673644932, 415.56158253043037, 5751.597388182829, 5933.940660593398, 6093.0, 6094.481969032638, 6251.843703907404, 4775.8806029849275, 5131.871703207422, 5970.34326224115, 6028.246469191351, 6065.909011364833, 4307.203167414023, 4449.265871131276, 4449.532799056101, 4484.349769283452, 4496.235639941209, 4262.424572682695, 4410.64714822815, 4460.933086003713, 4462.553744625544, 4493.887652808689, 4430.158269928719, 4436.157130145262, 4445.977770111145, 4452.398926144978, 4494.325851122325, 3503.0, 4232.492100947875, 4413.337999300131, 4458.933116003279, 4481.574250446202, 3824.521934758155, 3832.405977073558, 3833.7731925783482, 3846.307664620367, 3853.653171214576, 4776.880577985544, 5876.647401155944, 5901.203337549418, 5918.537655471554, 5921.141434491975, 3931.5085614298214, 5242.423333433319, 5290.709011004393, 5301.496357845998, 5351.277577527062, 5490.80782172622, 6277.748890044393, 6284.905726414107, 6447.677616119222, 6449.322821103763, 3641.5266015417824, 3745.4569087482437, 4330.437043184366, 4346.6522678185665, 4354.586314300168, 5837.387074357174, 6283.994560870285, 6453.806385808433, 6599.0, 6993.335633114846, 4224.7253928495165, 4410.184115938561, 4426.712263702849, 4436.26801577736, 4461.7992190351515, 4459.420275364247, 4473.261911784519, 4480.775961201992, 4489.595936365743, 4499.460064792246, 5008.974955125274, 5255.789768409298, 5283.418823929364, 5342.061865973777, 5342.385625653022, 6518.28298887122, 6520.510961677893, 6527.3472652734345, 6553.148090748172, 6600.930567286235, 1437.8705916467359, 1512.3194562446943, 1532.524917275648, 1538.9153596552296, 1542.8302886682457, 875.711015364928, 904.9954550448996, 921.4010892919522, 953.5565961827783, 969.2488321550713, 5874.559408044413, 6178.907316390258, 6216.378362163748, 6226.40849119333, 6234.2830574484515, 5281.894362112736, 6656.500762442836, 6660.533762636569, 6668.499862510331, 6716.0113749382035, 5429.077056900336, 6077.392260773887, 6078.696065196723, 6148.661823599656, 6178.7219575119225, 2761.7100204478243, 3478.4086705260165, 3485.7734247273847, 3489.668481494254, 3508.9122771930397, 5724.856878578069, 6462.868997925344, 6787.355201255873, 6792.898106528406, 6834.726610935606, 5583.860403489864, 6717.294684058202, 6800.353966373186, 6807.081044059088, 6826.556273842184, 5776.393478684678, 5969.582129250911, 6496.6426846522945, 6598.340165983459, 6846.828829279209, 5846.473817356458, 6402.815479136375, 6406.391392817675, 6746.460283177432, 6760.763373281911, 5363.0882749931825, 6062.272527296753, 6543.345665433419, 6565.638889861103, 6625.337466253336, 6866.690998904961, 6898.137273031836, 6908.930910690829, 6924.169099708067, 7008.439324854102, 4166.541680415091, 4281.379200015918, 4299.398084268268, 4313.352997050342, 4327.697061205811, 6176.0, 6549.836254093686, 6601.636909969806, 6620.867582648417, 6667.566608170453, 4981.626378021735, 5683.460071293221, 5856.765729370777, 5947.851303717442, 6374.0, 6320.62076275425, 6385.87228255423, 6418.454431373386, 6420.839479013062, 6423.0863389507995, 4665.906681866411, 5549.694766787866, 6035.336113027475, 6321.1782468278825, 6354.3963323484195, 5928.822135335947, 6397.456216221487, 6415.743370265323, 6423.775167869102, 6447.290798012309, 5651.463111004448, 5687.033204355353, 6247.187865577446, 6272.905906411499, 6293.496520278458], "value": 4654.429656813647, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [818.9508629482228, 819.4591569564088, 840.3907167303705, 861.8279140369096, 867.8611422172454, 14000.369983350749, 14603.123812571253, 16300.0, 16727.749083763752, 16739.665206695874, 16618.418355357564, 16957.745633815473, 17301.480955571355, 17322.393716219936, 17323.740143897852, 985.1281615770024, 993.7217579077869, 1009.3136667066392, 1012.9696109116701, 1016.0905989139716, 992.5087081894472, 1009.217856161477, 1010.1767059846238, 1010.4240582867768, 1016.7204018894789, 1076.860008198933, 1082.9891701083006, 1089.2375337263907, 1090.8145615245428, 1091.0562363555507, 1057.4395570347729, 1080.0009990758595, 1080.481368942904, 1081.291753901196, 1081.7025318037524, 791.7070683846956, 801.9238172373615, 803.634346372405, 803.8271771569141, 805.3798575097201, 16770.832291677172, 16854.66290674192, 17031.14844257782, 17076.146192690318, 17112.657746845118, 16892.324307027706, 17155.742663860052, 17376.391826286144, 17531.211095500734, 17542.824571754245, 13919.58241252754, 13920.37358318878, 13925.651858703613, 14079.507217247346, 14249.216293103875, 3524.859005639771, 3538.5399898013093, 3560.4334092998997, 3560.839762210707, 3561.28774245152, 117229.41385293104, 118603.40698296539, 118700.40649796696, 119438.0, 122024.0, 12023.458944347525, 13141.408636611375, 13178.341082946006, 13218.867811321956, 13382.197068175941, 24690.876545617157, 24929.252122436355, 25674.101406450685, 25925.740742592334, 26017.73982260191, 7392.852142957111, 7671.578063206465, 8534.103919088531, 8847.778805529784, 8892.911070889339, 4804.159272127364, 4865.318855360252, 4876.804927802919, 4917.9016419672125, 4927.655064145547, 4258.68059895509, 4388.956110438919, 4422.0, 4423.203823311835, 4432.734035957853, 866.4931015355961, 891.9554022298859, 898.2140626951417, 900.0819164452353, 902.0258121229057, 636.2587585462976, 648.1088503307951, 651.9804405867832, 657.4510283912987, 688.7899190746871, 11405.600803971822, 11592.594259200887, 11815.468303926344, 11839.822402663967, 11858.110641701734, 651.0754728285846, 655.308649374914, 662.8409181796334, 669.2003056347716, 685.7085738561092, 4391.385206071152, 5441.863953401196, 5495.560355171577, 5605.7197140142825, 5607.158926161109, 94720.57919131081, 98313.0, 99721.0, 101463.0, 102131.97868021224, 83498.0, 83597.58201208955, 83691.0, 84266.0, 84356.0, 76778.23221767711, 78722.6063869677, 78742.60628696934, 79389.20610793933, 80094.0, 9066.22937050358, 10853.565857365616, 11268.943655281671, 11287.0, 11315.472411224378, 39456.0, 40098.79703608897, 40396.79801601091, 40852.387214191214, 41069.38395924004, 52645.7367713159, 53473.197902032276, 53718.194227087406, 53730.85076596892, 54218.91562168813, 14048.719025619226, 16111.516654500383, 16865.07242101696, 16905.91547042257, 16953.576160596083, 15428.382864685736, 16997.405090822256, 18131.0, 18251.908740456212, 18617.720734189268, 16482.75275870887, 16904.15479226009, 17000.914995424944, 17178.828211717722, 17277.481675549752, 16350.509484715478, 16450.259738311564, 16980.0, 17057.232424540678, 17181.656366872343, 15900.68198636044, 16058.839411605735, 16284.267207975432, 16324.102174380523, 16412.17939103016, 10834.295770774874, 11029.558817647205, 11296.887031129583, 11324.773504530029, 11776.0, 10595.0, 12641.304728240035, 12723.618291451272, 12746.10987615088, 12796.680082998], "value": 8341.722466469328, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1683.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 121.0, 101.0, 188.0, 105.0, 181.0, 184.0, 163.0, 120.0, 122.0], "value": 139.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 120.0, 117.0, 161.0, 155.0, 164.0, 121.0, 150.0, 177.0, 165.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [221.0, 218.0, 219.0, 233.0, 214.0, 206.0, 214.0, 215.0, 210.0, 212.0], "value": 216.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 59.0, 59.0, 88.0, 68.0, 89.0, 95.0, 80.0, 75.0, 58.0], "value": 76.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 109.0, 113.0, 72.0, 73.0, 95.0, 127.0, 107.0, 75.0, 88.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 135.0, 92.0, 98.0, 88.0, 141.0, 143.0, 92.0, 93.0, 92.0], "value": 106.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 102.0, 99.0, 113.0, 106.0, 125.0, 152.0, 164.0, 122.0, 100.0], "value": 118.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 130.0, 105.0, 110.0, 155.0, 123.0, 107.0, 103.0, 156.0, 115.0], "value": 121.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 53.0, 53.0, 55.0, 52.0, 52.0, 54.0, 56.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 64.0, 58.0, 67.0, 60.0, 59.0, 59.0, 57.0, 59.0, 57.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 89.0, 79.0, 109.0, 117.0, 77.0, 102.0, 79.0, 118.0], "value": 94.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 146.0, 146.0, 158.0, 138.0, 172.0, 173.0, 134.0, 227.0, 185.0], "value": 162.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 196.0, 229.0, 243.0, 260.0, 261.0, 191.0, 197.0, 194.0, 195.0], "value": 216.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 72.0, 70.0, 70.0, 69.0, 85.0, 85.0, 63.0, 92.0], "value": 74.7, "unit": "score"}]}]} 15:22:03 INFO - Return code: 0 15:22:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:22:04 ERROR - # TBPL SUCCESS # 15:22:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:22:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:22:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:22:04 INFO - 2017-04-08 15:22:04.069 screenresolution[1678:16502] starting screenresolution argv=screenresolution get 15:22:04 INFO - 2017-04-08 15:22:04.072 screenresolution[1678:16502] Display 0: 1600x1200x32@60 15:22:04 INFO - 2017-04-08 15:22:04.079 screenresolution[1679:16505] starting screenresolution argv=screenresolution list 15:22:04 INFO - Available Modes on Display 0 15:22:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:22:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:22:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:22:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:22:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:22:04 INFO - Intel Iris: 15:22:04 INFO - Chipset Model: Intel Iris 15:22:04 INFO - Type: GPU 15:22:04 INFO - Bus: Built-In 15:22:04 INFO - VRAM (Dynamic, Max): 1536 MB 15:22:04 INFO - Vendor: Intel (0x8086) 15:22:04 INFO - Device ID: 0x0a2e 15:22:04 INFO - Revision ID: 0x0009 15:22:04 INFO - Displays: 15:22:04 INFO - Display: 15:22:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:22:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:22:04 INFO - Display Serial Number: 1600x1200 60 15:22:04 INFO - Main Display: Yes 15:22:04 INFO - Mirror: Off 15:22:04 INFO - Online: Yes 15:22:04 INFO - Rotation: Supported 15:22:04 INFO - Return code: 0 15:22:04 INFO - Running post-action listener: _resource_record_post_action 15:22:04 INFO - [mozharness: 2017-04-08 22:22:04.322145Z] Finished run-tests step (success) 15:22:04 INFO - Running post-run listener: _resource_record_post_run 15:22:04 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 34890240; Write bytes: 519878656; Read time: 322; Write time: 1643 15:22:04 INFO - TinderboxPrint: CPU usage
54.3% 15:22:04 INFO - TinderboxPrint: I/O read bytes / time
34,890,240 / 322 15:22:04 INFO - TinderboxPrint: I/O write bytes / time
519,878,656 / 1,643 15:22:04 INFO - TinderboxPrint: CPU idle
2,195.7 (45.7%) 15:22:04 INFO - TinderboxPrint: CPU system
969.8 (20.2%) 15:22:04 INFO - TinderboxPrint: CPU user
1,636.1 (34.1%) 15:22:04 INFO - TinderboxPrint: Swap in / out
238,563,328 / 0 15:22:04 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208863744; Write bytes: 211044352; Read time: 16068; Write time: 466 15:22:04 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 30040576; Write bytes: 307331072; Read time: 285; Write time: 1170 15:22:04 INFO - Running post-run listener: _upload_blobber_files 15:22:04 INFO - Blob upload gear active. 15:22:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:22:04 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 15:22:04 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'] 15:22:04 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 15:22:05 INFO - (blobuploader) - INFO - Open directory for files ... 15:22:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:22:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:22:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:05 INFO - (blobuploader) - INFO - Done attempting. 15:22:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:22:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:22:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:06 INFO - (blobuploader) - INFO - Done attempting. 15:22:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:22:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:22:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:08 INFO - (blobuploader) - INFO - Done attempting. 15:22:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:22:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:22:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:10 INFO - (blobuploader) - INFO - Done attempting. 15:22:10 INFO - (blobuploader) - INFO - Iteration through files over. 15:22:10 INFO - Return code: 0 15:22:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:22:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:22:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ddb79267a43d65a81e82ebf0d64c95124323cdf33c537e2271226b8fdc71adb6dbdabd26329ea8c62b6317c5b6d7e007fd0105ce0c4ea880c9dc0a3fc5855d6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79c2cdb431e5d53786840bbeaae60a84288f53a48bc72d7155b118dc39cd602b4b58ad4262e4b4e1d2cd5e5662fdd1a939055ece299a79046c4c4b700a9bee94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/393596f97ac4a18605760e3ed6e0ca8cd86742241a6ff527bda61e94d1083442e3c69ee6bbb30627406d194b5865351a0010f3a27546d2093023ae2c12f7146b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ba23514b4a45f8d117d7a98603c8d538e504132681d5c6c723a847738d989a98ee51e7cc2add891e0e00ab94f726f70e914f5edcd505037cd4362e88a22f042"} 15:22:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:22:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:22:10 INFO - Contents: 15:22:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ddb79267a43d65a81e82ebf0d64c95124323cdf33c537e2271226b8fdc71adb6dbdabd26329ea8c62b6317c5b6d7e007fd0105ce0c4ea880c9dc0a3fc5855d6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79c2cdb431e5d53786840bbeaae60a84288f53a48bc72d7155b118dc39cd602b4b58ad4262e4b4e1d2cd5e5662fdd1a939055ece299a79046c4c4b700a9bee94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/393596f97ac4a18605760e3ed6e0ca8cd86742241a6ff527bda61e94d1083442e3c69ee6bbb30627406d194b5865351a0010f3a27546d2093023ae2c12f7146b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ba23514b4a45f8d117d7a98603c8d538e504132681d5c6c723a847738d989a98ee51e7cc2add891e0e00ab94f726f70e914f5edcd505037cd4362e88a22f042"} 15:22:10 INFO - Running post-run listener: copy_logs_to_upload_dir 15:22:10 INFO - Copying logs to upload dir... 15:22:10 INFO - mkdir: /builds/slave/test/build/upload/logs 15:22:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.746967 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-04-08 15:22:10.980762) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-08 15:22:10.984632) ========= 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.gFlqRGTZdH/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.zkAfTWTsWZ/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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/4ddb79267a43d65a81e82ebf0d64c95124323cdf33c537e2271226b8fdc71adb6dbdabd26329ea8c62b6317c5b6d7e007fd0105ce0c4ea880c9dc0a3fc5855d6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79c2cdb431e5d53786840bbeaae60a84288f53a48bc72d7155b118dc39cd602b4b58ad4262e4b4e1d2cd5e5662fdd1a939055ece299a79046c4c4b700a9bee94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/393596f97ac4a18605760e3ed6e0ca8cd86742241a6ff527bda61e94d1083442e3c69ee6bbb30627406d194b5865351a0010f3a27546d2093023ae2c12f7146b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ba23514b4a45f8d117d7a98603c8d538e504132681d5c6c723a847738d989a98ee51e7cc2add891e0e00ab94f726f70e914f5edcd505037cd4362e88a22f042"} build_url:https://queue.taskcluster.net/v1/task/Mlo30LLeShOu8bdpsVgAFA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011113 build_url: 'https://queue.taskcluster.net/v1/task/Mlo30LLeShOu8bdpsVgAFA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ddb79267a43d65a81e82ebf0d64c95124323cdf33c537e2271226b8fdc71adb6dbdabd26329ea8c62b6317c5b6d7e007fd0105ce0c4ea880c9dc0a3fc5855d6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79c2cdb431e5d53786840bbeaae60a84288f53a48bc72d7155b118dc39cd602b4b58ad4262e4b4e1d2cd5e5662fdd1a939055ece299a79046c4c4b700a9bee94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/393596f97ac4a18605760e3ed6e0ca8cd86742241a6ff527bda61e94d1083442e3c69ee6bbb30627406d194b5865351a0010f3a27546d2093023ae2c12f7146b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ba23514b4a45f8d117d7a98603c8d538e504132681d5c6c723a847738d989a98ee51e7cc2add891e0e00ab94f726f70e914f5edcd505037cd4362e88a22f042"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-08 15:22:11.019264) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 15:22:11.019598) ========= 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.gFlqRGTZdH/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.zkAfTWTsWZ/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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.005101 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 15:22:11.068287) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-08 15:22:11.068623) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-08 15:22:11.068961) ========= ========= Total master_lag: 0.25 =========