builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0194 starttime: 1491765907.05 results: success (0) buildid: 20170409112921 builduid: b081392f2ee7436197295133e6a991c9 revision: f51bf8ee1e7b5be7442ae5fa57dd3f09699032ae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-09 12:25:07.049135) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-09 12:25:07.049630) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-09 12:25:07.049944) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-09 12:25:07.076605) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 12:25:07.077090) ========= 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.4xeFFCxD3r/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.XWq3bM49nb/Listeners TMPDIR=/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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-09 12:25:07-- 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% 153M=0s 2017-04-09 12:25:07 (153 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122997 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 12:25:07.224821) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 12:25:07.225134) ========= 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.4xeFFCxD3r/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.XWq3bM49nb/Listeners TMPDIR=/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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.028515 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 12:25:07.275891) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-09 12:25:07.276288) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f51bf8ee1e7b5be7442ae5fa57dd3f09699032ae --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 f51bf8ee1e7b5be7442ae5fa57dd3f09699032ae --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4xeFFCxD3r/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.XWq3bM49nb/Listeners TMPDIR=/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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-09 12:25:07,379 truncating revision to first 12 chars 2017-04-09 12:25:07,379 Setting DEBUG logging. 2017-04-09 12:25:07,379 attempt 1/10 2017-04-09 12:25:07,379 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f51bf8ee1e7b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-09 12:25:08,966 unpacking tar archive at: mozilla-central-f51bf8ee1e7b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.872680 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-09 12:25:09.173834) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-09 12:25:09.174463) ========= script_repo_revision: f51bf8ee1e7b5be7442ae5fa57dd3f09699032ae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-09 12:25:09.175134) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-09 12:25:09.175629) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-09 12:25:09.196913) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-09 12:25:09.197562) ========= /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.4xeFFCxD3r/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.XWq3bM49nb/Listeners TMPDIR=/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 12:25:09 INFO - MultiFileLogger online at 20170409 12:25:09 in /builds/slave/test 12:25:09 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 12:25:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:25:09 INFO - {'append_to_log': False, 12:25:09 INFO - 'base_work_dir': '/builds/slave/test', 12:25:09 INFO - 'blob_upload_branch': 'Firefox', 12:25:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:25:09 INFO - 'branch': 'Firefox', 12:25:09 INFO - 'buildbot_json_path': 'buildprops.json', 12:25:09 INFO - 'config_files': ('talos/mac_config.py',), 12:25:09 INFO - 'default_actions': ('clobber', 12:25:09 INFO - 'read-buildbot-config', 12:25:09 INFO - 'download-and-extract', 12:25:09 INFO - 'populate-webroot', 12:25:09 INFO - 'create-virtualenv', 12:25:09 INFO - 'install', 12:25:09 INFO - 'run-tests'), 12:25:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:25:09 INFO - 'download_minidump_stackwalk': True, 12:25:09 INFO - 'download_symbols': 'ondemand', 12:25:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:25:09 INFO - 'tooltool.py': '/tools/tooltool.py', 12:25:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:25:09 INFO - '/tools/misc-python/virtualenv.py')}, 12:25:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:25:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:25:09 INFO - 'gecko_profile': False, 12:25:09 INFO - 'gecko_profile_interval': 0, 12:25:09 INFO - 'installer_path': 'installer.exe', 12:25:09 INFO - 'log_level': 'info', 12:25:09 INFO - 'log_name': 'talos', 12:25:09 INFO - 'log_to_console': True, 12:25:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:25:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:25:09 INFO - 'opt_config_files': (), 12:25:09 INFO - 'pip_index': False, 12:25:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:25:09 INFO - 'cmd': ('bash', 12:25:09 INFO - '-c', 12:25:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:25:09 INFO - 'enabled': True, 12:25:09 INFO - 'halt_on_failure': False, 12:25:09 INFO - 'name': 'check_screen_resolution'},), 12:25:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:25:09 INFO - 'cmd': ('bash', 12:25:09 INFO - '-c', 12:25:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:25:09 INFO - 'enabled': True, 12:25:09 INFO - 'halt_on_failure': False, 12:25:09 INFO - 'name': 'check_screen_resolution'},), 12:25:09 INFO - 'run_cmd_checks_enabled': True, 12:25:09 INFO - 'suite': 'dromaeojs-e10s', 12:25:09 INFO - 'system_bits': '32', 12:25:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:25:09 INFO - 'title': 't-yosemite-r7-0194', 12:25:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:25:09 INFO - 'use_talos_json': True, 12:25:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:25:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:25:09 INFO - 'work_dir': 'build'} 12:25:09 INFO - [mozharness: 2017-04-09 19:25:09.418636Z] Running clobber step. 12:25:09 INFO - Running pre-action listener: _resource_record_pre_action 12:25:09 INFO - Running main action method: clobber 12:25:09 INFO - rmtree: /builds/slave/test/build 12:25:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:25:11 INFO - Running post-action listener: _resource_record_post_action 12:25:11 INFO - [mozharness: 2017-04-09 19:25:11.877554Z] Finished clobber step (success) 12:25:11 INFO - [mozharness: 2017-04-09 19:25:11.877710Z] Running read-buildbot-config step. 12:25:11 INFO - Running pre-action listener: _resource_record_pre_action 12:25:11 INFO - Running main action method: read_buildbot_config 12:25:11 INFO - Using buildbot properties: 12:25:11 INFO - { 12:25:11 INFO - "project": "", 12:25:11 INFO - "product": "firefox", 12:25:11 INFO - "script_repo_revision": "production", 12:25:11 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 12:25:11 INFO - "repository": "", 12:25:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 12:25:11 INFO - "buildid": "20170409112921", 12:25:11 INFO - "pgo_build": "False", 12:25:11 INFO - "basedir": "/builds/slave/test", 12:25:11 INFO - "buildnumber": 18, 12:25:11 INFO - "slavename": "t-yosemite-r7-0194", 12:25:11 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 12:25:11 INFO - "platform": "yosemite_r7", 12:25:11 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 12:25:11 INFO - "branch": "mozilla-central", 12:25:11 INFO - "repo_path": "mozilla-central", 12:25:11 INFO - "revision": "f51bf8ee1e7b5be7442ae5fa57dd3f09699032ae", 12:25:11 INFO - "stage_platform": "macosx64", 12:25:11 INFO - "builduid": "b081392f2ee7436197295133e6a991c9", 12:25:11 INFO - "slavebuilddir": "test" 12:25:11 INFO - } 12:25:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/F6i18v5cTHauZ9m_-wyysg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 12:25:11 INFO - Running post-action listener: _resource_record_post_action 12:25:11 INFO - [mozharness: 2017-04-09 19:25:11.880981Z] Finished read-buildbot-config step (success) 12:25:11 INFO - [mozharness: 2017-04-09 19:25:11.881114Z] Running download-and-extract step. 12:25:11 INFO - Running pre-action listener: _resource_record_pre_action 12:25:11 INFO - Running main action method: download_and_extract 12:25:11 INFO - mkdir: /builds/slave/test/build/tests 12:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:25:11 INFO - trying https://queue.taskcluster.net/v1/task/F6i18v5cTHauZ9m_-wyysg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 12:25:11 INFO - Downloading https://queue.taskcluster.net/v1/task/F6i18v5cTHauZ9m_-wyysg/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 12:25:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F6i18v5cTHauZ9m_-wyysg/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 12:25:13 INFO - Downloaded 1325 bytes. 12:25:13 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 12:25:13 INFO - Using the following test package requirements: 12:25:13 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:25:13 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 12:25:13 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 12:25:13 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:25:13 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 12:25:13 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:25:13 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 12:25:13 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:25:13 INFO - u'jsshell-mac.zip'], 12:25:13 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:25:13 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 12:25:13 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 12:25:13 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:25:13 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 12:25:13 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:25:13 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 12:25:13 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:25:13 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 12:25:13 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:25:13 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 12:25:13 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:25:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F6i18v5cTHauZ9m_-wyysg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 12:25:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F6i18v5cTHauZ9m_-wyysg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:25:13 INFO - Fetch https://queue.taskcluster.net/v1/task/F6i18v5cTHauZ9m_-wyysg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 12:25:14 INFO - Expected file size: 52525859 12:25:14 INFO - Obtained file size: 52525859 12:25:31 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 12:25:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F6i18v5cTHauZ9m_-wyysg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 12:25:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F6i18v5cTHauZ9m_-wyysg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:25:31 INFO - Fetch https://queue.taskcluster.net/v1/task/F6i18v5cTHauZ9m_-wyysg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 12:25:33 INFO - Expected file size: 52525859 12:25:33 INFO - Obtained file size: 52525859 12:25:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F6i18v5cTHauZ9m_-wyysg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 12:25:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F6i18v5cTHauZ9m_-wyysg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:25:48 INFO - Fetch https://queue.taskcluster.net/v1/task/F6i18v5cTHauZ9m_-wyysg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 12:25:49 INFO - Expected file size: 14404129 12:25:49 INFO - Obtained file size: 14404129 12:25:49 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')]} 12:25:49 INFO - trying https://queue.taskcluster.net/v1/task/F6i18v5cTHauZ9m_-wyysg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:25:49 INFO - Downloading https://queue.taskcluster.net/v1/task/F6i18v5cTHauZ9m_-wyysg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 12:25:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F6i18v5cTHauZ9m_-wyysg/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 12:25:52 INFO - Downloaded 70929659 bytes. 12:25:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F6i18v5cTHauZ9m_-wyysg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:25:52 INFO - mkdir: /builds/slave/test/properties 12:25:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:25:52 INFO - Writing to file /builds/slave/test/properties/build_url 12:25:52 INFO - Contents: 12:25:52 INFO - build_url:https://queue.taskcluster.net/v1/task/F6i18v5cTHauZ9m_-wyysg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:25:52 INFO - Running post-action listener: _resource_record_post_action 12:25:52 INFO - Running post-action listener: set_extra_try_arguments 12:25:52 INFO - [mozharness: 2017-04-09 19:25:52.682786Z] Finished download-and-extract step (success) 12:25:52 INFO - [mozharness: 2017-04-09 19:25:52.682946Z] Running populate-webroot step. 12:25:52 INFO - Running pre-action listener: _resource_record_pre_action 12:25:52 INFO - Running main action method: populate_webroot 12:25:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:25:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:25:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:25:52 INFO - '--tppagecycles', 12:25:52 INFO - '7'], 12:25:52 INFO - 'tests': ['tsvgm']}}, 12:25:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:25:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:25:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:25:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:25:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:25:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:25:52 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:25:52 INFO - 'talos_options': ['--disable-e10s'], 12:25:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:25:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:25:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:25:52 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:25:52 INFO - 'talos_options': ['--disable-e10s'], 12:25:52 INFO - 'tests': ['damp', 'tps']}, 12:25:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:25:52 INFO - 'tests': ['damp', 'tps']}, 12:25:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:25:52 INFO - 'tests': ['dromaeo_dom']}, 12:25:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:25:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:25:52 INFO - 'tests': ['basic_compositor_video']}, 12:25:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:25:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:25:52 INFO - 'tests': ['a11yr', 12:25:52 INFO - 'ts_paint', 12:25:52 INFO - 'tpaint', 12:25:52 INFO - 'sessionrestore', 12:25:52 INFO - 'sessionrestore_no_auto_restore', 12:25:52 INFO - 'tabpaint']}, 12:25:52 INFO - 'other-e10s': {'tests': ['a11yr', 12:25:52 INFO - 'ts_paint', 12:25:52 INFO - 'tpaint', 12:25:52 INFO - 'sessionrestore', 12:25:52 INFO - 'sessionrestore_no_auto_restore', 12:25:52 INFO - 'tabpaint']}, 12:25:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:25:52 INFO - 'ts_paint', 12:25:52 INFO - 'tpaint', 12:25:52 INFO - 'sessionrestore', 12:25:52 INFO - 'sessionrestore_no_auto_restore', 12:25:52 INFO - 'tabpaint']}, 12:25:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:25:52 INFO - 'ts_paint', 12:25:52 INFO - 'tpaint', 12:25:52 INFO - 'sessionrestore', 12:25:52 INFO - 'sessionrestore_no_auto_restore', 12:25:52 INFO - 'tabpaint']}, 12:25:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:25:52 INFO - 'tests': ['a11yr', 12:25:52 INFO - 'ts_paint', 12:25:52 INFO - 'tpaint', 12:25:52 INFO - 'sessionrestore', 12:25:52 INFO - 'sessionrestore_no_auto_restore', 12:25:52 INFO - 'tabpaint']}, 12:25:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:25:52 INFO - 'tests': ['a11yr', 12:25:52 INFO - 'ts_paint', 12:25:52 INFO - 'tpaint', 12:25:52 INFO - 'sessionrestore', 12:25:52 INFO - 'sessionrestore_no_auto_restore', 12:25:52 INFO - 'tabpaint']}, 12:25:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:25:52 INFO - 'tests': ['tsvgx', 12:25:52 INFO - 'tsvgr_opacity', 12:25:52 INFO - 'tart', 12:25:52 INFO - 'tscrollx', 12:25:52 INFO - 'cart', 12:25:52 INFO - 'tsvg_static']}, 12:25:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:25:52 INFO - 'tsvgr_opacity', 12:25:52 INFO - 'tart', 12:25:52 INFO - 'tscrollx', 12:25:52 INFO - 'cart', 12:25:52 INFO - 'tsvg_static']}, 12:25:52 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:25:52 INFO - 'talos_options': ['--disable-e10s'], 12:25:52 INFO - 'tests': ['tp5o']}, 12:25:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:25:52 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:25:52 INFO - 'talos_options': ['--disable-e10s', 12:25:52 INFO - '--xperf_path', 12:25:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:25:52 INFO - 'tests': ['tp5n']}, 12:25:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:25:52 INFO - 'talos_options': ['--xperf_path', 12:25:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:25:52 INFO - 'tests': ['tp5n']}}, 12:25:52 INFO - 'talos.zip': {'path': '', 12:25:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:25:52 INFO - Running post-action listener: _resource_record_post_action 12:25:52 INFO - [mozharness: 2017-04-09 19:25:52.701035Z] Finished populate-webroot step (success) 12:25:52 INFO - [mozharness: 2017-04-09 19:25:52.701146Z] Running create-virtualenv step. 12:25:52 INFO - Running pre-action listener: _resource_record_pre_action 12:25:52 INFO - Running main action method: create_virtualenv 12:25:52 INFO - Creating virtualenv /builds/slave/test/build/venv 12:25:52 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 12:25:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:25:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:25:52 INFO - Using real prefix '/tools/python27' 12:25:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:25:53 INFO - Installing distribute.............................................................................................................................................................................................done. 12:25:56 INFO - Installing pip.................done. 12:25:56 INFO - Return code: 0 12:25:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:25:56 INFO - Reading from file tmpfile_stdout 12:25:56 INFO - Output received: 12:25:56 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) 12:25:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:25:56 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')]} 12:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:56 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')]} 12:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:56 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 0x104182b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104185768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96aa496b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f60d30>, '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 0x103e87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f55be8>, '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.4xeFFCxD3r/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.XWq3bM49nb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 12:25:56 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 12:25:56 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 12:25:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4xeFFCxD3r/Render', 12:25:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:25:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:25:56 INFO - 'HOME': '/Users/cltbld', 12:25:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:25:56 INFO - 'LOGNAME': 'cltbld', 12:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:56 INFO - 'MOZ_NO_REMOTE': '1', 12:25:56 INFO - 'NO_EM_RESTART': '1', 12:25:56 INFO - 'PAGER': '/bin/cat', 12:25:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:56 INFO - 'PWD': '/builds/slave/test', 12:25:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:25:56 INFO - 'SHELL': '/bin/bash', 12:25:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XWq3bM49nb/Listeners', 12:25:56 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 12:25:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:25:56 INFO - 'USER': 'cltbld', 12:25:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:25:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:56 INFO - 'XPC_FLAGS': '0x0', 12:25:56 INFO - 'XPC_SERVICE_NAME': '0', 12:25:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:56 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 12:25:56 INFO - Cleaning up... 12:25:56 INFO - Return code: 0 12:25:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:25:56 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')]} 12:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:56 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')]} 12:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:56 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 0x104182b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104185768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96aa496b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f60d30>, '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 0x103e87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f55be8>, '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.4xeFFCxD3r/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.XWq3bM49nb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 12:25:56 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 12:25:56 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 12:25:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4xeFFCxD3r/Render', 12:25:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:25:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:25:56 INFO - 'HOME': '/Users/cltbld', 12:25:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:25:56 INFO - 'LOGNAME': 'cltbld', 12:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:56 INFO - 'MOZ_NO_REMOTE': '1', 12:25:56 INFO - 'NO_EM_RESTART': '1', 12:25:56 INFO - 'PAGER': '/bin/cat', 12:25:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:56 INFO - 'PWD': '/builds/slave/test', 12:25:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:25:56 INFO - 'SHELL': '/bin/bash', 12:25:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XWq3bM49nb/Listeners', 12:25:56 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 12:25:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:25:56 INFO - 'USER': 'cltbld', 12:25:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:25:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:56 INFO - 'XPC_FLAGS': '0x0', 12:25:56 INFO - 'XPC_SERVICE_NAME': '0', 12:25:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:57 INFO - Downloading/unpacking psutil>=3.1.1 12:25:57 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 12:25:57 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 12:25:57 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 12:25:57 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 12:25:57 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 12:25:57 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 12:26:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:26:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:26:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:26:00 INFO - Installing collected packages: psutil 12:26:00 INFO - Running setup.py install for psutil 12:26:00 INFO - building 'psutil._psutil_osx' extension 12:26:00 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 12:26:01 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 12:26:01 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 12:26:01 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 12:26:01 INFO - building 'psutil._psutil_posix' extension 12:26:01 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 12:26:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:26:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:26:01 INFO - ^ 12:26:01 INFO - 1 warning generated. 12:26:01 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 12:26:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:26:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:26:01 INFO - Successfully installed psutil 12:26:01 INFO - Cleaning up... 12:26:02 INFO - Return code: 0 12:26:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:26: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')]} 12:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26: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')]} 12:26:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104182b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104185768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96aa496b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f60d30>, '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 0x103e87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f55be8>, '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.4xeFFCxD3r/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.XWq3bM49nb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 12:26: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:26: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 mozsystemmonitor==0.3 12:26:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4xeFFCxD3r/Render', 12:26:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:26:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:26:02 INFO - 'HOME': '/Users/cltbld', 12:26:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:26:02 INFO - 'LOGNAME': 'cltbld', 12:26:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:02 INFO - 'MOZ_NO_REMOTE': '1', 12:26:02 INFO - 'NO_EM_RESTART': '1', 12:26:02 INFO - 'PAGER': '/bin/cat', 12:26:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:26:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:02 INFO - 'PWD': '/builds/slave/test', 12:26:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:26:02 INFO - 'SHELL': '/bin/bash', 12:26:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XWq3bM49nb/Listeners', 12:26:02 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 12:26:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:26:02 INFO - 'USER': 'cltbld', 12:26:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:26:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:26:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:02 INFO - 'XPC_FLAGS': '0x0', 12:26:02 INFO - 'XPC_SERVICE_NAME': '0', 12:26:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:26:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:26:03 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 12:26:03 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 12:26:03 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 12:26:03 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 12:26:03 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 12:26:03 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 12:26:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:26:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:26:06 INFO - Installing collected packages: mozsystemmonitor 12:26:06 INFO - Running setup.py install for mozsystemmonitor 12:26:06 INFO - Successfully installed mozsystemmonitor 12:26:06 INFO - Cleaning up... 12:26:06 INFO - Return code: 0 12:26:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104182b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104185768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96aa496b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f60d30>, '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 0x103e87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f55be8>, '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.4xeFFCxD3r/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.XWq3bM49nb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 12:26:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:26:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4xeFFCxD3r/Render', 12:26:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:26:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:26:06 INFO - 'HOME': '/Users/cltbld', 12:26:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:26:06 INFO - 'LOGNAME': 'cltbld', 12:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:06 INFO - 'MOZ_NO_REMOTE': '1', 12:26:06 INFO - 'NO_EM_RESTART': '1', 12:26:06 INFO - 'PAGER': '/bin/cat', 12:26:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:06 INFO - 'PWD': '/builds/slave/test', 12:26:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:26:06 INFO - 'SHELL': '/bin/bash', 12:26:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XWq3bM49nb/Listeners', 12:26:06 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 12:26:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:26:06 INFO - 'USER': 'cltbld', 12:26:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:26:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:06 INFO - 'XPC_FLAGS': '0x0', 12:26:06 INFO - 'XPC_SERVICE_NAME': '0', 12:26:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:06 INFO - Downloading/unpacking jsonschema==2.5.1 12:26:06 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 12:26:06 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 12:26:06 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 12:26:06 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 12:26:06 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 12:26:06 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 12:26:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:26:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:26:09 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 12:26:09 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 12:26:09 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 12:26:09 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 12:26:09 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 12:26:09 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 12:26:09 INFO - Downloading functools32-3.2.3-2.tar.gz 12:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:26:09 INFO - warning: no files found matching '*.txt' 12:26:09 INFO - no previously-included directories found matching 'build' 12:26:09 INFO - no previously-included directories found matching 'dist' 12:26:09 INFO - no previously-included directories found matching '.git*' 12:26:09 INFO - Installing collected packages: jsonschema, functools32 12:26:09 INFO - Running setup.py install for functools32 12:26:09 INFO - warning: no files found matching '*.txt' 12:26:09 INFO - no previously-included directories found matching 'build' 12:26:09 INFO - no previously-included directories found matching 'dist' 12:26:09 INFO - no previously-included directories found matching '.git*' 12:26:09 INFO - Successfully installed jsonschema functools32 12:26:09 INFO - Cleaning up... 12:26:10 INFO - Return code: 0 12:26:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104182b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104185768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96aa496b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f60d30>, '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 0x103e87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f55be8>, '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.4xeFFCxD3r/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.XWq3bM49nb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 12:26:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:26:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4xeFFCxD3r/Render', 12:26:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:26:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:26:10 INFO - 'HOME': '/Users/cltbld', 12:26:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:26:10 INFO - 'LOGNAME': 'cltbld', 12:26:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:10 INFO - 'MOZ_NO_REMOTE': '1', 12:26:10 INFO - 'NO_EM_RESTART': '1', 12:26:10 INFO - 'PAGER': '/bin/cat', 12:26:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:26:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:10 INFO - 'PWD': '/builds/slave/test', 12:26:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:26:10 INFO - 'SHELL': '/bin/bash', 12:26:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XWq3bM49nb/Listeners', 12:26:10 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 12:26:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:26:10 INFO - 'USER': 'cltbld', 12:26:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:26:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:26:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:10 INFO - 'XPC_FLAGS': '0x0', 12:26:10 INFO - 'XPC_SERVICE_NAME': '0', 12:26:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:26:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:26:10 INFO - Cleaning up... 12:26:10 INFO - Return code: 0 12:26:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104182b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104185768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96aa496b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f60d30>, '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 0x103e87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f55be8>, '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.4xeFFCxD3r/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.XWq3bM49nb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 12:26:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:26:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4xeFFCxD3r/Render', 12:26:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:26:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:26:10 INFO - 'HOME': '/Users/cltbld', 12:26:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:26:10 INFO - 'LOGNAME': 'cltbld', 12:26:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:10 INFO - 'MOZ_NO_REMOTE': '1', 12:26:10 INFO - 'NO_EM_RESTART': '1', 12:26:10 INFO - 'PAGER': '/bin/cat', 12:26:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:26:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:10 INFO - 'PWD': '/builds/slave/test', 12:26:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:26:10 INFO - 'SHELL': '/bin/bash', 12:26:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XWq3bM49nb/Listeners', 12:26:10 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 12:26:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:26:10 INFO - 'USER': 'cltbld', 12:26:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:26:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:26:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:10 INFO - 'XPC_FLAGS': '0x0', 12:26:10 INFO - 'XPC_SERVICE_NAME': '0', 12:26:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:26:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:10 INFO - Downloading/unpacking blobuploader==1.2.4 12:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:26:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:26:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:26:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:26:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:26:13 INFO - Downloading blobuploader-1.2.4.tar.gz 12:26:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:26:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:26:13 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 12:26:13 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 12:26:13 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 12:26:13 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 12:26:13 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 12:26:13 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 12:26:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:26:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:26:14 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 12:26:14 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 12:26:14 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 12:26:14 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 12:26:14 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 12:26:14 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 12:26:14 INFO - Downloading docopt-0.6.1.tar.gz 12:26:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:26:14 INFO - Installing collected packages: blobuploader, requests, docopt 12:26:14 INFO - Running setup.py install for blobuploader 12:26:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:26:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:26:14 INFO - Running setup.py install for requests 12:26:15 INFO - Running setup.py install for docopt 12:26:15 INFO - Successfully installed blobuploader requests docopt 12:26:15 INFO - Cleaning up... 12:26:15 INFO - Return code: 0 12:26:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:26:15 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')]} 12:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:15 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')]} 12:26:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:15 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 0x104182b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104185768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96aa496b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f60d30>, '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 0x103e87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f55be8>, '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.4xeFFCxD3r/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.XWq3bM49nb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 12:26:15 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 12:26:15 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 12:26:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4xeFFCxD3r/Render', 12:26:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:26:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:26:15 INFO - 'HOME': '/Users/cltbld', 12:26:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:26:15 INFO - 'LOGNAME': 'cltbld', 12:26:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:15 INFO - 'MOZ_NO_REMOTE': '1', 12:26:15 INFO - 'NO_EM_RESTART': '1', 12:26:15 INFO - 'PAGER': '/bin/cat', 12:26:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:26:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:15 INFO - 'PWD': '/builds/slave/test', 12:26:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:26:15 INFO - 'SHELL': '/bin/bash', 12:26:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XWq3bM49nb/Listeners', 12:26:15 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 12:26:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:26:15 INFO - 'USER': 'cltbld', 12:26:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:26:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:26:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:15 INFO - 'XPC_FLAGS': '0x0', 12:26:15 INFO - 'XPC_SERVICE_NAME': '0', 12:26:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:26:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:26:15 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-LJvSb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:26:15 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-iRReVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:26:15 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-REvlG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:26:16 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-0Pr70V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:26:16 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-BV10wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:26:16 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-DgC4bP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:26:16 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-5OtT3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:26:16 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-H5TEUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:26:16 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-uSb3LY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:26:16 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-mQs6ap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:26:16 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-5SmEiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:26:16 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-uJAoUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:26:16 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-WzJ82e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:26:17 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-AvCNrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:26:17 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-agyrgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:26:17 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-XhKPls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:26:17 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-Mp9jSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:26:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:26:17 INFO - Running setup.py install for manifestparser 12:26:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:26:17 INFO - Running setup.py install for mozcrash 12:26:17 INFO - Running setup.py install for mozdebug 12:26:17 INFO - Running setup.py install for mozdevice 12:26:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:26:18 INFO - Running setup.py install for mozfile 12:26:18 INFO - Running setup.py install for mozhttpd 12:26:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:26:18 INFO - Running setup.py install for mozinfo 12:26:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:26:18 INFO - Running setup.py install for mozInstall 12:26:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:26:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:26:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:26:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:26:18 INFO - Running setup.py install for mozleak 12:26:18 INFO - Running setup.py install for mozlog 12:26:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:26:18 INFO - Running setup.py install for moznetwork 12:26:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:26:19 INFO - Running setup.py install for mozprocess 12:26:19 INFO - Running setup.py install for mozprofile 12:26:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:26:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:26:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:26:19 INFO - Running setup.py install for mozrunner 12:26:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:26:19 INFO - Running setup.py install for mozscreenshot 12:26:19 INFO - Running setup.py install for moztest 12:26:19 INFO - Running setup.py install for mozversion 12:26:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:26:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:26:20 INFO - Cleaning up... 12:26:20 INFO - Return code: 0 12:26:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:20 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 0x104182b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104185768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96aa496b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f60d30>, '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 0x103e87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f55be8>, '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.4xeFFCxD3r/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.XWq3bM49nb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 12:26:20 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 12:26:20 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 12:26:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4xeFFCxD3r/Render', 12:26:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:26:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:26:20 INFO - 'HOME': '/Users/cltbld', 12:26:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:26:20 INFO - 'LOGNAME': 'cltbld', 12:26:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:20 INFO - 'MOZ_NO_REMOTE': '1', 12:26:20 INFO - 'NO_EM_RESTART': '1', 12:26:20 INFO - 'PAGER': '/bin/cat', 12:26:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:26:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:20 INFO - 'PWD': '/builds/slave/test', 12:26:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:26:20 INFO - 'SHELL': '/bin/bash', 12:26:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XWq3bM49nb/Listeners', 12:26:20 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 12:26:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:26:20 INFO - 'USER': 'cltbld', 12:26:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:26:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:26:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:20 INFO - 'XPC_FLAGS': '0x0', 12:26:20 INFO - 'XPC_SERVICE_NAME': '0', 12:26:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:26:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:26:20 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-YX78Mc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:26:20 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)) 12:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:26:20 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-Ztp2g1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:26:20 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)) 12:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:26:20 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-3edAu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:26:20 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)) 12:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:26:20 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-Ayd36a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:26:20 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)) 12:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:26:20 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-lVCeWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:26:20 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)) 12:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:26:20 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-XtKHcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:26:20 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)) 12:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:26:20 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-AMQdc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:26:21 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)) 12:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:26:21 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-85xwVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:26:21 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)) 12:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:26:21 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-z8XtNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:26:21 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)) 12:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:26:21 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-Wpdxbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:26:21 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)) 12:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:26:21 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-VM2AEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:26:21 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)) 12:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:26:21 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-zwGjG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:26:21 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)) 12:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:26:21 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-M0p1MH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:26:21 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)) 12:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:26:21 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-JIi6YD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:26:21 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)) 12:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:26:21 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-HEZb__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:26:21 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)) 12:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:26:21 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-AaP4SX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:26:22 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)) 12:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:26:22 INFO - Running setup.py (path:/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/pip-Gsf3s8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:26:22 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)) 12:26:22 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)) 12:26:22 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)) 12:26:22 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)) 12:26:22 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)) 12:26:22 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)) 12:26:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:26:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:26:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:26:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:26:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:26:24 INFO - Downloading blessings-1.6.tar.gz 12:26:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:26:24 INFO - Installing collected packages: blessings 12:26:24 INFO - Running setup.py install for blessings 12:26:25 INFO - Successfully installed blessings 12:26:25 INFO - Cleaning up... 12:26:25 INFO - Return code: 0 12:26:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:26:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:26:25 INFO - Reading from file tmpfile_stdout 12:26:25 INFO - Current package versions: 12:26:25 INFO - blessings == 1.6 12:26:25 INFO - blobuploader == 1.2.4 12:26:25 INFO - docopt == 0.6.1 12:26:25 INFO - functools32 == 3.2.3-2 12:26:25 INFO - jsonschema == 2.5.1 12:26:25 INFO - manifestparser == 1.1 12:26:25 INFO - mozInstall == 1.12 12:26:25 INFO - mozcrash == 1.0 12:26:25 INFO - mozdebug == 0.1 12:26:25 INFO - mozdevice == 0.50 12:26:25 INFO - mozfile == 1.2 12:26:25 INFO - mozhttpd == 0.7 12:26:25 INFO - mozinfo == 0.9 12:26:25 INFO - mozleak == 0.1 12:26:25 INFO - mozlog == 3.4 12:26:25 INFO - moznetwork == 0.27 12:26:25 INFO - mozprocess == 0.25 12:26:25 INFO - mozprofile == 0.28 12:26:25 INFO - mozrunner == 6.13 12:26:25 INFO - mozscreenshot == 0.1 12:26:25 INFO - mozsystemmonitor == 0.3 12:26:25 INFO - moztest == 0.8 12:26:25 INFO - mozversion == 1.4 12:26:25 INFO - psutil == 3.1.1 12:26:25 INFO - requests == 1.2.3 12:26:25 INFO - wsgiref == 0.1.2 12:26:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:25 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 0x104182b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104185768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96aa496b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f60d30>, '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 0x103e87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f55be8>, '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.4xeFFCxD3r/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.XWq3bM49nb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 12:26:25 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 12:26:25 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 12:26:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4xeFFCxD3r/Render', 12:26:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:26:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:26:25 INFO - 'HOME': '/Users/cltbld', 12:26:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:26:25 INFO - 'LOGNAME': 'cltbld', 12:26:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:25 INFO - 'MOZ_NO_REMOTE': '1', 12:26:25 INFO - 'NO_EM_RESTART': '1', 12:26:25 INFO - 'PAGER': '/bin/cat', 12:26:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:26:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:25 INFO - 'PWD': '/builds/slave/test', 12:26:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:26:25 INFO - 'SHELL': '/bin/bash', 12:26:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XWq3bM49nb/Listeners', 12:26:25 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 12:26:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:26:25 INFO - 'USER': 'cltbld', 12:26:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:26:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:26:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:25 INFO - 'XPC_FLAGS': '0x0', 12:26:25 INFO - 'XPC_SERVICE_NAME': '0', 12:26:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:26:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:25 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)) 12:26:25 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)) 12:26:25 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)) 12:26:25 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)) 12:26:25 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)) 12:26:25 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)) 12:26:25 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)) 12:26:25 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)) 12:26:25 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)) 12:26:25 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)) 12:26:25 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)) 12:26:25 INFO - Cleaning up... 12:26:25 INFO - Return code: 0 12:26:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:26:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104182b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104185768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96aa496b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103f60d30>, '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 0x103e87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f55be8>, '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.4xeFFCxD3r/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.XWq3bM49nb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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 12:26:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:26:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4xeFFCxD3r/Render', 12:26:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:26:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:26:25 INFO - 'HOME': '/Users/cltbld', 12:26:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:26:25 INFO - 'LOGNAME': 'cltbld', 12:26:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:25 INFO - 'MOZ_NO_REMOTE': '1', 12:26:25 INFO - 'NO_EM_RESTART': '1', 12:26:25 INFO - 'PAGER': '/bin/cat', 12:26:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:26:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:25 INFO - 'PWD': '/builds/slave/test', 12:26:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:26:25 INFO - 'SHELL': '/bin/bash', 12:26:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XWq3bM49nb/Listeners', 12:26:25 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 12:26:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:26:25 INFO - 'USER': 'cltbld', 12:26:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:26:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:26:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:25 INFO - 'XPC_FLAGS': '0x0', 12:26:25 INFO - 'XPC_SERVICE_NAME': '0', 12:26:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:26:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:26:26 INFO - Cleaning up... 12:26:26 INFO - Return code: 0 12:26:26 INFO - Running post-action listener: _resource_record_post_action 12:26:26 INFO - Running post-action listener: _start_resource_monitoring 12:26:26 INFO - Starting resource monitoring. 12:26:26 INFO - [mozharness: 2017-04-09 19:26:26.062159Z] Finished create-virtualenv step (success) 12:26:26 INFO - [mozharness: 2017-04-09 19:26:26.063094Z] Running install step. 12:26:26 INFO - Running pre-action listener: _resource_record_pre_action 12:26:26 INFO - Running main action method: install 12:26:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:26:26 INFO - Reading from file tmpfile_stdout 12:26:26 INFO - Detecting whether we're running mozinstall >=1.0... 12:26:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:26:26 INFO - Reading from file tmpfile_stdout 12:26:26 INFO - Output received: 12:26:26 INFO - Usage: mozinstall [options] installer 12:26:26 INFO - Options: 12:26:26 INFO - -h, --help show this help message and exit 12:26:26 INFO - -d DEST, --destination=DEST 12:26:26 INFO - Directory to install application into. [default: 12:26:26 INFO - "/builds/slave/test"] 12:26:26 INFO - --app=APP Application being installed. [default: firefox] 12:26:26 INFO - mkdir: /builds/slave/test/build/application 12:26:26 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'] 12:26:26 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 12:26:46 INFO - Reading from file tmpfile_stdout 12:26:46 INFO - Output received: 12:26:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:26:46 INFO - Running post-action listener: _resource_record_post_action 12:26:46 INFO - [mozharness: 2017-04-09 19:26:46.012221Z] Finished install step (success) 12:26:46 INFO - [mozharness: 2017-04-09 19:26:46.012392Z] Running run-tests step. 12:26:46 INFO - Running pre-action listener: _resource_record_pre_action 12:26:46 INFO - Running main action method: run_tests 12:26:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:26:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:26:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:26:46 INFO - 2017-04-09 12:26:46.026 screenresolution[1628:7358] starting screenresolution argv=screenresolution get 12:26:46 INFO - 2017-04-09 12:26:46.028 screenresolution[1628:7358] Display 0: 1600x1200x32@60 12:26:46 INFO - 2017-04-09 12:26:46.034 screenresolution[1629:7364] starting screenresolution argv=screenresolution list 12:26:46 INFO - Available Modes on Display 0 12:26:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:26:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:26:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:26:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:26:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:26:46 INFO - Intel Iris: 12:26:46 INFO - Chipset Model: Intel Iris 12:26:46 INFO - Type: GPU 12:26:46 INFO - Bus: Built-In 12:26:46 INFO - VRAM (Dynamic, Max): 1536 MB 12:26:46 INFO - Vendor: Intel (0x8086) 12:26:46 INFO - Device ID: 0x0a2e 12:26:46 INFO - Revision ID: 0x0009 12:26:46 INFO - Displays: 12:26:46 INFO - Display: 12:26:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:26:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:26:46 INFO - Display Serial Number: 1600x1200 60 12:26:46 INFO - Main Display: Yes 12:26:46 INFO - Mirror: Off 12:26:46 INFO - Online: Yes 12:26:46 INFO - Rotation: Supported 12:26:46 INFO - Return code: 0 12:26:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:26:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:26:46 INFO - Python 2.7.3 12:26:46 INFO - Return code: 0 12:26:46 INFO - grabbing minidump binary from tooltool 12:26:46 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')]} 12:26:46 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 0x103f60d30>, '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 0x103e87db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103f55be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:26:46 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 12:26:46 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 12:26:46 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 12:26:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:26:46 INFO - Return code: 0 12:26:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:26:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:26:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:26:46 INFO - ENV: RUST_BACKTRACE is now 1 12:26:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:26:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:26:46 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/F6i18v5cTHauZ9m_-wyysg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0194', '--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 12:26:46 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/F6i18v5cTHauZ9m_-wyysg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0194 --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 12:26:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4xeFFCxD3r/Render', 12:26:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:26:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:26:46 INFO - 'HOME': '/Users/cltbld', 12:26:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:26:46 INFO - 'LOGNAME': 'cltbld', 12:26:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:26:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:46 INFO - 'MOZ_NO_REMOTE': '1', 12:26:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:26:46 INFO - 'NO_EM_RESTART': '1', 12:26:46 INFO - 'PAGER': '/bin/cat', 12:26:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:46 INFO - 'PWD': '/builds/slave/test', 12:26:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:26:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:26:46 INFO - 'RUST_BACKTRACE': '1', 12:26:46 INFO - 'SHELL': '/bin/bash', 12:26:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XWq3bM49nb/Listeners', 12:26:46 INFO - 'TMPDIR': '/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/', 12:26:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:26:46 INFO - 'USER': 'cltbld', 12:26:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:26:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:46 INFO - 'XPC_FLAGS': '0x0', 12:26:46 INFO - 'XPC_SERVICE_NAME': '0', 12:26:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:26:46 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/F6i18v5cTHauZ9m_-wyysg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0194', '--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 12:26:46 INFO - mozversion application_buildid: 20170409112921 12:26:46 INFO - mozversion application_changeset: f51bf8ee1e7b5be7442ae5fa57dd3f09699032ae 12:26:46 INFO - mozversion application_display_name: Nightly 12:26:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:26:46 INFO - mozversion application_name: Firefox 12:26:46 INFO - mozversion application_remotingname: firefox 12:26:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:26:46 INFO - mozversion application_vendor: Mozilla 12:26:46 INFO - mozversion application_version: 55.0a1 12:26:46 INFO - mozversion platform_buildid: 20170409112921 12:26:46 INFO - mozversion platform_changeset: f51bf8ee1e7b5be7442ae5fa57dd3f09699032ae 12:26:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:26:46 INFO - mozversion platform_version: 55.0a1 12:26:46 INFO - using testdate: 1491766006 12:26:46 INFO - actual date: 1491766006 12:26:46 INFO - starting webserver on 'localhost:49248' 12:26:46 INFO - SUITE-START | Running 2 tests 12:26:46 INFO - TEST-START | dromaeo_css 12:26:46 INFO - operating with platform_type : mac_ 12:26:46 INFO - Initialising browser for dromaeo_css test... 12:26:46 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/tmpWryOLT/profile http://localhost:49248/getInfo.html) 12:26:49 INFO - PID 1639 | 2017-04-09 12:26:49.637 plugin-container[1641:7537] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c47, name = 'com.apple.tsm.portname' 12:26:49 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:26:49 INFO - PID 1639 | 2017-04-09 12:26:49.640 plugin-container[1641:7537] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950b, name = 'com.apple.CFPasteboardClient' 12:26:49 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:26:49 INFO - PID 1639 | 2017-04-09 12:26:49.640 plugin-container[1641:7537] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:26:49 INFO - PID 1639 | __metrics Screen width/height:1600/1200 12:26:49 INFO - PID 1639 | colorDepth:24 12:26:49 INFO - PID 1639 | Browser inner width/height: 1024/689 12:26:49 INFO - PID 1639 | __metrics 12:26:49 ERROR - PID 1639 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 12:26:50 INFO - TEST-INFO | 1639: exit 0 12:26:50 INFO - Browser initialized. 12:26:50 INFO - Running cycle 1/1 for dromaeo_css test... 12:26:50 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/tmpWryOLT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:26:53 INFO - PID 1642 | 2017-04-09 12:26:53.398 plugin-container[1643:7669] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b33, name = 'com.apple.tsm.portname' 12:26:53 INFO - PID 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:26:53 INFO - PID 1642 | 2017-04-09 12:26:53.399 plugin-container[1643:7669] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4923, name = 'com.apple.CFPasteboardClient' 12:26:53 INFO - PID 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:26:53 INFO - PID 1642 | 2017-04-09 12:26:53.399 plugin-container[1643:7669] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:27:03 INFO - PID 1642 | RSS: Main: 233500672 12:27:03 INFO - PID 1642 | 12:30:07 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 12:30:08 INFO - PID 1642 | RSS: Main: 250986496 12:30:08 INFO - PID 1642 | 12:31:51 INFO - PID 1642 | ************************* 12:31:51 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 12:31:51 INFO - PID 1642 | 12:31:51 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:31:51 INFO - PID 1642 | Full stack: 12:31:51 INFO - PID 1642 | ************************* 12:31:51 INFO - PID 1642 | ************************* 12:31:51 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 12:31:51 INFO - PID 1642 | 12:31:51 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:31:51 INFO - PID 1642 | Full stack: 12:31:51 INFO - PID 1642 | ************************* 12:31:51 INFO - PID 1642 | ************************* 12:31:51 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 12:31:51 INFO - PID 1642 | 12:31:51 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:31:51 INFO - PID 1642 | Full stack: 12:31:51 INFO - PID 1642 | ************************* 12:31:51 INFO - PID 1642 | ************************* 12:31:51 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 12:31:51 INFO - PID 1642 | 12:31:51 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:31:51 INFO - PID 1642 | Full stack: 12:31:51 INFO - PID 1642 | ************************* 12:33:10 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 12:33:11 INFO - PID 1642 | RSS: Main: 259207168 12:33:11 INFO - PID 1642 | 12:36:13 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 12:36:13 INFO - PID 1642 | RSS: Main: 274505728 12:36:13 INFO - PID 1642 | 12:39:15 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 12:39:16 INFO - PID 1642 | RSS: Main: 266887168 12:39:16 INFO - PID 1642 | 12:42:19 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 12:42:19 INFO - PID 1642 | RSS: Main: 277815296 12:42:19 INFO - PID 1642 | 12:45:21 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 12:45:22 INFO - PID 1642 | RSS: Main: 271458304 12:45:22 INFO - PID 1642 | 12:45:22 INFO - PID 1642 | __start_tp_report 12:45:22 INFO - PID 1642 | _x_x_mozilla_page_load 12:45:22 INFO - PID 1642 | _x_x_mozilla_page_load_details 12:45:22 INFO - PID 1642 | |i|pagename|runs| 12:45:22 INFO - PID 1642 | |0;dojo.html;2933.222695985564;3339.9980005998195;3508.842102105404;3544.1671207266304;3556.5909920359168;6102.398363691434;6194.814155575329;6218.626882387054;6269.717862696179;6303.905441418371;6146.446819786218;6181;6187.938120618793;6221.657808820513;6222.12890195373;4717.9056418871605;5270;5507.972460137694;5519.365272993617;5633.60564760467;5475.972620136914;5537.36320323164;5613.270274864282;5622.775088996435;5631.662100273976;5440.6735595864375;5497.505224529771;5537.390887002426;5573.526250268732;5647.943520564803;5526.226328314039;5532.806351777668;5560.582956278255;5565.972170139124;5597.104463285855;5463.726813659301;5477.123660214386;5480.561555075585;5480.862978425532;5494.1758736189495;5190.806114593627;5400.973814975142;5433.918491222635;6152.6308421494405;6175.7529698811995;6722.49581281401;6741.629210393427;6746.291639377893;6759.155105611799;6770.830729231809;6817.5227734058635;6822.4200942919915;6825.283345248727;6844.93155068448;6849;5245.370555533361;6198.194234749454;6213.720382582795;6345.777897773556;6377.872442551169;5764.654120752768;5856.326522449887;6967;6981.825454363681;7002.7899163025195;6435.324290949477;6500;6581.670916454158;6620.9006864897065;6656.83357916056;6743.1908171019795;6797.864042719217;6798.04827324175;6798.116244888231;6850.897236541456;6502.317256688074;6546.541742078009;6703.731850726014;6736.629485378351;6740.595564266159;5107.8723031923755;5560.86097847549;6656.400923916871;6761.154855643044;6777.796666100025;5395.81114660985;5403.9459605403445;5407.567394608422;5433.972830135824;5456.91814622781;4681.812727490862;4790;4806.975965120152;4826.32431459596;4829.73436460991;6131.754729810847;6248;6308.842278943063;6317.936820631827;6369.20384951881;6836.248012718597;6839.658017099126;6842.315768423118;6859.382655561023;6888.521296745212;6241.625502469867;6307.653079080603;6312.400321969406;6339.873202535923;6360.650164241011;5809.2738407699035;5814.982378083819;5851.21008663825;5885.47030767233;5897.852553686193;6082.482988945901;6955.791326260221;6963.791086267217;6970.756023539152;6974.093367862349;6792;6803.336997995207;6849.931500684929;6859.348361905611;6869.931300687129;6870.862582748417;6940.375366217065;6959.164900211805;6971.163460384786;6984.930150698428;6006.669633170043;6225.3774622537385;6440.806775796734;6530.346965303432;6584.374484423972;6492.870142597216;6788.083608712761;6817.216020157745;6820.3861652451515;6824.18109826824;6436.356364363526;6447.871042579216;6454.709538070704;6528.804135875931;6643.036759669917;5499;6575.046618240424;6611.636360000246;6617.239017513048;6631.535792494479;6275.874482510233;6343.524235682435;6436;6442.162518872704;6469;6532.183477065367;6541.411272985454;6574.539782215199;6591.077249185214;6639.734410623521;5255.842324730264;6422.871542569216;6426.903596445964;6458.289588145206;6475.352464753487 12:45:22 INFO - PID 1642 | |1;ext.html;806.3388021822107;1244.676384140124;1255.869717254471;1259;1278.7506436244937;35972;36818.07954801128;36870.63129368705;36899.4465083024;36992.26015479689;36964.81517592415;37340;37360.626393736056;37467.437988430196;37510.249795004085;7781.610919454033;8251.422400431971;8466.449680770731;8469.66121355145;8481.915180848175;8512.446690965067;8595.484270943733;8601.483910965331;8617.784555386103;8644.178803013703;8573.228409443149;8641.95679021604;8644.524551149685;8645.135486451367;8646.956765216197;8603.526806025666;8628.956855215747;8630.395872288942;8631.482111073356;8652.178043085896;8324.375671824637;8379.203975622306;8381.706640267623;8403.243708066242;8448.83102337956;36843.71047013369;36928.44607330892;37116.62883371186;37129.81435092807;37143.4428483573;3617.475466057433;3661.743677942545;3667.413213885792;3667.743257971943;3674.173311005029;30656.540151897738;30695.232619184477;30703;30703.69296307053;30732.078037658906;2929.0480593807097;3007.3083190866223;3200.2159470929773;3222.516622506619;3236.449803533405;236640.99999999828;282869;284129;285368;286141;36857.81571092181;38097.42853857194;46800.59598212059;46816.7659161702;47122;48451.27323090156;48580;49067.509324907005;49113.01773964501;49149.75425122923;13062.34688265602;14231.50189743354;14382.993190476565;14402;14406.063605865585;11059.336439813636;11647.825282620768;11793.056555475541;11816.113791465674;11826.349550774617;12992.415341309665;13219.272939988394;13241.73516529664;13286.3356832158;13331.733365332639;5994.9700251499335;6006.2191915051635;6035.185249991283;6049.969750151221;6059.21230240066;901.5717534171216;966.8694726212012;973.9043575977025;1037.6160820496464;1076.2036093291065;24277.635835462483;24311.27066188017;24331.513369732507;24341.26976190717;24419.87790061074;1139.145640769423;1142.3203194099497;1173.9119566032582;1175.18324764288;1182.3142577305143;11979.585818041991;12457.377131143407;12468.189567678071;12473.376331183405;12502.562410315777;322811;323638.7636123656;324154;324841;325511;52951.73524132355;52960.470395296325;52960.94078118416;53047.73476132672;54347.45652543424;1505.7139143562688;1557.322564684366;1560.9063456192664;1567.6551158745058;1577.1246957938454;23206.76793232046;23357.41606459852;23365.948532315746;23430.64854027157;23469.530609387377;36428.27143457063;36946;37015.81492092522;37020.889373318845;37042.629573704995;295511;295566;295769.04230957414;295868;298251;32074.839625802655;32864.50703239501;33091.50362744513;33233.83681571134;33709.325813483105;37358;44180;45155.77422112868;45206;45289.54710452853;28952.710472895;30017.3996520064;30115;30748.770049198676;31088.378232434774;29996;30462.84768576143;30812.840266563726;30936.53595196029;30989;35907.46138807972;36149.09627259339;36732.26535469329;36885.26229475449;36928.26143477062;29848.955286564866;30320.848395758763;30361.69638303677;30618.846905765327;31214;22605.747899997375;24136.637950430406;24224.878875606213;24272.87863560671;24340.634890476304 12:45:22 INFO - PID 1642 | |2;jquery.html;428.3189728331956;438.5548668101876;444.9565768273398;452.87772301478594;458.1592777253741;19792.802071979277;21456.24903128389;22139.446513837163;22223.555528889454;22324.66513002304;18041.4587562373;23128.65307020392;23661.5267694646;23968.52062958744;24001.399965000885;6203.658798766066;6221.813345599628;6427.485801135921;6447.323031081739;6476.255230648465;5426.782928682848;5871.236739223917;5917.349091599921;6201.534884883629;6381.425671689547;6102.96948515259;6273.278572964122;6302.810915672514;6333.49332053437;6339.11252424661;6239.532035097363;6239.937600623981;6312.179416675849;6320.778772742932;6324.241091069055;5371.3822910365025;5601.551875849922;5613.831585052455;5620.1288800236025;5641.069223578104;23160.65259021116;27657.723422765717;27677.584836227474;27753.583696244572;27754.722452775415;2181.8472706910525;2227.4988127671145;2239.8432109752325;2241.1931704586336;2248.6739422783767;17939;18157.45527634173;18229.635407291913;18335.633287334313;18531.49824773652;1711.563551294412;2193.396815875631;2224.9666255006186;2228.944276393087;2233.2741858895924;159823;160492;163129;164213.93646698853;164371.3562864368;10020.899791002143;12205.450754715881;12338.951189148844;12503.312317822607;12546.623601291976;16135.273912673723;16167.919160404357;16179;16180;16199.514014579581;7659.61701914902;8745.330259915654;8895.24390426808;9062.139096785795;9219.90780092204;8705.216530512158;8720.345974051972;8721.084286149862;8887.73336799897;8930.464172149692;7767.611619419006;7915.327197188303;7955.647539918228;7959.9602001989615;7965.561894095765;2165.989170054171;2171.185805323004;2171.272623671088;2172.435166856597;2343.5398212453033;972.3582435592475;972.4116909269932;977.3451787302524;998.226374559722;1016.6441745389054;20302.69545956812;21245.78754212469;21639.459013524473;21781.25749940001;22095.784731839583;1026.8294144675076;1030.2891005206384;1035.9896401035894;1051.8211903976342;1057.259918057363;9810.901890981142;10016.699499015042;10565.520827084214;11379.943100284445;11414.315141091562;693918;709059;727424;732667;749904;107791;153420.93158136774;166656;167622;167674;1114.5318966034285;1199.400299850075;1199.4662375242933;1248.0078337721534;1250.2810883741886;18204.544886377946;20921.790782091983;21755.782442175376;22926.541469170857;23207.88396058009;64966.02550961834;65094.34905650883;65894.34105659074;66366;66751.33248667451;69182.65408672925;89576;94163.52918235365;94806;94898.52550737202;9097.13577210164;9148.862767058632;9200.95399523025;9224.584893679666;9267.073292670679;12034.879651203375;12145;13878.791818122534;14589.124652520883;14739.631509211926;10670.62652807148;11970.281783093042;12016.459259333176;12017.21888077307;12253.142280040312;11330.093592512743;11450.312981221154;11464.770704586028;11669.649910502698;11835.763284734428;10742.892571074502;12336.259824410565;12400.31798251105;12404.875951240732;12584.622461326175;8595.140485951355;8903.554822258731;9048.683296084606;9252.861207082035;9281.628734850801;11323;11686.766264674829;11800.291982481078;11853.703657408634;11940.761184776082 12:45:22 INFO - PID 1642 | |3;mootools.html;1430.5565274764822;1474.8525147485252;1476.4463326252655;1484.9925750371247;1494.1931357067185;11620.883791162096;11995.700107497318;12088.153829231946;12114.69713257169;12332.691682707937;11943.283402995827;12146.271223726582;12152.513899444011;12170.756584868297;12182.147249692503;2465.6424818401274;2516.55960206964;2518.055729101587;2520.0171932946164;2523.3691577105724;2417.3352328109736;2442.926712198637;2477.752224777526;2477.913273035444;2481.9079604973754;2453.521563295158;2459.5695753243112;2477.752224777526;2492.302155396492;2505.799536037122;2452.4359397338535;2458.2748089313695;2474.7772700456953;2485.9005639774387;2493.463905260378;2451.9877400613063;2465.8520488770732;2478.529079474912;2478.6529885816;2484.2671411933343;11776.175667703264;11797.823032654516;12032.639020829389;12046.879531204751;12057.975072118881;6302.905456418157;6450.064980505829;6503.317151699098;6509.967450162719;6533.575317604388;3952.170044290702;4132.359484279941;4178.955261184704;4230.238557059728;4246.150769846043;1239.8140278958138;1260.848698156218;1310.4627102887866;1310.6264714556305;1314.0407502523117;15086.170260635661;15662.921685391613;16499.83500164995;16626.085565293903;16643.750343744854;5409.648372855751;5481.561475081984;5663.830085097454;5700.315962084494;5712.857178570569;12339.321337326353;12452.066095042908;12454.31501267439;12501.874981250254;12538.87461125377;6526.575772574767;6527.314631963671;6529.347065293433;6531.8367040823405;6545.639989800607;6064.818055458343;6100.450959413585;6154.569180157436;6154.969225153845;6220.440160385587;3702.278055779151;4420.092028978559;4521.728696278234;4545.4545454545005;4596.4024676791805;1283.3839756916545;1309.18830325199;1313.8029295605545;1320.9273489957952;1324.8542660307357;779.8596252674573;798.5785302162161;811.6550466051905;812.7033632724132;830.8379865926087;6106.358832322631;6109.022556390956;6282.623042617458;6334.873302533923;6338.176037115146;529.3224672419309;572.6564061563029;582.3535875178549;584.7894757887158;590.1884908251154;3763.8682646107804;3821;3831.65515103642;3849.7882616455804;3910.745801522949;11215.66353009411;12860.485580576673;13682.589522314347;15183.937124401407;15298.311575979107;14968.625784355478;15214.239288035775;15219.239038048274;15231.923840380949;15426;10722;10915.508802103925;11035.889641103648;11037.0618497427;11244.66266012021;5724.856878578069;6751.932480675327;6950.965245173742;6951.374376306157;7010.808162612266;11245.381504017358;12122.212056216318;12342.01263898868;13565.86434135646;13925.164490130219;12960.740785184433;13368.799468007794;14037.087589306662;14206.360713767699;14240.572782816533;9453.574589143367;9616.23070154372;9635.518224088908;9645.517724113626;9650.179734722627;9206.953965230132;10802.459877005962;10933.234673573092;10967.945160274467;11059.834102488308;8198.713045043394;9241.168294853496;9354.953225234103;9409.764755880884;9466.574004169692;7597.392208623407;9069.591868366071;9222.308326875376;9284.396514226553;9285.164335209864;8211.260986511243;8290.170982901904;8307.543085130133;8365.62354694028;8367.372447066373;5649.152627105967;6016;6046.879062418815;6151.784687535915;6199.969000154971;6046.788362407295;6116.694165291807;6223.439890409885;6275.995840665471;6279.152314437675 12:45:22 INFO - PID 1642 | |4;prototype.html;343.6769436729474;369.2301551265611;381.8052793075532;390.27798572640603;405.39393606558184;5561.138023606338;5756.338021127572;5808.896309701159;6186.350433204516;6417.390347916947;5825.310659908621;6082.604630699001;6220.346863579315;6241.500679945605;6276.811695649127;4529.365888775574;4531.365608814768;4556.567126123013;4562.726236425825;4564.520725323843;4550.271956486963;4554.567316104964;4570.79431425585;4573.199690054244;4597.471290801551;4120.423140760296;4291.8497852575165;4400.295952647577;4536.342230376594;4542.15970045541;3731.440283957401;4484.686071974963;4506.346579745951;4521.174266083714;4527;3590.389633762267;3884.3590807516725;3886.4753258310047;3900.5124359455067;3918.745281556718;4673.6027437667835;5927.318358388798;5989.850253743692;6048.274207095133;6070;4302.741835489849;5365.785368585291;5376.301080859503;5408.35099788024;5419.888922770822;5791.652500849962;6357.904631430532;6600.93399066008;6640.900386494206;6666.200055993263;4391.385206071152;4421.916630425534;4549.4068381022835;4744.976275118603;4811.367417599725;5975.820725378246;6560.047978409735;7023.051887995106;7028.718851245995;7151.89272160918;3929.3713005918917;4829.96155826499;4833.32333473314;4850.660453768273;4858.392700912386;4100.302948498763;4535.750533720677;4954.504549545017;4954.677945933503;4992.425871024879;4585.403897493305;4928.359313289249;5296.814611488579;5463.262459567987;5572;5591.049521581341;6749.59502429846;6753.358430949052;6765.830854228684;6835.69239384219;1500.3698446652213;1680.8151103378618;1705.7356109803;1706.2407228783072;1707.5048236011417;993.5926270229171;1099.4722533184117;1127.7462570921477;1134.6766171641043;1163.633455461544;6232.875342493125;6321.589096708791;6327.145835312174;6350.206224221973;6362.141110950055;6097.207363042865;6859.176898772179;6940.271271516418;6965.79102626922;6972.860542789217;5592.552595792326;6237.96881015592;6321.55749097568;6337.873242535124;6340.936590634127;2944.661363943131;2958.3195864950753;3641.8543258269374;3652.872149474809;3654.780713157219;5956.791512297135;7008.301803805572;7151.177614574286;7153.320434558708;7156.354038571158;5934.902043122036;6905;7062.435005199572;7068.187158476738;7193.604351760599;5595.300587426572;5912.970435147883;6937.68780404883;7099.361057504952;7149.139464689009;5201.089809283285;6169.259688837368;6316.494680425463;6972.267911869383;6998.685059172248;5729.825385795985;5964.777220669665;6224.564280500503;6819.215790184192;6873.20958089826;6031.5476339273855;6353.682315884095;6917.37743603058;7049.577025378494;7069.293070692889;3923.8822835314986;3962.9498182980956;4467.620252278462;4479.006841955299;4482.529334419839;6535.823551760729;6729.394354508117;6887.965560172167;7015.649217539;7033.577985320897;5103;6158.353372895782;6200.937990620036;6586.934130658632;6801.8639627206185;6088.939110608837;6754.2570317266045;6761.870010946536;6778.389944904982;6800.795976120724;5286.656367336111;5761.8559536011935;6531.542792004704;6567.9671601641685;6573.309802470863;5361.169018802092;6136.7726454708345;6565.540412171103;6700.773396750543;6756.831079223059;5972.820815375546;5999.820005399845;6213.565050446426;6438.806835794933;6481.222253329631 12:45:22 INFO - PID 1642 | |5;yui.html;764.3159372361737;831.1688311688312;849.4521033933113;851.944623599466;867.8264347130576;14789.926050369746;16281.83718162818;16735.58161045973;17989.7301540477;18775.90612046941;17756.289748410047;17945.192466339013;18150.909245453753;18210.180541875616;18652.53368665784;989.579428742785;1013.6705570689519;1014.3406785589389;1015.7105225010873;1016.207358260558;1004.8743907011624;1021.3361315145178;1021.8927012663675;1025.3130402630218;1027.9537420816043;1070.0155856611937;1075.67192006438;1082.431723345242;1087.0053900680869;1088.1294964028746;1062.2033474893828;1070.0631856340049;1073.726199819045;1075.0109898893038;1076.5962763963553;781.1407451803028;782.0459039971227;784.2510402565593;789.0728394136867;806.6410447350931;16803.91598042014;16881.662366752596;17036.574085647957;17053.82946170547;17086.231119599648;16927.3229070837;17218.397356092602;17261;17382.478525644252;17408.825911740973;12175.817362739566;13825.377857996415;13882.791758123636;13982.370793314325;14099.083559568595;3517.437210046406;3578.1054736315923;3580.9283814323826;3587.0673624857723;3594.137407022322;91798.62302065408;121024;121395.78604213933;122538;124151.3792431032;13328.533501327602;13463.932680336535;13685.726285474235;13697.863021369858;13708.108972916729;18410;20871.791282086986;24969.12608058709;25183;25339.746602533738;8762.737117886474;9068.138526839939;9258.027907069796;9278.489683067495;9298.395604285699;4848.733319667452;4931.309616653672;4958.281049247839;4965.205567109245;4993.226049962262;3035.4991426414394;4237.576242375738;4348.717333373321;4350.71720338177;4374.081442896963;832.7168762620738;941.750436134425;968.41894863083;970.6554173268388;977.9070988256104;632.8354627796806;657.4871600151794;667.3260007392569;672.458670770025;683.3200965039817;9209.263258939403;9958.053984871425;10570.365778053341;11426.771464570662;11910.821337679941;639.972843586047;656.7504348347597;682.6791408038214;684.0833283400268;693.5665209244222;4755.953690188222;5120.462351453119;5544.972275138599;5575.944240557624;5770.365259821417;97882;98698.50650746844;99375;100110.49944750375;101719.98280017253;65885.67057164683;67758.90169884734;90674.54662726643;92028;92880;70371;72691.63654181696;77479.61260193663;77485.61257193678;78644.23725847954;10738;12049;12561.05792065617;12584.18202816814;12653.240805551697;34414.31171376609;38984.80507597444;39339.409908850816;40792.59207407888;41375.37936930888;49580;49874.750626246634;49940;50127.746806330135;50353;15905.125218113115;15999.68000640004;16420;16665.16674166311;16783.32866685368;17587;18161;18220.36228731988;18394.98827564497;18566.443006709822;16476.258568364214;16942.491725248263;17269.050202239;17339.739903901198;17422.606191504903;14744.48394306237;14746.926265368604;14840.925795370955;16382.426615068416;16797.580060498585;16024.439144629881;16383.836161638232;16601.169941502634;16802.24389902482;16814.495565133064;11422.086233101498;11651.475683594428;11917.880821192024;11949.283043017447;12171.756564868476;11447.427628618369;13838.031337806256;13909.165450073027;13996;13997.950153738713 12:45:22 INFO - PID 1642 | __end_tp_report 12:45:22 INFO - PID 1642 | __start_cc_report 12:45:22 INFO - PID 1642 | _x_x_mozilla_cycle_collect,424 12:45:22 INFO - PID 1642 | __end_cc_report 12:45:22 INFO - PID 1642 | __startTimestamp1491767122028__endTimestamp 12:45:22 INFO - PID 1642 | 12:45:22 INFO - PID 1642 | ------- Summary: start ------- 12:45:22 INFO - PID 1642 | Number of tests: 6 12:45:22 INFO - PID 1642 | 12:45:22 INFO - PID 1642 | [#0] dojo.html Cycles:165 Average:6137.13 Median:6345.78 stddev:766.12 (12.1%) stddev-sans-first:726.07 12:45:22 INFO - PID 1642 | Values: 2933.2 3340.0 3508.8 3544.2 3556.6 6102.4 6194.8 6218.6 6269.7 6303.9 6146.4 6181.0 6187.9 6221.7 6222.1 4717.9 5270.0 5508.0 5519.4 5633.6 5476.0 5537.4 5613.3 5622.8 5631.7 5440.7 5497.5 5537.4 5573.5 5647.9 5526.2 5532.8 5560.6 5566.0 5597.1 5463.7 5477.1 5480.6 5480.9 5494.2 5190.8 5401.0 5433.9 6152.6 6175.8 6722.5 6741.6 6746.3 6759.2 6770.8 6817.5 6822.4 6825.3 6844.9 6849.0 5245.4 6198.2 6213.7 6345.8 6377.9 5764.7 5856.3 6967.0 6981.8 7002.8 6435.3 6500.0 6581.7 6620.9 6656.8 6743.2 6797.9 6798.0 6798.1 6850.9 6502.3 6546.5 6703.7 6736.6 6740.6 5107.9 5560.9 6656.4 6761.2 6777.8 5395.8 5403.9 5407.6 5434.0 5456.9 4681.8 4790.0 4807.0 4826.3 4829.7 6131.8 6248.0 6308.8 6317.9 6369.2 6836.2 6839.7 6842.3 6859.4 6888.5 6241.6 6307.7 6312.4 6339.9 6360.7 5809.3 5815.0 5851.2 5885.5 5897.9 6082.5 6955.8 6963.8 6970.8 6974.1 6792.0 6803.3 6849.9 6859.3 6869.9 6870.9 6940.4 6959.2 6971.2 6984.9 6006.7 6225.4 6440.8 6530.3 6584.4 6492.9 6788.1 6817.2 6820.4 6824.2 6436.4 6447.9 6454.7 6528.8 6643.0 5499.0 6575.0 6611.6 6617.2 6631.5 6275.9 6343.5 6436.0 6442.2 6469.0 6532.2 6541.4 6574.5 6591.1 6639.7 5255.8 6422.9 6426.9 6458.3 6475.4 12:45:22 INFO - PID 1642 | 12:45:22 INFO - PID 1642 | [#1] ext.html Cycles:180 Average:44631.60 Median:325176.00 stddev:78490.30 (24.1%) stddev-sans-first:78641.52 12:45:22 INFO - PID 1642 | Values: 806.3 1244.7 1255.9 1259.0 1278.8 35972.0 36818.1 36870.6 36899.4 36992.3 36964.8 37340.0 37360.6 37467.4 37510.2 7781.6 8251.4 8466.4 8469.7 8481.9 8512.4 8595.5 8601.5 8617.8 8644.2 8573.2 8642.0 8644.5 8645.1 8647.0 8603.5 8629.0 8630.4 8631.5 8652.2 8324.4 8379.2 8381.7 8403.2 8448.8 36843.7 36928.4 37116.6 37129.8 37143.4 3617.5 3661.7 3667.4 3667.7 3674.2 30656.5 30695.2 30703.0 30703.7 30732.1 2929.0 3007.3 3200.2 3222.5 3236.4 236641.0 282869.0 284129.0 285368.0 286141.0 36857.8 38097.4 46800.6 46816.8 47122.0 48451.3 48580.0 49067.5 49113.0 49149.8 13062.3 14231.5 14383.0 14402.0 14406.1 11059.3 11647.8 11793.1 11816.1 11826.3 12992.4 13219.3 13241.7 13286.3 13331.7 5995.0 6006.2 6035.2 6050.0 6059.2 901.6 966.9 973.9 1037.6 1076.2 24277.6 24311.3 24331.5 24341.3 24419.9 1139.1 1142.3 1173.9 1175.2 1182.3 11979.6 12457.4 12468.2 12473.4 12502.6 322811.0 323638.8 324154.0 324841.0 325511.0 52951.7 52960.5 52960.9 53047.7 54347.5 1505.7 1557.3 1560.9 1567.7 1577.1 23206.8 23357.4 23365.9 23430.6 23469.5 36428.3 36946.0 37015.8 37020.9 37042.6 295511.0 295566.0 295769.0 295868.0 298251.0 32074.8 32864.5 33091.5 33233.8 33709.3 37358.0 44180.0 45155.8 45206.0 45289.5 28952.7 30017.4 30115.0 30748.8 31088.4 29996.0 30462.8 30812.8 30936.5 30989.0 35907.5 36149.1 36732.3 36885.3 36928.3 29849.0 30320.8 30361.7 30618.8 31214.0 22605.7 24136.6 24224.9 24272.9 24340.6 12:45:22 INFO - PID 1642 | 12:45:22 INFO - PID 1642 | [#2] jquery.html Cycles:180 Average:41878.65 Median:2240.52 stddev:121288.93 (5413.4%) stddev-sans-first:121589.24 12:45:22 INFO - PID 1642 | Values: 428.3 438.6 445.0 452.9 458.2 19792.8 21456.2 22139.4 22223.6 22324.7 18041.5 23128.7 23661.5 23968.5 24001.4 6203.7 6221.8 6427.5 6447.3 6476.3 5426.8 5871.2 5917.3 6201.5 6381.4 6103.0 6273.3 6302.8 6333.5 6339.1 6239.5 6239.9 6312.2 6320.8 6324.2 5371.4 5601.6 5613.8 5620.1 5641.1 23160.7 27657.7 27677.6 27753.6 27754.7 2181.8 2227.5 2239.8 2241.2 2248.7 17939.0 18157.5 18229.6 18335.6 18531.5 1711.6 2193.4 2225.0 2228.9 2233.3 159823.0 160492.0 163129.0 164213.9 164371.4 10020.9 12205.5 12339.0 12503.3 12546.6 16135.3 16167.9 16179.0 16180.0 16199.5 7659.6 8745.3 8895.2 9062.1 9219.9 8705.2 8720.3 8721.1 8887.7 8930.5 7767.6 7915.3 7955.6 7960.0 7965.6 2166.0 2171.2 2171.3 2172.4 2343.5 972.4 972.4 977.3 998.2 1016.6 20302.7 21245.8 21639.5 21781.3 22095.8 1026.8 1030.3 1036.0 1051.8 1057.3 9810.9 10016.7 10565.5 11379.9 11414.3 693918.0 709059.0 727424.0 732667.0 749904.0 107791.0 153420.9 166656.0 167622.0 167674.0 1114.5 1199.4 1199.5 1248.0 1250.3 18204.5 20921.8 21755.8 22926.5 23207.9 64966.0 65094.3 65894.3 66366.0 66751.3 69182.7 89576.0 94163.5 94806.0 94898.5 9097.1 9148.9 9201.0 9224.6 9267.1 12034.9 12145.0 13878.8 14589.1 14739.6 10670.6 11970.3 12016.5 12017.2 12253.1 11330.1 11450.3 11464.8 11669.6 11835.8 10742.9 12336.3 12400.3 12404.9 12584.6 8595.1 8903.6 9048.7 9252.9 9281.6 11323.0 11686.8 11800.3 11853.7 11940.8 12:45:22 INFO - PID 1642 | 12:45:22 INFO - PID 1642 | [#3] mootools.html Cycles:180 Average:7151.49 Median:2517.31 stddev:4534.87 (180.1%) stddev-sans-first:4527.21 12:45:22 INFO - PID 1642 | Values: 1430.6 1474.9 1476.4 1485.0 1494.2 11620.9 11995.7 12088.2 12114.7 12332.7 11943.3 12146.3 12152.5 12170.8 12182.1 2465.6 2516.6 2518.1 2520.0 2523.4 2417.3 2442.9 2477.8 2477.9 2481.9 2453.5 2459.6 2477.8 2492.3 2505.8 2452.4 2458.3 2474.8 2485.9 2493.5 2452.0 2465.9 2478.5 2478.7 2484.3 11776.2 11797.8 12032.6 12046.9 12058.0 6302.9 6450.1 6503.3 6510.0 6533.6 3952.2 4132.4 4179.0 4230.2 4246.2 1239.8 1260.8 1310.5 1310.6 1314.0 15086.2 15662.9 16499.8 16626.1 16643.8 5409.6 5481.6 5663.8 5700.3 5712.9 12339.3 12452.1 12454.3 12501.9 12538.9 6526.6 6527.3 6529.3 6531.8 6545.6 6064.8 6100.5 6154.6 6155.0 6220.4 3702.3 4420.1 4521.7 4545.5 4596.4 1283.4 1309.2 1313.8 1320.9 1324.9 779.9 798.6 811.7 812.7 830.8 6106.4 6109.0 6282.6 6334.9 6338.2 529.3 572.7 582.4 584.8 590.2 3763.9 3821.0 3831.7 3849.8 3910.7 11215.7 12860.5 13682.6 15183.9 15298.3 14968.6 15214.2 15219.2 15231.9 15426.0 10722.0 10915.5 11035.9 11037.1 11244.7 5724.9 6751.9 6951.0 6951.4 7010.8 11245.4 12122.2 12342.0 13565.9 13925.2 12960.7 13368.8 14037.1 14206.4 14240.6 9453.6 9616.2 9635.5 9645.5 9650.2 9207.0 10802.5 10933.2 10967.9 11059.8 8198.7 9241.2 9355.0 9409.8 9466.6 7597.4 9069.6 9222.3 9284.4 9285.2 8211.3 8290.2 8307.5 8365.6 8367.4 5649.2 6016.0 6046.9 6151.8 6200.0 6046.8 6116.7 6223.4 6276.0 6279.2 12:45:22 INFO - PID 1642 | 12:45:22 INFO - PID 1642 | [#4] prototype.html Cycles:180 Average:5317.72 Median:5931.11 stddev:1662.67 (28.0%) stddev-sans-first:1624.87 12:45:22 INFO - PID 1642 | Values: 343.7 369.2 381.8 390.3 405.4 5561.1 5756.3 5808.9 6186.4 6417.4 5825.3 6082.6 6220.3 6241.5 6276.8 4529.4 4531.4 4556.6 4562.7 4564.5 4550.3 4554.6 4570.8 4573.2 4597.5 4120.4 4291.8 4400.3 4536.3 4542.2 3731.4 4484.7 4506.3 4521.2 4527.0 3590.4 3884.4 3886.5 3900.5 3918.7 4673.6 5927.3 5989.9 6048.3 6070.0 4302.7 5365.8 5376.3 5408.4 5419.9 5791.7 6357.9 6600.9 6640.9 6666.2 4391.4 4421.9 4549.4 4745.0 4811.4 5975.8 6560.0 7023.1 7028.7 7151.9 3929.4 4830.0 4833.3 4850.7 4858.4 4100.3 4535.8 4954.5 4954.7 4992.4 4585.4 4928.4 5296.8 5463.3 5572.0 5591.0 6749.6 6753.4 6765.8 6835.7 1500.4 1680.8 1705.7 1706.2 1707.5 993.6 1099.5 1127.7 1134.7 1163.6 6232.9 6321.6 6327.1 6350.2 6362.1 6097.2 6859.2 6940.3 6965.8 6972.9 5592.6 6238.0 6321.6 6337.9 6340.9 2944.7 2958.3 3641.9 3652.9 3654.8 5956.8 7008.3 7151.2 7153.3 7156.4 5934.9 6905.0 7062.4 7068.2 7193.6 5595.3 5913.0 6937.7 7099.4 7149.1 5201.1 6169.3 6316.5 6972.3 6998.7 5729.8 5964.8 6224.6 6819.2 6873.2 6031.5 6353.7 6917.4 7049.6 7069.3 3923.9 3962.9 4467.6 4479.0 4482.5 6535.8 6729.4 6888.0 7015.6 7033.6 5103.0 6158.4 6200.9 6586.9 6801.9 6088.9 6754.3 6761.9 6778.4 6800.8 5286.7 5761.9 6531.5 6568.0 6573.3 5361.2 6136.8 6565.5 6700.8 6756.8 5972.8 5999.8 6213.6 6438.8 6481.2 12:45:22 INFO - PID 1642 | 12:45:22 INFO - PID 1642 | [#5] yui.html Cycles:180 Average:20779.53 Median:18155.95 stddev:28384.70 (156.3%) stddev-sans-first:28424.54 12:45:22 INFO - PID 1642 | Values: 764.3 831.2 849.5 851.9 867.8 14789.9 16281.8 16735.6 17989.7 18775.9 17756.3 17945.2 18150.9 18210.2 18652.5 989.6 1013.7 1014.3 1015.7 1016.2 1004.9 1021.3 1021.9 1025.3 1028.0 1070.0 1075.7 1082.4 1087.0 1088.1 1062.2 1070.1 1073.7 1075.0 1076.6 781.1 782.0 784.3 789.1 806.6 16803.9 16881.7 17036.6 17053.8 17086.2 16927.3 17218.4 17261.0 17382.5 17408.8 12175.8 13825.4 13882.8 13982.4 14099.1 3517.4 3578.1 3580.9 3587.1 3594.1 91798.6 121024.0 121395.8 122538.0 124151.4 13328.5 13463.9 13685.7 13697.9 13708.1 18410.0 20871.8 24969.1 25183.0 25339.7 8762.7 9068.1 9258.0 9278.5 9298.4 4848.7 4931.3 4958.3 4965.2 4993.2 3035.5 4237.6 4348.7 4350.7 4374.1 832.7 941.8 968.4 970.7 977.9 632.8 657.5 667.3 672.5 683.3 9209.3 9958.1 10570.4 11426.8 11910.8 640.0 656.8 682.7 684.1 693.6 4756.0 5120.5 5545.0 5575.9 5770.4 97882.0 98698.5 99375.0 100110.5 101720.0 65885.7 67758.9 90674.5 92028.0 92880.0 70371.0 72691.6 77479.6 77485.6 78644.2 10738.0 12049.0 12561.1 12584.2 12653.2 34414.3 38984.8 39339.4 40792.6 41375.4 49580.0 49874.8 49940.0 50127.7 50353.0 15905.1 15999.7 16420.0 16665.2 16783.3 17587.0 18161.0 18220.4 18395.0 18566.4 16476.3 16942.5 17269.1 17339.7 17422.6 14744.5 14746.9 14840.9 16382.4 16797.6 16024.4 16383.8 16601.2 16802.2 16814.5 11422.1 11651.5 11917.9 11949.3 12171.8 11447.4 13838.0 13909.2 13996.0 13998.0 12:45:22 INFO - PID 1642 | -------- Summary: end -------- 12:45:22 INFO - PID 1642 | 12:45:22 INFO - TEST-INFO | 1642: exit 0 12:45:22 INFO - TEST-OK | dromaeo_css | took 1116070ms 12:45:22 INFO - TEST-START | kraken 12:45:22 INFO - operating with platform_type : mac_ 12:45:22 INFO - Initialising browser for kraken test... 12:45:22 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/tmp1r7W3w/profile http://localhost:49248/getInfo.html) 12:45:25 INFO - PID 1654 | 2017-04-09 12:45:25.718 plugin-container[1655:10143] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 12:45:25 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:45:25 INFO - PID 1654 | 2017-04-09 12:45:25.723 plugin-container[1655:10143] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x901b, name = 'com.apple.CFPasteboardClient' 12:45:25 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:45:25 INFO - PID 1654 | 2017-04-09 12:45:25.723 plugin-container[1655:10143] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:45:25 INFO - PID 1654 | __metrics Screen width/height:1600/1200 12:45:25 INFO - PID 1654 | colorDepth:24 12:45:25 INFO - PID 1654 | Browser inner width/height: 1024/689 12:45:25 INFO - PID 1654 | __metrics 12:45:25 ERROR - PID 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 12:45:26 INFO - TEST-INFO | 1654: exit 0 12:45:26 INFO - Browser initialized. 12:45:26 INFO - Running cycle 1/1 for kraken test... 12:45:26 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/T/tmp1r7W3w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:45:29 INFO - PID 1656 | 2017-04-09 12:45:29.452 plugin-container[1657:10268] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a43, name = 'com.apple.tsm.portname' 12:45:29 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:45:29 INFO - PID 1656 | 2017-04-09 12:45:29.456 plugin-container[1657:10268] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x431f, name = 'com.apple.CFPasteboardClient' 12:45:29 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:45:29 INFO - PID 1656 | 2017-04-09 12:45:29.456 plugin-container[1657:10268] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:45:39 INFO - PID 1656 | RSS: Main: 234512384 12:45:39 INFO - PID 1656 | 12:45:41 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 12:45:42 INFO - PID 1656 | RSS: Main: 248352768 12:45:42 INFO - PID 1656 | 12:45:45 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 12:45:46 INFO - PID 1656 | RSS: Main: 257036288 12:45:46 INFO - PID 1656 | 12:45:49 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 12:45:50 INFO - PID 1656 | RSS: Main: 259186688 12:45:50 INFO - PID 1656 | 12:45:52 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 12:45:53 INFO - PID 1656 | RSS: Main: 261312512 12:45:53 INFO - PID 1656 | 12:45:55 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:45:55 INFO - PID 1656 | RSS: Main: 261640192 12:45:55 INFO - PID 1656 | 12:45:59 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 12:45:59 INFO - PID 1656 | RSS: Main: 267522048 12:45:59 INFO - PID 1656 | 12:46:03 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 12:46:03 INFO - PID 1656 | RSS: Main: 265846784 12:46:03 INFO - PID 1656 | 12:46:07 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 12:46:08 INFO - PID 1656 | RSS: Main: 266903552 12:46:08 INFO - PID 1656 | 12:46:09 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:46:10 INFO - PID 1656 | RSS: Main: 266772480 12:46:10 INFO - PID 1656 | 12:46:12 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:46:12 INFO - PID 1656 | RSS: Main: 266952704 12:46:12 INFO - PID 1656 | 12:46:15 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:46:15 INFO - PID 1656 | RSS: Main: 267120640 12:46:15 INFO - PID 1656 | 12:46:18 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:46:19 INFO - PID 1656 | RSS: Main: 267542528 12:46:19 INFO - PID 1656 | 12:46:22 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:46:23 INFO - PID 1656 | RSS: Main: 267165696 12:46:23 INFO - PID 1656 | 12:46:25 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 12:46:25 INFO - PID 1656 | RSS: Main: 270356480 12:46:25 INFO - PID 1656 | 12:46:25 INFO - PID 1656 | __start_tp_report 12:46:25 INFO - PID 1656 | _x_x_mozilla_page_load 12:46:25 INFO - PID 1656 | _x_x_mozilla_page_load_details 12:46:25 INFO - PID 1656 | |i|pagename|runs| 12:46:25 INFO - PID 1656 | |0;ai-astar;109;124;124;124;124;116;116;124;120;123 12:46:25 INFO - PID 1656 | |1;audio-beat-detection;194;153;141;155;119;117;115;116;147;117 12:46:25 INFO - PID 1656 | |2;audio-dft;214;221;216;231;240;222;231;229;262;293 12:46:25 INFO - PID 1656 | |3;audio-fft;76;59;55;112;87;53;79;87;102;88 12:46:25 INFO - PID 1656 | |4;audio-oscillator;105;72;72;95;57;75;117;104;57;73 12:46:25 INFO - PID 1656 | |5;imaging-gaussian-blur;93;92;98;132;88;80;79;79;103;95 12:46:25 INFO - PID 1656 | |6;imaging-darkroom;105;102;139;95;97;155;162;114;165;113 12:46:25 INFO - PID 1656 | |7;imaging-desaturate;101;126;126;97;162;162;101;104;151;117 12:46:25 INFO - PID 1656 | |8;json-parse-financial;53;53;51;54;53;53;46;67;64;47 12:46:25 INFO - PID 1656 | |9;json-stringify-tinderbox;54;57;64;89;96;83;51;65;63;55 12:46:25 INFO - PID 1656 | |10;stanford-crypto-aes;89;88;88;122;77;106;117;113;87;88 12:46:25 INFO - PID 1656 | |11;stanford-crypto-ccm;150;146;146;152;154;158;168;170;221;182 12:46:25 INFO - PID 1656 | |12;stanford-crypto-pbkdf2;199;198;199;195;195;197;196;235;255;207 12:46:25 INFO - PID 1656 | |13;stanford-crypto-sha256-iterative;72;72;73;72;71;70;72;73;71;76 12:46:25 INFO - PID 1656 | __end_tp_report 12:46:25 INFO - PID 1656 | __start_cc_report 12:46:25 INFO - PID 1656 | _x_x_mozilla_cycle_collect,1015 12:46:25 INFO - PID 1656 | __end_cc_report 12:46:25 INFO - PID 1656 | __startTimestamp1491767185593__endTimestamp 12:46:25 INFO - PID 1656 | 12:46:25 INFO - PID 1656 | ------- Summary: start ------- 12:46:25 INFO - PID 1656 | Number of tests: 14 12:46:25 INFO - PID 1656 | 12:46:25 INFO - PID 1656 | [#0] ai-astar Cycles:10 Average:120.40 Median:124.00 stddev:5.17 (4.2%) stddev-sans-first:3.46 12:46:25 INFO - PID 1656 | Values: 109.0 124.0 124.0 124.0 124.0 116.0 116.0 124.0 120.0 123.0 12:46:25 INFO - PID 1656 | 12:46:25 INFO - PID 1656 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:144.00 stddev:25.80 (17.9%) stddev-sans-first:17.44 12:46:25 INFO - PID 1656 | Values: 194.0 153.0 141.0 155.0 119.0 117.0 115.0 116.0 147.0 117.0 12:46:25 INFO - PID 1656 | 12:46:25 INFO - PID 1656 | [#2] audio-dft Cycles:10 Average:235.90 Median:231.00 stddev:24.37 (10.5%) stddev-sans-first:24.53 12:46:25 INFO - PID 1656 | Values: 214.0 221.0 216.0 231.0 240.0 222.0 231.0 229.0 262.0 293.0 12:46:25 INFO - PID 1656 | 12:46:25 INFO - PID 1656 | [#3] audio-fft Cycles:10 Average:79.80 Median:77.50 stddev:19.67 (25.4%) stddev-sans-first:20.81 12:46:25 INFO - PID 1656 | Values: 76.0 59.0 55.0 112.0 87.0 53.0 79.0 87.0 102.0 88.0 12:46:25 INFO - PID 1656 | 12:46:25 INFO - PID 1656 | [#4] audio-oscillator Cycles:10 Average:82.70 Median:72.00 stddev:21.03 (29.2%) stddev-sans-first:20.70 12:46:25 INFO - PID 1656 | Values: 105.0 72.0 72.0 95.0 57.0 75.0 117.0 104.0 57.0 73.0 12:46:25 INFO - PID 1656 | 12:46:25 INFO - PID 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:93.90 Median:90.00 stddev:15.74 (17.5%) stddev-sans-first:16.69 12:46:25 INFO - PID 1656 | Values: 93.0 92.0 98.0 132.0 88.0 80.0 79.0 79.0 103.0 95.0 12:46:25 INFO - PID 1656 | 12:46:25 INFO - PID 1656 | [#6] imaging-darkroom Cycles:10 Average:124.70 Median:158.50 stddev:27.77 (17.5%) stddev-sans-first:28.53 12:46:25 INFO - PID 1656 | Values: 105.0 102.0 139.0 95.0 97.0 155.0 162.0 114.0 165.0 113.0 12:46:25 INFO - PID 1656 | 12:46:25 INFO - PID 1656 | [#7] imaging-desaturate Cycles:10 Average:124.70 Median:138.50 stddev:25.51 (18.4%) stddev-sans-first:25.57 12:46:25 INFO - PID 1656 | Values: 101.0 126.0 126.0 97.0 162.0 162.0 101.0 104.0 151.0 117.0 12:46:25 INFO - PID 1656 | 12:46:25 INFO - PID 1656 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:53.00 stddev:6.62 (12.5%) stddev-sans-first:7.01 12:46:25 INFO - PID 1656 | Values: 53.0 53.0 51.0 54.0 53.0 53.0 46.0 67.0 64.0 47.0 12:46:25 INFO - PID 1656 | 12:46:25 INFO - PID 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:64.50 stddev:15.90 (24.6%) stddev-sans-first:16.07 12:46:25 INFO - PID 1656 | Values: 54.0 57.0 64.0 89.0 96.0 83.0 51.0 65.0 63.0 55.0 12:46:25 INFO - PID 1656 | 12:46:25 INFO - PID 1656 | [#10] stanford-crypto-aes Cycles:10 Average:97.50 Median:87.50 stddev:15.52 (17.7%) stddev-sans-first:16.15 12:46:25 INFO - PID 1656 | Values: 89.0 88.0 88.0 122.0 77.0 106.0 117.0 113.0 87.0 88.0 12:46:25 INFO - PID 1656 | 12:46:25 INFO - PID 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:164.70 Median:163.00 stddev:22.96 (14.1%) stddev-sans-first:23.73 12:46:25 INFO - PID 1656 | Values: 150.0 146.0 146.0 152.0 154.0 158.0 168.0 170.0 221.0 182.0 12:46:25 INFO - PID 1656 | 12:46:25 INFO - PID 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:207.60 Median:199.00 stddev:20.55 (10.3%) stddev-sans-first:21.56 12:46:25 INFO - PID 1656 | Values: 199.0 198.0 199.0 195.0 195.0 197.0 196.0 235.0 255.0 207.0 12:46:25 INFO - PID 1656 | 12:46:25 INFO - PID 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:72.00 stddev:1.62 (2.2%) stddev-sans-first:1.72 12:46:25 INFO - PID 1656 | Values: 72.0 72.0 73.0 72.0 71.0 70.0 72.0 73.0 71.0 76.0 12:46:25 INFO - PID 1656 | -------- Summary: end -------- 12:46:25 INFO - PID 1656 | 12:46:26 INFO - TEST-INFO | 1656: exit 0 12:46:26 INFO - TEST-OK | kraken | took 63965ms 12:46:26 INFO - SUITE-END | took 1180s 12:46:26 INFO - Completed test suite (00:19:40) 12:46:26 INFO - javascript benchmark 12:46:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7920.657831486068, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2933.222695985564, 3339.9980005998195, 3508.842102105404, 3544.1671207266304, 3556.5909920359168, 6102.398363691434, 6194.814155575329, 6218.626882387054, 6269.717862696179, 6303.905441418371, 6146.446819786218, 6181.0, 6187.938120618793, 6221.657808820513, 6222.12890195373, 4717.9056418871605, 5270.0, 5507.972460137694, 5519.365272993617, 5633.60564760467, 5475.972620136914, 5537.36320323164, 5613.270274864282, 5622.775088996435, 5631.662100273976, 5440.6735595864375, 5497.505224529771, 5537.390887002426, 5573.526250268732, 5647.943520564803, 5526.226328314039, 5532.806351777668, 5560.582956278255, 5565.972170139124, 5597.104463285855, 5463.726813659301, 5477.123660214386, 5480.561555075585, 5480.862978425532, 5494.1758736189495, 5190.806114593627, 5400.973814975142, 5433.918491222635, 6152.6308421494405, 6175.7529698811995, 6722.49581281401, 6741.629210393427, 6746.291639377893, 6759.155105611799, 6770.830729231809, 6817.5227734058635, 6822.4200942919915, 6825.283345248727, 6844.93155068448, 6849.0, 5245.370555533361, 6198.194234749454, 6213.720382582795, 6345.777897773556, 6377.872442551169, 5764.654120752768, 5856.326522449887, 6967.0, 6981.825454363681, 7002.7899163025195, 6435.324290949477, 6500.0, 6581.670916454158, 6620.9006864897065, 6656.83357916056, 6743.1908171019795, 6797.864042719217, 6798.04827324175, 6798.116244888231, 6850.897236541456, 6502.317256688074, 6546.541742078009, 6703.731850726014, 6736.629485378351, 6740.595564266159, 5107.8723031923755, 5560.86097847549, 6656.400923916871, 6761.154855643044, 6777.796666100025, 5395.81114660985, 5403.9459605403445, 5407.567394608422, 5433.972830135824, 5456.91814622781, 4681.812727490862, 4790.0, 4806.975965120152, 4826.32431459596, 4829.73436460991, 6131.754729810847, 6248.0, 6308.842278943063, 6317.936820631827, 6369.20384951881, 6836.248012718597, 6839.658017099126, 6842.315768423118, 6859.382655561023, 6888.521296745212, 6241.625502469867, 6307.653079080603, 6312.400321969406, 6339.873202535923, 6360.650164241011, 5809.2738407699035, 5814.982378083819, 5851.21008663825, 5885.47030767233, 5897.852553686193, 6082.482988945901, 6955.791326260221, 6963.791086267217, 6970.756023539152, 6974.093367862349, 6792.0, 6803.336997995207, 6849.931500684929, 6859.348361905611, 6869.931300687129, 6870.862582748417, 6940.375366217065, 6959.164900211805, 6971.163460384786, 6984.930150698428, 6006.669633170043, 6225.3774622537385, 6440.806775796734, 6530.346965303432, 6584.374484423972, 6492.870142597216, 6788.083608712761, 6817.216020157745, 6820.3861652451515, 6824.18109826824, 6436.356364363526, 6447.871042579216, 6454.709538070704, 6528.804135875931, 6643.036759669917, 5499.0, 6575.046618240424, 6611.636360000246, 6617.239017513048, 6631.535792494479, 6275.874482510233, 6343.524235682435, 6436.0, 6442.162518872704, 6469.0, 6532.183477065367, 6541.411272985454, 6574.539782215199, 6591.077249185214, 6639.734410623521, 5255.842324730264, 6422.871542569216, 6426.903596445964, 6458.289588145206, 6475.352464753487], "value": 6085.534807360395, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [806.3388021822107, 1244.676384140124, 1255.869717254471, 1259.0, 1278.7506436244937, 35972.0, 36818.07954801128, 36870.63129368705, 36899.4465083024, 36992.26015479689, 36964.81517592415, 37340.0, 37360.626393736056, 37467.437988430196, 37510.249795004085, 7781.610919454033, 8251.422400431971, 8466.449680770731, 8469.66121355145, 8481.915180848175, 8512.446690965067, 8595.484270943733, 8601.483910965331, 8617.784555386103, 8644.178803013703, 8573.228409443149, 8641.95679021604, 8644.524551149685, 8645.135486451367, 8646.956765216197, 8603.526806025666, 8628.956855215747, 8630.395872288942, 8631.482111073356, 8652.178043085896, 8324.375671824637, 8379.203975622306, 8381.706640267623, 8403.243708066242, 8448.83102337956, 36843.71047013369, 36928.44607330892, 37116.62883371186, 37129.81435092807, 37143.4428483573, 3617.475466057433, 3661.743677942545, 3667.413213885792, 3667.743257971943, 3674.173311005029, 30656.540151897738, 30695.232619184477, 30703.0, 30703.69296307053, 30732.078037658906, 2929.0480593807097, 3007.3083190866223, 3200.2159470929773, 3222.516622506619, 3236.449803533405, 236640.99999999828, 282869.0, 284129.0, 285368.0, 286141.0, 36857.81571092181, 38097.42853857194, 46800.59598212059, 46816.7659161702, 47122.0, 48451.27323090156, 48580.0, 49067.509324907005, 49113.01773964501, 49149.75425122923, 13062.34688265602, 14231.50189743354, 14382.993190476565, 14402.0, 14406.063605865585, 11059.336439813636, 11647.825282620768, 11793.056555475541, 11816.113791465674, 11826.349550774617, 12992.415341309665, 13219.272939988394, 13241.73516529664, 13286.3356832158, 13331.733365332639, 5994.9700251499335, 6006.2191915051635, 6035.185249991283, 6049.969750151221, 6059.21230240066, 901.5717534171216, 966.8694726212012, 973.9043575977025, 1037.6160820496464, 1076.2036093291065, 24277.635835462483, 24311.27066188017, 24331.513369732507, 24341.26976190717, 24419.87790061074, 1139.145640769423, 1142.3203194099497, 1173.9119566032582, 1175.18324764288, 1182.3142577305143, 11979.585818041991, 12457.377131143407, 12468.189567678071, 12473.376331183405, 12502.562410315777, 322811.0, 323638.7636123656, 324154.0, 324841.0, 325511.0, 52951.73524132355, 52960.470395296325, 52960.94078118416, 53047.73476132672, 54347.45652543424, 1505.7139143562688, 1557.322564684366, 1560.9063456192664, 1567.6551158745058, 1577.1246957938454, 23206.76793232046, 23357.41606459852, 23365.948532315746, 23430.64854027157, 23469.530609387377, 36428.27143457063, 36946.0, 37015.81492092522, 37020.889373318845, 37042.629573704995, 295511.0, 295566.0, 295769.04230957414, 295868.0, 298251.0, 32074.839625802655, 32864.50703239501, 33091.50362744513, 33233.83681571134, 33709.325813483105, 37358.0, 44180.0, 45155.77422112868, 45206.0, 45289.54710452853, 28952.710472895, 30017.3996520064, 30115.0, 30748.770049198676, 31088.378232434774, 29996.0, 30462.84768576143, 30812.840266563726, 30936.53595196029, 30989.0, 35907.46138807972, 36149.09627259339, 36732.26535469329, 36885.26229475449, 36928.26143477062, 29848.955286564866, 30320.848395758763, 30361.69638303677, 30618.846905765327, 31214.0, 22605.747899997375, 24136.637950430406, 24224.878875606213, 24272.87863560671, 24340.634890476304], "value": 17523.45075772998, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.3189728331956, 438.5548668101876, 444.9565768273398, 452.87772301478594, 458.1592777253741, 19792.802071979277, 21456.24903128389, 22139.446513837163, 22223.555528889454, 22324.66513002304, 18041.4587562373, 23128.65307020392, 23661.5267694646, 23968.52062958744, 24001.399965000885, 6203.658798766066, 6221.813345599628, 6427.485801135921, 6447.323031081739, 6476.255230648465, 5426.782928682848, 5871.236739223917, 5917.349091599921, 6201.534884883629, 6381.425671689547, 6102.96948515259, 6273.278572964122, 6302.810915672514, 6333.49332053437, 6339.11252424661, 6239.532035097363, 6239.937600623981, 6312.179416675849, 6320.778772742932, 6324.241091069055, 5371.3822910365025, 5601.551875849922, 5613.831585052455, 5620.1288800236025, 5641.069223578104, 23160.65259021116, 27657.723422765717, 27677.584836227474, 27753.583696244572, 27754.722452775415, 2181.8472706910525, 2227.4988127671145, 2239.8432109752325, 2241.1931704586336, 2248.6739422783767, 17939.0, 18157.45527634173, 18229.635407291913, 18335.633287334313, 18531.49824773652, 1711.563551294412, 2193.396815875631, 2224.9666255006186, 2228.944276393087, 2233.2741858895924, 159823.0, 160492.0, 163129.0, 164213.93646698853, 164371.3562864368, 10020.899791002143, 12205.450754715881, 12338.951189148844, 12503.312317822607, 12546.623601291976, 16135.273912673723, 16167.919160404357, 16179.0, 16180.0, 16199.514014579581, 7659.61701914902, 8745.330259915654, 8895.24390426808, 9062.139096785795, 9219.90780092204, 8705.216530512158, 8720.345974051972, 8721.084286149862, 8887.73336799897, 8930.464172149692, 7767.611619419006, 7915.327197188303, 7955.647539918228, 7959.9602001989615, 7965.561894095765, 2165.989170054171, 2171.185805323004, 2171.272623671088, 2172.435166856597, 2343.5398212453033, 972.3582435592475, 972.4116909269932, 977.3451787302524, 998.226374559722, 1016.6441745389054, 20302.69545956812, 21245.78754212469, 21639.459013524473, 21781.25749940001, 22095.784731839583, 1026.8294144675076, 1030.2891005206384, 1035.9896401035894, 1051.8211903976342, 1057.259918057363, 9810.901890981142, 10016.699499015042, 10565.520827084214, 11379.943100284445, 11414.315141091562, 693918.0, 709059.0, 727424.0, 732667.0, 749904.0, 107791.0, 153420.93158136774, 166656.0, 167622.0, 167674.0, 1114.5318966034285, 1199.400299850075, 1199.4662375242933, 1248.0078337721534, 1250.2810883741886, 18204.544886377946, 20921.790782091983, 21755.782442175376, 22926.541469170857, 23207.88396058009, 64966.02550961834, 65094.34905650883, 65894.34105659074, 66366.0, 66751.33248667451, 69182.65408672925, 89576.0, 94163.52918235365, 94806.0, 94898.52550737202, 9097.13577210164, 9148.862767058632, 9200.95399523025, 9224.584893679666, 9267.073292670679, 12034.879651203375, 12145.0, 13878.791818122534, 14589.124652520883, 14739.631509211926, 10670.62652807148, 11970.281783093042, 12016.459259333176, 12017.21888077307, 12253.142280040312, 11330.093592512743, 11450.312981221154, 11464.770704586028, 11669.649910502698, 11835.763284734428, 10742.892571074502, 12336.259824410565, 12400.31798251105, 12404.875951240732, 12584.622461326175, 8595.140485951355, 8903.554822258731, 9048.683296084606, 9252.861207082035, 9281.628734850801, 11323.0, 11686.766264674829, 11800.291982481078, 11853.703657408634, 11940.761184776082], "value": 10772.747227119607, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1430.5565274764822, 1474.8525147485252, 1476.4463326252655, 1484.9925750371247, 1494.1931357067185, 11620.883791162096, 11995.700107497318, 12088.153829231946, 12114.69713257169, 12332.691682707937, 11943.283402995827, 12146.271223726582, 12152.513899444011, 12170.756584868297, 12182.147249692503, 2465.6424818401274, 2516.55960206964, 2518.055729101587, 2520.0171932946164, 2523.3691577105724, 2417.3352328109736, 2442.926712198637, 2477.752224777526, 2477.913273035444, 2481.9079604973754, 2453.521563295158, 2459.5695753243112, 2477.752224777526, 2492.302155396492, 2505.799536037122, 2452.4359397338535, 2458.2748089313695, 2474.7772700456953, 2485.9005639774387, 2493.463905260378, 2451.9877400613063, 2465.8520488770732, 2478.529079474912, 2478.6529885816, 2484.2671411933343, 11776.175667703264, 11797.823032654516, 12032.639020829389, 12046.879531204751, 12057.975072118881, 6302.905456418157, 6450.064980505829, 6503.317151699098, 6509.967450162719, 6533.575317604388, 3952.170044290702, 4132.359484279941, 4178.955261184704, 4230.238557059728, 4246.150769846043, 1239.8140278958138, 1260.848698156218, 1310.4627102887866, 1310.6264714556305, 1314.0407502523117, 15086.170260635661, 15662.921685391613, 16499.83500164995, 16626.085565293903, 16643.750343744854, 5409.648372855751, 5481.561475081984, 5663.830085097454, 5700.315962084494, 5712.857178570569, 12339.321337326353, 12452.066095042908, 12454.31501267439, 12501.874981250254, 12538.87461125377, 6526.575772574767, 6527.314631963671, 6529.347065293433, 6531.8367040823405, 6545.639989800607, 6064.818055458343, 6100.450959413585, 6154.569180157436, 6154.969225153845, 6220.440160385587, 3702.278055779151, 4420.092028978559, 4521.728696278234, 4545.4545454545005, 4596.4024676791805, 1283.3839756916545, 1309.18830325199, 1313.8029295605545, 1320.9273489957952, 1324.8542660307357, 779.8596252674573, 798.5785302162161, 811.6550466051905, 812.7033632724132, 830.8379865926087, 6106.358832322631, 6109.022556390956, 6282.623042617458, 6334.873302533923, 6338.176037115146, 529.3224672419309, 572.6564061563029, 582.3535875178549, 584.7894757887158, 590.1884908251154, 3763.8682646107804, 3821.0, 3831.65515103642, 3849.7882616455804, 3910.745801522949, 11215.66353009411, 12860.485580576673, 13682.589522314347, 15183.937124401407, 15298.311575979107, 14968.625784355478, 15214.239288035775, 15219.239038048274, 15231.923840380949, 15426.0, 10722.0, 10915.508802103925, 11035.889641103648, 11037.0618497427, 11244.66266012021, 5724.856878578069, 6751.932480675327, 6950.965245173742, 6951.374376306157, 7010.808162612266, 11245.381504017358, 12122.212056216318, 12342.01263898868, 13565.86434135646, 13925.164490130219, 12960.740785184433, 13368.799468007794, 14037.087589306662, 14206.360713767699, 14240.572782816533, 9453.574589143367, 9616.23070154372, 9635.518224088908, 9645.517724113626, 9650.179734722627, 9206.953965230132, 10802.459877005962, 10933.234673573092, 10967.945160274467, 11059.834102488308, 8198.713045043394, 9241.168294853496, 9354.953225234103, 9409.764755880884, 9466.574004169692, 7597.392208623407, 9069.591868366071, 9222.308326875376, 9284.396514226553, 9285.164335209864, 8211.260986511243, 8290.170982901904, 8307.543085130133, 8365.62354694028, 8367.372447066373, 5649.152627105967, 6016.0, 6046.879062418815, 6151.784687535915, 6199.969000154971, 6046.788362407295, 6116.694165291807, 6223.439890409885, 6275.995840665471, 6279.152314437675], "value": 5343.5208756587335, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.6769436729474, 369.2301551265611, 381.8052793075532, 390.27798572640603, 405.39393606558184, 5561.138023606338, 5756.338021127572, 5808.896309701159, 6186.350433204516, 6417.390347916947, 5825.310659908621, 6082.604630699001, 6220.346863579315, 6241.500679945605, 6276.811695649127, 4529.365888775574, 4531.365608814768, 4556.567126123013, 4562.726236425825, 4564.520725323843, 4550.271956486963, 4554.567316104964, 4570.79431425585, 4573.199690054244, 4597.471290801551, 4120.423140760296, 4291.8497852575165, 4400.295952647577, 4536.342230376594, 4542.15970045541, 3731.440283957401, 4484.686071974963, 4506.346579745951, 4521.174266083714, 4527.0, 3590.389633762267, 3884.3590807516725, 3886.4753258310047, 3900.5124359455067, 3918.745281556718, 4673.6027437667835, 5927.318358388798, 5989.850253743692, 6048.274207095133, 6070.0, 4302.741835489849, 5365.785368585291, 5376.301080859503, 5408.35099788024, 5419.888922770822, 5791.652500849962, 6357.904631430532, 6600.93399066008, 6640.900386494206, 6666.200055993263, 4391.385206071152, 4421.916630425534, 4549.4068381022835, 4744.976275118603, 4811.367417599725, 5975.820725378246, 6560.047978409735, 7023.051887995106, 7028.718851245995, 7151.89272160918, 3929.3713005918917, 4829.96155826499, 4833.32333473314, 4850.660453768273, 4858.392700912386, 4100.302948498763, 4535.750533720677, 4954.504549545017, 4954.677945933503, 4992.425871024879, 4585.403897493305, 4928.359313289249, 5296.814611488579, 5463.262459567987, 5572.0, 5591.049521581341, 6749.59502429846, 6753.358430949052, 6765.830854228684, 6835.69239384219, 1500.3698446652213, 1680.8151103378618, 1705.7356109803, 1706.2407228783072, 1707.5048236011417, 993.5926270229171, 1099.4722533184117, 1127.7462570921477, 1134.6766171641043, 1163.633455461544, 6232.875342493125, 6321.589096708791, 6327.145835312174, 6350.206224221973, 6362.141110950055, 6097.207363042865, 6859.176898772179, 6940.271271516418, 6965.79102626922, 6972.860542789217, 5592.552595792326, 6237.96881015592, 6321.55749097568, 6337.873242535124, 6340.936590634127, 2944.661363943131, 2958.3195864950753, 3641.8543258269374, 3652.872149474809, 3654.780713157219, 5956.791512297135, 7008.301803805572, 7151.177614574286, 7153.320434558708, 7156.354038571158, 5934.902043122036, 6905.0, 7062.435005199572, 7068.187158476738, 7193.604351760599, 5595.300587426572, 5912.970435147883, 6937.68780404883, 7099.361057504952, 7149.139464689009, 5201.089809283285, 6169.259688837368, 6316.494680425463, 6972.267911869383, 6998.685059172248, 5729.825385795985, 5964.777220669665, 6224.564280500503, 6819.215790184192, 6873.20958089826, 6031.5476339273855, 6353.682315884095, 6917.37743603058, 7049.577025378494, 7069.293070692889, 3923.8822835314986, 3962.9498182980956, 4467.620252278462, 4479.006841955299, 4482.529334419839, 6535.823551760729, 6729.394354508117, 6887.965560172167, 7015.649217539, 7033.577985320897, 5103.0, 6158.353372895782, 6200.937990620036, 6586.934130658632, 6801.8639627206185, 6088.939110608837, 6754.2570317266045, 6761.870010946536, 6778.389944904982, 6800.795976120724, 5286.656367336111, 5761.8559536011935, 6531.542792004704, 6567.9671601641685, 6573.309802470863, 5361.169018802092, 6136.7726454708345, 6565.540412171103, 6700.773396750543, 6756.831079223059, 5972.820815375546, 5999.820005399845, 6213.565050446426, 6438.806835794933, 6481.222253329631], "value": 4807.4596520287, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [764.3159372361737, 831.1688311688312, 849.4521033933113, 851.944623599466, 867.8264347130576, 14789.926050369746, 16281.83718162818, 16735.58161045973, 17989.7301540477, 18775.90612046941, 17756.289748410047, 17945.192466339013, 18150.909245453753, 18210.180541875616, 18652.53368665784, 989.579428742785, 1013.6705570689519, 1014.3406785589389, 1015.7105225010873, 1016.207358260558, 1004.8743907011624, 1021.3361315145178, 1021.8927012663675, 1025.3130402630218, 1027.9537420816043, 1070.0155856611937, 1075.67192006438, 1082.431723345242, 1087.0053900680869, 1088.1294964028746, 1062.2033474893828, 1070.0631856340049, 1073.726199819045, 1075.0109898893038, 1076.5962763963553, 781.1407451803028, 782.0459039971227, 784.2510402565593, 789.0728394136867, 806.6410447350931, 16803.91598042014, 16881.662366752596, 17036.574085647957, 17053.82946170547, 17086.231119599648, 16927.3229070837, 17218.397356092602, 17261.0, 17382.478525644252, 17408.825911740973, 12175.817362739566, 13825.377857996415, 13882.791758123636, 13982.370793314325, 14099.083559568595, 3517.437210046406, 3578.1054736315923, 3580.9283814323826, 3587.0673624857723, 3594.137407022322, 91798.62302065408, 121024.0, 121395.78604213933, 122538.0, 124151.3792431032, 13328.533501327602, 13463.932680336535, 13685.726285474235, 13697.863021369858, 13708.108972916729, 18410.0, 20871.791282086986, 24969.12608058709, 25183.0, 25339.746602533738, 8762.737117886474, 9068.138526839939, 9258.027907069796, 9278.489683067495, 9298.395604285699, 4848.733319667452, 4931.309616653672, 4958.281049247839, 4965.205567109245, 4993.226049962262, 3035.4991426414394, 4237.576242375738, 4348.717333373321, 4350.71720338177, 4374.081442896963, 832.7168762620738, 941.750436134425, 968.41894863083, 970.6554173268388, 977.9070988256104, 632.8354627796806, 657.4871600151794, 667.3260007392569, 672.458670770025, 683.3200965039817, 9209.263258939403, 9958.053984871425, 10570.365778053341, 11426.771464570662, 11910.821337679941, 639.972843586047, 656.7504348347597, 682.6791408038214, 684.0833283400268, 693.5665209244222, 4755.953690188222, 5120.462351453119, 5544.972275138599, 5575.944240557624, 5770.365259821417, 97882.0, 98698.50650746844, 99375.0, 100110.49944750375, 101719.98280017253, 65885.67057164683, 67758.90169884734, 90674.54662726643, 92028.0, 92880.0, 70371.0, 72691.63654181696, 77479.61260193663, 77485.61257193678, 78644.23725847954, 10738.0, 12049.0, 12561.05792065617, 12584.18202816814, 12653.240805551697, 34414.31171376609, 38984.80507597444, 39339.409908850816, 40792.59207407888, 41375.37936930888, 49580.0, 49874.750626246634, 49940.0, 50127.746806330135, 50353.0, 15905.125218113115, 15999.68000640004, 16420.0, 16665.16674166311, 16783.32866685368, 17587.0, 18161.0, 18220.36228731988, 18394.98827564497, 18566.443006709822, 16476.258568364214, 16942.491725248263, 17269.050202239, 17339.739903901198, 17422.606191504903, 14744.48394306237, 14746.926265368604, 14840.925795370955, 16382.426615068416, 16797.580060498585, 16024.439144629881, 16383.836161638232, 16601.169941502634, 16802.24389902482, 16814.495565133064, 11422.086233101498, 11651.475683594428, 11917.880821192024, 11949.283043017447, 12171.756564868476, 11447.427628618369, 13838.031337806256, 13909.165450073027, 13996.0, 13997.950153738713], "value": 8366.590455706615, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1663.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 124.0, 124.0, 124.0, 124.0, 116.0, 116.0, 124.0, 120.0, 123.0], "value": 120.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 153.0, 141.0, 155.0, 119.0, 117.0, 115.0, 116.0, 147.0, 117.0], "value": 137.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [214.0, 221.0, 216.0, 231.0, 240.0, 222.0, 231.0, 229.0, 262.0, 293.0], "value": 235.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 59.0, 55.0, 112.0, 87.0, 53.0, 79.0, 87.0, 102.0, 88.0], "value": 79.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 72.0, 72.0, 95.0, 57.0, 75.0, 117.0, 104.0, 57.0, 73.0], "value": 82.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 98.0, 132.0, 88.0, 80.0, 79.0, 79.0, 103.0, 95.0], "value": 93.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 102.0, 139.0, 95.0, 97.0, 155.0, 162.0, 114.0, 165.0, 113.0], "value": 124.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 126.0, 126.0, 97.0, 162.0, 162.0, 101.0, 104.0, 151.0, 117.0], "value": 124.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 51.0, 54.0, 53.0, 53.0, 46.0, 67.0, 64.0, 47.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 64.0, 89.0, 96.0, 83.0, 51.0, 65.0, 63.0, 55.0], "value": 67.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 88.0, 122.0, 77.0, 106.0, 117.0, 113.0, 87.0, 88.0], "value": 97.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 146.0, 146.0, 152.0, 154.0, 158.0, 168.0, 170.0, 221.0, 182.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 198.0, 199.0, 195.0, 195.0, 197.0, 196.0, 235.0, 255.0, 207.0], "value": 207.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 73.0, 72.0, 71.0, 70.0, 72.0, 73.0, 71.0, 76.0], "value": 72.2, "unit": "score"}]}]} 12:46:26 INFO - Return code: 0 12:46:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:46:26 ERROR - # TBPL SUCCESS # 12:46:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:46:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:46:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:46:26 INFO - 2017-04-09 12:46:26.897 screenresolution[1661:10652] starting screenresolution argv=screenresolution get 12:46:26 INFO - 2017-04-09 12:46:26.900 screenresolution[1661:10652] Display 0: 1600x1200x32@60 12:46:26 INFO - 2017-04-09 12:46:26.906 screenresolution[1662:10655] starting screenresolution argv=screenresolution list 12:46:26 INFO - Available Modes on Display 0 12:46:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:46:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:46:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:46:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:46:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:46:27 INFO - Intel Iris: 12:46:27 INFO - Chipset Model: Intel Iris 12:46:27 INFO - Type: GPU 12:46:27 INFO - Bus: Built-In 12:46:27 INFO - VRAM (Dynamic, Max): 1536 MB 12:46:27 INFO - Vendor: Intel (0x8086) 12:46:27 INFO - Device ID: 0x0a2e 12:46:27 INFO - Revision ID: 0x0009 12:46:27 INFO - Displays: 12:46:27 INFO - Display: 12:46:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:46:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:46:27 INFO - Display Serial Number: 1600x1200 60 12:46:27 INFO - Main Display: Yes 12:46:27 INFO - Mirror: Off 12:46:27 INFO - Online: Yes 12:46:27 INFO - Rotation: Supported 12:46:27 INFO - Return code: 0 12:46:27 INFO - Running post-action listener: _resource_record_post_action 12:46:27 INFO - [mozharness: 2017-04-09 19:46:27.154653Z] Finished run-tests step (success) 12:46:27 INFO - Running post-run listener: _resource_record_post_run 12:46:27 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 38869504; Write bytes: 518384640; Read time: 405; Write time: 1583 12:46:27 INFO - TinderboxPrint: CPU usage
54.1% 12:46:27 INFO - TinderboxPrint: I/O read bytes / time
38,869,504 / 405 12:46:27 INFO - TinderboxPrint: I/O write bytes / time
518,384,640 / 1,583 12:46:27 INFO - TinderboxPrint: CPU idle
2,203.1 (45.9%) 12:46:27 INFO - TinderboxPrint: CPU system
964.2 (20.1%) 12:46:27 INFO - TinderboxPrint: CPU user
1,634.4 (34.0%) 12:46:27 INFO - TinderboxPrint: Swap in / out
245,219,328 / 0 12:46:27 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 194232832; Write bytes: 194217984; Read time: 14952; Write time: 416 12:46:27 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 37825024; Write bytes: 307319808; Read time: 387; Write time: 1118 12:46:27 INFO - Running post-run listener: _upload_blobber_files 12:46:27 INFO - Blob upload gear active. 12:46:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:46:27 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 12:46:27 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'] 12:46:27 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 12:46:28 INFO - (blobuploader) - INFO - Open directory for files ... 12:46:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:46:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:46:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:46:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:46:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:46:29 INFO - (blobuploader) - INFO - Done attempting. 12:46:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:46:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:46:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:46:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:46:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:46:29 INFO - (blobuploader) - INFO - Done attempting. 12:46:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:46:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:46:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:46:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:46:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:46:31 INFO - (blobuploader) - INFO - Done attempting. 12:46:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:46:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:46:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:46:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:46:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:46:32 INFO - (blobuploader) - INFO - Done attempting. 12:46:32 INFO - (blobuploader) - INFO - Iteration through files over. 12:46:32 INFO - Return code: 0 12:46:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:46:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:46:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/066ee604efe28d3d10cf6727e439ecaa18277df060d1cc26dcb8ac1ac7cbc09460c6bded48c03f4f330d1fd6ff57989af536218d89ea15623d54434ca4c055f7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33c872d7fb847b5ddf7ba22c44ca2a6f0a8515fc9fd68496c7f66e6880861e9cdcbd7c62de4bcb1907831cd8686d884cee9c3ee440087757a81102c4c81d6eb6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c927ddde6f0011a26aa7e8665d9ce565031ea064b5ba5d64ed7cd9a3cc8a2876ff9f17b86afe4b6271ff88b3a3a8c640ac93d4f92364f5d3d402939c2b70e43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e4fdd1ee886f38201529054ecf61d918bec25742875ad000d31c72c02106d55f379e154de5f00fb4e5b0a8a3631427312715c399b8e545cefa88ae4ac30bce9"} 12:46:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:46:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:46:32 INFO - Contents: 12:46:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/066ee604efe28d3d10cf6727e439ecaa18277df060d1cc26dcb8ac1ac7cbc09460c6bded48c03f4f330d1fd6ff57989af536218d89ea15623d54434ca4c055f7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33c872d7fb847b5ddf7ba22c44ca2a6f0a8515fc9fd68496c7f66e6880861e9cdcbd7c62de4bcb1907831cd8686d884cee9c3ee440087757a81102c4c81d6eb6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c927ddde6f0011a26aa7e8665d9ce565031ea064b5ba5d64ed7cd9a3cc8a2876ff9f17b86afe4b6271ff88b3a3a8c640ac93d4f92364f5d3d402939c2b70e43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e4fdd1ee886f38201529054ecf61d918bec25742875ad000d31c72c02106d55f379e154de5f00fb4e5b0a8a3631427312715c399b8e545cefa88ae4ac30bce9"} 12:46:32 INFO - Running post-run listener: copy_logs_to_upload_dir 12:46:32 INFO - Copying logs to upload dir... 12:46:32 INFO - mkdir: /builds/slave/test/build/upload/logs 12:46:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.729662 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-09 12:46:32.967859) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-09 12:46:32.971936) ========= 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.4xeFFCxD3r/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.XWq3bM49nb/Listeners TMPDIR=/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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/066ee604efe28d3d10cf6727e439ecaa18277df060d1cc26dcb8ac1ac7cbc09460c6bded48c03f4f330d1fd6ff57989af536218d89ea15623d54434ca4c055f7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33c872d7fb847b5ddf7ba22c44ca2a6f0a8515fc9fd68496c7f66e6880861e9cdcbd7c62de4bcb1907831cd8686d884cee9c3ee440087757a81102c4c81d6eb6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c927ddde6f0011a26aa7e8665d9ce565031ea064b5ba5d64ed7cd9a3cc8a2876ff9f17b86afe4b6271ff88b3a3a8c640ac93d4f92364f5d3d402939c2b70e43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e4fdd1ee886f38201529054ecf61d918bec25742875ad000d31c72c02106d55f379e154de5f00fb4e5b0a8a3631427312715c399b8e545cefa88ae4ac30bce9"} build_url:https://queue.taskcluster.net/v1/task/F6i18v5cTHauZ9m_-wyysg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011084 build_url: 'https://queue.taskcluster.net/v1/task/F6i18v5cTHauZ9m_-wyysg/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/066ee604efe28d3d10cf6727e439ecaa18277df060d1cc26dcb8ac1ac7cbc09460c6bded48c03f4f330d1fd6ff57989af536218d89ea15623d54434ca4c055f7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33c872d7fb847b5ddf7ba22c44ca2a6f0a8515fc9fd68496c7f66e6880861e9cdcbd7c62de4bcb1907831cd8686d884cee9c3ee440087757a81102c4c81d6eb6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c927ddde6f0011a26aa7e8665d9ce565031ea064b5ba5d64ed7cd9a3cc8a2876ff9f17b86afe4b6271ff88b3a3a8c640ac93d4f92364f5d3d402939c2b70e43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9e4fdd1ee886f38201529054ecf61d918bec25742875ad000d31c72c02106d55f379e154de5f00fb4e5b0a8a3631427312715c399b8e545cefa88ae4ac30bce9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-09 12:46:33.007073) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 12:46:33.007415) ========= 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.4xeFFCxD3r/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.XWq3bM49nb/Listeners TMPDIR=/var/folders/_b/g35s3zjn6ljbjq1c44x2r50w00000w/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.005264 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 12:46:33.056529) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-09 12:46:33.056842) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-09 12:46:33.057291) ========= ========= Total master_lag: 0.18 =========