builder: pine_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0299 starttime: 1493350716.55 results: success (0) buildid: 20170427113225 builduid: 4be79eac2d4f4fe3b156a4752812ee67 revision: 720f68335aeed63d96f86be7b3f90aba8bbc1f6a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-27 20:38:36.554818) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-27 20:38:36.555229) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-27 20:38:36.555519) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-27 20:38:36.602911) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 20:38:36.603285) ========= 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.9xh7wTDHbr/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.OvmINPcrGo/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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-27 20:38:36-- 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% 20.2M=0.001s 2017-04-27 20:38:36 (20.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.082598 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 20:38:36.713419) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 20:38:36.716845) ========= 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.9xh7wTDHbr/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.OvmINPcrGo/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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.021604 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 20:38:36.765629) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-27 20:38:36.766075) ========= bash -c 'python archiver_client.py mozharness --repo projects/pine --rev 720f68335aeed63d96f86be7b3f90aba8bbc1f6a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/pine --rev 720f68335aeed63d96f86be7b3f90aba8bbc1f6a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9xh7wTDHbr/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.OvmINPcrGo/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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-27 20:38:36,860 truncating revision to first 12 chars 2017-04-27 20:38:36,860 Setting DEBUG logging. 2017-04-27 20:38:36,860 attempt 1/10 2017-04-27 20:38:36,860 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/pine/720f68335aee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-27 20:38:38,100 unpacking tar archive at: pine-720f68335aee/testing/mozharness/ program finished with exit code 0 elapsedTime=1.513419 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-27 20:38:38.304673) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-27 20:38:38.304997) ========= script_repo_revision: 720f68335aeed63d96f86be7b3f90aba8bbc1f6a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-27 20:38:38.305428) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-27 20:38:38.305714) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-27 20:38:38.326779) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-27 20:38:38.327075) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 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', 'Pine', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Pine'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9xh7wTDHbr/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.OvmINPcrGo/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 20:38:38 INFO - MultiFileLogger online at 20170427 20:38:38 in /builds/slave/test 20:38:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 20:38:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:38:38 INFO - {'append_to_log': False, 20:38:38 INFO - 'base_work_dir': '/builds/slave/test', 20:38:38 INFO - 'blob_upload_branch': 'Pine', 20:38:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:38:38 INFO - 'branch': 'Pine', 20:38:38 INFO - 'buildbot_json_path': 'buildprops.json', 20:38:38 INFO - 'config_files': ('talos/mac_config.py',), 20:38:38 INFO - 'default_actions': ('clobber', 20:38:38 INFO - 'read-buildbot-config', 20:38:38 INFO - 'download-and-extract', 20:38:38 INFO - 'populate-webroot', 20:38:38 INFO - 'create-virtualenv', 20:38:38 INFO - 'install', 20:38:38 INFO - 'run-tests'), 20:38:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:38:38 INFO - 'download_minidump_stackwalk': True, 20:38:38 INFO - 'download_symbols': 'ondemand', 20:38:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:38:38 INFO - 'tooltool.py': '/tools/tooltool.py', 20:38:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:38:38 INFO - '/tools/misc-python/virtualenv.py')}, 20:38:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:38:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:38:38 INFO - 'gecko_profile': False, 20:38:38 INFO - 'gecko_profile_interval': 0, 20:38:38 INFO - 'installer_path': 'installer.exe', 20:38:38 INFO - 'log_level': 'info', 20:38:38 INFO - 'log_name': 'talos', 20:38:38 INFO - 'log_to_console': True, 20:38:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:38:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:38:38 INFO - 'opt_config_files': (), 20:38:38 INFO - 'pip_index': False, 20:38:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:38:38 INFO - 'cmd': ('bash', 20:38:38 INFO - '-c', 20:38:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:38:38 INFO - 'enabled': True, 20:38:38 INFO - 'halt_on_failure': False, 20:38:38 INFO - 'name': 'check_screen_resolution'},), 20:38:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:38:38 INFO - 'cmd': ('bash', 20:38:38 INFO - '-c', 20:38:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:38:38 INFO - 'enabled': True, 20:38:38 INFO - 'halt_on_failure': False, 20:38:38 INFO - 'name': 'check_screen_resolution'},), 20:38:38 INFO - 'run_cmd_checks_enabled': True, 20:38:38 INFO - 'suite': 'dromaeojs-e10s', 20:38:38 INFO - 'system_bits': '32', 20:38:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:38:38 INFO - 'title': 't-yosemite-r7-0299', 20:38:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:38:38 INFO - 'use_talos_json': True, 20:38:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:38:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:38:38 INFO - 'work_dir': 'build'} 20:38:38 INFO - [mozharness: 2017-04-28 03:38:38.540943Z] Running clobber step. 20:38:38 INFO - Running pre-action listener: _resource_record_pre_action 20:38:38 INFO - Running main action method: clobber 20:38:38 INFO - rmtree: /builds/slave/test/build 20:38:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:38:40 INFO - Running post-action listener: _resource_record_post_action 20:38:40 INFO - [mozharness: 2017-04-28 03:38:40.470722Z] Finished clobber step (success) 20:38:40 INFO - [mozharness: 2017-04-28 03:38:40.470920Z] Running read-buildbot-config step. 20:38:40 INFO - Running pre-action listener: _resource_record_pre_action 20:38:40 INFO - Running main action method: read_buildbot_config 20:38:40 INFO - Using buildbot properties: 20:38:40 INFO - { 20:38:40 INFO - "project": "", 20:38:40 INFO - "product": "firefox", 20:38:40 INFO - "script_repo_revision": "default", 20:38:40 INFO - "builddir": "pine_yosemite_r7_test-dromaeojs-e10s", 20:38:40 INFO - "repository": "", 20:38:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 pine talos dromaeojs-e10s", 20:38:40 INFO - "buildid": "20170427113225", 20:38:40 INFO - "pgo_build": "False", 20:38:40 INFO - "basedir": "/builds/slave/test", 20:38:40 INFO - "buildnumber": 3, 20:38:40 INFO - "slavename": "t-yosemite-r7-0299", 20:38:40 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 20:38:40 INFO - "platform": "yosemite_r7", 20:38:40 INFO - "scheduler": "tests-pine-macosx64-talos", 20:38:40 INFO - "branch": "pine", 20:38:40 INFO - "repo_path": "projects/pine", 20:38:40 INFO - "revision": "720f68335aeed63d96f86be7b3f90aba8bbc1f6a", 20:38:40 INFO - "stage_platform": "macosx64", 20:38:40 INFO - "builduid": "4be79eac2d4f4fe3b156a4752812ee67", 20:38:40 INFO - "slavebuilddir": "test" 20:38:40 INFO - } 20:38:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/G3cqTc1HTMKr2CVVD1j3NA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 20:38:40 INFO - Running post-action listener: _resource_record_post_action 20:38:40 INFO - [mozharness: 2017-04-28 03:38:40.474964Z] Finished read-buildbot-config step (success) 20:38:40 INFO - [mozharness: 2017-04-28 03:38:40.475142Z] Running download-and-extract step. 20:38:40 INFO - Running pre-action listener: _resource_record_pre_action 20:38:40 INFO - Running main action method: download_and_extract 20:38:40 INFO - mkdir: /builds/slave/test/build/tests 20:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:38:40 INFO - trying https://queue.taskcluster.net/v1/task/G3cqTc1HTMKr2CVVD1j3NA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 20:38:40 INFO - Downloading https://queue.taskcluster.net/v1/task/G3cqTc1HTMKr2CVVD1j3NA/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 20:38:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G3cqTc1HTMKr2CVVD1j3NA/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 20:38:41 INFO - Downloaded 1325 bytes. 20:38:41 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 20:38:41 INFO - Using the following test package requirements: 20:38:41 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 20:38:41 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 20:38:41 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 20:38:41 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 20:38:41 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 20:38:41 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 20:38:41 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 20:38:41 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 20:38:41 INFO - u'jsshell-mac.zip'], 20:38:41 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 20:38:41 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 20:38:41 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 20:38:41 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 20:38:41 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 20:38:41 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 20:38:41 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 20:38:41 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 20:38:41 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 20:38:41 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 20:38:41 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 20:38:41 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:38:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G3cqTc1HTMKr2CVVD1j3NA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 20:38:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G3cqTc1HTMKr2CVVD1j3NA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:38:41 INFO - Fetch https://queue.taskcluster.net/v1/task/G3cqTc1HTMKr2CVVD1j3NA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 20:38:43 INFO - Content-Length response header: 52532350 20:38:43 INFO - Bytes received: 52532350 20:39:00 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 20:39:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G3cqTc1HTMKr2CVVD1j3NA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 20:39:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G3cqTc1HTMKr2CVVD1j3NA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:39:00 INFO - Fetch https://queue.taskcluster.net/v1/task/G3cqTc1HTMKr2CVVD1j3NA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 20:39:01 INFO - Content-Length response header: 52532350 20:39:01 INFO - Bytes received: 52532350 20:39:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G3cqTc1HTMKr2CVVD1j3NA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 20:39:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G3cqTc1HTMKr2CVVD1j3NA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 20:39:17 INFO - Fetch https://queue.taskcluster.net/v1/task/G3cqTc1HTMKr2CVVD1j3NA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 20:39:18 INFO - Content-Length response header: 14408809 20:39:18 INFO - Bytes received: 14408809 20:39:18 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')]} 20:39:18 INFO - trying https://queue.taskcluster.net/v1/task/G3cqTc1HTMKr2CVVD1j3NA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 20:39:18 INFO - Downloading https://queue.taskcluster.net/v1/task/G3cqTc1HTMKr2CVVD1j3NA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 20:39:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G3cqTc1HTMKr2CVVD1j3NA/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 20:39:20 INFO - Downloaded 71178055 bytes. 20:39:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G3cqTc1HTMKr2CVVD1j3NA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 20:39:20 INFO - mkdir: /builds/slave/test/properties 20:39:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:39:20 INFO - Writing to file /builds/slave/test/properties/build_url 20:39:20 INFO - Contents: 20:39:20 INFO - build_url:https://queue.taskcluster.net/v1/task/G3cqTc1HTMKr2CVVD1j3NA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 20:39:21 INFO - Running post-action listener: _resource_record_post_action 20:39:21 INFO - Running post-action listener: set_extra_try_arguments 20:39:21 INFO - [mozharness: 2017-04-28 03:39:21.265868Z] Finished download-and-extract step (success) 20:39:21 INFO - [mozharness: 2017-04-28 03:39:21.265985Z] Running populate-webroot step. 20:39:21 INFO - Running pre-action listener: _resource_record_pre_action 20:39:21 INFO - Running main action method: populate_webroot 20:39:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:39:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:39:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:39:21 INFO - '--tppagecycles', 20:39:21 INFO - '7'], 20:39:21 INFO - 'tests': ['tsvgm']}}, 20:39:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:39:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:39:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:39:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:39:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:39:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:39:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:39:21 INFO - 'talos_options': ['--disable-e10s'], 20:39:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:39:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:39:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:39:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:39:21 INFO - 'talos_options': ['--disable-e10s'], 20:39:21 INFO - 'tests': ['damp', 'tps']}, 20:39:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:39:21 INFO - 'tests': ['damp', 'tps']}, 20:39:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:39:21 INFO - 'tests': ['dromaeo_dom']}, 20:39:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:39:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:39:21 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 20:39:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 20:39:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:39:21 INFO - 'tests': ['a11yr', 20:39:21 INFO - 'ts_paint', 20:39:21 INFO - 'tpaint', 20:39:21 INFO - 'sessionrestore', 20:39:21 INFO - 'sessionrestore_no_auto_restore', 20:39:21 INFO - 'tabpaint']}, 20:39:21 INFO - 'other-e10s': {'tests': ['a11yr', 20:39:21 INFO - 'ts_paint', 20:39:21 INFO - 'tpaint', 20:39:21 INFO - 'sessionrestore', 20:39:21 INFO - 'sessionrestore_no_auto_restore', 20:39:21 INFO - 'tabpaint']}, 20:39:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:39:21 INFO - 'ts_paint', 20:39:21 INFO - 'tpaint', 20:39:21 INFO - 'sessionrestore', 20:39:21 INFO - 'sessionrestore_no_auto_restore', 20:39:21 INFO - 'tabpaint']}, 20:39:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:39:21 INFO - 'ts_paint', 20:39:21 INFO - 'tpaint', 20:39:21 INFO - 'sessionrestore', 20:39:21 INFO - 'sessionrestore_no_auto_restore', 20:39:21 INFO - 'tabpaint']}, 20:39:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:39:21 INFO - 'tests': ['a11yr', 20:39:21 INFO - 'ts_paint', 20:39:21 INFO - 'tpaint', 20:39:21 INFO - 'sessionrestore', 20:39:21 INFO - 'sessionrestore_no_auto_restore', 20:39:21 INFO - 'tabpaint']}, 20:39:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:39:21 INFO - 'tests': ['a11yr', 20:39:21 INFO - 'ts_paint', 20:39:21 INFO - 'tpaint', 20:39:21 INFO - 'sessionrestore', 20:39:21 INFO - 'sessionrestore_no_auto_restore', 20:39:21 INFO - 'tabpaint']}, 20:39:21 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 20:39:21 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 20:39:21 INFO - 'bloom_basic_ref']}, 20:39:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:39:21 INFO - 'tests': ['tsvgx', 20:39:21 INFO - 'tsvgr_opacity', 20:39:21 INFO - 'tart', 20:39:21 INFO - 'tscrollx', 20:39:21 INFO - 'cart', 20:39:21 INFO - 'tsvg_static']}, 20:39:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:39:21 INFO - 'tsvgr_opacity', 20:39:21 INFO - 'tart', 20:39:21 INFO - 'tscrollx', 20:39:21 INFO - 'cart', 20:39:21 INFO - 'tsvg_static']}, 20:39:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:39:21 INFO - 'talos_options': ['--disable-e10s'], 20:39:21 INFO - 'tests': ['tp5o']}, 20:39:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:39:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:39:21 INFO - 'talos_options': ['--disable-e10s', 20:39:21 INFO - '--xperf_path', 20:39:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:39:21 INFO - 'tests': ['tp5n']}, 20:39:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:39:21 INFO - 'talos_options': ['--xperf_path', 20:39:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:39:21 INFO - 'tests': ['tp5n']}}, 20:39:21 INFO - 'talos.zip': {'path': '', 20:39:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:39:21 INFO - Running post-action listener: _resource_record_post_action 20:39:21 INFO - [mozharness: 2017-04-28 03:39:21.284733Z] Finished populate-webroot step (success) 20:39:21 INFO - [mozharness: 2017-04-28 03:39:21.284863Z] Running create-virtualenv step. 20:39:21 INFO - Running pre-action listener: _resource_record_pre_action 20:39:21 INFO - Running main action method: create_virtualenv 20:39:21 INFO - Creating virtualenv /builds/slave/test/build/venv 20:39:21 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 20:39:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:39:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:39:21 INFO - Using real prefix '/tools/python27' 20:39:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:39:22 INFO - Installing distribute.............................................................................................................................................................................................done. 20:39:25 INFO - Installing pip.................done. 20:39:25 INFO - Return code: 0 20:39:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:39:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:39:25 INFO - Reading from file tmpfile_stdout 20:39:25 INFO - Output received: 20:39:25 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) 20:39:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:39: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')]} 20:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39: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')]} 20:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10113cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9068586540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1ad30>, '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 0x100e40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f0fbe8>, '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.9xh7wTDHbr/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.OvmINPcrGo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 20:39: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', 'pip>=1.5'] in /builds/slave/test/build 20:39: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 pip>=1.5 20:39:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9xh7wTDHbr/Render', 20:39:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:39:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:39:25 INFO - 'HOME': '/Users/cltbld', 20:39:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:39:25 INFO - 'LOGNAME': 'cltbld', 20:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:25 INFO - 'MOZ_NO_REMOTE': '1', 20:39:25 INFO - 'NO_EM_RESTART': '1', 20:39:25 INFO - 'PAGER': '/bin/cat', 20:39:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:25 INFO - 'PWD': '/builds/slave/test', 20:39:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:39:25 INFO - 'SHELL': '/bin/bash', 20:39:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OvmINPcrGo/Listeners', 20:39:25 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 20:39:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:39:25 INFO - 'USER': 'cltbld', 20:39:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:39:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:25 INFO - 'XPC_FLAGS': '0x0', 20:39:25 INFO - 'XPC_SERVICE_NAME': '0', 20:39:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:25 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 20:39:25 INFO - Cleaning up... 20:39:25 INFO - Return code: 0 20:39:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:39: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')]} 20:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39: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')]} 20:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39: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', '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 0x10113cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9068586540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1ad30>, '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 0x100e40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f0fbe8>, '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.9xh7wTDHbr/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.OvmINPcrGo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 20:39: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', 'psutil>=3.1.1'] in /builds/slave/test/build 20:39: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 psutil>=3.1.1 20:39:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9xh7wTDHbr/Render', 20:39:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:39:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:39:25 INFO - 'HOME': '/Users/cltbld', 20:39:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:39:25 INFO - 'LOGNAME': 'cltbld', 20:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:25 INFO - 'MOZ_NO_REMOTE': '1', 20:39:25 INFO - 'NO_EM_RESTART': '1', 20:39:25 INFO - 'PAGER': '/bin/cat', 20:39:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:25 INFO - 'PWD': '/builds/slave/test', 20:39:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:39:25 INFO - 'SHELL': '/bin/bash', 20:39:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OvmINPcrGo/Listeners', 20:39:25 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 20:39:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:39:25 INFO - 'USER': 'cltbld', 20:39:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:39:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:25 INFO - 'XPC_FLAGS': '0x0', 20:39:25 INFO - 'XPC_SERVICE_NAME': '0', 20:39:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:25 INFO - Downloading/unpacking psutil>=3.1.1 20:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:39:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:39:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:39:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:39:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:39:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:39:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:39:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:39:29 INFO - Installing collected packages: psutil 20:39:29 INFO - Running setup.py install for psutil 20:39:29 INFO - building 'psutil._psutil_osx' extension 20:39:29 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 20:39:29 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 20:39:29 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 20:39:29 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 20:39:29 INFO - building 'psutil._psutil_posix' extension 20:39:29 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 20:39:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:39:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:39:29 INFO - ^ 20:39:29 INFO - 1 warning generated. 20:39:29 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 20:39:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:39:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:39:29 INFO - Successfully installed psutil 20:39:29 INFO - Cleaning up... 20:39:30 INFO - Return code: 0 20:39:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:39:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10113cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9068586540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1ad30>, '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 0x100e40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f0fbe8>, '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.9xh7wTDHbr/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.OvmINPcrGo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 20:39:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:39:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:39:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9xh7wTDHbr/Render', 20:39:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:39:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:39:30 INFO - 'HOME': '/Users/cltbld', 20:39:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:39:30 INFO - 'LOGNAME': 'cltbld', 20:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:30 INFO - 'MOZ_NO_REMOTE': '1', 20:39:30 INFO - 'NO_EM_RESTART': '1', 20:39:30 INFO - 'PAGER': '/bin/cat', 20:39:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:30 INFO - 'PWD': '/builds/slave/test', 20:39:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:39:30 INFO - 'SHELL': '/bin/bash', 20:39:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OvmINPcrGo/Listeners', 20:39:30 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 20:39:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:39:30 INFO - 'USER': 'cltbld', 20:39:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:39:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:30 INFO - 'XPC_FLAGS': '0x0', 20:39:30 INFO - 'XPC_SERVICE_NAME': '0', 20:39:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:39:30 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 20:39:30 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 20:39:30 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 20:39:30 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 20:39:30 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 20:39:30 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 20:39:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:39:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:39:32 INFO - Installing collected packages: mozsystemmonitor 20:39:32 INFO - Running setup.py install for mozsystemmonitor 20:39:33 INFO - Successfully installed mozsystemmonitor 20:39:33 INFO - Cleaning up... 20:39:33 INFO - Return code: 0 20:39:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:39:33 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')]} 20:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:33 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')]} 20:39:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10113cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9068586540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1ad30>, '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 0x100e40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f0fbe8>, '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.9xh7wTDHbr/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.OvmINPcrGo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 20:39:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:39:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:39:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9xh7wTDHbr/Render', 20:39:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:39:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:39:34 INFO - 'HOME': '/Users/cltbld', 20:39:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:39:34 INFO - 'LOGNAME': 'cltbld', 20:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:34 INFO - 'MOZ_NO_REMOTE': '1', 20:39:34 INFO - 'NO_EM_RESTART': '1', 20:39:34 INFO - 'PAGER': '/bin/cat', 20:39:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:34 INFO - 'PWD': '/builds/slave/test', 20:39:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:39:34 INFO - 'SHELL': '/bin/bash', 20:39:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OvmINPcrGo/Listeners', 20:39:34 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 20:39:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:39:34 INFO - 'USER': 'cltbld', 20:39:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:39:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:34 INFO - 'XPC_FLAGS': '0x0', 20:39:34 INFO - 'XPC_SERVICE_NAME': '0', 20:39:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:39:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:34 INFO - Downloading/unpacking jsonschema==2.5.1 20:39:34 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 20:39:34 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 20:39:34 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 20:39:34 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 20:39:34 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 20:39:34 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 20:39:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:39:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:39:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:39:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:39:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:39:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:39:37 INFO - Downloading functools32-3.2.3-2.tar.gz 20:39:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:39:37 INFO - warning: no files found matching '*.txt' 20:39:37 INFO - no previously-included directories found matching 'build' 20:39:37 INFO - no previously-included directories found matching 'dist' 20:39:37 INFO - no previously-included directories found matching '.git*' 20:39:37 INFO - Installing collected packages: jsonschema, functools32 20:39:37 INFO - Running setup.py install for functools32 20:39:38 INFO - warning: no files found matching '*.txt' 20:39:38 INFO - no previously-included directories found matching 'build' 20:39:38 INFO - no previously-included directories found matching 'dist' 20:39:38 INFO - no previously-included directories found matching '.git*' 20:39:38 INFO - Successfully installed jsonschema functools32 20:39:38 INFO - Cleaning up... 20:39:38 INFO - Return code: 0 20:39:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:39:38 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')]} 20:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:38 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')]} 20:39:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:38 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 0x10113cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9068586540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1ad30>, '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 0x100e40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f0fbe8>, '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.9xh7wTDHbr/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.OvmINPcrGo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 20:39:38 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 20:39:38 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 20:39:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9xh7wTDHbr/Render', 20:39:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:39:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:39:38 INFO - 'HOME': '/Users/cltbld', 20:39:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:39:38 INFO - 'LOGNAME': 'cltbld', 20:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:38 INFO - 'MOZ_NO_REMOTE': '1', 20:39:38 INFO - 'NO_EM_RESTART': '1', 20:39:38 INFO - 'PAGER': '/bin/cat', 20:39:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:38 INFO - 'PWD': '/builds/slave/test', 20:39:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:39:38 INFO - 'SHELL': '/bin/bash', 20:39:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OvmINPcrGo/Listeners', 20:39:38 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 20:39:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:39:38 INFO - 'USER': 'cltbld', 20:39:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:39:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:38 INFO - 'XPC_FLAGS': '0x0', 20:39:38 INFO - 'XPC_SERVICE_NAME': '0', 20:39:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:39:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:39:38 INFO - Cleaning up... 20:39:38 INFO - Return code: 0 20:39:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:39:38 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')]} 20:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:38 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')]} 20:39:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:38 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 0x10113cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9068586540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1ad30>, '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 0x100e40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f0fbe8>, '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.9xh7wTDHbr/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.OvmINPcrGo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 20:39:38 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 20:39:38 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 20:39:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9xh7wTDHbr/Render', 20:39:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:39:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:39:38 INFO - 'HOME': '/Users/cltbld', 20:39:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:39:38 INFO - 'LOGNAME': 'cltbld', 20:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:38 INFO - 'MOZ_NO_REMOTE': '1', 20:39:38 INFO - 'NO_EM_RESTART': '1', 20:39:38 INFO - 'PAGER': '/bin/cat', 20:39:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:38 INFO - 'PWD': '/builds/slave/test', 20:39:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:39:38 INFO - 'SHELL': '/bin/bash', 20:39:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OvmINPcrGo/Listeners', 20:39:38 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 20:39:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:39:38 INFO - 'USER': 'cltbld', 20:39:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:39:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:38 INFO - 'XPC_FLAGS': '0x0', 20:39:38 INFO - 'XPC_SERVICE_NAME': '0', 20:39:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:39:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:38 INFO - Downloading/unpacking blobuploader==1.2.4 20:39:38 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 20:39:38 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 20:39:38 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 20:39:38 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 20:39:38 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 20:39:38 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 20:39:41 INFO - Downloading blobuploader-1.2.4.tar.gz 20:39:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:39:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:39:41 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 20:39:41 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 20:39:41 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 20:39:41 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 20:39:41 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 20:39:41 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 20:39:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:39:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:39:41 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 20:39:41 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 20:39:41 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 20:39:41 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 20:39:41 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 20:39:41 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 20:39:42 INFO - Downloading docopt-0.6.1.tar.gz 20:39:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:39:42 INFO - Installing collected packages: blobuploader, requests, docopt 20:39:42 INFO - Running setup.py install for blobuploader 20:39:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:39:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:39:42 INFO - Running setup.py install for requests 20:39:43 INFO - Running setup.py install for docopt 20:39:43 INFO - Successfully installed blobuploader requests docopt 20:39:43 INFO - Cleaning up... 20:39:43 INFO - Return code: 0 20:39:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:43 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 0x10113cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9068586540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1ad30>, '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 0x100e40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f0fbe8>, '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.9xh7wTDHbr/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.OvmINPcrGo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 20:39:43 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 20:39:43 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 20:39:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9xh7wTDHbr/Render', 20:39:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:39:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:39:43 INFO - 'HOME': '/Users/cltbld', 20:39:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:39:43 INFO - 'LOGNAME': 'cltbld', 20:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:43 INFO - 'MOZ_NO_REMOTE': '1', 20:39:43 INFO - 'NO_EM_RESTART': '1', 20:39:43 INFO - 'PAGER': '/bin/cat', 20:39:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:43 INFO - 'PWD': '/builds/slave/test', 20:39:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:39:43 INFO - 'SHELL': '/bin/bash', 20:39:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OvmINPcrGo/Listeners', 20:39:43 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 20:39:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:39:43 INFO - 'USER': 'cltbld', 20:39:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:39:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:43 INFO - 'XPC_FLAGS': '0x0', 20:39:43 INFO - 'XPC_SERVICE_NAME': '0', 20:39:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:39:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:39:43 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-x7Lele-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:39:43 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-e6ujoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:39:43 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-q1y9tn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:39:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-lqZZrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:39:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-9jtkJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:39:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-aXaOZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:39:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-vnjPmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:39:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-z3a7YQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:39:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-_bO4mP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:39:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-9PCO2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:39:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-K4mZZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:39:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-XSnAfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:39:44 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-UkXHjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:39:45 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-aFaNVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:39:45 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-21eTSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:39:45 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-e_7Me8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:39:45 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-aUji52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:39:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:39:45 INFO - Running setup.py install for manifestparser 20:39:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:39:45 INFO - Running setup.py install for mozcrash 20:39:45 INFO - Running setup.py install for mozdebug 20:39:45 INFO - Running setup.py install for mozdevice 20:39:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:39:46 INFO - Running setup.py install for mozfile 20:39:46 INFO - Running setup.py install for mozhttpd 20:39:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:39:46 INFO - Running setup.py install for mozinfo 20:39:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:39:46 INFO - Running setup.py install for mozInstall 20:39:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:39:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:39:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:39:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:39:46 INFO - Running setup.py install for mozleak 20:39:46 INFO - Running setup.py install for mozlog 20:39:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:39:46 INFO - Running setup.py install for moznetwork 20:39:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:39:47 INFO - Running setup.py install for mozprocess 20:39:47 INFO - Running setup.py install for mozprofile 20:39:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:39:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:39:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:39:47 INFO - Running setup.py install for mozrunner 20:39:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:39:47 INFO - Running setup.py install for mozscreenshot 20:39:47 INFO - Running setup.py install for moztest 20:39:47 INFO - Running setup.py install for mozversion 20:39:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:39:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:39:48 INFO - Cleaning up... 20:39:48 INFO - Return code: 0 20:39:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:48 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 0x10113cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9068586540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1ad30>, '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 0x100e40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f0fbe8>, '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.9xh7wTDHbr/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.OvmINPcrGo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 20:39:48 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 20:39:48 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 20:39:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9xh7wTDHbr/Render', 20:39:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:39:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:39:48 INFO - 'HOME': '/Users/cltbld', 20:39:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:39:48 INFO - 'LOGNAME': 'cltbld', 20:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:48 INFO - 'MOZ_NO_REMOTE': '1', 20:39:48 INFO - 'NO_EM_RESTART': '1', 20:39:48 INFO - 'PAGER': '/bin/cat', 20:39:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:48 INFO - 'PWD': '/builds/slave/test', 20:39:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:39:48 INFO - 'SHELL': '/bin/bash', 20:39:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OvmINPcrGo/Listeners', 20:39:48 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 20:39:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:39:48 INFO - 'USER': 'cltbld', 20:39:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:39:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:48 INFO - 'XPC_FLAGS': '0x0', 20:39:48 INFO - 'XPC_SERVICE_NAME': '0', 20:39:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:39:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:39:48 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-hrz_xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:39:48 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)) 20:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:39:48 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-_528cy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:39:48 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)) 20:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:39:48 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-_lGkE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:39:48 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)) 20:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:39:48 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-BTDXc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:39:48 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)) 20:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:39:48 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-skHyps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:39:48 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)) 20:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:39:48 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-isZ6KE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:39:48 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)) 20:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:39:48 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-XQF2wJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:39:49 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)) 20:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:39:49 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-3vqoxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:39:49 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)) 20:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:39:49 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-sN1Wxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:39:49 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)) 20:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:39:49 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-Cl5Kwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:39:49 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)) 20:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:39:49 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-g6q95A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:39:49 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)) 20:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:39:49 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-saYa51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:39:49 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)) 20:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:39:49 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-kmZ0hq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:39:49 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)) 20:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:39:49 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-AJAlqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:39:49 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)) 20:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:39:49 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-GM8QPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:39:49 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)) 20:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:39:49 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-NUACan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:39:50 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)) 20:39:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:39:50 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-dVHuFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:39:50 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)) 20:39:50 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)) 20:39:50 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)) 20:39:50 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)) 20:39:50 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)) 20:39:50 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)) 20:39:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:39:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:39:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:39:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:39:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:39:52 INFO - Downloading blessings-1.6.tar.gz 20:39:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:39:52 INFO - Installing collected packages: blessings 20:39:52 INFO - Running setup.py install for blessings 20:39:53 INFO - Successfully installed blessings 20:39:53 INFO - Cleaning up... 20:39:53 INFO - Return code: 0 20:39:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:39:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:39:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:39:53 INFO - Reading from file tmpfile_stdout 20:39:53 INFO - Current package versions: 20:39:53 INFO - blessings == 1.6 20:39:53 INFO - blobuploader == 1.2.4 20:39:53 INFO - docopt == 0.6.1 20:39:53 INFO - functools32 == 3.2.3-2 20:39:53 INFO - jsonschema == 2.5.1 20:39:53 INFO - manifestparser == 1.1 20:39:53 INFO - mozInstall == 1.12 20:39:53 INFO - mozcrash == 1.0 20:39:53 INFO - mozdebug == 0.1 20:39:53 INFO - mozdevice == 0.50 20:39:53 INFO - mozfile == 1.2 20:39:53 INFO - mozhttpd == 0.7 20:39:53 INFO - mozinfo == 0.9 20:39:53 INFO - mozleak == 0.1 20:39:53 INFO - mozlog == 3.4 20:39:53 INFO - moznetwork == 0.27 20:39:53 INFO - mozprocess == 0.25 20:39:53 INFO - mozprofile == 0.28 20:39:53 INFO - mozrunner == 6.13 20:39:53 INFO - mozscreenshot == 0.1 20:39:53 INFO - mozsystemmonitor == 0.3 20:39:53 INFO - moztest == 0.8 20:39:53 INFO - mozversion == 1.4 20:39:53 INFO - psutil == 3.1.1 20:39:53 INFO - requests == 1.2.3 20:39:53 INFO - wsgiref == 0.1.2 20:39:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:39:53 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')]} 20:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:53 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')]} 20:39:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:53 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 0x10113cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9068586540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1ad30>, '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 0x100e40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f0fbe8>, '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.9xh7wTDHbr/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.OvmINPcrGo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 20:39:53 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 20:39:53 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 20:39:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9xh7wTDHbr/Render', 20:39:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:39:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:39:53 INFO - 'HOME': '/Users/cltbld', 20:39:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:39:53 INFO - 'LOGNAME': 'cltbld', 20:39:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:53 INFO - 'MOZ_NO_REMOTE': '1', 20:39:53 INFO - 'NO_EM_RESTART': '1', 20:39:53 INFO - 'PAGER': '/bin/cat', 20:39:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:39:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:53 INFO - 'PWD': '/builds/slave/test', 20:39:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:39:53 INFO - 'SHELL': '/bin/bash', 20:39:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OvmINPcrGo/Listeners', 20:39:53 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 20:39:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:39:53 INFO - 'USER': 'cltbld', 20:39:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:39:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:39:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:53 INFO - 'XPC_FLAGS': '0x0', 20:39:53 INFO - 'XPC_SERVICE_NAME': '0', 20:39:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:39:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:53 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)) 20:39:53 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)) 20:39:53 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)) 20:39:53 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)) 20:39:53 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)) 20:39:53 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)) 20:39:53 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)) 20:39:53 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)) 20:39:53 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)) 20:39:53 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)) 20:39:53 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)) 20:39:53 INFO - Cleaning up... 20:39:53 INFO - Return code: 0 20:39:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:39:53 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')]} 20:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:39:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:53 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')]} 20:39:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:39:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:39:53 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 0x10113cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9068586540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f1ad30>, '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 0x100e40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f0fbe8>, '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.9xh7wTDHbr/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.OvmINPcrGo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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 20:39:53 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 20:39:53 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 20:39:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9xh7wTDHbr/Render', 20:39:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:39:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:39:53 INFO - 'HOME': '/Users/cltbld', 20:39:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:39:53 INFO - 'LOGNAME': 'cltbld', 20:39:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:39:53 INFO - 'MOZ_NO_REMOTE': '1', 20:39:53 INFO - 'NO_EM_RESTART': '1', 20:39:53 INFO - 'PAGER': '/bin/cat', 20:39:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:39:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:39:53 INFO - 'PWD': '/builds/slave/test', 20:39:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:39:53 INFO - 'SHELL': '/bin/bash', 20:39:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OvmINPcrGo/Listeners', 20:39:53 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 20:39:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:39:53 INFO - 'USER': 'cltbld', 20:39:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:39:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:39:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:39:53 INFO - 'XPC_FLAGS': '0x0', 20:39:53 INFO - 'XPC_SERVICE_NAME': '0', 20:39:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:39:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:39:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:39:53 INFO - Cleaning up... 20:39:53 INFO - Return code: 0 20:39:53 INFO - Running post-action listener: _resource_record_post_action 20:39:53 INFO - Running post-action listener: _start_resource_monitoring 20:39:53 INFO - Starting resource monitoring. 20:39:53 INFO - [mozharness: 2017-04-28 03:39:53.973778Z] Finished create-virtualenv step (success) 20:39:53 INFO - [mozharness: 2017-04-28 03:39:53.974712Z] Running install step. 20:39:53 INFO - Running pre-action listener: _resource_record_pre_action 20:39:53 INFO - Running main action method: install 20:39:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:39:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:39:54 INFO - Reading from file tmpfile_stdout 20:39:54 INFO - Detecting whether we're running mozinstall >=1.0... 20:39:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:39:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:39:54 INFO - Reading from file tmpfile_stdout 20:39:54 INFO - Output received: 20:39:54 INFO - Usage: mozinstall [options] installer 20:39:54 INFO - Options: 20:39:54 INFO - -h, --help show this help message and exit 20:39:54 INFO - -d DEST, --destination=DEST 20:39:54 INFO - Directory to install application into. [default: 20:39:54 INFO - "/builds/slave/test"] 20:39:54 INFO - --app=APP Application being installed. [default: firefox] 20:39:54 INFO - mkdir: /builds/slave/test/build/application 20:39:54 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'] 20:39:54 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 20:40:13 INFO - Reading from file tmpfile_stdout 20:40:13 INFO - Output received: 20:40:13 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:40:13 INFO - Running post-action listener: _resource_record_post_action 20:40:13 INFO - [mozharness: 2017-04-28 03:40:13.934921Z] Finished install step (success) 20:40:13 INFO - [mozharness: 2017-04-28 03:40:13.935049Z] Running run-tests step. 20:40:13 INFO - Running pre-action listener: _resource_record_pre_action 20:40:13 INFO - Running main action method: run_tests 20:40:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:40:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:40:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:40:13 INFO - 2017-04-27 20:40:13.949 screenresolution[2552:35298] starting screenresolution argv=screenresolution get 20:40:13 INFO - 2017-04-27 20:40:13.952 screenresolution[2552:35298] Display 0: 1600x1200x32@60 20:40:13 INFO - 2017-04-27 20:40:13.958 screenresolution[2553:35301] starting screenresolution argv=screenresolution list 20:40:13 INFO - Available Modes on Display 0 20:40:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:40:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:40:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:40:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:40:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:40:14 INFO - Intel Iris: 20:40:14 INFO - Chipset Model: Intel Iris 20:40:14 INFO - Type: GPU 20:40:14 INFO - Bus: Built-In 20:40:14 INFO - VRAM (Dynamic, Max): 1536 MB 20:40:14 INFO - Vendor: Intel (0x8086) 20:40:14 INFO - Device ID: 0x0a2e 20:40:14 INFO - Revision ID: 0x0009 20:40:14 INFO - Displays: 20:40:14 INFO - Display: 20:40:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:40:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:40:14 INFO - Display Serial Number: 1600x1200 60 20:40:14 INFO - Main Display: Yes 20:40:14 INFO - Mirror: Off 20:40:14 INFO - Online: Yes 20:40:14 INFO - Rotation: Supported 20:40:14 INFO - Return code: 0 20:40:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:40:14 INFO - Python 2.7.3 20:40:14 INFO - Return code: 0 20:40:14 INFO - grabbing minidump binary from tooltool 20:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:40:14 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 0x100f1ad30>, '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 0x100e40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f0fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:40:14 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 20:40:14 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 20:40:14 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 20:40:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:40:14 INFO - Return code: 0 20:40:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:40:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:40:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:40:14 INFO - ENV: RUST_BACKTRACE is now 1 20:40:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:40:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:40:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G3cqTc1HTMKr2CVVD1j3NA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0299', '--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 20:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Pine --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G3cqTc1HTMKr2CVVD1j3NA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0299 --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 20:40:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9xh7wTDHbr/Render', 20:40:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:40:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:40:14 INFO - 'HOME': '/Users/cltbld', 20:40:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:40:14 INFO - 'LOGNAME': 'cltbld', 20:40:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:40:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:40:14 INFO - 'MOZ_NO_REMOTE': '1', 20:40:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:40:14 INFO - 'NO_EM_RESTART': '1', 20:40:14 INFO - 'PAGER': '/bin/cat', 20:40:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:40:14 INFO - 'PWD': '/builds/slave/test', 20:40:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:40:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:40:14 INFO - 'RUST_BACKTRACE': '1', 20:40:14 INFO - 'SHELL': '/bin/bash', 20:40:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OvmINPcrGo/Listeners', 20:40:14 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 20:40:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:40:14 INFO - 'USER': 'cltbld', 20:40:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:40:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:40:14 INFO - 'XPC_FLAGS': '0x0', 20:40:14 INFO - 'XPC_SERVICE_NAME': '0', 20:40:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:40:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G3cqTc1HTMKr2CVVD1j3NA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0299', '--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 20:40:14 INFO - mozversion application_buildid: 20170427113225 20:40:14 INFO - mozversion application_changeset: 720f68335aeed63d96f86be7b3f90aba8bbc1f6a 20:40:14 INFO - mozversion application_display_name: Nightly 20:40:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:40:14 INFO - mozversion application_name: Firefox 20:40:14 INFO - mozversion application_remotingname: firefox 20:40:14 INFO - mozversion application_repository: https://hg.mozilla.org/projects/pine 20:40:14 INFO - mozversion application_vendor: Mozilla 20:40:14 INFO - mozversion application_version: 55.0a1 20:40:14 INFO - mozversion platform_buildid: 20170427113225 20:40:14 INFO - mozversion platform_changeset: 720f68335aeed63d96f86be7b3f90aba8bbc1f6a 20:40:14 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/pine 20:40:14 INFO - mozversion platform_version: 55.0a1 20:40:14 INFO - using testdate: 1493350814 20:40:14 INFO - actual date: 1493350814 20:40:14 INFO - starting webserver on 'localhost:60727' 20:40:14 INFO - SUITE-START | Running 2 tests 20:40:14 INFO - TEST-START | dromaeo_css 20:40:14 INFO - operating with platform_type : mac_ 20:40:14 INFO - Initialising browser for dromaeo_css test... 20:40:14 INFO - TEST-INFO | started process 2563 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpifJatn/profile http://localhost:60727/getInfo.html) 20:40:17 INFO - PID 2563 | 2017-04-27 20:40:17.237 plugin-container[2565:35469] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a4b, name = 'com.apple.tsm.portname' 20:40:17 INFO - PID 2563 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:40:17 INFO - PID 2563 | 2017-04-27 20:40:17.240 plugin-container[2565:35469] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x491b, name = 'com.apple.CFPasteboardClient' 20:40:17 INFO - PID 2563 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:40:17 INFO - PID 2563 | 2017-04-27 20:40:17.240 plugin-container[2565:35469] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:40:17 INFO - PID 2563 | __metrics Screen width/height:1600/1200 20:40:17 INFO - PID 2563 | colorDepth:24 20:40:17 INFO - PID 2563 | Browser inner width/height: 1024/689 20:40:17 INFO - PID 2563 | __metrics 20:40:17 ERROR - PID 2563 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 20:40:18 INFO - TEST-INFO | 2563: exit 0 20:40:18 INFO - Browser initialized. 20:40:18 INFO - Running cycle 1/1 for dromaeo_css test... 20:40:18 INFO - TEST-INFO | started process 2566 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpifJatn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:40:21 INFO - PID 2566 | 2017-04-27 20:40:21.141 plugin-container[2567:35591] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 20:40:21 INFO - PID 2566 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:40:21 INFO - PID 2566 | 2017-04-27 20:40:21.142 plugin-container[2567:35591] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x990f, name = 'com.apple.CFPasteboardClient' 20:40:21 INFO - PID 2566 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:40:21 INFO - PID 2566 | 2017-04-27 20:40:21.142 plugin-container[2567:35591] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:40:30 INFO - PID 2566 | RSS: Main: 238854144 20:40:30 INFO - PID 2566 | 20:43:35 INFO - PID 2566 | Cycle 1(1): loaded http://localhost:60727/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60727/tests/dromaeo/cssquery-ext.html) 20:43:36 INFO - PID 2566 | RSS: Main: 259850240 20:43:36 INFO - PID 2566 | 20:45:18 INFO - PID 2566 | ************************* 20:45:18 INFO - PID 2566 | A coding exception was thrown and uncaught in a Task. 20:45:18 INFO - PID 2566 | 20:45:18 ERROR - PID 2566 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:45:18 INFO - PID 2566 | Full stack: 20:45:18 INFO - PID 2566 | ************************* 20:45:18 INFO - PID 2566 | ************************* 20:45:18 INFO - PID 2566 | A coding exception was thrown and uncaught in a Task. 20:45:18 INFO - PID 2566 | 20:45:18 ERROR - PID 2566 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:45:18 INFO - PID 2566 | Full stack: 20:45:18 INFO - PID 2566 | ************************* 20:45:18 INFO - PID 2566 | ************************* 20:45:18 INFO - PID 2566 | A coding exception was thrown and uncaught in a Task. 20:45:18 INFO - PID 2566 | 20:45:18 ERROR - PID 2566 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:45:18 INFO - PID 2566 | Full stack: 20:45:18 INFO - PID 2566 | ************************* 20:45:18 INFO - PID 2566 | ************************* 20:45:18 INFO - PID 2566 | A coding exception was thrown and uncaught in a Task. 20:45:18 INFO - PID 2566 | 20:45:18 ERROR - PID 2566 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:45:18 INFO - PID 2566 | Full stack: 20:45:18 INFO - PID 2566 | ************************* 20:46:38 INFO - PID 2566 | Cycle 1(1): loaded http://localhost:60727/tests/dromaeo/cssquery-ext.html (next: http://localhost:60727/tests/dromaeo/cssquery-jquery.html) 20:46:39 INFO - PID 2566 | RSS: Main: 260194304 20:46:39 INFO - PID 2566 | 20:49:41 INFO - PID 2566 | Cycle 1(1): loaded http://localhost:60727/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60727/tests/dromaeo/cssquery-mootools.html) 20:49:41 INFO - PID 2566 | RSS: Main: 268914688 20:49:41 INFO - PID 2566 | 20:52:43 INFO - PID 2566 | Cycle 1(1): loaded http://localhost:60727/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60727/tests/dromaeo/cssquery-prototype.html) 20:52:44 INFO - PID 2566 | RSS: Main: 261885952 20:52:44 INFO - PID 2566 | 20:55:46 INFO - PID 2566 | Cycle 1(1): loaded http://localhost:60727/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60727/tests/dromaeo/cssquery-yui.html) 20:55:47 INFO - PID 2566 | RSS: Main: 271048704 20:55:47 INFO - PID 2566 | 20:58:49 INFO - PID 2566 | Cycle 1(1): loaded http://localhost:60727/tests/dromaeo/cssquery-yui.html (next: http://localhost:60727/tests/dromaeo/cssquery-dojo.html) 20:58:49 INFO - PID 2566 | RSS: Main: 265588736 20:58:49 INFO - PID 2566 | 20:58:49 INFO - PID 2566 | __start_tp_report 20:58:49 INFO - PID 2566 | _x_x_mozilla_page_load 20:58:49 INFO - PID 2566 | _x_x_mozilla_page_load_details 20:58:49 INFO - PID 2566 | |i|pagename|runs| 20:58:49 INFO - PID 2566 | |0;dojo.html;3219.468787650038;3534.24013837025;3585.892423227304;3587.4080776671844;3592.0660628236665;6128.448439640431;6164.907526387102;6171.043488259315;6198.411150940653;6212.316645169028;6048.939510604903;6144.771045790837;6148.600340977833;6162.137300777895;6212.720427580758;5338.119210330291;5441.020616289066;5463.972680136613;5510.1459273812425;5592.636478628897;5383;5524.58565607579;5564.693941833198;5582.134769110774;5596.58025648076;5474.972625136888;5530.142827861688;5557.972210138943;5593.720313984305;5613.494785469307;5350.785968561253;5423.159410291371;5459.645123066988;5468.28912241406;5472.398036216013;5386.515213630752;5433.375161856397;5440.564754819605;5486.753096110685;5501.092319767274;5949.970250148722;6181.443670069715;6190.535709821736;6192;6207.968960155215;6428.935710642881;6528.445082167974;6532.5753826001155;6659.667016649197;6680.465562754968;6747.224069232052;6753.628550429725;6763.830904227384;6778.525503214777;6798.422134118557;6301.842453938597;6307.5269354798575;6314.242290925118;6321.55749097568;6337.7781777637565;5168.250603662448;5527.281453411031;6612.768553100618;6649.534532582769;6769.593824370553;6328.6835658216905;6434.517411194086;6434.903476447857;6529.249136349381;6542.901856472156;6535.411812936859;6580.341965803477;6624.56940298879;6728.529002969843;6745.52781305304;6510.479161667055;6638.6680665966505;6640.933590664032;6644.202695676549;6657.46740260778;6628.767993120217;6644.634545099969;6653.73385064592;6655.239789518906;6683.933160668428;4519.683622146418;5186.196139598368;5244.475552444801;5251.396089449686;5285.841424757264;4706.764661766898;4712.081144176921;4732.6687131900435;4759.333693282943;4790.137775200427;5007.69953802773;6234.189555357774;6260.123582698426;6263.749450022039;6277.403646653561;6414.935850641527;6628.204615446081;6660.600363978177;6717.899231511531;6721.831954201184;6249.218847644044;6249.281332646713;6285.811425657238;6288.465480434123;6317.526185536103;5876.324222714357;5878.911816322759;5883.764649414061;5886.882262354815;5923.348431672599;6629.668516574248;6699.732010719516;6831.45348372139;6921.169459664872;6937.895931561132;6682.83292917681;6698.631575263213;6744.494162937701;6755.42578880781;6755.594664320157;6896.827579310357;6904.240533541206;6912.723491060502;6955.374016338554;6984.580925144508;6340.524460665561;6475.125858009108;6552.901706474502;6562.639054851838;6610.173728283965;6550.344965503412;6684;6711.6308603025345;6714.52998290115;6750.223724271772;6552.508561857975;6553.574017688835;6561;6562.639054852029;6567.868642627216;6220.937790622036;6344.1118243445035;6377.362263773771;6382.5532212744665;6479.287278399466;6229.4393504584805;6410.8076757697345;6415.133956915944;6425.453836423956;6430.48556115519;6524.086627872007;6544.607323560602;6550.246721627074;6551.868962620625;6553.5084868634085;6155.292141403616;6281.96859015702;6394.072859435263;6401.3598640135615;6402.711877965596 20:58:49 INFO - PID 2566 | |1;ext.html;752.8669352624299;818.2758258940836;842.9452085614435;1027.650598796409;1132.5526417065264;36185.638143618555;36801.81599092004;36910.63089369106;36948.07629809249;37051.25897482052;38950.63672771453;39314.80342598283;39442.21115577694;39606.8019659902;39690.40464393029;7489.28851759082;8387.790305242357;8473.618687159078;8602.397832151752;8623;6628.734850605994;8606.354523410739;8632.525211113387;8632.827343453127;8640.524771137585;8591.699290524833;8672.479651220916;8700.129987001312;8706.651733930667;8730.301575873915;7832.490888092313;8079.353651707849;8621.310295176403;8645.394822362437;8657.0044444889;8500.404971651988;8553.786155346104;8557.572121393905;8560.272376847975;8567.443116197428;31059.602317895522;31663.84168079168;36010.45984310238;37273.44089838654;37342;3391.1522119470133;3488.66857648523;3539.4513850353237;3571.8035508047046;3572.517710109154;30470;30540.54189187164;30567.69432305693;30589.69410305913;30714.23214419635;2631.7105118436957;3160.62072551293;3185.8566364513654;3194.952075718866;3198.504231844068;182766;248567;278103.99999999796;297191;299373;46295;46518.06963860704;46521.534784652395;46583.76708116438;46841.531584684395;49444;49703;49734.50265497299;49736.756581085036;49784;13874.65313367174;13879.722405551833;13907.79138312926;14010.089344192595;14019.71960560783;11650.067994560415;11658;11680.474378652982;11685.298882067103;11739.354335511629;13490.86509134896;13508.594742157751;13513.459461621425;13529.30883639545;13623.910087193;5924.940750592526;5986.73059712314;6014.6090504117965;6033.668148251801;6049.939500604937;837.2924878477677;997.4912794474725;1005.7435353984687;1010.1262408017012;1039.6932904793105;20736.48158796012;23952.64071038901;25045.497270163847;25216.74783252144;25216.747832521807;1088.455772113943;1104.9502772375263;1138.9863021910505;1144.6566030190909;1145.5761368293618;10419.270651054505;12273.509059637514;12691.048171387183;12829.294388808705;12865.935670321589;322192;323480;324610;324852;325017;54233;54342.45657543374;54351.91296174054;54375.72812135914;54538.45461545334;1326.7877139657608;1464.692414592926;1516.041370111195;1519.8860085493632;1525.0620868165997;22057.11771529121;22306;24516.50966980686;24614.384640383418;24701;37875.242495150495;37900;37922.43116353202;37993.81003095077;38169.618303816605;241113;292452;292536;293320;293609;33035.339293214485;33768.83115584406;34585;34715.47926781151;34765;43488.34767478427;44027;45722.542774571826;45836.770816145705;45842.541574583825;30305.69694303029;30735.538966915068;31284.217894552818;31476.685233147375;31670.683293167695;30403.847980759954;30760.38479230358;30852.69147308588;31191.68808311888;31428.528572071893;36299.09252268715;37114.25771484609;37440;37486;37611.05972350713;30956.53565196569;31672;31727;31826.045218643478;31916;22288.665670015285;23454.76545234526;24689.012439502938;24969.500609988063;25141.994320226986 20:58:49 INFO - PID 2566 | |2;jquery.html;438.5022998896252;443.6362183009931;445.7147425647585;461.2412581303755;467.3970577954439;21472.46318842028;22174.50091465839;22235.999380027897;22817.429564260903;22818.88590557049;21773.346799595998;22525.211617593388;22556.21053263136;22783.202587909425;22939.42651433715;5999.640021598707;6002.729877155539;6022.5483088768515;6131.570790044699;6190;5936.5250779937505;6053.152558641794;6144.44699977002;6150.6924653767355;6158.938410615904;6172.814815555541;6202.937970620281;6205.689715514229;6215.28524219716;6218.129461875318;5981.730822113037;6081.3006504252135;6151.261848578154;6205.906911396332;6212.502999760009;5439.945600544023;5475.780968761244;5476;5480.616356855022;5496.038193316153;26694.5995810063;26855.46289074227;27292.727072729216;27483.038093666826;27623.447531049267;2230.2305704532073;2270.9886450567806;2274.294968559735;2288.3592594073684;2289.7366802817724;17636.823631763647;17957.281708731767;18326.175322110535;18447.44657660259;18648.06759662025;2119.173522326294;2191.638379667353;2215.080741492279;2216.180013395038;2231.386368748591;134971.60113595444;161505.19247403688;165331;168135;171587;12894.548690795777;12910.483580656857;12923.870761292455;13050.804237936438;13193.274369909555;13683;16670.91664541694;16896.493105206864;16963.915180424265;17038.31846726142;7382.889256661155;8765.956170219108;9142.908570914338;9215.723528294162;9554.331196816294;8519.361047921431;8553.315734741205;8580.099089595502;8671.306295496344;8700.78248043804;8016.318612917968;8094.1501142380375;8110.553919534483;8143.877841832377;8156.388270879589;1757.314647287559;1789.4452719656688;1851.7222416637612;2222.833287503444;2231.5983123037686;931.743770463128;941.8775559177263;946.2760987844305;978.4569563891966;983.2183414185739;15592.844071559366;20369;21235.256766013117;21395.67906481404;21623.45941351479;896.2292428511475;984.6652138273022;987.4963768477984;1009.7021378693303;1021.1881554164457;9752.219822414332;10552.419616921143;10929.398883061349;10981.231313807957;11060.668179954615;524763;540997;542681;544633;544906;117882.82117178719;123625;141586;145700.2714986418;146493;1091.3779145886767;1170.7834050700649;1199.3703305764543;1242.9564965226173;1249.237964841446;21548.92255387256;22400;22450.214242501435;22522.986465609414;22540;57980.13029804472;58554;58599.70700146472;60354.09468857883;60867;83426;84085;84150;84652;86831;9020.458772473672;9170.44977301364;9247.213986811197;9255.76860578464;9296.860547091934;14125.081869678437;14477.855221447651;14535.636609084857;14695.632609184855;14753.92623036878;11013.614523491638;11922.582709605122;11947.641570752892;12114.878851211375;12275.69310767238;11105;11396.430178491208;11729.237599556001;11737.119716021161;11984;11824.881751182378;11914.225575337576;12136.211146275464;12145.878541214475;12278.447469863699;7282;7827.412944029106;9108.225800807006;9162.587683554122;9172.174504294646;10634.627788027381;10880.836787448035;10983.560657573928;11813;12348.135630505778 20:58:49 INFO - PID 2566 | |3;mootools.html;1409.1545072956228;1436.1322259071203;1458.8759955403784;1482.332950172422;1490.6496973211295;8031.518108913469;10301.742456438593;11325.716857078567;11713.180077394585;11857.7628447431;11171.106311495081;11464.942675286611;11480.311181329105;11551.653450396481;11566.47950842212;2502.687164104487;2555.2589748972778;2560.6031065184925;2563.3976015636313;2569.3448170716533;2495.1765917247267;2551.6427700122;2556.0542599238306;2556.642070110186;2558.09187738353;2065.8760474371584;2084.770675225724;2518.496300739859;2522.1046528482398;2538.4415428605676;2485.490474452733;2489.278109348296;2496.950060998788;2498.300475866742;2498.537770512452;2461.113998960373;2464.7042354917344;2474.356667266524;2475.8143139264625;2480.2435257246534;11620.244684095507;11660.008899243574;11736.061115110857;11738.119641026957;11757.941210293979;6513;6736.191657001191;6752.93247067528;6755.088063111466;6768.221654509745;4108.4864391951005;4316.6978311518205;4410.404595379615;4415.51429342772;4424.159409712177;1243.875612438758;1258.452573130691;1272.573687814574;1309.0836414509881;1313.1070871807167;12925.935370323088;16343.673126537522;16587.668246635;16605.252763625544;16612.418565350155;4962.627802914796;5801.593888427854;5895.882082358329;6155.692215389302;6156.969215153896;13465.192088474723;13540.187588744708;13601.387937542835;13611.52359667407;13657.795133073012;6734.8989765153565;6769.729210831511;6818.863622727517;6833.214180369222;6847.726090956406;5490.6431081979545;6201.658908760061;6202.379762023852;6254.9687251563455;6270.2789179244055;4595.724256544551;4730.5032971538185;4765.166095933268;4800.135975524369;4808.230683090689;1478.9630259243604;1501.1968596800878;1508.3212554350587;1519.2024187301754;1521.7565189569616;786.3080489169608;792.5957761541655;808.9919100808917;814;831.6465502161557;6462.289148193695;6806.489513286523;6856.794296171123;6969.431877827448;7018.719251229893;588.2235449207005;608.3277977834517;608.7504123309421;614.0727501472808;621.0745988477137;3633.672969432711;3806.7525610835205;3876.3991581304945;3906.980465097656;3956.9010774730286;14567.271636418136;15142.54572362831;15247.23763811805;15252.847471525143;15256.237188140549;14818.33317500715;14971.850281497263;15076.095434273979;15160.848391515943;15175.241237938058;8328;8641.913580864237;8725.869111963326;8731.345149113842;8763.167499087576;6877.862442751017;6886.380225779704;7049.08361912948;7049.131980025195;7135.393491553276;13313;13598.184108953494;13701.931490342484;13705.383257753625;13716.245606491739;11027.724306892393;13551.86448135506;13700;14000.089994150349;14159.36282867294;8403.495790252604;8642.783930401538;9174.403663761834;9190.908090919005;9481.004494527975;11022.944885275523;11098.722531936766;11131.443427828739;11134.554617815196;11159.49782259784;8972.19250267479;9165.54172291396;9273.165415112673;9336.439813611205;9397;7113.3953613943395;8046.517208967481;8520.957395212985;8934.88313960755;9076.591553379982;7951.642176102205;7994.880076798969;8023.277904988579;8063.153368896416;8117.228863257981;4378.6278166356215;6138.693065346625;6144.539159562962;6171.9691401542705;6188.1027251049245;6052.969735151296;6135.877282454415;6173.919564076179;6185.938140618716;6280.434760871543 20:58:49 INFO - PID 2566 | |4;prototype.html;362.8167775273487;371.73235270605187;394.99210015799684;407.7573843563079;421.7237709300409;4838.250071238959;6189.319174890758;6310.172717870821;6321.273053598838;6331.588446750964;5016.874578135548;5960.850978725523;6118.724657390417;6151.169592105064;6163.568550201488;4063.2686116499017;4401.185780630578;4470.664700147494;4672.252439609663;4785.3300537924715;4497.775111244441;4773.734960235523;4775.758302841269;4778.737169455696;4817.807287708488;4162.146759914211;4701.788419521113;4735.360726301957;4768.64235182361;4785.353977213066;4032.9111139992333;4063.5936406359424;4633.4439867215815;4718.4809670936165;4738.502457242009;3450.240946991658;3647.835847386874;4202.831886724527;4229.217594744951;4252.255855225354;5937.495312898409;6089.208402907594;6121.326654068049;6132.908006379907;6134;5634.690092044936;5667;5668.886622267572;5692.260006199168;5716.399778023331;5722.597963498928;6737.023131645933;6740.696668649874;6764.0530325754435;6781.72873085076;4701.858944231679;4826.476672029403;4847.903041939141;4881.438634557036;4885.267209918505;5665.03447586691;6021.2473440819895;6459.192600924837;7072.434205263567;7086.228442889278;3470.444728843373;4139.544650088488;4868.123737727243;4903.656744027955;4933.432655244693;5013.621254155137;5033.496650334937;5033.546980771748;5042.546170844642;5044.319016932667;5270.894582108336;5467.305135408036;5536.833894983157;5543.228385807097;5601.915971260434;6205.73490675909;6698.866022679616;6702.765403210864;6735.797926062226;6741.460683145337;1517.2034681792147;1587.396789220089;1693.6866679664056;1716.9055701936513;1737.4527023987403;1172.7451626759457;1185.5257896841333;1198.1972078707288;1198.556534082395;1212.5392350906775;6158.599691020069;6164.3835616438;6181.96909015452;6191.133241346215;6198.969005155035;5553.611247212737;6100.389961003864;6270.498360131179;6542.901856472156;6570.671466426659;5213.905079933256;5569.498745112959;5674.2339784129435;6123.142760013601;6167.537434692416;3566.375884220251;3595.3168897909313;3600.765950213228;3602.837872295753;3612.7290453216115;6516.348365163446;6867.278935711678;7062.6821793019435;7110.288971102848;7141.607211603412;6011.939880601226;6073.240844894388;6497.480201583862;7060.281172250494;7112.466565007645;6470.288268290578;6487.610743355413;6933;7067.6112813795735;7121.821954451077;6863.279355667583;6869.832128538261;6892.931070689229;6907.585544867324;6940.236573976757;6383.840403989938;6637.601743895381;6656.434203092597;6805.659717014229;6828.917180260069;6144.8771024580155;7104.538205016657;7170.784876453715;7184;7192.2088570258275;3946.2304850553865;4344.131173765323;4406.493253275914;4408.845690400821;4416.1609294233995;5754.712264386848;6172.4136207060255;6483.546151769519;6860.382565569123;7009.866366928937;5580.776768929198;6733.52865299444;6752.898706519308;6755.898661519983;6760.431036206211;5143.5113664201845;5549.389567147691;5797.391273916178;6509.446697030806;6678.766243181465;5411;6555.934440655723;6578.407943285128;6613.404793568602;6615.37153970372;5120.334356533627;5528.474794894479;6125.601835880653;6788.389044985975;6821.89767153503;4937.530934561211;5394.487523685244;5662.065759149694;6326.778562750282;6695.4978376620975 20:58:49 INFO - PID 2566 | |5;yui.html;672.0456951129396;855.8844555984942;877.0703054761949;883.5626364949347;888.0276097673046;15415.460458883941;16872.66254674906;17067.658646827073;17223.913880430613;19111.71332430011;17855.64288714225;17894.37369692061;18031.36890208843;18085.819141808577;18337.724934126;966.3718582921123;985.9942858284545;991.479473276532;995.1143482300758;998.1615443027855;1006.5621454667244;1014.0721240065332;1014.6195176808696;1015.0610685116238;1016.0499932563077;1050.1231471721085;1050.406520316019;1050.9579616815317;1053.773438710677;1062.1184416933966;1045.7908418316367;1046.9738256543571;1047.4291511126455;1048.2924026282267;1062.2351906627255;753.1414187825883;761.2083433229435;763.4236151705427;767.6699019421646;775.2247752247753;16531.504054878373;16596.336146554124;16689.916550417292;16692.74960875588;16726;16700.49898503047;16904;17142.742858857127;17213.967161970322;17250.654986900317;13867.653308667364;13932.860671393257;14099.154050756988;14110.647233819134;14174.645633859132;3519.04985653872;3547.6452354764315;3570.821458927069;3580.1383280693894;3580.2123532823;127645;131590.3420482901;139130.30434847862;140055;143729.28135359255;13225.73548529024;13326.866731332562;13357.866421335857;13470.730585388237;13538.729225415436;25029.374265643506;25448.363790905005;25502.23493295204;25766.613500797503;25786.097486587878;7696.807579810437;7797.454178207471;7973.641186146638;8042.517448953082;8052.838943221102;3964.702647301464;4033.8184781684895;4041.4341992121126;4051.513818341818;4098.323776576891;3756.887293381203;4163.167366526707;4274.7435153890865;4320.891977700519;4326.891827704269;840.9152193670219;956.7177682583655;966.6375109334;974.7124598243536;974.8732664753537;537.5538303208406;632.9208848893888;658.4633523678283;662.6256165266609;683.1563019670702;9448.763780905532;11246.268992515461;12029.338386388832;12208.816867746991;12209.877901220874;642.9807105786834;650.7884937395365;656.5601047298321;668.5888178770022;677.6374639567807;4660.720356778605;5542.7782888684005;5727.5990680652785;5743.195952566644;5860.853478663067;93131;108682.45658771656;110441.89558104477;111585;113838;95531.52234238923;95598;95920.52039739757;96588.51705741427;96805;55341.723291383285;80406.79389809158;85758;88175.55912220526;89226.55386723155;8756.956215218883;9270.258379329773;11505.769884602094;11529.423528823692;11581.88418115808;41959.370609441496;42470.78764606157;42589;42823.715288541396;42867.71396858099;56715;56760;57616.4238357611;57690.711546442;58307.12539311998;14543.563693089225;14723.558293251219;14763.852361476678;14764.48324308644;14808.925955370154;17866.374676886768;18584.81415185885;18626.534336641693;18771.155298011894;18967.715484268025;16050.438234661731;16067.678646426772;17135.971841689538;17179.828201717824;17276.13619319004;16679.58301042435;16864;17132.828671713123;17266.136693165543;17287.56781080433;15860.68278634444;16114.597135071717;16621;16823.327066917675;16886.408975686285;11829.881701182878;11860.822087668865;11950.70123246891;11961.282323060645;12278.693032674255;12652.367381631066;13008.219506829242;13821.378037988114;13926.303684815515;13951.441942322193 20:58:49 INFO - PID 2566 | __end_tp_report 20:58:49 INFO - PID 2566 | __start_cc_report 20:58:49 INFO - PID 2566 | _x_x_mozilla_cycle_collect,430 20:58:49 INFO - PID 2566 | __end_cc_report 20:58:49 INFO - PID 2566 | __startTimestamp1493351929589__endTimestamp 20:58:49 INFO - PID 2566 | 20:58:49 INFO - PID 2566 | ------- Summary: start ------- 20:58:49 INFO - PID 2566 | Number of tests: 6 20:58:49 INFO - PID 2566 | 20:58:49 INFO - PID 2566 | [#0] dojo.html Cycles:165 Average:6122.41 Median:6340.52 stddev:723.27 (11.4%) stddev-sans-first:688.71 20:58:49 INFO - PID 2566 | Values: 3219.5 3534.2 3585.9 3587.4 3592.1 6128.4 6164.9 6171.0 6198.4 6212.3 6048.9 6144.8 6148.6 6162.1 6212.7 5338.1 5441.0 5464.0 5510.1 5592.6 5383.0 5524.6 5564.7 5582.1 5596.6 5475.0 5530.1 5558.0 5593.7 5613.5 5350.8 5423.2 5459.6 5468.3 5472.4 5386.5 5433.4 5440.6 5486.8 5501.1 5950.0 6181.4 6190.5 6192.0 6208.0 6428.9 6528.4 6532.6 6659.7 6680.5 6747.2 6753.6 6763.8 6778.5 6798.4 6301.8 6307.5 6314.2 6321.6 6337.8 5168.3 5527.3 6612.8 6649.5 6769.6 6328.7 6434.5 6434.9 6529.2 6542.9 6535.4 6580.3 6624.6 6728.5 6745.5 6510.5 6638.7 6640.9 6644.2 6657.5 6628.8 6644.6 6653.7 6655.2 6683.9 4519.7 5186.2 5244.5 5251.4 5285.8 4706.8 4712.1 4732.7 4759.3 4790.1 5007.7 6234.2 6260.1 6263.7 6277.4 6414.9 6628.2 6660.6 6717.9 6721.8 6249.2 6249.3 6285.8 6288.5 6317.5 5876.3 5878.9 5883.8 5886.9 5923.3 6629.7 6699.7 6831.5 6921.2 6937.9 6682.8 6698.6 6744.5 6755.4 6755.6 6896.8 6904.2 6912.7 6955.4 6984.6 6340.5 6475.1 6552.9 6562.6 6610.2 6550.3 6684.0 6711.6 6714.5 6750.2 6552.5 6553.6 6561.0 6562.6 6567.9 6220.9 6344.1 6377.4 6382.6 6479.3 6229.4 6410.8 6415.1 6425.5 6430.5 6524.1 6544.6 6550.2 6551.9 6553.5 6155.3 6282.0 6394.1 6401.4 6402.7 20:58:49 INFO - PID 2566 | 20:58:49 INFO - PID 2566 | [#1] ext.html Cycles:180 Average:44172.01 Median:324934.50 stddev:76504.70 (23.5%) stddev-sans-first:76649.85 20:58:49 INFO - PID 2566 | Values: 752.9 818.3 842.9 1027.7 1132.6 36185.6 36801.8 36910.6 36948.1 37051.3 38950.6 39314.8 39442.2 39606.8 39690.4 7489.3 8387.8 8473.6 8602.4 8623.0 6628.7 8606.4 8632.5 8632.8 8640.5 8591.7 8672.5 8700.1 8706.7 8730.3 7832.5 8079.4 8621.3 8645.4 8657.0 8500.4 8553.8 8557.6 8560.3 8567.4 31059.6 31663.8 36010.5 37273.4 37342.0 3391.2 3488.7 3539.5 3571.8 3572.5 30470.0 30540.5 30567.7 30589.7 30714.2 2631.7 3160.6 3185.9 3195.0 3198.5 182766.0 248567.0 278104.0 297191.0 299373.0 46295.0 46518.1 46521.5 46583.8 46841.5 49444.0 49703.0 49734.5 49736.8 49784.0 13874.7 13879.7 13907.8 14010.1 14019.7 11650.1 11658.0 11680.5 11685.3 11739.4 13490.9 13508.6 13513.5 13529.3 13623.9 5924.9 5986.7 6014.6 6033.7 6049.9 837.3 997.5 1005.7 1010.1 1039.7 20736.5 23952.6 25045.5 25216.7 25216.7 1088.5 1105.0 1139.0 1144.7 1145.6 10419.3 12273.5 12691.0 12829.3 12865.9 322192.0 323480.0 324610.0 324852.0 325017.0 54233.0 54342.5 54351.9 54375.7 54538.5 1326.8 1464.7 1516.0 1519.9 1525.1 22057.1 22306.0 24516.5 24614.4 24701.0 37875.2 37900.0 37922.4 37993.8 38169.6 241113.0 292452.0 292536.0 293320.0 293609.0 33035.3 33768.8 34585.0 34715.5 34765.0 43488.3 44027.0 45722.5 45836.8 45842.5 30305.7 30735.5 31284.2 31476.7 31670.7 30403.8 30760.4 30852.7 31191.7 31428.5 36299.1 37114.3 37440.0 37486.0 37611.1 30956.5 31672.0 31727.0 31826.0 31916.0 22288.7 23454.8 24689.0 24969.5 25142.0 20:58:49 INFO - PID 2566 | 20:58:49 INFO - PID 2566 | [#2] jquery.html Cycles:180 Average:35996.33 Median:22800.32 stddev:92205.40 (404.4%) stddev-sans-first:92425.41 20:58:49 INFO - PID 2566 | Values: 438.5 443.6 445.7 461.2 467.4 21472.5 22174.5 22236.0 22817.4 22818.9 21773.3 22525.2 22556.2 22783.2 22939.4 5999.6 6002.7 6022.5 6131.6 6190.0 5936.5 6053.2 6144.4 6150.7 6158.9 6172.8 6202.9 6205.7 6215.3 6218.1 5981.7 6081.3 6151.3 6205.9 6212.5 5439.9 5475.8 5476.0 5480.6 5496.0 26694.6 26855.5 27292.7 27483.0 27623.4 2230.2 2271.0 2274.3 2288.4 2289.7 17636.8 17957.3 18326.2 18447.4 18648.1 2119.2 2191.6 2215.1 2216.2 2231.4 134971.6 161505.2 165331.0 168135.0 171587.0 12894.5 12910.5 12923.9 13050.8 13193.3 13683.0 16670.9 16896.5 16963.9 17038.3 7382.9 8766.0 9142.9 9215.7 9554.3 8519.4 8553.3 8580.1 8671.3 8700.8 8016.3 8094.2 8110.6 8143.9 8156.4 1757.3 1789.4 1851.7 2222.8 2231.6 931.7 941.9 946.3 978.5 983.2 15592.8 20369.0 21235.3 21395.7 21623.5 896.2 984.7 987.5 1009.7 1021.2 9752.2 10552.4 10929.4 10981.2 11060.7 524763.0 540997.0 542681.0 544633.0 544906.0 117882.8 123625.0 141586.0 145700.3 146493.0 1091.4 1170.8 1199.4 1243.0 1249.2 21548.9 22400.0 22450.2 22523.0 22540.0 57980.1 58554.0 58599.7 60354.1 60867.0 83426.0 84085.0 84150.0 84652.0 86831.0 9020.5 9170.4 9247.2 9255.8 9296.9 14125.1 14477.9 14535.6 14695.6 14753.9 11013.6 11922.6 11947.6 12114.9 12275.7 11105.0 11396.4 11729.2 11737.1 11984.0 11824.9 11914.2 12136.2 12145.9 12278.4 7282.0 7827.4 9108.2 9162.6 9172.2 10634.6 10880.8 10983.6 11813.0 12348.1 20:58:49 INFO - PID 2566 | 20:58:49 INFO - PID 2566 | [#3] mootools.html Cycles:180 Average:7130.16 Median:3841.58 stddev:4513.07 (117.5%) stddev-sans-first:4505.26 20:58:49 INFO - PID 2566 | Values: 1409.2 1436.1 1458.9 1482.3 1490.6 8031.5 10301.7 11325.7 11713.2 11857.8 11171.1 11464.9 11480.3 11551.7 11566.5 2502.7 2555.3 2560.6 2563.4 2569.3 2495.2 2551.6 2556.1 2556.6 2558.1 2065.9 2084.8 2518.5 2522.1 2538.4 2485.5 2489.3 2497.0 2498.3 2498.5 2461.1 2464.7 2474.4 2475.8 2480.2 11620.2 11660.0 11736.1 11738.1 11757.9 6513.0 6736.2 6752.9 6755.1 6768.2 4108.5 4316.7 4410.4 4415.5 4424.2 1243.9 1258.5 1272.6 1309.1 1313.1 12925.9 16343.7 16587.7 16605.3 16612.4 4962.6 5801.6 5895.9 6155.7 6157.0 13465.2 13540.2 13601.4 13611.5 13657.8 6734.9 6769.7 6818.9 6833.2 6847.7 5490.6 6201.7 6202.4 6255.0 6270.3 4595.7 4730.5 4765.2 4800.1 4808.2 1479.0 1501.2 1508.3 1519.2 1521.8 786.3 792.6 809.0 814.0 831.6 6462.3 6806.5 6856.8 6969.4 7018.7 588.2 608.3 608.8 614.1 621.1 3633.7 3806.8 3876.4 3907.0 3956.9 14567.3 15142.5 15247.2 15252.8 15256.2 14818.3 14971.9 15076.1 15160.8 15175.2 8328.0 8641.9 8725.9 8731.3 8763.2 6877.9 6886.4 7049.1 7049.1 7135.4 13313.0 13598.2 13701.9 13705.4 13716.2 11027.7 13551.9 13700.0 14000.1 14159.4 8403.5 8642.8 9174.4 9190.9 9481.0 11022.9 11098.7 11131.4 11134.6 11159.5 8972.2 9165.5 9273.2 9336.4 9397.0 7113.4 8046.5 8521.0 8934.9 9076.6 7951.6 7994.9 8023.3 8063.2 8117.2 4378.6 6138.7 6144.5 6172.0 6188.1 6053.0 6135.9 6173.9 6185.9 6280.4 20:58:49 INFO - PID 2566 | 20:58:49 INFO - PID 2566 | [#4] prototype.html Cycles:180 Average:5348.51 Median:5719.50 stddev:1624.64 (28.4%) stddev-sans-first:1585.52 20:58:49 INFO - PID 2566 | Values: 362.8 371.7 395.0 407.8 421.7 4838.3 6189.3 6310.2 6321.3 6331.6 5016.9 5960.9 6118.7 6151.2 6163.6 4063.3 4401.2 4470.7 4672.3 4785.3 4497.8 4773.7 4775.8 4778.7 4817.8 4162.1 4701.8 4735.4 4768.6 4785.4 4032.9 4063.6 4633.4 4718.5 4738.5 3450.2 3647.8 4202.8 4229.2 4252.3 5937.5 6089.2 6121.3 6132.9 6134.0 5634.7 5667.0 5668.9 5692.3 5716.4 5722.6 6737.0 6740.7 6764.1 6781.7 4701.9 4826.5 4847.9 4881.4 4885.3 5665.0 6021.2 6459.2 7072.4 7086.2 3470.4 4139.5 4868.1 4903.7 4933.4 5013.6 5033.5 5033.5 5042.5 5044.3 5270.9 5467.3 5536.8 5543.2 5601.9 6205.7 6698.9 6702.8 6735.8 6741.5 1517.2 1587.4 1693.7 1716.9 1737.5 1172.7 1185.5 1198.2 1198.6 1212.5 6158.6 6164.4 6182.0 6191.1 6199.0 5553.6 6100.4 6270.5 6542.9 6570.7 5213.9 5569.5 5674.2 6123.1 6167.5 3566.4 3595.3 3600.8 3602.8 3612.7 6516.3 6867.3 7062.7 7110.3 7141.6 6011.9 6073.2 6497.5 7060.3 7112.5 6470.3 6487.6 6933.0 7067.6 7121.8 6863.3 6869.8 6892.9 6907.6 6940.2 6383.8 6637.6 6656.4 6805.7 6828.9 6144.9 7104.5 7170.8 7184.0 7192.2 3946.2 4344.1 4406.5 4408.8 4416.2 5754.7 6172.4 6483.5 6860.4 7009.9 5580.8 6733.5 6752.9 6755.9 6760.4 5143.5 5549.4 5797.4 6509.4 6678.8 5411.0 6555.9 6578.4 6613.4 6615.4 5120.3 5528.5 6125.6 6788.4 6821.9 4937.5 5394.5 5662.1 6326.8 6695.5 20:58:49 INFO - PID 2566 | 20:58:49 INFO - PID 2566 | [#5] yui.html Cycles:180 Average:22379.39 Median:18461.27 stddev:32337.12 (175.2%) stddev-sans-first:32386.76 20:58:49 INFO - PID 2566 | Values: 672.0 855.9 877.1 883.6 888.0 15415.5 16872.7 17067.7 17223.9 19111.7 17855.6 17894.4 18031.4 18085.8 18337.7 966.4 986.0 991.5 995.1 998.2 1006.6 1014.1 1014.6 1015.1 1016.0 1050.1 1050.4 1051.0 1053.8 1062.1 1045.8 1047.0 1047.4 1048.3 1062.2 753.1 761.2 763.4 767.7 775.2 16531.5 16596.3 16689.9 16692.7 16726.0 16700.5 16904.0 17142.7 17214.0 17250.7 13867.7 13932.9 14099.2 14110.6 14174.6 3519.0 3547.6 3570.8 3580.1 3580.2 127645.0 131590.3 139130.3 140055.0 143729.3 13225.7 13326.9 13357.9 13470.7 13538.7 25029.4 25448.4 25502.2 25766.6 25786.1 7696.8 7797.5 7973.6 8042.5 8052.8 3964.7 4033.8 4041.4 4051.5 4098.3 3756.9 4163.2 4274.7 4320.9 4326.9 840.9 956.7 966.6 974.7 974.9 537.6 632.9 658.5 662.6 683.2 9448.8 11246.3 12029.3 12208.8 12209.9 643.0 650.8 656.6 668.6 677.6 4660.7 5542.8 5727.6 5743.2 5860.9 93131.0 108682.5 110441.9 111585.0 113838.0 95531.5 95598.0 95920.5 96588.5 96805.0 55341.7 80406.8 85758.0 88175.6 89226.6 8757.0 9270.3 11505.8 11529.4 11581.9 41959.4 42470.8 42589.0 42823.7 42867.7 56715.0 56760.0 57616.4 57690.7 58307.1 14543.6 14723.6 14763.9 14764.5 14808.9 17866.4 18584.8 18626.5 18771.2 18967.7 16050.4 16067.7 17136.0 17179.8 17276.1 16679.6 16864.0 17132.8 17266.1 17287.6 15860.7 16114.6 16621.0 16823.3 16886.4 11829.9 11860.8 11950.7 11961.3 12278.7 12652.4 13008.2 13821.4 13926.3 13951.4 20:58:49 INFO - PID 2566 | -------- Summary: end -------- 20:58:49 INFO - PID 2566 | 20:58:50 INFO - TEST-INFO | 2566: exit 0 20:58:50 INFO - TEST-OK | dromaeo_css | took 1115688ms 20:58:50 INFO - TEST-START | kraken 20:58:50 INFO - operating with platform_type : mac_ 20:58:50 INFO - Initialising browser for kraken test... 20:58:50 INFO - TEST-INFO | started process 2570 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpcxwjdn/profile http://localhost:60727/getInfo.html) 20:58:53 INFO - PID 2570 | 2017-04-27 20:58:53.120 plugin-container[2571:37699] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 20:58:53 INFO - PID 2570 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:58:53 INFO - PID 2570 | 2017-04-27 20:58:53.123 plugin-container[2571:37699] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9813, name = 'com.apple.CFPasteboardClient' 20:58:53 INFO - PID 2570 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:58:53 INFO - PID 2570 | 2017-04-27 20:58:53.123 plugin-container[2571:37699] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:58:53 INFO - PID 2570 | __metrics Screen width/height:1600/1200 20:58:53 INFO - PID 2570 | colorDepth:24 20:58:53 INFO - PID 2570 | Browser inner width/height: 1024/689 20:58:53 INFO - PID 2570 | __metrics 20:58:53 ERROR - PID 2570 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 20:58:54 INFO - TEST-INFO | 2570: exit 0 20:58:54 INFO - Browser initialized. 20:58:54 INFO - Running cycle 1/1 for kraken test... 20:58:54 INFO - TEST-INFO | started process 2572 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpcxwjdn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:58:56 INFO - PID 2572 | 2017-04-27 20:58:56.514 plugin-container[2573:37825] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 20:58:56 INFO - PID 2572 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:58:56 INFO - PID 2572 | 2017-04-27 20:58:56.517 plugin-container[2573:37825] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a03, name = 'com.apple.CFPasteboardClient' 20:58:56 INFO - PID 2572 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:58:56 INFO - PID 2572 | 2017-04-27 20:58:56.517 plugin-container[2573:37825] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:59:06 INFO - PID 2572 | RSS: Main: 238993408 20:59:06 INFO - PID 2572 | 20:59:09 INFO - PID 2572 | Cycle 1(1): loaded http://localhost:60727/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60727/tests/kraken/driver.html?testName=audio-beat-detection) 20:59:10 INFO - PID 2572 | RSS: Main: 251154432 20:59:10 INFO - PID 2572 | 20:59:12 INFO - PID 2572 | Cycle 1(1): loaded http://localhost:60727/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60727/tests/kraken/driver.html?testName=audio-dft) 20:59:13 INFO - PID 2572 | RSS: Main: 259833856 20:59:13 INFO - PID 2572 | 20:59:16 INFO - PID 2572 | Cycle 1(1): loaded http://localhost:60727/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60727/tests/kraken/driver.html?testName=audio-fft) 20:59:17 INFO - PID 2572 | RSS: Main: 261935104 20:59:17 INFO - PID 2572 | 20:59:19 INFO - PID 2572 | Cycle 1(1): loaded http://localhost:60727/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60727/tests/kraken/driver.html?testName=audio-oscillator) 20:59:19 INFO - PID 2572 | RSS: Main: 262955008 20:59:19 INFO - PID 2572 | 20:59:21 INFO - PID 2572 | Cycle 1(1): loaded http://localhost:60727/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60727/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:59:22 INFO - PID 2572 | RSS: Main: 264888320 20:59:22 INFO - PID 2572 | 20:59:25 INFO - PID 2572 | Cycle 1(1): loaded http://localhost:60727/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60727/tests/kraken/driver.html?testName=imaging-darkroom) 20:59:26 INFO - PID 2572 | RSS: Main: 270233600 20:59:26 INFO - PID 2572 | 20:59:29 INFO - PID 2572 | Cycle 1(1): loaded http://localhost:60727/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60727/tests/kraken/driver.html?testName=imaging-desaturate) 20:59:30 INFO - PID 2572 | RSS: Main: 271425536 20:59:30 INFO - PID 2572 | 20:59:32 INFO - PID 2572 | Cycle 1(1): loaded http://localhost:60727/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60727/tests/kraken/driver.html?testName=json-parse-financial) 20:59:33 INFO - PID 2572 | RSS: Main: 271155200 20:59:33 INFO - PID 2572 | 20:59:35 INFO - PID 2572 | Cycle 1(1): loaded http://localhost:60727/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60727/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:59:35 INFO - PID 2572 | RSS: Main: 270962688 20:59:35 INFO - PID 2572 | 20:59:37 INFO - PID 2572 | Cycle 1(1): loaded http://localhost:60727/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60727/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:59:38 INFO - PID 2572 | RSS: Main: 271278080 20:59:38 INFO - PID 2572 | 20:59:40 INFO - PID 2572 | Cycle 1(1): loaded http://localhost:60727/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60727/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:59:40 INFO - PID 2572 | RSS: Main: 270766080 20:59:40 INFO - PID 2572 | 20:59:43 INFO - PID 2572 | Cycle 1(1): loaded http://localhost:60727/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60727/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:59:44 INFO - PID 2572 | RSS: Main: 270938112 20:59:44 INFO - PID 2572 | 20:59:47 INFO - PID 2572 | Cycle 1(1): loaded http://localhost:60727/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60727/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:59:48 INFO - PID 2572 | RSS: Main: 271007744 20:59:48 INFO - PID 2572 | 20:59:50 INFO - PID 2572 | Cycle 1(1): loaded http://localhost:60727/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60727/tests/kraken/driver.html?testName=ai-astar) 20:59:50 INFO - PID 2572 | RSS: Main: 272625664 20:59:50 INFO - PID 2572 | 20:59:50 INFO - PID 2572 | __start_tp_report 20:59:50 INFO - PID 2572 | _x_x_mozilla_page_load 20:59:50 INFO - PID 2572 | _x_x_mozilla_page_load_details 20:59:50 INFO - PID 2572 | |i|pagename|runs| 20:59:50 INFO - PID 2572 | |0;ai-astar;103;123;113;113;115;114;113;114;115;114 20:59:50 INFO - PID 2572 | |1;audio-beat-detection;161;110;117;187;119;110;109;118;163;149 20:59:50 INFO - PID 2572 | |2;audio-dft;202;198;206;230;211;210;200;249;199;196 20:59:50 INFO - PID 2572 | |3;audio-fft;82;58;60;81;61;58;59;65;78;57 20:59:50 INFO - PID 2572 | |4;audio-oscillator;80;77;81;101;103;59;105;96;117;104 20:59:50 INFO - PID 2572 | |5;imaging-gaussian-blur;89;107;107;89;99;88;103;88;89;111 20:59:50 INFO - PID 2572 | |6;imaging-darkroom;99;153;126;99;133;130;94;89;94;151 20:59:50 INFO - PID 2572 | |7;imaging-desaturate;92;93;89;91;91;91;89;94;91;91 20:59:50 INFO - PID 2572 | |8;json-parse-financial;52;51;50;52;52;52;51;50;59;79 20:59:50 INFO - PID 2572 | |9;json-stringify-tinderbox;60;55;56;57;68;63;60;64;84;64 20:59:50 INFO - PID 2572 | |10;stanford-crypto-aes;81;86;107;106;81;83;84;80;89;72 20:59:50 INFO - PID 2572 | |11;stanford-crypto-ccm;137;139;144;130;164;159;153;138;181;134 20:59:50 INFO - PID 2572 | |12;stanford-crypto-pbkdf2;186;186;229;181;182;181;189;180;184;189 20:59:50 INFO - PID 2572 | |13;stanford-crypto-sha256-iterative;66;72;71;67;68;65;69;69;77;86 20:59:50 INFO - PID 2572 | __end_tp_report 20:59:50 INFO - PID 2572 | __start_cc_report 20:59:50 INFO - PID 2572 | _x_x_mozilla_cycle_collect,1016 20:59:50 INFO - PID 2572 | __end_cc_report 20:59:50 INFO - PID 2572 | __startTimestamp1493351990288__endTimestamp 20:59:50 INFO - PID 2572 | 20:59:50 INFO - PID 2572 | ------- Summary: start ------- 20:59:50 INFO - PID 2572 | Number of tests: 14 20:59:50 INFO - PID 2572 | 20:59:50 INFO - PID 2572 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:4.79 (4.2%) stddev-sans-first:3.14 20:59:50 INFO - PID 2572 | Values: 103.0 123.0 113.0 113.0 115.0 114.0 113.0 114.0 115.0 114.0 20:59:50 INFO - PID 2572 | 20:59:50 INFO - PID 2572 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:134.00 stddev:28.19 (21.0%) stddev-sans-first:28.19 20:59:50 INFO - PID 2572 | Values: 161.0 110.0 117.0 187.0 119.0 110.0 109.0 118.0 163.0 149.0 20:59:50 INFO - PID 2572 | 20:59:50 INFO - PID 2572 | [#2] audio-dft Cycles:10 Average:210.10 Median:208.00 stddev:16.88 (8.1%) stddev-sans-first:17.64 20:59:50 INFO - PID 2572 | Values: 202.0 198.0 206.0 230.0 211.0 210.0 200.0 249.0 199.0 196.0 20:59:50 INFO - PID 2572 | 20:59:50 INFO - PID 2572 | [#3] audio-fft Cycles:10 Average:65.90 Median:63.00 stddev:10.25 (16.3%) stddev-sans-first:9.06 20:59:50 INFO - PID 2572 | Values: 82.0 58.0 60.0 81.0 61.0 58.0 59.0 65.0 78.0 57.0 20:59:50 INFO - PID 2572 | 20:59:50 INFO - PID 2572 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:68.00 stddev:17.43 (25.6%) stddev-sans-first:17.91 20:59:50 INFO - PID 2572 | Values: 80.0 77.0 81.0 101.0 103.0 59.0 105.0 96.0 117.0 104.0 20:59:50 INFO - PID 2572 | 20:59:50 INFO - PID 2572 | [#5] imaging-gaussian-blur Cycles:10 Average:97.00 Median:88.50 stddev:9.37 (10.6%) stddev-sans-first:9.48 20:59:50 INFO - PID 2572 | Values: 89.0 107.0 107.0 89.0 99.0 88.0 103.0 88.0 89.0 111.0 20:59:50 INFO - PID 2572 | 20:59:50 INFO - PID 2572 | [#6] imaging-darkroom Cycles:10 Average:116.80 Median:91.50 stddev:24.60 (26.9%) stddev-sans-first:25.24 20:59:50 INFO - PID 2572 | Values: 99.0 153.0 126.0 99.0 133.0 130.0 94.0 89.0 94.0 151.0 20:59:50 INFO - PID 2572 | 20:59:50 INFO - PID 2572 | [#7] imaging-desaturate Cycles:10 Average:91.20 Median:91.00 stddev:1.55 (1.7%) stddev-sans-first:1.62 20:59:50 INFO - PID 2572 | Values: 92.0 93.0 89.0 91.0 91.0 91.0 89.0 94.0 91.0 91.0 20:59:50 INFO - PID 2572 | 20:59:50 INFO - PID 2572 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:52.00 stddev:8.88 (17.1%) stddev-sans-first:9.36 20:59:50 INFO - PID 2572 | Values: 52.0 51.0 50.0 52.0 52.0 52.0 51.0 50.0 59.0 79.0 20:59:50 INFO - PID 2572 | 20:59:50 INFO - PID 2572 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.50 stddev:8.40 (13.2%) stddev-sans-first:8.83 20:59:50 INFO - PID 2572 | Values: 60.0 55.0 56.0 57.0 68.0 63.0 60.0 64.0 84.0 64.0 20:59:50 INFO - PID 2572 | 20:59:50 INFO - PID 2572 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:82.00 stddev:11.24 (13.7%) stddev-sans-first:11.72 20:59:50 INFO - PID 2572 | Values: 81.0 86.0 107.0 106.0 81.0 83.0 84.0 80.0 89.0 72.0 20:59:50 INFO - PID 2572 | 20:59:50 INFO - PID 2572 | [#11] stanford-crypto-ccm Cycles:10 Average:147.90 Median:148.50 stddev:16.09 (10.8%) stddev-sans-first:16.57 20:59:50 INFO - PID 2572 | Values: 137.0 139.0 144.0 130.0 164.0 159.0 153.0 138.0 181.0 134.0 20:59:50 INFO - PID 2572 | 20:59:50 INFO - PID 2572 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.70 Median:186.00 stddev:14.53 (7.8%) stddev-sans-first:15.38 20:59:50 INFO - PID 2572 | Values: 186.0 186.0 229.0 181.0 182.0 181.0 189.0 180.0 184.0 189.0 20:59:50 INFO - PID 2572 | 20:59:50 INFO - PID 2572 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:70.00 stddev:6.29 (9.0%) stddev-sans-first:6.41 20:59:50 INFO - PID 2572 | Values: 66.0 72.0 71.0 67.0 68.0 65.0 69.0 69.0 77.0 86.0 20:59:50 INFO - PID 2572 | -------- Summary: end -------- 20:59:50 INFO - PID 2572 | 20:59:51 INFO - TEST-INFO | 2572: exit 0 20:59:51 INFO - TEST-OK | kraken | took 61228ms 20:59:51 INFO - SUITE-END | took 1176s 20:59:51 INFO - Completed test suite (00:19:37) 20:59:51 INFO - javascript benchmark 20:59:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7913.043655684299, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3219.468787650038, 3534.24013837025, 3585.892423227304, 3587.4080776671844, 3592.0660628236665, 6128.448439640431, 6164.907526387102, 6171.043488259315, 6198.411150940653, 6212.316645169028, 6048.939510604903, 6144.771045790837, 6148.600340977833, 6162.137300777895, 6212.720427580758, 5338.119210330291, 5441.020616289066, 5463.972680136613, 5510.1459273812425, 5592.636478628897, 5383.0, 5524.58565607579, 5564.693941833198, 5582.134769110774, 5596.58025648076, 5474.972625136888, 5530.142827861688, 5557.972210138943, 5593.720313984305, 5613.494785469307, 5350.785968561253, 5423.159410291371, 5459.645123066988, 5468.28912241406, 5472.398036216013, 5386.515213630752, 5433.375161856397, 5440.564754819605, 5486.753096110685, 5501.092319767274, 5949.970250148722, 6181.443670069715, 6190.535709821736, 6192.0, 6207.968960155215, 6428.935710642881, 6528.445082167974, 6532.5753826001155, 6659.667016649197, 6680.465562754968, 6747.224069232052, 6753.628550429725, 6763.830904227384, 6778.525503214777, 6798.422134118557, 6301.842453938597, 6307.5269354798575, 6314.242290925118, 6321.55749097568, 6337.7781777637565, 5168.250603662448, 5527.281453411031, 6612.768553100618, 6649.534532582769, 6769.593824370553, 6328.6835658216905, 6434.517411194086, 6434.903476447857, 6529.249136349381, 6542.901856472156, 6535.411812936859, 6580.341965803477, 6624.56940298879, 6728.529002969843, 6745.52781305304, 6510.479161667055, 6638.6680665966505, 6640.933590664032, 6644.202695676549, 6657.46740260778, 6628.767993120217, 6644.634545099969, 6653.73385064592, 6655.239789518906, 6683.933160668428, 4519.683622146418, 5186.196139598368, 5244.475552444801, 5251.396089449686, 5285.841424757264, 4706.764661766898, 4712.081144176921, 4732.6687131900435, 4759.333693282943, 4790.137775200427, 5007.69953802773, 6234.189555357774, 6260.123582698426, 6263.749450022039, 6277.403646653561, 6414.935850641527, 6628.204615446081, 6660.600363978177, 6717.899231511531, 6721.831954201184, 6249.218847644044, 6249.281332646713, 6285.811425657238, 6288.465480434123, 6317.526185536103, 5876.324222714357, 5878.911816322759, 5883.764649414061, 5886.882262354815, 5923.348431672599, 6629.668516574248, 6699.732010719516, 6831.45348372139, 6921.169459664872, 6937.895931561132, 6682.83292917681, 6698.631575263213, 6744.494162937701, 6755.42578880781, 6755.594664320157, 6896.827579310357, 6904.240533541206, 6912.723491060502, 6955.374016338554, 6984.580925144508, 6340.524460665561, 6475.125858009108, 6552.901706474502, 6562.639054851838, 6610.173728283965, 6550.344965503412, 6684.0, 6711.6308603025345, 6714.52998290115, 6750.223724271772, 6552.508561857975, 6553.574017688835, 6561.0, 6562.639054852029, 6567.868642627216, 6220.937790622036, 6344.1118243445035, 6377.362263773771, 6382.5532212744665, 6479.287278399466, 6229.4393504584805, 6410.8076757697345, 6415.133956915944, 6425.453836423956, 6430.48556115519, 6524.086627872007, 6544.607323560602, 6550.246721627074, 6551.868962620625, 6553.5084868634085, 6155.292141403616, 6281.96859015702, 6394.072859435263, 6401.3598640135615, 6402.711877965596], "value": 6074.244539991074, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.8669352624299, 818.2758258940836, 842.9452085614435, 1027.650598796409, 1132.5526417065264, 36185.638143618555, 36801.81599092004, 36910.63089369106, 36948.07629809249, 37051.25897482052, 38950.63672771453, 39314.80342598283, 39442.21115577694, 39606.8019659902, 39690.40464393029, 7489.28851759082, 8387.790305242357, 8473.618687159078, 8602.397832151752, 8623.0, 6628.734850605994, 8606.354523410739, 8632.525211113387, 8632.827343453127, 8640.524771137585, 8591.699290524833, 8672.479651220916, 8700.129987001312, 8706.651733930667, 8730.301575873915, 7832.490888092313, 8079.353651707849, 8621.310295176403, 8645.394822362437, 8657.0044444889, 8500.404971651988, 8553.786155346104, 8557.572121393905, 8560.272376847975, 8567.443116197428, 31059.602317895522, 31663.84168079168, 36010.45984310238, 37273.44089838654, 37342.0, 3391.1522119470133, 3488.66857648523, 3539.4513850353237, 3571.8035508047046, 3572.517710109154, 30470.0, 30540.54189187164, 30567.69432305693, 30589.69410305913, 30714.23214419635, 2631.7105118436957, 3160.62072551293, 3185.8566364513654, 3194.952075718866, 3198.504231844068, 182766.0, 248567.0, 278103.99999999796, 297191.0, 299373.0, 46295.0, 46518.06963860704, 46521.534784652395, 46583.76708116438, 46841.531584684395, 49444.0, 49703.0, 49734.50265497299, 49736.756581085036, 49784.0, 13874.65313367174, 13879.722405551833, 13907.79138312926, 14010.089344192595, 14019.71960560783, 11650.067994560415, 11658.0, 11680.474378652982, 11685.298882067103, 11739.354335511629, 13490.86509134896, 13508.594742157751, 13513.459461621425, 13529.30883639545, 13623.910087193, 5924.940750592526, 5986.73059712314, 6014.6090504117965, 6033.668148251801, 6049.939500604937, 837.2924878477677, 997.4912794474725, 1005.7435353984687, 1010.1262408017012, 1039.6932904793105, 20736.48158796012, 23952.64071038901, 25045.497270163847, 25216.74783252144, 25216.747832521807, 1088.455772113943, 1104.9502772375263, 1138.9863021910505, 1144.6566030190909, 1145.5761368293618, 10419.270651054505, 12273.509059637514, 12691.048171387183, 12829.294388808705, 12865.935670321589, 322192.0, 323480.0, 324610.0, 324852.0, 325017.0, 54233.0, 54342.45657543374, 54351.91296174054, 54375.72812135914, 54538.45461545334, 1326.7877139657608, 1464.692414592926, 1516.041370111195, 1519.8860085493632, 1525.0620868165997, 22057.11771529121, 22306.0, 24516.50966980686, 24614.384640383418, 24701.0, 37875.242495150495, 37900.0, 37922.43116353202, 37993.81003095077, 38169.618303816605, 241113.0, 292452.0, 292536.0, 293320.0, 293609.0, 33035.339293214485, 33768.83115584406, 34585.0, 34715.47926781151, 34765.0, 43488.34767478427, 44027.0, 45722.542774571826, 45836.770816145705, 45842.541574583825, 30305.69694303029, 30735.538966915068, 31284.217894552818, 31476.685233147375, 31670.683293167695, 30403.847980759954, 30760.38479230358, 30852.69147308588, 31191.68808311888, 31428.528572071893, 36299.09252268715, 37114.25771484609, 37440.0, 37486.0, 37611.05972350713, 30956.53565196569, 31672.0, 31727.0, 31826.045218643478, 31916.0, 22288.665670015285, 23454.76545234526, 24689.012439502938, 24969.500609988063, 25141.994320226986], "value": 17403.17997518186, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [438.5022998896252, 443.6362183009931, 445.7147425647585, 461.2412581303755, 467.3970577954439, 21472.46318842028, 22174.50091465839, 22235.999380027897, 22817.429564260903, 22818.88590557049, 21773.346799595998, 22525.211617593388, 22556.21053263136, 22783.202587909425, 22939.42651433715, 5999.640021598707, 6002.729877155539, 6022.5483088768515, 6131.570790044699, 6190.0, 5936.5250779937505, 6053.152558641794, 6144.44699977002, 6150.6924653767355, 6158.938410615904, 6172.814815555541, 6202.937970620281, 6205.689715514229, 6215.28524219716, 6218.129461875318, 5981.730822113037, 6081.3006504252135, 6151.261848578154, 6205.906911396332, 6212.502999760009, 5439.945600544023, 5475.780968761244, 5476.0, 5480.616356855022, 5496.038193316153, 26694.5995810063, 26855.46289074227, 27292.727072729216, 27483.038093666826, 27623.447531049267, 2230.2305704532073, 2270.9886450567806, 2274.294968559735, 2288.3592594073684, 2289.7366802817724, 17636.823631763647, 17957.281708731767, 18326.175322110535, 18447.44657660259, 18648.06759662025, 2119.173522326294, 2191.638379667353, 2215.080741492279, 2216.180013395038, 2231.386368748591, 134971.60113595444, 161505.19247403688, 165331.0, 168135.0, 171587.0, 12894.548690795777, 12910.483580656857, 12923.870761292455, 13050.804237936438, 13193.274369909555, 13683.0, 16670.91664541694, 16896.493105206864, 16963.915180424265, 17038.31846726142, 7382.889256661155, 8765.956170219108, 9142.908570914338, 9215.723528294162, 9554.331196816294, 8519.361047921431, 8553.315734741205, 8580.099089595502, 8671.306295496344, 8700.78248043804, 8016.318612917968, 8094.1501142380375, 8110.553919534483, 8143.877841832377, 8156.388270879589, 1757.314647287559, 1789.4452719656688, 1851.7222416637612, 2222.833287503444, 2231.5983123037686, 931.743770463128, 941.8775559177263, 946.2760987844305, 978.4569563891966, 983.2183414185739, 15592.844071559366, 20369.0, 21235.256766013117, 21395.67906481404, 21623.45941351479, 896.2292428511475, 984.6652138273022, 987.4963768477984, 1009.7021378693303, 1021.1881554164457, 9752.219822414332, 10552.419616921143, 10929.398883061349, 10981.231313807957, 11060.668179954615, 524763.0, 540997.0, 542681.0, 544633.0, 544906.0, 117882.82117178719, 123625.0, 141586.0, 145700.2714986418, 146493.0, 1091.3779145886767, 1170.7834050700649, 1199.3703305764543, 1242.9564965226173, 1249.237964841446, 21548.92255387256, 22400.0, 22450.214242501435, 22522.986465609414, 22540.0, 57980.13029804472, 58554.0, 58599.70700146472, 60354.09468857883, 60867.0, 83426.0, 84085.0, 84150.0, 84652.0, 86831.0, 9020.458772473672, 9170.44977301364, 9247.213986811197, 9255.76860578464, 9296.860547091934, 14125.081869678437, 14477.855221447651, 14535.636609084857, 14695.632609184855, 14753.92623036878, 11013.614523491638, 11922.582709605122, 11947.641570752892, 12114.878851211375, 12275.69310767238, 11105.0, 11396.430178491208, 11729.237599556001, 11737.119716021161, 11984.0, 11824.881751182378, 11914.225575337576, 12136.211146275464, 12145.878541214475, 12278.447469863699, 7282.0, 7827.412944029106, 9108.225800807006, 9162.587683554122, 9172.174504294646, 10634.627788027381, 10880.836787448035, 10983.560657573928, 11813.0, 12348.135630505778], "value": 10569.327759253136, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1409.1545072956228, 1436.1322259071203, 1458.8759955403784, 1482.332950172422, 1490.6496973211295, 8031.518108913469, 10301.742456438593, 11325.716857078567, 11713.180077394585, 11857.7628447431, 11171.106311495081, 11464.942675286611, 11480.311181329105, 11551.653450396481, 11566.47950842212, 2502.687164104487, 2555.2589748972778, 2560.6031065184925, 2563.3976015636313, 2569.3448170716533, 2495.1765917247267, 2551.6427700122, 2556.0542599238306, 2556.642070110186, 2558.09187738353, 2065.8760474371584, 2084.770675225724, 2518.496300739859, 2522.1046528482398, 2538.4415428605676, 2485.490474452733, 2489.278109348296, 2496.950060998788, 2498.300475866742, 2498.537770512452, 2461.113998960373, 2464.7042354917344, 2474.356667266524, 2475.8143139264625, 2480.2435257246534, 11620.244684095507, 11660.008899243574, 11736.061115110857, 11738.119641026957, 11757.941210293979, 6513.0, 6736.191657001191, 6752.93247067528, 6755.088063111466, 6768.221654509745, 4108.4864391951005, 4316.6978311518205, 4410.404595379615, 4415.51429342772, 4424.159409712177, 1243.875612438758, 1258.452573130691, 1272.573687814574, 1309.0836414509881, 1313.1070871807167, 12925.935370323088, 16343.673126537522, 16587.668246635, 16605.252763625544, 16612.418565350155, 4962.627802914796, 5801.593888427854, 5895.882082358329, 6155.692215389302, 6156.969215153896, 13465.192088474723, 13540.187588744708, 13601.387937542835, 13611.52359667407, 13657.795133073012, 6734.8989765153565, 6769.729210831511, 6818.863622727517, 6833.214180369222, 6847.726090956406, 5490.6431081979545, 6201.658908760061, 6202.379762023852, 6254.9687251563455, 6270.2789179244055, 4595.724256544551, 4730.5032971538185, 4765.166095933268, 4800.135975524369, 4808.230683090689, 1478.9630259243604, 1501.1968596800878, 1508.3212554350587, 1519.2024187301754, 1521.7565189569616, 786.3080489169608, 792.5957761541655, 808.9919100808917, 814.0, 831.6465502161557, 6462.289148193695, 6806.489513286523, 6856.794296171123, 6969.431877827448, 7018.719251229893, 588.2235449207005, 608.3277977834517, 608.7504123309421, 614.0727501472808, 621.0745988477137, 3633.672969432711, 3806.7525610835205, 3876.3991581304945, 3906.980465097656, 3956.9010774730286, 14567.271636418136, 15142.54572362831, 15247.23763811805, 15252.847471525143, 15256.237188140549, 14818.33317500715, 14971.850281497263, 15076.095434273979, 15160.848391515943, 15175.241237938058, 8328.0, 8641.913580864237, 8725.869111963326, 8731.345149113842, 8763.167499087576, 6877.862442751017, 6886.380225779704, 7049.08361912948, 7049.131980025195, 7135.393491553276, 13313.0, 13598.184108953494, 13701.931490342484, 13705.383257753625, 13716.245606491739, 11027.724306892393, 13551.86448135506, 13700.0, 14000.089994150349, 14159.36282867294, 8403.495790252604, 8642.783930401538, 9174.403663761834, 9190.908090919005, 9481.004494527975, 11022.944885275523, 11098.722531936766, 11131.443427828739, 11134.554617815196, 11159.49782259784, 8972.19250267479, 9165.54172291396, 9273.165415112673, 9336.439813611205, 9397.0, 7113.3953613943395, 8046.517208967481, 8520.957395212985, 8934.88313960755, 9076.591553379982, 7951.642176102205, 7994.880076798969, 8023.277904988579, 8063.153368896416, 8117.228863257981, 4378.6278166356215, 6138.693065346625, 6144.539159562962, 6171.9691401542705, 6188.1027251049245, 6052.969735151296, 6135.877282454415, 6173.919564076179, 6185.938140618716, 6280.434760871543], "value": 5368.006292068108, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.8167775273487, 371.73235270605187, 394.99210015799684, 407.7573843563079, 421.7237709300409, 4838.250071238959, 6189.319174890758, 6310.172717870821, 6321.273053598838, 6331.588446750964, 5016.874578135548, 5960.850978725523, 6118.724657390417, 6151.169592105064, 6163.568550201488, 4063.2686116499017, 4401.185780630578, 4470.664700147494, 4672.252439609663, 4785.3300537924715, 4497.775111244441, 4773.734960235523, 4775.758302841269, 4778.737169455696, 4817.807287708488, 4162.146759914211, 4701.788419521113, 4735.360726301957, 4768.64235182361, 4785.353977213066, 4032.9111139992333, 4063.5936406359424, 4633.4439867215815, 4718.4809670936165, 4738.502457242009, 3450.240946991658, 3647.835847386874, 4202.831886724527, 4229.217594744951, 4252.255855225354, 5937.495312898409, 6089.208402907594, 6121.326654068049, 6132.908006379907, 6134.0, 5634.690092044936, 5667.0, 5668.886622267572, 5692.260006199168, 5716.399778023331, 5722.597963498928, 6737.023131645933, 6740.696668649874, 6764.0530325754435, 6781.72873085076, 4701.858944231679, 4826.476672029403, 4847.903041939141, 4881.438634557036, 4885.267209918505, 5665.03447586691, 6021.2473440819895, 6459.192600924837, 7072.434205263567, 7086.228442889278, 3470.444728843373, 4139.544650088488, 4868.123737727243, 4903.656744027955, 4933.432655244693, 5013.621254155137, 5033.496650334937, 5033.546980771748, 5042.546170844642, 5044.319016932667, 5270.894582108336, 5467.305135408036, 5536.833894983157, 5543.228385807097, 5601.915971260434, 6205.73490675909, 6698.866022679616, 6702.765403210864, 6735.797926062226, 6741.460683145337, 1517.2034681792147, 1587.396789220089, 1693.6866679664056, 1716.9055701936513, 1737.4527023987403, 1172.7451626759457, 1185.5257896841333, 1198.1972078707288, 1198.556534082395, 1212.5392350906775, 6158.599691020069, 6164.3835616438, 6181.96909015452, 6191.133241346215, 6198.969005155035, 5553.611247212737, 6100.389961003864, 6270.498360131179, 6542.901856472156, 6570.671466426659, 5213.905079933256, 5569.498745112959, 5674.2339784129435, 6123.142760013601, 6167.537434692416, 3566.375884220251, 3595.3168897909313, 3600.765950213228, 3602.837872295753, 3612.7290453216115, 6516.348365163446, 6867.278935711678, 7062.6821793019435, 7110.288971102848, 7141.607211603412, 6011.939880601226, 6073.240844894388, 6497.480201583862, 7060.281172250494, 7112.466565007645, 6470.288268290578, 6487.610743355413, 6933.0, 7067.6112813795735, 7121.821954451077, 6863.279355667583, 6869.832128538261, 6892.931070689229, 6907.585544867324, 6940.236573976757, 6383.840403989938, 6637.601743895381, 6656.434203092597, 6805.659717014229, 6828.917180260069, 6144.8771024580155, 7104.538205016657, 7170.784876453715, 7184.0, 7192.2088570258275, 3946.2304850553865, 4344.131173765323, 4406.493253275914, 4408.845690400821, 4416.1609294233995, 5754.712264386848, 6172.4136207060255, 6483.546151769519, 6860.382565569123, 7009.866366928937, 5580.776768929198, 6733.52865299444, 6752.898706519308, 6755.898661519983, 6760.431036206211, 5143.5113664201845, 5549.389567147691, 5797.391273916178, 6509.446697030806, 6678.766243181465, 5411.0, 6555.934440655723, 6578.407943285128, 6613.404793568602, 6615.37153970372, 5120.334356533627, 5528.474794894479, 6125.601835880653, 6788.389044985975, 6821.89767153503, 4937.530934561211, 5394.487523685244, 5662.065759149694, 6326.778562750282, 6695.4978376620975], "value": 4856.87433721841, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.0456951129396, 855.8844555984942, 877.0703054761949, 883.5626364949347, 888.0276097673046, 15415.460458883941, 16872.66254674906, 17067.658646827073, 17223.913880430613, 19111.71332430011, 17855.64288714225, 17894.37369692061, 18031.36890208843, 18085.819141808577, 18337.724934126, 966.3718582921123, 985.9942858284545, 991.479473276532, 995.1143482300758, 998.1615443027855, 1006.5621454667244, 1014.0721240065332, 1014.6195176808696, 1015.0610685116238, 1016.0499932563077, 1050.1231471721085, 1050.406520316019, 1050.9579616815317, 1053.773438710677, 1062.1184416933966, 1045.7908418316367, 1046.9738256543571, 1047.4291511126455, 1048.2924026282267, 1062.2351906627255, 753.1414187825883, 761.2083433229435, 763.4236151705427, 767.6699019421646, 775.2247752247753, 16531.504054878373, 16596.336146554124, 16689.916550417292, 16692.74960875588, 16726.0, 16700.49898503047, 16904.0, 17142.742858857127, 17213.967161970322, 17250.654986900317, 13867.653308667364, 13932.860671393257, 14099.154050756988, 14110.647233819134, 14174.645633859132, 3519.04985653872, 3547.6452354764315, 3570.821458927069, 3580.1383280693894, 3580.2123532823, 127645.0, 131590.3420482901, 139130.30434847862, 140055.0, 143729.28135359255, 13225.73548529024, 13326.866731332562, 13357.866421335857, 13470.730585388237, 13538.729225415436, 25029.374265643506, 25448.363790905005, 25502.23493295204, 25766.613500797503, 25786.097486587878, 7696.807579810437, 7797.454178207471, 7973.641186146638, 8042.517448953082, 8052.838943221102, 3964.702647301464, 4033.8184781684895, 4041.4341992121126, 4051.513818341818, 4098.323776576891, 3756.887293381203, 4163.167366526707, 4274.7435153890865, 4320.891977700519, 4326.891827704269, 840.9152193670219, 956.7177682583655, 966.6375109334, 974.7124598243536, 974.8732664753537, 537.5538303208406, 632.9208848893888, 658.4633523678283, 662.6256165266609, 683.1563019670702, 9448.763780905532, 11246.268992515461, 12029.338386388832, 12208.816867746991, 12209.877901220874, 642.9807105786834, 650.7884937395365, 656.5601047298321, 668.5888178770022, 677.6374639567807, 4660.720356778605, 5542.7782888684005, 5727.5990680652785, 5743.195952566644, 5860.853478663067, 93131.0, 108682.45658771656, 110441.89558104477, 111585.0, 113838.0, 95531.52234238923, 95598.0, 95920.52039739757, 96588.51705741427, 96805.0, 55341.723291383285, 80406.79389809158, 85758.0, 88175.55912220526, 89226.55386723155, 8756.956215218883, 9270.258379329773, 11505.769884602094, 11529.423528823692, 11581.88418115808, 41959.370609441496, 42470.78764606157, 42589.0, 42823.715288541396, 42867.71396858099, 56715.0, 56760.0, 57616.4238357611, 57690.711546442, 58307.12539311998, 14543.563693089225, 14723.558293251219, 14763.852361476678, 14764.48324308644, 14808.925955370154, 17866.374676886768, 18584.81415185885, 18626.534336641693, 18771.155298011894, 18967.715484268025, 16050.438234661731, 16067.678646426772, 17135.971841689538, 17179.828201717824, 17276.13619319004, 16679.58301042435, 16864.0, 17132.828671713123, 17266.136693165543, 17287.56781080433, 15860.68278634444, 16114.597135071717, 16621.0, 16823.327066917675, 16886.408975686285, 11829.881701182878, 11860.822087668865, 11950.70123246891, 11961.282323060645, 12278.693032674255, 12652.367381631066, 13008.219506829242, 13821.378037988114, 13926.303684815515, 13951.441942322193], "value": 8427.391045470082, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 123.0, 113.0, 113.0, 115.0, 114.0, 113.0, 114.0, 115.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 110.0, 117.0, 187.0, 119.0, 110.0, 109.0, 118.0, 163.0, 149.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 198.0, 206.0, 230.0, 211.0, 210.0, 200.0, 249.0, 199.0, 196.0], "value": 210.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 60.0, 81.0, 61.0, 58.0, 59.0, 65.0, 78.0, 57.0], "value": 65.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 77.0, 81.0, 101.0, 103.0, 59.0, 105.0, 96.0, 117.0, 104.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 107.0, 107.0, 89.0, 99.0, 88.0, 103.0, 88.0, 89.0, 111.0], "value": 97.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 153.0, 126.0, 99.0, 133.0, 130.0, 94.0, 89.0, 94.0, 151.0], "value": 116.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 89.0, 91.0, 91.0, 91.0, 89.0, 94.0, 91.0, 91.0], "value": 91.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 50.0, 52.0, 52.0, 52.0, 51.0, 50.0, 59.0, 79.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 55.0, 56.0, 57.0, 68.0, 63.0, 60.0, 64.0, 84.0, 64.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 86.0, 107.0, 106.0, 81.0, 83.0, 84.0, 80.0, 89.0, 72.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 139.0, 144.0, 130.0, 164.0, 159.0, 153.0, 138.0, 181.0, 134.0], "value": 147.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 186.0, 229.0, 181.0, 182.0, 181.0, 189.0, 180.0, 184.0, 189.0], "value": 188.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 72.0, 71.0, 67.0, 68.0, 65.0, 69.0, 69.0, 77.0, 86.0], "value": 71.0, "unit": "score"}]}]} 20:59:52 INFO - Return code: 0 20:59:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:59:52 ERROR - # TBPL SUCCESS # 20:59:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:59:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:59:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:59:52 INFO - 2017-04-27 20:59:52.119 screenresolution[2577:38206] starting screenresolution argv=screenresolution get 20:59:52 INFO - 2017-04-27 20:59:52.122 screenresolution[2577:38206] Display 0: 1600x1200x32@60 20:59:52 INFO - 2017-04-27 20:59:52.128 screenresolution[2578:38209] starting screenresolution argv=screenresolution list 20:59:52 INFO - Available Modes on Display 0 20:59:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:59:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:59:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:59:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:59:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:59:52 INFO - Intel Iris: 20:59:52 INFO - Chipset Model: Intel Iris 20:59:52 INFO - Type: GPU 20:59:52 INFO - Bus: Built-In 20:59:52 INFO - VRAM (Dynamic, Max): 1536 MB 20:59:52 INFO - Vendor: Intel (0x8086) 20:59:52 INFO - Device ID: 0x0a2e 20:59:52 INFO - Revision ID: 0x0009 20:59:52 INFO - Displays: 20:59:52 INFO - Display: 20:59:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:59:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:59:52 INFO - Display Serial Number: 1600x1200 60 20:59:52 INFO - Main Display: Yes 20:59:52 INFO - Mirror: Off 20:59:52 INFO - Online: Yes 20:59:52 INFO - Rotation: Supported 20:59:52 INFO - Return code: 0 20:59:52 INFO - Running post-action listener: _resource_record_post_action 20:59:52 INFO - [mozharness: 2017-04-28 03:59:52.362284Z] Finished run-tests step (success) 20:59:52 INFO - Running post-run listener: _resource_record_post_run 20:59:52 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 2164224; Write bytes: 511816192; Read time: 13; Write time: 1598 20:59:52 INFO - TinderboxPrint: CPU usage
54.1% 20:59:52 INFO - TinderboxPrint: I/O read bytes / time
2,164,224 / 13 20:59:52 INFO - TinderboxPrint: I/O write bytes / time
511,816,192 / 1,598 20:59:52 INFO - TinderboxPrint: CPU idle
2,200.6 (45.9%) 20:59:52 INFO - TinderboxPrint: CPU system
962.9 (20.1%) 20:59:52 INFO - TinderboxPrint: CPU user
1,626.2 (34.0%) 20:59:52 INFO - TinderboxPrint: Swap in / out
210,423,808 / 0 20:59:52 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 194947584; Write bytes: 192737280; Read time: 15020; Write time: 402 20:59:52 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 2160128; Write bytes: 301399040; Read time: 12; Write time: 1139 20:59:52 INFO - Running post-run listener: _upload_blobber_files 20:59:52 INFO - Blob upload gear active. 20:59:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:59:52 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 20:59:52 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', 'Pine', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:59:52 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 Pine -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:59:53 INFO - (blobuploader) - INFO - Open directory for files ... 20:59:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:59:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:59:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:59:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:59:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:59:54 INFO - (blobuploader) - INFO - Done attempting. 20:59:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:59:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:59:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:59:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:59:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:59:56 INFO - (blobuploader) - INFO - Done attempting. 20:59:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:59:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:59:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:59:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:59:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:59:58 INFO - (blobuploader) - INFO - Done attempting. 20:59:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:59:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:59:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:00:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:00:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:00:00 INFO - (blobuploader) - INFO - Done attempting. 21:00:00 INFO - (blobuploader) - INFO - Iteration through files over. 21:00:00 INFO - Return code: 0 21:00:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:00:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:00:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/e59e5ef18d9a7ad3f80e9f00707dd6220da5726d26b85be494676c73a492f74c3f954e3a715e9e0d4e006966ebc8bd88a63724f2519b1c679ab3e3f6479c5410", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/cced5532ecebd5b319c76574463637bc7fdd79a3a7979872342d211dc7338486a8d70e4faf70ee7d8d726489264ef8af8e2a3600e1ab7cfeb135831edceab13c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/9f629ef883581f8dfd90b73975b3a0f1c15721ce77243e9b4e0bdf6c3f28acd140293c91e076c1b7198aaf3ddb183b58619f115d6079ab538a563b940a2f0487", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/8730c9a59ac812cafd517aca73a08a07ded7c4fabc9d9f41e280b6cd43af5772e76396cddceac1cdb8de51b8f5af78e96496b51745adbcba47d1bb3c8826f6c2"} 21:00:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:00:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:00:00 INFO - Contents: 21:00:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/e59e5ef18d9a7ad3f80e9f00707dd6220da5726d26b85be494676c73a492f74c3f954e3a715e9e0d4e006966ebc8bd88a63724f2519b1c679ab3e3f6479c5410", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/cced5532ecebd5b319c76574463637bc7fdd79a3a7979872342d211dc7338486a8d70e4faf70ee7d8d726489264ef8af8e2a3600e1ab7cfeb135831edceab13c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/9f629ef883581f8dfd90b73975b3a0f1c15721ce77243e9b4e0bdf6c3f28acd140293c91e076c1b7198aaf3ddb183b58619f115d6079ab538a563b940a2f0487", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/8730c9a59ac812cafd517aca73a08a07ded7c4fabc9d9f41e280b6cd43af5772e76396cddceac1cdb8de51b8f5af78e96496b51745adbcba47d1bb3c8826f6c2"} 21:00:00 INFO - Running post-run listener: copy_logs_to_upload_dir 21:00:00 INFO - Copying logs to upload dir... 21:00:00 INFO - mkdir: /builds/slave/test/build/upload/logs 21:00:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.607098 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-27 21:00:00.973799) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-27 21:00:00.978939) ========= 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.9xh7wTDHbr/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.OvmINPcrGo/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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/Pine/sha512/e59e5ef18d9a7ad3f80e9f00707dd6220da5726d26b85be494676c73a492f74c3f954e3a715e9e0d4e006966ebc8bd88a63724f2519b1c679ab3e3f6479c5410", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/cced5532ecebd5b319c76574463637bc7fdd79a3a7979872342d211dc7338486a8d70e4faf70ee7d8d726489264ef8af8e2a3600e1ab7cfeb135831edceab13c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/9f629ef883581f8dfd90b73975b3a0f1c15721ce77243e9b4e0bdf6c3f28acd140293c91e076c1b7198aaf3ddb183b58619f115d6079ab538a563b940a2f0487", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/8730c9a59ac812cafd517aca73a08a07ded7c4fabc9d9f41e280b6cd43af5772e76396cddceac1cdb8de51b8f5af78e96496b51745adbcba47d1bb3c8826f6c2"} build_url:https://queue.taskcluster.net/v1/task/G3cqTc1HTMKr2CVVD1j3NA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009563 build_url: 'https://queue.taskcluster.net/v1/task/G3cqTc1HTMKr2CVVD1j3NA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/e59e5ef18d9a7ad3f80e9f00707dd6220da5726d26b85be494676c73a492f74c3f954e3a715e9e0d4e006966ebc8bd88a63724f2519b1c679ab3e3f6479c5410", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/cced5532ecebd5b319c76574463637bc7fdd79a3a7979872342d211dc7338486a8d70e4faf70ee7d8d726489264ef8af8e2a3600e1ab7cfeb135831edceab13c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/9f629ef883581f8dfd90b73975b3a0f1c15721ce77243e9b4e0bdf6c3f28acd140293c91e076c1b7198aaf3ddb183b58619f115d6079ab538a563b940a2f0487", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/8730c9a59ac812cafd517aca73a08a07ded7c4fabc9d9f41e280b6cd43af5772e76396cddceac1cdb8de51b8f5af78e96496b51745adbcba47d1bb3c8826f6c2"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-27 21:00:01.018609) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 21:00:01.019022) ========= 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.9xh7wTDHbr/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.OvmINPcrGo/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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.004716 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 21:00:01.068466) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-27 21:00:01.070563) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-27 21:00:01.070929) ========= ========= Total master_lag: 0.19 =========