builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0244 starttime: 1471395450.36 results: success (0) buildid: 20160816143514 builduid: fcc46ec626d84b06aa8424f0bd50b3b5 revision: 32ff5490a900e617eceb7b2458f1a20470dbb81f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 17:57:30.364403) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 17:57:30.364746) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 17:57:30.365026) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 17:57:30.491880) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 17:57:30.492157) ========= 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.ONUgF9ri2R/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.IjUGrCA7cH/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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 --2016-08-16 17:57:30-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 66.2M=0s 2016-08-16 17:57:31 (66.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.645835 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 17:57:31.182880) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 17:57:31.183204) ========= 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.ONUgF9ri2R/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.IjUGrCA7cH/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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.027338 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 17:57:31.284211) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-16 17:57:31.284520) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 32ff5490a900e617eceb7b2458f1a20470dbb81f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 32ff5490a900e617eceb7b2458f1a20470dbb81f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ONUgF9ri2R/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.IjUGrCA7cH/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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 2016-08-16 17:57:31,389 truncating revision to first 12 chars 2016-08-16 17:57:31,390 Setting DEBUG logging. 2016-08-16 17:57:31,390 attempt 1/10 2016-08-16 17:57:31,390 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/32ff5490a900?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 17:57:33,044 unpacking tar archive at: fx-team-32ff5490a900/testing/mozharness/ program finished with exit code 0 elapsedTime=1.939017 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-16 17:57:33.362135) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 17:57:33.362445) ========= script_repo_revision: 32ff5490a900e617eceb7b2458f1a20470dbb81f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 17:57:33.362838) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2016-08-16 17:57:33.363350) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2016-08-16 17:57:34.589860) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-08-16 17:57:34.690436) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ONUgF9ri2R/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.IjUGrCA7cH/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 17:57:35 INFO - MultiFileLogger online at 20160816 17:57:35 in /builds/slave/test 17:57:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:57:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:57:35 INFO - {'append_to_log': False, 17:57:35 INFO - 'base_work_dir': '/builds/slave/test', 17:57:35 INFO - 'blob_upload_branch': 'Fx-Team', 17:57:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:57:35 INFO - 'branch': 'Fx-Team', 17:57:35 INFO - 'buildbot_json_path': 'buildprops.json', 17:57:35 INFO - 'config_files': ('talos/mac_config.py',), 17:57:35 INFO - 'default_actions': ('clobber', 17:57:35 INFO - 'read-buildbot-config', 17:57:35 INFO - 'download-and-extract', 17:57:35 INFO - 'populate-webroot', 17:57:35 INFO - 'create-virtualenv', 17:57:35 INFO - 'install', 17:57:35 INFO - 'run-tests'), 17:57:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:57:35 INFO - 'download_minidump_stackwalk': True, 17:57:35 INFO - 'download_symbols': 'ondemand', 17:57:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:57:35 INFO - 'tooltool.py': '/tools/tooltool.py', 17:57:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:57:35 INFO - '/tools/misc-python/virtualenv.py')}, 17:57:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:57:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:57:35 INFO - 'installer_path': 'installer.exe', 17:57:35 INFO - 'log_level': 'info', 17:57:35 INFO - 'log_name': 'talos', 17:57:35 INFO - 'log_to_console': True, 17:57:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:57:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:57:35 INFO - 'opt_config_files': (), 17:57:35 INFO - 'pip_index': False, 17:57:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:57:35 INFO - 'cmd': ('bash', 17:57:35 INFO - '-c', 17:57:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:57:35 INFO - 'enabled': True, 17:57:35 INFO - 'halt_on_failure': False, 17:57:35 INFO - 'name': 'check_screen_resolution'},), 17:57:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:57:35 INFO - 'cmd': ('bash', 17:57:35 INFO - '-c', 17:57:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:57:35 INFO - 'enabled': True, 17:57:35 INFO - 'halt_on_failure': False, 17:57:35 INFO - 'name': 'check_screen_resolution'},), 17:57:35 INFO - 'run_cmd_checks_enabled': True, 17:57:35 INFO - 'sps_profile': False, 17:57:35 INFO - 'sps_profile_interval': 0, 17:57:35 INFO - 'suite': 'dromaeojs-e10s', 17:57:35 INFO - 'system_bits': '32', 17:57:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:57:35 INFO - 'title': 't-yosemite-r7-0244', 17:57:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:57:35 INFO - 'use_talos_json': True, 17:57:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:57:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:57:35 INFO - 'work_dir': 'build'} 17:57:35 INFO - [mozharness: 2016-08-17 00:57:35.044468Z] Running clobber step. 17:57:35 INFO - Running pre-action listener: _resource_record_pre_action 17:57:35 INFO - Running main action method: clobber 17:57:35 INFO - rmtree: /builds/slave/test/build 17:57:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:57:36 INFO - Running post-action listener: _resource_record_post_action 17:57:36 INFO - [mozharness: 2016-08-17 00:57:36.986056Z] Finished clobber step (success) 17:57:36 INFO - [mozharness: 2016-08-17 00:57:36.986192Z] Running read-buildbot-config step. 17:57:36 INFO - Running pre-action listener: _resource_record_pre_action 17:57:36 INFO - Running main action method: read_buildbot_config 17:57:36 INFO - Using buildbot properties: 17:57:36 INFO - { 17:57:36 INFO - "project": "", 17:57:36 INFO - "product": "firefox", 17:57:36 INFO - "script_repo_revision": "production", 17:57:36 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 17:57:36 INFO - "repository": "", 17:57:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 17:57:36 INFO - "buildid": "20160816143514", 17:57:36 INFO - "pgo_build": "False", 17:57:36 INFO - "basedir": "/builds/slave/test", 17:57:36 INFO - "buildnumber": 28, 17:57:36 INFO - "slavename": "t-yosemite-r7-0244", 17:57:36 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 17:57:36 INFO - "platform": "yosemite_r7", 17:57:36 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 17:57:36 INFO - "branch": "fx-team", 17:57:36 INFO - "repo_path": "integration/fx-team", 17:57:36 INFO - "revision": "32ff5490a900e617eceb7b2458f1a20470dbb81f", 17:57:36 INFO - "stage_platform": "macosx64", 17:57:36 INFO - "builduid": "fcc46ec626d84b06aa8424f0bd50b3b5", 17:57:36 INFO - "slavebuilddir": "test" 17:57:36 INFO - } 17:57:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 17:57:36 INFO - Running post-action listener: _resource_record_post_action 17:57:36 INFO - [mozharness: 2016-08-17 00:57:36.989406Z] Finished read-buildbot-config step (success) 17:57:36 INFO - [mozharness: 2016-08-17 00:57:36.989521Z] Running download-and-extract step. 17:57:36 INFO - Running pre-action listener: _resource_record_pre_action 17:57:36 INFO - Running main action method: download_and_extract 17:57:36 INFO - mkdir: /builds/slave/test/build/tests 17:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:36 INFO - trying https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 17:57:36 INFO - Downloading https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 17:57:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 17:57:38 INFO - Downloaded 1199 bytes. 17:57:38 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 17:57:38 INFO - Using the following test package requirements: 17:57:38 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 17:57:38 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:57:38 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 17:57:38 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:57:38 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 17:57:38 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:57:38 INFO - u'jsshell-mac.zip'], 17:57:38 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:57:38 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 17:57:38 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 17:57:38 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:57:38 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 17:57:38 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:57:38 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 17:57:38 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:57:38 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 17:57:38 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:57:38 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 17:57:38 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:57: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')]} 17:57:38 INFO - trying https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:57:38 INFO - Downloading https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:57:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:57:39 INFO - Downloaded 16332150 bytes. 17:57:39 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 17:57:46 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:46 INFO - trying https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:57:46 INFO - Downloading https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:57:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:57:48 INFO - Downloaded 16332150 bytes. 17:57:48 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 17:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:54 INFO - trying https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 17:57:54 INFO - Downloading https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 17:57:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:57:55 INFO - Downloaded 14413719 bytes. 17:57:55 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 17:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:57:56 INFO - trying https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:57:56 INFO - Downloading https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 17:57:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 17:57:59 INFO - Downloaded 111084819 bytes. 17:57:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:57:59 INFO - mkdir: /builds/slave/test/properties 17:57:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:57:59 INFO - Writing to file /builds/slave/test/properties/build_url 17:57:59 INFO - Contents: 17:57:59 INFO - build_url:https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:57:59 INFO - Running post-action listener: _resource_record_post_action 17:57:59 INFO - Running post-action listener: set_extra_try_arguments 17:57:59 INFO - [mozharness: 2016-08-17 00:57:59.911396Z] Finished download-and-extract step (success) 17:57:59 INFO - [mozharness: 2016-08-17 00:57:59.911524Z] Running populate-webroot step. 17:57:59 INFO - Running pre-action listener: _resource_record_pre_action 17:57:59 INFO - Running main action method: populate_webroot 17:57:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:57:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:57:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:57:59 INFO - '--tppagecycles', 17:57:59 INFO - '7'], 17:57:59 INFO - 'tests': ['tsvgm']}}, 17:57:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:57:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:57:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:57:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:57:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:57:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:57:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:57:59 INFO - 'talos_options': ['--disable-e10s'], 17:57:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:57:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:57:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:57:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:57:59 INFO - 'talos_options': ['--disable-e10s'], 17:57:59 INFO - 'tests': ['damp', 'tps']}, 17:57:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:57:59 INFO - 'tests': ['damp', 'tps']}, 17:57:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:57:59 INFO - 'tests': ['dromaeo_dom']}, 17:57:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:57:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:57:59 INFO - 'tests': ['basic_compositor_video']}, 17:57:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:57:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:57:59 INFO - 'tests': ['a11yr', 17:57:59 INFO - 'ts_paint', 17:57:59 INFO - 'tpaint', 17:57:59 INFO - 'sessionrestore', 17:57:59 INFO - 'sessionrestore_no_auto_restore', 17:57:59 INFO - 'tabpaint']}, 17:57:59 INFO - 'other-e10s': {'tests': ['a11yr', 17:57:59 INFO - 'ts_paint', 17:57:59 INFO - 'tpaint', 17:57:59 INFO - 'sessionrestore', 17:57:59 INFO - 'sessionrestore_no_auto_restore', 17:57:59 INFO - 'tabpaint']}, 17:57:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:57:59 INFO - 'ts_paint', 17:57:59 INFO - 'tpaint', 17:57:59 INFO - 'sessionrestore', 17:57:59 INFO - 'sessionrestore_no_auto_restore', 17:57:59 INFO - 'tabpaint']}, 17:57:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:57:59 INFO - 'ts_paint', 17:57:59 INFO - 'tpaint', 17:57:59 INFO - 'sessionrestore', 17:57:59 INFO - 'sessionrestore_no_auto_restore', 17:57:59 INFO - 'tabpaint']}, 17:57:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:57:59 INFO - 'tests': ['a11yr', 17:57:59 INFO - 'ts_paint', 17:57:59 INFO - 'tpaint', 17:57:59 INFO - 'sessionrestore', 17:57:59 INFO - 'sessionrestore_no_auto_restore', 17:57:59 INFO - 'tabpaint']}, 17:57:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:57:59 INFO - 'tests': ['a11yr', 17:57:59 INFO - 'ts_paint', 17:57:59 INFO - 'tpaint', 17:57:59 INFO - 'sessionrestore', 17:57:59 INFO - 'sessionrestore_no_auto_restore', 17:57:59 INFO - 'tabpaint']}, 17:57:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:57:59 INFO - 'tests': ['tsvgx', 17:57:59 INFO - 'tsvgr_opacity', 17:57:59 INFO - 'tart', 17:57:59 INFO - 'tscrollx', 17:57:59 INFO - 'cart']}, 17:57:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:57:59 INFO - 'tsvgr_opacity', 17:57:59 INFO - 'tart', 17:57:59 INFO - 'tscrollx', 17:57:59 INFO - 'cart']}, 17:57:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:57:59 INFO - 'talos_options': ['--disable-e10s'], 17:57:59 INFO - 'tests': ['tp5o']}, 17:57:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:57:59 INFO - 'tests': ['tp5o']}, 17:57:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:57:59 INFO - 'talos_options': ['--disable-e10s', 17:57:59 INFO - '--xperf_path', 17:57:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:57:59 INFO - 'tests': ['tp5n']}, 17:57:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:57:59 INFO - 'talos_options': ['--xperf_path', 17:57:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:57:59 INFO - 'tests': ['tp5n']}}, 17:57:59 INFO - 'talos.zip': {'path': '', 17:57:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:57:59 INFO - Running post-action listener: _resource_record_post_action 17:57:59 INFO - [mozharness: 2016-08-17 00:57:59.930425Z] Finished populate-webroot step (success) 17:57:59 INFO - [mozharness: 2016-08-17 00:57:59.930538Z] Running create-virtualenv step. 17:57:59 INFO - Running pre-action listener: _resource_record_pre_action 17:57:59 INFO - Running main action method: create_virtualenv 17:57:59 INFO - Creating virtualenv /builds/slave/test/build/venv 17:57:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:57:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:58:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:58:00 INFO - Using real prefix '/tools/python27' 17:58:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:58:00 INFO - Installing distribute.............................................................................................................................................................................................done. 17:58:03 INFO - Installing pip.................done. 17:58:03 INFO - Return code: 0 17:58:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:03 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 0x108673a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108708618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc648564040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085d7d30>, '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 0x10833cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085cfb20>, '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.ONUgF9ri2R/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.IjUGrCA7cH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:58:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:58:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:58:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ONUgF9ri2R/Render', 17:58:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:03 INFO - 'HOME': '/Users/cltbld', 17:58:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:03 INFO - 'LOGNAME': 'cltbld', 17:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:03 INFO - 'MOZ_NO_REMOTE': '1', 17:58:03 INFO - 'NO_EM_RESTART': '1', 17:58:03 INFO - 'PAGER': '/bin/cat', 17:58:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:03 INFO - 'PWD': '/builds/slave/test', 17:58:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:03 INFO - 'SHELL': '/bin/bash', 17:58:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IjUGrCA7cH/Listeners', 17:58:03 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 17:58:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:03 INFO - 'USER': 'cltbld', 17:58:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:03 INFO - 'XPC_FLAGS': '0x0', 17:58:03 INFO - 'XPC_SERVICE_NAME': '0', 17:58:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:58:03 INFO - Cleaning up... 17:58:03 INFO - Return code: 0 17:58:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:03 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 0x108673a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108708618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc648564040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085d7d30>, '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 0x10833cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085cfb20>, '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.ONUgF9ri2R/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.IjUGrCA7cH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:58:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:58:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:58:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ONUgF9ri2R/Render', 17:58:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:03 INFO - 'HOME': '/Users/cltbld', 17:58:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:03 INFO - 'LOGNAME': 'cltbld', 17:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:03 INFO - 'MOZ_NO_REMOTE': '1', 17:58:03 INFO - 'NO_EM_RESTART': '1', 17:58:03 INFO - 'PAGER': '/bin/cat', 17:58:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:03 INFO - 'PWD': '/builds/slave/test', 17:58:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:03 INFO - 'SHELL': '/bin/bash', 17:58:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IjUGrCA7cH/Listeners', 17:58:03 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 17:58:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:03 INFO - 'USER': 'cltbld', 17:58:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:03 INFO - 'XPC_FLAGS': '0x0', 17:58:03 INFO - 'XPC_SERVICE_NAME': '0', 17:58:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:04 INFO - Downloading/unpacking psutil>=3.1.1 17:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:58:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:58:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:58:07 INFO - Installing collected packages: psutil 17:58:07 INFO - Running setup.py install for psutil 17:58:07 INFO - building 'psutil._psutil_osx' extension 17:58:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 17:58:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 17:58:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 17:58:08 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 17:58:08 INFO - building 'psutil._psutil_posix' extension 17:58:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 17:58:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:58:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:58:08 INFO - ^ 17:58:08 INFO - 1 warning generated. 17:58:08 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 17:58:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:58:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:58:08 INFO - Successfully installed psutil 17:58:08 INFO - Cleaning up... 17:58:08 INFO - Return code: 0 17:58:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:08 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 0x108673a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108708618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc648564040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085d7d30>, '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 0x10833cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085cfb20>, '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.ONUgF9ri2R/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.IjUGrCA7cH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:58:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:58:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:58:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ONUgF9ri2R/Render', 17:58:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:08 INFO - 'HOME': '/Users/cltbld', 17:58:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:08 INFO - 'LOGNAME': 'cltbld', 17:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:08 INFO - 'MOZ_NO_REMOTE': '1', 17:58:08 INFO - 'NO_EM_RESTART': '1', 17:58:08 INFO - 'PAGER': '/bin/cat', 17:58:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:08 INFO - 'PWD': '/builds/slave/test', 17:58:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:08 INFO - 'SHELL': '/bin/bash', 17:58:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IjUGrCA7cH/Listeners', 17:58:08 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 17:58:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:08 INFO - 'USER': 'cltbld', 17:58:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:08 INFO - 'XPC_FLAGS': '0x0', 17:58:08 INFO - 'XPC_SERVICE_NAME': '0', 17:58:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:58:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:58:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:58:11 INFO - Installing collected packages: mozsystemmonitor 17:58:11 INFO - Running setup.py install for mozsystemmonitor 17:58:11 INFO - Successfully installed mozsystemmonitor 17:58:11 INFO - Cleaning up... 17:58:12 INFO - Return code: 0 17:58:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108673a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108708618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc648564040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085d7d30>, '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 0x10833cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085cfb20>, '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.ONUgF9ri2R/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.IjUGrCA7cH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:58:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:58:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ONUgF9ri2R/Render', 17:58:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:12 INFO - 'HOME': '/Users/cltbld', 17:58:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:12 INFO - 'LOGNAME': 'cltbld', 17:58:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:12 INFO - 'MOZ_NO_REMOTE': '1', 17:58:12 INFO - 'NO_EM_RESTART': '1', 17:58:12 INFO - 'PAGER': '/bin/cat', 17:58:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:12 INFO - 'PWD': '/builds/slave/test', 17:58:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:12 INFO - 'SHELL': '/bin/bash', 17:58:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IjUGrCA7cH/Listeners', 17:58:12 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 17:58:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:12 INFO - 'USER': 'cltbld', 17:58:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:12 INFO - 'XPC_FLAGS': '0x0', 17:58:12 INFO - 'XPC_SERVICE_NAME': '0', 17:58:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:12 INFO - Downloading/unpacking jsonschema==2.5.1 17:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:58:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:15 INFO - Downloading functools32-3.2.3-2.tar.gz 17:58:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:58:15 INFO - warning: no files found matching '*.txt' 17:58:15 INFO - no previously-included directories found matching 'build' 17:58:15 INFO - no previously-included directories found matching 'dist' 17:58:15 INFO - no previously-included directories found matching '.git*' 17:58:15 INFO - Installing collected packages: jsonschema, functools32 17:58:15 INFO - Running setup.py install for functools32 17:58:15 INFO - warning: no files found matching '*.txt' 17:58:15 INFO - no previously-included directories found matching 'build' 17:58:15 INFO - no previously-included directories found matching 'dist' 17:58:15 INFO - no previously-included directories found matching '.git*' 17:58:15 INFO - Successfully installed jsonschema functools32 17:58:15 INFO - Cleaning up... 17:58:15 INFO - Return code: 0 17:58:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:58:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:15 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 0x108673a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108708618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc648564040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085d7d30>, '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 0x10833cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085cfb20>, '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.ONUgF9ri2R/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.IjUGrCA7cH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:58:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:58:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:58:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ONUgF9ri2R/Render', 17:58:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:15 INFO - 'HOME': '/Users/cltbld', 17:58:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:15 INFO - 'LOGNAME': 'cltbld', 17:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:15 INFO - 'MOZ_NO_REMOTE': '1', 17:58:15 INFO - 'NO_EM_RESTART': '1', 17:58:15 INFO - 'PAGER': '/bin/cat', 17:58:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:15 INFO - 'PWD': '/builds/slave/test', 17:58:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:15 INFO - 'SHELL': '/bin/bash', 17:58:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IjUGrCA7cH/Listeners', 17:58:15 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 17:58:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:15 INFO - 'USER': 'cltbld', 17:58:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:15 INFO - 'XPC_FLAGS': '0x0', 17:58:15 INFO - 'XPC_SERVICE_NAME': '0', 17:58:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:58:15 INFO - Cleaning up... 17:58:15 INFO - Return code: 0 17:58:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:58:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:15 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 0x108673a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108708618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc648564040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085d7d30>, '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 0x10833cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085cfb20>, '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.ONUgF9ri2R/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.IjUGrCA7cH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:58:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:58:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:58:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ONUgF9ri2R/Render', 17:58:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:15 INFO - 'HOME': '/Users/cltbld', 17:58:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:15 INFO - 'LOGNAME': 'cltbld', 17:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:15 INFO - 'MOZ_NO_REMOTE': '1', 17:58:15 INFO - 'NO_EM_RESTART': '1', 17:58:15 INFO - 'PAGER': '/bin/cat', 17:58:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:15 INFO - 'PWD': '/builds/slave/test', 17:58:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:15 INFO - 'SHELL': '/bin/bash', 17:58:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IjUGrCA7cH/Listeners', 17:58:15 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 17:58:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:15 INFO - 'USER': 'cltbld', 17:58:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:15 INFO - 'XPC_FLAGS': '0x0', 17:58:15 INFO - 'XPC_SERVICE_NAME': '0', 17:58:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:16 INFO - Downloading/unpacking blobuploader==1.2.4 17:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:18 INFO - Downloading blobuploader-1.2.4.tar.gz 17:58:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:58:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:58:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:19 INFO - Downloading docopt-0.6.1.tar.gz 17:58:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:58:19 INFO - Installing collected packages: blobuploader, requests, docopt 17:58:19 INFO - Running setup.py install for blobuploader 17:58:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:58:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:58:20 INFO - Running setup.py install for requests 17:58:20 INFO - Running setup.py install for docopt 17:58:20 INFO - Successfully installed blobuploader requests docopt 17:58:20 INFO - Cleaning up... 17:58:20 INFO - Return code: 0 17:58:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:58:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:20 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 0x108673a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108708618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc648564040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085d7d30>, '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 0x10833cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085cfb20>, '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.ONUgF9ri2R/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.IjUGrCA7cH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:58:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:58:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:58:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ONUgF9ri2R/Render', 17:58:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:20 INFO - 'HOME': '/Users/cltbld', 17:58:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:20 INFO - 'LOGNAME': 'cltbld', 17:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:20 INFO - 'MOZ_NO_REMOTE': '1', 17:58:20 INFO - 'NO_EM_RESTART': '1', 17:58:20 INFO - 'PAGER': '/bin/cat', 17:58:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:20 INFO - 'PWD': '/builds/slave/test', 17:58:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:20 INFO - 'SHELL': '/bin/bash', 17:58:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IjUGrCA7cH/Listeners', 17:58:20 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 17:58:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:20 INFO - 'USER': 'cltbld', 17:58:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:20 INFO - 'XPC_FLAGS': '0x0', 17:58:20 INFO - 'XPC_SERVICE_NAME': '0', 17:58:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:58:21 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-9hcxZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:58:21 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-z0Cj2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:58:21 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-UrJHaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:58:21 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-oK0DTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:58:21 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-ekbPOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:58:21 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-Tb8hQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:58:21 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-U02sb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:58:21 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-lD6ZHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:58:21 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-O8uHuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:58:21 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-_dmw4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:58:22 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-8LHutW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:58:22 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-48IjrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:58:22 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-icMkTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:58:22 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-JS8Vk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:58:22 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-Vx6mZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:58:22 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-OHr0jq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:58:22 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-olhp2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:58:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:58:22 INFO - Running setup.py install for manifestparser 17:58:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:58:22 INFO - Running setup.py install for mozcrash 17:58:23 INFO - Running setup.py install for mozdebug 17:58:23 INFO - Running setup.py install for mozdevice 17:58:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:58:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:58:23 INFO - Running setup.py install for mozfile 17:58:23 INFO - Running setup.py install for mozhttpd 17:58:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:58:23 INFO - Running setup.py install for mozinfo 17:58:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:58:23 INFO - Running setup.py install for mozInstall 17:58:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:58:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:58:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:58:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:58:23 INFO - Running setup.py install for mozleak 17:58:24 INFO - Running setup.py install for mozlog 17:58:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:58:24 INFO - Running setup.py install for moznetwork 17:58:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:58:24 INFO - Running setup.py install for mozprocess 17:58:24 INFO - Running setup.py install for mozprofile 17:58:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:58:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:58:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:58:24 INFO - Running setup.py install for mozrunner 17:58:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:58:24 INFO - Running setup.py install for mozscreenshot 17:58:24 INFO - Running setup.py install for moztest 17:58:25 INFO - Running setup.py install for mozversion 17:58:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:58:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:58:25 INFO - Cleaning up... 17:58:25 INFO - Return code: 0 17:58:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:58: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')]} 17:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58: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')]} 17:58:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:25 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 0x108673a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108708618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc648564040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085d7d30>, '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 0x10833cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085cfb20>, '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.ONUgF9ri2R/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.IjUGrCA7cH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:58:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:58:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ONUgF9ri2R/Render', 17:58:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:25 INFO - 'HOME': '/Users/cltbld', 17:58:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:25 INFO - 'LOGNAME': 'cltbld', 17:58:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:25 INFO - 'MOZ_NO_REMOTE': '1', 17:58:25 INFO - 'NO_EM_RESTART': '1', 17:58:25 INFO - 'PAGER': '/bin/cat', 17:58:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:25 INFO - 'PWD': '/builds/slave/test', 17:58:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:25 INFO - 'SHELL': '/bin/bash', 17:58:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IjUGrCA7cH/Listeners', 17:58:25 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 17:58:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:25 INFO - 'USER': 'cltbld', 17:58:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:25 INFO - 'XPC_FLAGS': '0x0', 17:58:25 INFO - 'XPC_SERVICE_NAME': '0', 17:58:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:58:25 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-1g_Vdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:58:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:58:25 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-GSPqEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:58:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:58:25 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-VzelSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:58:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:58:25 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-loquU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:58:26 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-ivjDrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:58:26 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-yuN4Tg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:58:26 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-EqqWPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:58:26 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-UDToao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:58:26 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-UUJJxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:58:26 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-toGvvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:58:26 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-HoDnbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:58:26 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-o3fT3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:58:26 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-HhU80E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:58:26 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-FLM3rc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:58:27 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-rsIh8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:58:27 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-ZgIrEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:58:27 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-uWrxTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:58:27 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:58:27 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:58:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:58:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:58:29 INFO - Downloading blessings-1.6.tar.gz 17:58:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:58:29 INFO - Installing collected packages: blessings 17:58:29 INFO - Running setup.py install for blessings 17:58:30 INFO - Successfully installed blessings 17:58:30 INFO - Cleaning up... 17:58:30 INFO - Return code: 0 17:58:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:58:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:58:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:58:30 INFO - Reading from file tmpfile_stdout 17:58:30 INFO - Current package versions: 17:58:30 INFO - blessings == 1.6 17:58:30 INFO - blobuploader == 1.2.4 17:58:30 INFO - docopt == 0.6.1 17:58:30 INFO - functools32 == 3.2.3-2 17:58:30 INFO - jsonschema == 2.5.1 17:58:30 INFO - manifestparser == 1.1 17:58:30 INFO - mozInstall == 1.12 17:58:30 INFO - mozcrash == 0.17 17:58:30 INFO - mozdebug == 0.1 17:58:30 INFO - mozdevice == 0.48 17:58:30 INFO - mozfile == 1.2 17:58:30 INFO - mozhttpd == 0.7 17:58:30 INFO - mozinfo == 0.9 17:58:30 INFO - mozleak == 0.1 17:58:30 INFO - mozlog == 3.3 17:58:30 INFO - moznetwork == 0.27 17:58:30 INFO - mozprocess == 0.23 17:58:30 INFO - mozprofile == 0.28 17:58:30 INFO - mozrunner == 6.12 17:58:30 INFO - mozscreenshot == 0.1 17:58:30 INFO - mozsystemmonitor == 0.3 17:58:30 INFO - moztest == 0.7 17:58:30 INFO - mozversion == 1.4 17:58:30 INFO - psutil == 3.1.1 17:58:30 INFO - requests == 1.2.3 17:58:30 INFO - wsgiref == 0.1.2 17:58:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:30 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 0x108673a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108708618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc648564040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085d7d30>, '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 0x10833cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085cfb20>, '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.ONUgF9ri2R/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.IjUGrCA7cH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:58:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:58:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:58:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ONUgF9ri2R/Render', 17:58:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:30 INFO - 'HOME': '/Users/cltbld', 17:58:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:30 INFO - 'LOGNAME': 'cltbld', 17:58:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:30 INFO - 'MOZ_NO_REMOTE': '1', 17:58:30 INFO - 'NO_EM_RESTART': '1', 17:58:30 INFO - 'PAGER': '/bin/cat', 17:58:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:30 INFO - 'PWD': '/builds/slave/test', 17:58:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:30 INFO - 'SHELL': '/bin/bash', 17:58:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IjUGrCA7cH/Listeners', 17:58:30 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 17:58:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:30 INFO - 'USER': 'cltbld', 17:58:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:30 INFO - 'XPC_FLAGS': '0x0', 17:58:30 INFO - 'XPC_SERVICE_NAME': '0', 17:58:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:58:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:58:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:58:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:58:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:58:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:58:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:58:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:58:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:58:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:58:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:58:30 INFO - Cleaning up... 17:58:30 INFO - Return code: 0 17:58:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:58:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:58:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:58:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:58: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108673a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108708618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc648564040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085d7d30>, '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 0x10833cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085cfb20>, '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.ONUgF9ri2R/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.IjUGrCA7cH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:58: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', 'jsonschema'] in /builds/slave/test/build 17:58: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 jsonschema 17:58:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ONUgF9ri2R/Render', 17:58:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:58:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:58:30 INFO - 'HOME': '/Users/cltbld', 17:58:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:58:30 INFO - 'LOGNAME': 'cltbld', 17:58:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:58:30 INFO - 'MOZ_NO_REMOTE': '1', 17:58:30 INFO - 'NO_EM_RESTART': '1', 17:58:30 INFO - 'PAGER': '/bin/cat', 17:58:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:58:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:58:30 INFO - 'PWD': '/builds/slave/test', 17:58:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:58:30 INFO - 'SHELL': '/bin/bash', 17:58:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IjUGrCA7cH/Listeners', 17:58:30 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 17:58:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:58:30 INFO - 'USER': 'cltbld', 17:58:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:58:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:58:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:58:30 INFO - 'XPC_FLAGS': '0x0', 17:58:30 INFO - 'XPC_SERVICE_NAME': '0', 17:58:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:58:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:58:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:58:31 INFO - Cleaning up... 17:58:31 INFO - Return code: 0 17:58:31 INFO - Running post-action listener: _resource_record_post_action 17:58:31 INFO - Running post-action listener: _start_resource_monitoring 17:58:31 INFO - Starting resource monitoring. 17:58:31 INFO - [mozharness: 2016-08-17 00:58:31.045775Z] Finished create-virtualenv step (success) 17:58:31 INFO - [mozharness: 2016-08-17 00:58:31.046746Z] Running install step. 17:58:31 INFO - Running pre-action listener: _resource_record_pre_action 17:58:31 INFO - Running main action method: install 17:58:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:58:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:58:31 INFO - Reading from file tmpfile_stdout 17:58:31 INFO - Detecting whether we're running mozinstall >=1.0... 17:58:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:58:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:58:31 INFO - Reading from file tmpfile_stdout 17:58:31 INFO - Output received: 17:58:31 INFO - Usage: mozinstall [options] installer 17:58:31 INFO - Options: 17:58:31 INFO - -h, --help show this help message and exit 17:58:31 INFO - -d DEST, --destination=DEST 17:58:31 INFO - Directory to install application into. [default: 17:58:31 INFO - "/builds/slave/test"] 17:58:31 INFO - --app=APP Application being installed. [default: firefox] 17:58:31 INFO - mkdir: /builds/slave/test/build/application 17:58:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:58:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:59:05 INFO - Reading from file tmpfile_stdout 17:59:05 INFO - Output received: 17:59:05 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:59:05 INFO - Running post-action listener: _resource_record_post_action 17:59:05 INFO - [mozharness: 2016-08-17 00:59:05.300235Z] Finished install step (success) 17:59:05 INFO - [mozharness: 2016-08-17 00:59:05.300374Z] Running run-tests step. 17:59:05 INFO - Running pre-action listener: _resource_record_pre_action 17:59:05 INFO - Running main action method: run_tests 17:59:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:59:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:59:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:59:05 INFO - 2016-08-16 17:59:05.314 screenresolution[1638:8271] starting screenresolution argv=screenresolution get 17:59:05 INFO - 2016-08-16 17:59:05.317 screenresolution[1638:8271] Display 0: 1600x1200x32@60 17:59:05 INFO - 2016-08-16 17:59:05.323 screenresolution[1639:8273] starting screenresolution argv=screenresolution list 17:59:05 INFO - Available Modes on Display 0 17:59:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:59:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:59:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:59:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:59:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:59:05 INFO - Intel Iris: 17:59:05 INFO - Chipset Model: Intel Iris 17:59:05 INFO - Type: GPU 17:59:05 INFO - Bus: Built-In 17:59:05 INFO - VRAM (Dynamic, Max): 1536 MB 17:59:05 INFO - Vendor: Intel (0x8086) 17:59:05 INFO - Device ID: 0x0a2e 17:59:05 INFO - Revision ID: 0x0009 17:59:05 INFO - Displays: 17:59:05 INFO - Display: 17:59:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:59:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:59:05 INFO - Display Serial Number: 1600x1200 60 17:59:05 INFO - Main Display: Yes 17:59:05 INFO - Mirror: Off 17:59:05 INFO - Online: Yes 17:59:05 INFO - Rotation: Supported 17:59:05 INFO - Return code: 0 17:59:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:59:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:59:05 INFO - Python 2.7.3 17:59:05 INFO - Return code: 0 17:59:05 INFO - grabbing minidump binary from tooltool 17:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:59:05 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 0x1085d7d30>, '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 0x10833cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1085cfb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:59:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:59:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 17:59:05 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:59:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:59:05 INFO - Return code: 0 17:59:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:59:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:59:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:59:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:59:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:59:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0244', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:59:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0244 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:59:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ONUgF9ri2R/Render', 17:59:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:59:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:59:05 INFO - 'HOME': '/Users/cltbld', 17:59:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:59:05 INFO - 'LOGNAME': 'cltbld', 17:59:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:59:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:59:05 INFO - 'MOZ_NO_REMOTE': '1', 17:59:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:59:05 INFO - 'NO_EM_RESTART': '1', 17:59:05 INFO - 'PAGER': '/bin/cat', 17:59:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:59:05 INFO - 'PWD': '/builds/slave/test', 17:59:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:59:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:59:05 INFO - 'SHELL': '/bin/bash', 17:59:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IjUGrCA7cH/Listeners', 17:59:05 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 17:59:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:59:05 INFO - 'USER': 'cltbld', 17:59:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:59:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:59:05 INFO - 'XPC_FLAGS': '0x0', 17:59:05 INFO - 'XPC_SERVICE_NAME': '0', 17:59:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:59:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0244', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:59:05 INFO - mozversion application_buildid: 20160816143514 17:59:05 INFO - mozversion application_changeset: 32ff5490a900e617eceb7b2458f1a20470dbb81f 17:59:05 INFO - mozversion application_display_name: Nightly 17:59:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:59:05 INFO - mozversion application_name: Firefox 17:59:05 INFO - mozversion application_remotingname: firefox 17:59:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:59:05 INFO - mozversion application_vendor: Mozilla 17:59:05 INFO - mozversion application_version: 51.0a1 17:59:05 INFO - mozversion platform_buildid: 20160816143514 17:59:05 INFO - mozversion platform_changeset: 32ff5490a900e617eceb7b2458f1a20470dbb81f 17:59:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:59:05 INFO - mozversion platform_version: 51.0a1 17:59:05 INFO - using testdate: 1471395545 17:59:05 INFO - actual date: 1471395545 17:59:05 INFO - starting webserver on 'localhost:49268' 17:59:05 INFO - SUITE-START | Running 2 tests 17:59:05 INFO - TEST-START | dromaeo_css 17:59:05 INFO - operating with platform_type : mac_ 17:59:05 INFO - Initialising browser for dromaeo_css test... 17:59:05 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmpmNNOWx/profile http://localhost:49268/getInfo.html) 17:59:08 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 17:59:08 INFO - PROCESS | 1649 | colorDepth:24 17:59:08 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 17:59:08 INFO - PROCESS | 1649 | __metrics 17:59:09 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 17:59:09 INFO - TEST-INFO | 1649: exit 0 17:59:09 INFO - Browser initialized. 17:59:09 INFO - Running cycle 1/1 for dromaeo_css test... 17:59:09 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmpmNNOWx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:59:21 INFO - PROCESS | 1652 | RSS: Main: 236838912 17:59:21 INFO - PROCESS | 1652 | 18:00:11 INFO - PROCESS | 1652 | 1471395611400 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:02:23 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49268/tests/dromaeo/cssquery-ext.html) 18:02:24 INFO - PROCESS | 1652 | RSS: Main: 251953152 18:02:24 INFO - PROCESS | 1652 | 18:05:26 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-ext.html (next: http://localhost:49268/tests/dromaeo/cssquery-jquery.html) 18:05:27 INFO - PROCESS | 1652 | RSS: Main: 264740864 18:05:27 INFO - PROCESS | 1652 | 18:08:29 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49268/tests/dromaeo/cssquery-mootools.html) 18:08:30 INFO - PROCESS | 1652 | RSS: Main: 269914112 18:08:30 INFO - PROCESS | 1652 | 18:11:32 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49268/tests/dromaeo/cssquery-prototype.html) 18:11:32 INFO - PROCESS | 1652 | RSS: Main: 269357056 18:11:32 INFO - PROCESS | 1652 | 18:14:35 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49268/tests/dromaeo/cssquery-yui.html) 18:14:36 INFO - PROCESS | 1652 | RSS: Main: 274636800 18:14:36 INFO - PROCESS | 1652 | 18:17:38 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-yui.html (next: http://localhost:49268/tests/dromaeo/cssquery-dojo.html) 18:17:39 INFO - PROCESS | 1652 | RSS: Main: 277336064 18:17:39 INFO - PROCESS | 1652 | 18:17:39 INFO - PROCESS | 1652 | __start_tp_report 18:17:39 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 18:17:39 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 18:17:39 INFO - PROCESS | 1652 | |i|pagename|runs| 18:17:39 INFO - PROCESS | 1652 | |0;dojo.html;3363.125587347289;3366.444536651453;3388.593368795744;3418.7435942304332;3425.4348032574626;5677.57418193635;5680.204771332012;5695.7152142392815;5699.0596551569;5742.569307301948;5591.888162236763;5704.629199102055;5734.197212390269;5742.511886489643;5764.106563482656;5206.687598744069;5224.346956630421;5260.184671375943;5293.602979776513;5311.097113490697;5194;5335.573154147659;5363.195520671891;5369.2080118338445;5384.138537833947;5163.66436181647;5265.842024739264;5268.1834315681135;5286.709230992313;5314.335708036496;5190.92213616796;5224.843254702365;5255.60582956276;5271.367435907678;5296.761645725913;5158.432572417031;5166.199239117943;5171.250168725552;5179.482051794828;5236.659617124913;5559.916601250984;5623.775048998035;5729.598928075036;5740.4833564978935;5768.509676677488;6147.815565533041;6167.568270221086;6213.87572248557;6224.844378890519;6229.314775374751;6224.408681175281;6237.345078766755;6237.812865614039;6246.6252024878195;6274.749010039593;5674.886502269931;5747.827565173052;5790.189373487715;5820.2724659418;5864.120381942743;5234.26720259164;6338.904916426257;6341.112244285804;6346;6346;6174.660393678301;6176.629402235881;6177.2587289525545;6182.567220294536;6186.443220110122;6105.702364394958;6147.323794382703;6163;6227.06594010902;6228.937710622927;6104.3590423005835;6219.222597175353;6228.719707613168;6235.345288744707;6236.002239641635;6206.937930620727;6213.65824879627;6239.344868788802;6249.843753906098;6278.372162783777;4934.185859333242;4957.157283261854;4960.70235785854;4974.751262436864;5023.14606516893;3554.413521768931;3567;3809.104860357814;4377.883639671863;4424.911501769947;5684.573656975744;5781.277340332458;5810.622309549865;5823.767049318065;5871.941280587225;6064.605800622945;6143.634700640286;6218.657973811393;6218.906716399258;6237.812865613948;4906.484819094015;5868.647881127146;5945.16767652529;5960.195373624505;5963.701814909237;4521.84173553924;4591.288350305708;5449.155380915964;5470.56235501159;5541.307336582927;6183.690815459299;6293.433590976834;6384.744610215632;6411.230652321751;6432.099506069154;6209.565330426827;6214.844628884314;6223.471004964447;6231.688415579293;6251.656158911122;5652.689102099424;6426.678666066585;6433.29233784274;6435.742570297136;6527.184101987062;5304.541251155963;6039.849003774941;6209.0996805462055;6227.408396202353;6230.096635987847;6021.54838387114;6103.664298463449;6183.659898705614;6265.780697675559;6266.060090986389;6154.753809847556;6163.8150855474405;6166.599171054047;6168.982117950667;6169.2288463942;5929.555283353852;6116.571839971337;6140.846478838065;6157.230346206724;6189.845253868509;5903.173555702119;5925.792597259076;6011.90982135277;6034.758609655564;6094.14681944537;6079.209702738615;6090.817275481742;6142.723577439116;6149.292831324455;6186.350433204449;5844.3571207168025;5942.732577033958;5954.732037058429;6018.9398106020135;6051.848703782441 18:17:39 INFO - PROCESS | 1652 | |1;ext.html;468.9320048592952;528.3342987835327;534.369444056014;540.8242321245593;572.1160806553873;38487.422688659695;39568.80215598925;39578.2084358313;39607;39639;40655.796721016355;41169.7941510292;41203.381949270784;41275.79362103185;41346.966325841866;9574.329796914219;9781.657641982532;9790.412575245473;9801.019898010214;9813.509324533781;8560.785980350478;9726.9513652432;9819.754506137333;9865;9897.307188496809;9754.561044753003;9860.457674827881;9861.063198996084;9890.901090989106;9897.4556399398;9808.901910980905;9820.852687209626;9834.409935403863;9850.50747462631;9878.802423951482;9663.565139568736;9671.323007389485;9732.2214222862;9750.609975600968;9752.756865920806;38687.8065609673;38818.417723734165;38825.611743882764;39014;39153.60846391528;2672.8396296222095;3304.2069903223055;3523.4186359250693;3527.417976033951;3546.8935931922083;29027.709722902713;29079.56380654292;30494.695053049407;30918;31405.842970785;2923.6491621005403;2950.4236992084975;3033.9393212135856;3041.756659467237;3082.9383412331854;391168;460811;470367.99999999657;470609;471044.64477677736;49073;59614.70192649009;59700;59761;60030.69984650049;33404.66595334064;34741.305173896886;34882;61958.69020654868;62152.68923655443;15696.529104126894;15862.682746345008;15906.045637261801;15957.44148954781;15959.521214363587;12026.398680065962;12187.39063046844;12220.694482638006;12229.960453361564;12234.449449774782;18441.631167376847;18508.537286567942;18528;18544.629107417775;18550.350737724115;8046.436749427484;8142.3486121111355;8215.890854734655;8217.58912054395;8220.506769593843;884.4781578868499;1004.7287232447198;1028.2134167361974;1032.7314898126542;1065.9093977012042;30036.948706795596;30038.849805750833;30287.394252114835;30669.8466507666;31003.844980774953;1007.1791489935825;1040.9219308551737;1099.8845121262311;1102.5644870276196;1120.1878637987556;14333.140011599337;15069.869759768062;15132.848671513364;15139.481931372546;15380.615484612974;658940;665648;667445;668921;669039;46916.5308346919;53959.73020134874;54453.910921781346;54493.63765905884;54652;1355.390074466494;1363.236587510997;1405.901586888908;1408.7745960646248;1410.9435622575188;23124.768752312935;23177.768222318235;27855.860720696266;28929.62955598397;29491.262718432212;45160;47399.28901066418;47895.281570777166;48097.27854082262;48307.27539086846;496087;514856.425717869;515293;517044.4147779237;518891;20461.693074603594;25207.621885672095;25251;25323.366915827253;25326.366840829127;36160.81919590385;43825.78087109544;44246;44862.55137448584;45626.54373456223;36528.634713653584;36750.63249367579;36865;37854.242915142095;38022.42966355452;36498.635013649524;36645;37550.87347379583;37627.43558846565;37779.05552361103;36635.08412289714;37136.81431592825;37785.433218501195;38637;39862.60480883155;33011.174720631214;33867.4919876207;34466.82766586151;34544;34692;25556.488870222118;25671.87164064168;25706;25919.352016199748;26297.474050519264 18:17:39 INFO - PROCESS | 1652 | |2;jquery.html;371.9200371920037;373.13805110195466;379.3134426687695;383.97120215983807;400.8196311659754;19273.132709028094;20366.898165509152;21502.569948601038;21696.566068678618;21831.781682183195;10839;11114;11995.10036747243;12343.5062597496;19083.42749717507;5186.611004174692;5626.859328516799;5646.745896434671;5655.4061823508555;5671.376148623648;5487.945120548783;5505.862353441156;5555.50000499955;5562;5573.164025396182;5385.865353366158;5504.724763761816;5520.696361700105;5560.304961879765;5561.860953476175;5542.2517960075475;5908.67502287374;6077.237601095677;6148.477379422754;6159.045347971071;4619.607333376667;5294.391145018295;5347.812826551052;5374.140137578008;5438.809641662562;13523.864761352359;13870.791938120836;23371.641783609568;23802.047918083255;24960.5007899841;2030.3908827351736;2277.7836105569945;2413.4207790130417;2656;3027;8311.750647480525;10268.28122031458;10381.169506439466;10384.480775961172;10396;1800.5138612574663;1875.1936667233085;1941.4466876940146;1943.6112777444425;1958.5886963737632;107370;119418.40290798577;121953;122021.38989305086;124703.41207349172;11377.943110284561;11404;11636.709082272842;11819.409029548488;12111.394430278451;11618.302901825917;12046.518139274505;13811.033227673966;14554;14570.781438278435;6496.545241833026;6822.249552549216;7782.377409807202;7811.296983271533;7891.723789667334;7327.413806895435;7419.703211871572;7485.401167906554;7554.320111190019;7598.430117741192;4523.7285762854335;4525.072360166158;4534.36518887356;4574.519675434098;4655.953440465552;1628.3974929276244;1949;1961.264525802824;1997.5605366819277;1998.8700734452505;833.5790425834914;839.6607411179159;882.7075010211945;932.9067093290753;939.5161491831713;18184.181711823;20110.296139635044;21650.783492165192;21874.671879921814;21890.562188756136;883.8598208311206;891.3225948279224;915.514777168102;925.726910561386;942.0297093993198;10901.01890829829;11413.885861141449;11515.424228788695;11534.192606517463;11564.710882228012;454415;459852;460282;565911;571834;115530;126333.99999999817;129106;137692;145174;962.8748262725801;983.3067687280593;1014.1075853249093;1014.4775440648073;1017.6692574913183;18011.639767204844;19223.711644325627;19668.803311966698;19743.21027158955;20006.89996550008;38552.42171367376;48250;49890.501094988584;55479.44520554904;56265.43734562766;76686.2331376679;76785.464290715;77720.61139694265;77725;78087.6095619541;6848.863022739617;7764.92235077642;8267.793305167419;8358.498490090615;8381.95809020951;9914.206863450763;13032.934835325763;13187.274699891213;13480.86519134796;13519.526816561372;11004.229703920648;11229.438528073728;11233.213675042669;11520.769584608428;11597.59408420735;10983.286086404358;11118.61084862026;11186.384748838893;11196.216264861381;11382.487788049391;10554.419506927192;10682.732931676459;11302;11665.125115616192;11783.410829458322;6913.274106218774;8011.256473969432;8200.42597018203;8241.57756808189;8380.958095209486;10747.677569672922;11255.549778008788;11307.491162897853;11421.486033128695;11465.14011449128 18:17:39 INFO - PROCESS | 1652 | |3;mootools.html;1523.740964036114;1553.603831023089;1730.351118330626;1848.713449415341;1864.6084322292309;6590.308017658149;7974.760757177287;8001.8799718004275;8584.313254939605;8903.866442003375;8666.176713212235;8739.91260087399;8748.125187481248;8765.123487651232;8768.605412756426;2162.7296587926508;2233.7877901599404;2344.6834677318557;2371.27676058802;2376.7147942246957;2019.0005947056227;2303.28598134578;2364.2788949370433;2384.2966324934187;2391.7249516305587;2002.3392280547384;2316.7104111986;2351.47091904321;2380.880955952204;2390.4143484846236;2342.6837376954063;2355.4464700795297;2358.716953965518;2362.9763702363016;2364.7871691547757;2342.426105604121;2344.10923848938;2350.4476448034698;2351.7413084560685;2351.905923763047;8701.7824554386;8871.955640221757;8876.201141897196;8885.111488851127;8886.822263554757;5224.294720212761;5358.115910874701;5395.649282796606;5406.459354064601;5426.728663566806;2872.8563571821323;2997.8158627342295;3437.7937323760652;3597.964020359789;3623.5832879218965;864.3128712673376;898.5731777405746;929.2101713543501;1093.7593729379603;1098.0995583621434;11512.366819824907;11635.94182029093;11683.240589361749;11690.47392867323;11717.17979741427;4611.631069514431;4675.275332323427;4768.427788665383;4829.2997515360075;4830.9275360869615;9774.218062554979;9847.655332063343;9847.803043939224;9864.605415783288;9897.554610042565;5324.733763311819;5345.839624811262;5352.759125839269;5357.7589008494715;5365.678059316453;3892.4745159403683;4087.202995415865;4401.625861801783;4908.312836202863;4978.178600530944;3164.920876978048;3205.406999705062;3890.8832735017995;3976.165005348851;4089.1208390195657;1293.1077556485996;1296.4554886947317;1305.1516514265613;1306.1248963194682;1315.967100822468;792.7185849023629;837.677494164751;849.1338834389012;874.8250349930039;971.8347880860271;5455.208994695747;5837.9124313135335;5979.282486101695;6016.639001659827;6250.124982502453;426.86767102198417;431.5662758927258;444.7153821554208;455.4352602772538;456.9991718137335;3352.96058221952;3965.88102356924;4042.333015052542;4104.979475102665;4138.668906487474;10171.237157213238;10425.530851111718;10584.153267738562;10652.360858348524;10707.892921070845;10662.253642245123;10667.359958402521;10675.039246467855;10678.359298442118;10702.411367374869;7817.491863028885;8052.718154864551;8182.959085204536;8276.668933242723;8281.006279246409;5954.19618351517;6012.909806352821;6067.332593414809;6146.846328841814;6147.631142131487;9424.104710052534;9933.950330248303;10076.949615251877;10136.797264054825;10152.441615711206;8059.3552515799765;10214.591416343263;10218.591256349662;10231.232657550565;10241.385516869012;7009.754658587129;7366.926330736624;7544.396448284234;7565.659545320584;7674.2325767425045;8454.281386082006;8467.53428561435;8538.829223415372;8550.74347769568;8564.486130831921;7480.513766605153;7553.471257011956;7614.048243969504;7664.048266180872;7745.419093568117;6603.603783772989;7329.267073292628;7341.70633174667;7486.43851711113;7550.7734767957045;6981.895271571032;6995.755148569776;7056;7057.788266352018;7067.469939754436;4979.825706100269;5013.699178049329;5035.773390197523;5158;5180.300659411082;4257.8509752158525;4922.062350119962;5119.872003199801;5214;5258.263843062051 18:17:39 INFO - PROCESS | 1652 | |4;prototype.html;289.1686401595413;302.06811985026195;307.84453850805346;309.5202436223854;309.84817439454673;4795.68828026178;5210.879660872912;5290.180022096576;5568.331800183979;5679.148127780835;4226.725262857912;4556.954430455695;4720.504347043562;5294.364676238857;5561.499465048145;3931.783751893645;3971.642552170304;4000.3996403237174;4097.774622395767;4186.555638304795;3639.6178401267885;4154.459920210384;4156.854510092147;4172.207280616688;4175.4363160973335;3633.273345330931;4149.091417947732;4175.331946888498;4205.600467955539;4212.178625168093;3692.5568931728367;4031.2743706132737;4065.146319272956;4142.772147531915;4198.097409057053;2990.7158819912074;3079.969200307991;3233.4503134467195;3584.390653588896;3596.406592912166;3999.6400323970693;5358.410574836765;5384.434634363413;5420.647657902224;5424.077906755861;4178.874633760992;4468.93296600548;4476.731396116211;4819.481863213076;4838.782254798507;4812.831550895737;5686.5735069869925;5815.447532484407;5835.387284335126;5911.261092363455;3854.8242785950274;3880.941785873186;3884.436756670267;3904.3752999520225;3904.941425878614;5146.871328216787;5391.838244852661;5640.210370548127;6161.599496032743;6206.038064100072;3904.4338570907626;3935.976646072042;3969.047428617111;3969.7419667721506;3990;4033.7378070425916;4039.313316736162;4057.89855253621;4063.090347536653;4081.3061779497557;4758.42898852133;4775.976120119377;4785.511534002299;4796.184648609745;4796.424429068534;5320;5662.348829884616;5924.318703349084;5949.345571987078;5967.343592204854;1275.2922128218743;1346.5354452713798;1377.4627895120911;1377.5260471295817;1380.4340220509544;699.8033362949413;738.5162718419336;743.598456833304;784.9332806711379;843.3632607381388;4448.621867141264;5293.497117773805;5492.588055895823;5494.203340515603;5646.6047376684055;5254.579633629301;5277.762500687479;5347.732613369394;6103.443621876482;6161.151654503631;4292.377605247221;5470.522958801102;5522.895420915833;5526.751296191681;5550.306211723535;2990.925226869346;3110.548970399325;3171.7313074769813;3193.6746250305864;3290.8683652653626;5313.256144139824;5558.666480011212;5706.002898985322;6234.9688251558455;6352.936470635327;5707.885842283131;5847.561432892465;5965.463108320272;6199.690015499207;6271.43557079865;5805.535557155333;6347.71435285404;6407.839804004844;6415.807525774234;6451.677416129269;5333.8265581571995;5512.629569285245;5924.940750592611;6053.515718742578;6113.938860611337;5706.942930570807;6010;6026.668533230714;6028.558433834304;6033.42682445167;5677.261955945701;6269.341719119427;6313.842153946188;6343.429091381798;6354.332795056637;3764.981175094107;3887.572367039567;4011.097503061788;4056.5537790842395;4108.6918481114635;5286.255535673142;5570.913671834115;6050.9394906050375;6071.666058366833;6084.6349219047;4854.563089321978;5084.47465760263;5690.687012214368;5756.539476841926;5868.2958045033165;4776.761161941959;5537.833864984057;5725.942740572541;5749.338826034892;5780.826575202751;5697.487226149667;5736.569757268138;5754.9424505754405;5767.625104368202;5777.931082749705;5042.344495215599;5130.948690513196;5586.960759322899;5649.051077378298;5661.688607126647;5062.873428164326;5759.7665715698095;5781.21953536284;5796.420357964338;5796.681182535001 18:17:39 INFO - PROCESS | 1652 | |5;yui.html;636.2206297285823;649.912261844651;778.552332408865;780.8438312337533;805.2028491793122;13310.667233319147;15340.53978380649;16048.27782749776;16093.436729714462;16126.838731612681;14533.636659083528;14658;14683.33924973376;14689.779653305182;14708.338124784384;670.4803777072759;818.8648872935959;822.198356602314;843.4011851585382;846.6571038729325;845.2055068235869;849.1254008371387;849.2569002123142;849.8215374771305;859.4499520307008;904.041715781274;909.6543313540845;909.6770646420524;909.7361765088117;911.694582314922;687.22000529399;769.9961500192519;885.6103314541581;902.9367944243905;905.1943770044666;655.3184687924553;664.9035889796;669.5112567825514;672.3612568060313;672.579637726421;15189.088654680643;15201;15202.46791362297;15244.847551524454;15291.464798732102;14687.412503499847;14795.55613331591;14833;14883.851161488463;14959.775603365959;11173.033573081602;11936.58221962227;12157.148999570034;12256.203346782431;12401.317927513983;3667.669909708139;3822.9617703822883;3996.6003399660094;4032.4556184914954;4034.4553485279407;108045;109739;110522.26344155912;110642.3403648946;111003;10944.616938407118;11384.487698053608;11393.772124557463;11488.94255528717;11883.940580297043;23389.649155262345;23427.531449370916;23465.8267086645;23509.41226469352;23542;7814.765557033298;8133.877991830127;8181.222783835645;8200.384971127189;8260.380471464665;4403.647708183337;4477.395551600493;4498.2577874650315;4537.523560026216;4635.049814787961;3632.8728494502566;3698.093966978108;3719.75821571597;3746.550413950343;3752.981235093807;561.5956511311849;649.2857856358063;652.3085529338916;662.2516556291456;675.2774531251612;529.1639210048115;553.5690240727764;604.7188057553259;612.2672835874465;635.3011687144104;6924.723011079501;7855.0570349770915;8421.873671894926;9407.952960235156;9433.433993960385;538.0959987221505;561.8174093419655;590.4892268187987;607.3471018654964;632.5888172687697;3844.3464611016193;4419.447569053868;4610.907781844345;4639.86080417588;4694.225452800318;101664;116129;118293;130489;142377;126242;127480;129904.40191196123;130207;132227;97776.02223977669;102431;115869;117381;117783;9974.800503989734;10015.39907605546;10111.118331275551;10114.241431892491;10133.797324053625;45423.54576454193;55317;61929.69035154796;63742;64799.02801458076;92557;95142;96804.51597741967;98439.50780246053;101343;12891.419886105336;13184.868151318364;13189.868101318863;13390.799138012742;13774.931125344308;15124.54626361211;15140.015898966532;15206.16366099875;15219.315130819361;15241.3903443861;13878.306084695927;13937.930310348384;13954;14076.859231407554;14118.929405352908;12183.147179697691;13847.30763461843;14029.438822446988;14324.212168330425;14641.560753177422;13211.405486753312;13703;13951.023428360324;14316.355763990854;14425.990180687251;11232.887671123184;11416.828747568627;11503.194776365573;11619.883801161881;11711.531538738696;9902.603895844086;11576.536938522364;11858.288502689866;11861.229020113666;11949.76100478003 18:17:39 INFO - PROCESS | 1652 | __end_tp_report 18:17:39 INFO - PROCESS | 1652 | __start_cc_report 18:17:39 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,400 18:17:39 INFO - PROCESS | 1652 | __end_cc_report 18:17:39 INFO - PROCESS | 1652 | __startTimestamp1471396659017__endTimestamp 18:17:39 INFO - PROCESS | 1652 | 18:17:39 INFO - PROCESS | 1652 | ------- Summary: start ------- 18:17:39 INFO - PROCESS | 1652 | Number of tests: 6 18:17:39 INFO - PROCESS | 1652 | 18:17:39 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5727.93 Median:5960.20 stddev:683.36 (11.5%) stddev-sans-first:659.79 18:17:39 INFO - PROCESS | 1652 | Values: 3363.1 3366.4 3388.6 3418.7 3425.4 5677.6 5680.2 5695.7 5699.1 5742.6 5591.9 5704.6 5734.2 5742.5 5764.1 5206.7 5224.3 5260.2 5293.6 5311.1 5194.0 5335.6 5363.2 5369.2 5384.1 5163.7 5265.8 5268.2 5286.7 5314.3 5190.9 5224.8 5255.6 5271.4 5296.8 5158.4 5166.2 5171.3 5179.5 5236.7 5559.9 5623.8 5729.6 5740.5 5768.5 6147.8 6167.6 6213.9 6224.8 6229.3 6224.4 6237.3 6237.8 6246.6 6274.7 5674.9 5747.8 5790.2 5820.3 5864.1 5234.3 6338.9 6341.1 6346.0 6346.0 6174.7 6176.6 6177.3 6182.6 6186.4 6105.7 6147.3 6163.0 6227.1 6228.9 6104.4 6219.2 6228.7 6235.3 6236.0 6206.9 6213.7 6239.3 6249.8 6278.4 4934.2 4957.2 4960.7 4974.8 5023.1 3554.4 3567.0 3809.1 4377.9 4424.9 5684.6 5781.3 5810.6 5823.8 5871.9 6064.6 6143.6 6218.7 6218.9 6237.8 4906.5 5868.6 5945.2 5960.2 5963.7 4521.8 4591.3 5449.2 5470.6 5541.3 6183.7 6293.4 6384.7 6411.2 6432.1 6209.6 6214.8 6223.5 6231.7 6251.7 5652.7 6426.7 6433.3 6435.7 6527.2 5304.5 6039.8 6209.1 6227.4 6230.1 6021.5 6103.7 6183.7 6265.8 6266.1 6154.8 6163.8 6166.6 6169.0 6169.2 5929.6 6116.6 6140.8 6157.2 6189.8 5903.2 5925.8 6011.9 6034.8 6094.1 6079.2 6090.8 6142.7 6149.3 6186.4 5844.4 5942.7 5954.7 6018.9 6051.8 18:17:39 INFO - PROCESS | 1652 | 18:17:39 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:66931.06 Median:38254.93 stddev:147504.84 (385.6%) stddev-sans-first:147834.22 18:17:39 INFO - PROCESS | 1652 | Values: 468.9 528.3 534.4 540.8 572.1 38487.4 39568.8 39578.2 39607.0 39639.0 40655.8 41169.8 41203.4 41275.8 41347.0 9574.3 9781.7 9790.4 9801.0 9813.5 8560.8 9727.0 9819.8 9865.0 9897.3 9754.6 9860.5 9861.1 9890.9 9897.5 9808.9 9820.9 9834.4 9850.5 9878.8 9663.6 9671.3 9732.2 9750.6 9752.8 38687.8 38818.4 38825.6 39014.0 39153.6 2672.8 3304.2 3523.4 3527.4 3546.9 29027.7 29079.6 30494.7 30918.0 31405.8 2923.6 2950.4 3033.9 3041.8 3082.9 391168.0 460811.0 470368.0 470609.0 471044.6 49073.0 59614.7 59700.0 59761.0 60030.7 33404.7 34741.3 34882.0 61958.7 62152.7 15696.5 15862.7 15906.0 15957.4 15959.5 12026.4 12187.4 12220.7 12230.0 12234.4 18441.6 18508.5 18528.0 18544.6 18550.4 8046.4 8142.3 8215.9 8217.6 8220.5 884.5 1004.7 1028.2 1032.7 1065.9 30036.9 30038.8 30287.4 30669.8 31003.8 1007.2 1040.9 1099.9 1102.6 1120.2 14333.1 15069.9 15132.8 15139.5 15380.6 658940.0 665648.0 667445.0 668921.0 669039.0 46916.5 53959.7 54453.9 54493.6 54652.0 1355.4 1363.2 1405.9 1408.8 1410.9 23124.8 23177.8 27855.9 28929.6 29491.3 45160.0 47399.3 47895.3 48097.3 48307.3 496087.0 514856.4 515293.0 517044.4 518891.0 20461.7 25207.6 25251.0 25323.4 25326.4 36160.8 43825.8 44246.0 44862.6 45626.5 36528.6 36750.6 36865.0 37854.2 38022.4 36498.6 36645.0 37550.9 37627.4 37779.1 36635.1 37136.8 37785.4 38637.0 39862.6 33011.2 33867.5 34466.8 34544.0 34692.0 25556.5 25671.9 25706.0 25919.4 26297.5 18:17:39 INFO - PROCESS | 1652 | 18:17:39 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:31938.93 Median:23586.84 stddev:85564.34 (362.8%) stddev-sans-first:85771.54 18:17:39 INFO - PROCESS | 1652 | Values: 371.9 373.1 379.3 384.0 400.8 19273.1 20366.9 21502.6 21696.6 21831.8 10839.0 11114.0 11995.1 12343.5 19083.4 5186.6 5626.9 5646.7 5655.4 5671.4 5487.9 5505.9 5555.5 5562.0 5573.2 5385.9 5504.7 5520.7 5560.3 5561.9 5542.3 5908.7 6077.2 6148.5 6159.0 4619.6 5294.4 5347.8 5374.1 5438.8 13523.9 13870.8 23371.6 23802.0 24960.5 2030.4 2277.8 2413.4 2656.0 3027.0 8311.8 10268.3 10381.2 10384.5 10396.0 1800.5 1875.2 1941.4 1943.6 1958.6 107370.0 119418.4 121953.0 122021.4 124703.4 11377.9 11404.0 11636.7 11819.4 12111.4 11618.3 12046.5 13811.0 14554.0 14570.8 6496.5 6822.2 7782.4 7811.3 7891.7 7327.4 7419.7 7485.4 7554.3 7598.4 4523.7 4525.1 4534.4 4574.5 4656.0 1628.4 1949.0 1961.3 1997.6 1998.9 833.6 839.7 882.7 932.9 939.5 18184.2 20110.3 21650.8 21874.7 21890.6 883.9 891.3 915.5 925.7 942.0 10901.0 11413.9 11515.4 11534.2 11564.7 454415.0 459852.0 460282.0 565911.0 571834.0 115530.0 126334.0 129106.0 137692.0 145174.0 962.9 983.3 1014.1 1014.5 1017.7 18011.6 19223.7 19668.8 19743.2 20006.9 38552.4 48250.0 49890.5 55479.4 56265.4 76686.2 76785.5 77720.6 77725.0 78087.6 6848.9 7764.9 8267.8 8358.5 8382.0 9914.2 13032.9 13187.3 13480.9 13519.5 11004.2 11229.4 11233.2 11520.8 11597.6 10983.3 11118.6 11186.4 11196.2 11382.5 10554.4 10682.7 11302.0 11665.1 11783.4 6913.3 8011.3 8200.4 8241.6 8381.0 10747.7 11255.5 11307.5 11421.5 11465.1 18:17:39 INFO - PROCESS | 1652 | 18:17:39 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5657.34 Median:4979.00 stddev:3212.90 (64.5%) stddev-sans-first:3206.90 18:17:39 INFO - PROCESS | 1652 | Values: 1523.7 1553.6 1730.4 1848.7 1864.6 6590.3 7974.8 8001.9 8584.3 8903.9 8666.2 8739.9 8748.1 8765.1 8768.6 2162.7 2233.8 2344.7 2371.3 2376.7 2019.0 2303.3 2364.3 2384.3 2391.7 2002.3 2316.7 2351.5 2380.9 2390.4 2342.7 2355.4 2358.7 2363.0 2364.8 2342.4 2344.1 2350.4 2351.7 2351.9 8701.8 8872.0 8876.2 8885.1 8886.8 5224.3 5358.1 5395.6 5406.5 5426.7 2872.9 2997.8 3437.8 3598.0 3623.6 864.3 898.6 929.2 1093.8 1098.1 11512.4 11635.9 11683.2 11690.5 11717.2 4611.6 4675.3 4768.4 4829.3 4830.9 9774.2 9847.7 9847.8 9864.6 9897.6 5324.7 5345.8 5352.8 5357.8 5365.7 3892.5 4087.2 4401.6 4908.3 4978.2 3164.9 3205.4 3890.9 3976.2 4089.1 1293.1 1296.5 1305.2 1306.1 1316.0 792.7 837.7 849.1 874.8 971.8 5455.2 5837.9 5979.3 6016.6 6250.1 426.9 431.6 444.7 455.4 457.0 3353.0 3965.9 4042.3 4105.0 4138.7 10171.2 10425.5 10584.2 10652.4 10707.9 10662.3 10667.4 10675.0 10678.4 10702.4 7817.5 8052.7 8183.0 8276.7 8281.0 5954.2 6012.9 6067.3 6146.8 6147.6 9424.1 9934.0 10076.9 10136.8 10152.4 8059.4 10214.6 10218.6 10231.2 10241.4 7009.8 7366.9 7544.4 7565.7 7674.2 8454.3 8467.5 8538.8 8550.7 8564.5 7480.5 7553.5 7614.0 7664.0 7745.4 6603.6 7329.3 7341.7 7486.4 7550.8 6981.9 6995.8 7056.0 7057.8 7067.5 4979.8 5013.7 5035.8 5158.0 5180.3 4257.9 4922.1 5119.9 5214.0 5258.3 18:17:39 INFO - PROCESS | 1652 | 18:17:39 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4679.48 Median:5293.93 stddev:1473.74 (27.8%) stddev-sans-first:1440.56 18:17:39 INFO - PROCESS | 1652 | Values: 289.2 302.1 307.8 309.5 309.8 4795.7 5210.9 5290.2 5568.3 5679.1 4226.7 4557.0 4720.5 5294.4 5561.5 3931.8 3971.6 4000.4 4097.8 4186.6 3639.6 4154.5 4156.9 4172.2 4175.4 3633.3 4149.1 4175.3 4205.6 4212.2 3692.6 4031.3 4065.1 4142.8 4198.1 2990.7 3080.0 3233.5 3584.4 3596.4 3999.6 5358.4 5384.4 5420.6 5424.1 4178.9 4468.9 4476.7 4819.5 4838.8 4812.8 5686.6 5815.4 5835.4 5911.3 3854.8 3880.9 3884.4 3904.4 3904.9 5146.9 5391.8 5640.2 6161.6 6206.0 3904.4 3936.0 3969.0 3969.7 3990.0 4033.7 4039.3 4057.9 4063.1 4081.3 4758.4 4776.0 4785.5 4796.2 4796.4 5320.0 5662.3 5924.3 5949.3 5967.3 1275.3 1346.5 1377.5 1377.5 1380.4 699.8 738.5 743.6 784.9 843.4 4448.6 5293.5 5492.6 5494.2 5646.6 5254.6 5277.8 5347.7 6103.4 6161.2 4292.4 5470.5 5522.9 5526.8 5550.3 2990.9 3110.5 3171.7 3193.7 3290.9 5313.3 5558.7 5706.0 6235.0 6352.9 5707.9 5847.6 5965.5 6199.7 6271.4 5805.5 6347.7 6407.8 6415.8 6451.7 5333.8 5512.6 5924.9 6053.5 6113.9 5706.9 6010.0 6026.7 6028.6 6033.4 5677.3 6269.3 6313.8 6343.4 6354.3 3765.0 3887.6 4011.1 4056.6 4108.7 5286.3 5570.9 6050.9 6071.7 6084.6 4854.6 5084.5 5690.7 5756.5 5868.3 4776.8 5537.8 5725.9 5749.3 5780.8 5697.5 5736.6 5754.9 5767.6 5777.9 5042.3 5130.9 5587.0 5649.1 5661.7 5062.9 5759.8 5781.2 5796.4 5796.7 18:17:39 INFO - PROCESS | 1652 | 18:17:39 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:24338.79 Median:23487.62 stddev:37688.36 (160.5%) stddev-sans-first:37752.07 18:17:39 INFO - PROCESS | 1652 | Values: 636.2 649.9 778.6 780.8 805.2 13310.7 15340.5 16048.3 16093.4 16126.8 14533.6 14658.0 14683.3 14689.8 14708.3 670.5 818.9 822.2 843.4 846.7 845.2 849.1 849.3 849.8 859.4 904.0 909.7 909.7 909.7 911.7 687.2 770.0 885.6 902.9 905.2 655.3 664.9 669.5 672.4 672.6 15189.1 15201.0 15202.5 15244.8 15291.5 14687.4 14795.6 14833.0 14883.9 14959.8 11173.0 11936.6 12157.1 12256.2 12401.3 3667.7 3823.0 3996.6 4032.5 4034.5 108045.0 109739.0 110522.3 110642.3 111003.0 10944.6 11384.5 11393.8 11488.9 11883.9 23389.6 23427.5 23465.8 23509.4 23542.0 7814.8 8133.9 8181.2 8200.4 8260.4 4403.6 4477.4 4498.3 4537.5 4635.0 3632.9 3698.1 3719.8 3746.6 3753.0 561.6 649.3 652.3 662.3 675.3 529.2 553.6 604.7 612.3 635.3 6924.7 7855.1 8421.9 9408.0 9433.4 538.1 561.8 590.5 607.3 632.6 3844.3 4419.4 4610.9 4639.9 4694.2 101664.0 116129.0 118293.0 130489.0 142377.0 126242.0 127480.0 129904.4 130207.0 132227.0 97776.0 102431.0 115869.0 117381.0 117783.0 9974.8 10015.4 10111.1 10114.2 10133.8 45423.5 55317.0 61929.7 63742.0 64799.0 92557.0 95142.0 96804.5 98439.5 101343.0 12891.4 13184.9 13189.9 13390.8 13774.9 15124.5 15140.0 15206.2 15219.3 15241.4 13878.3 13937.9 13954.0 14076.9 14118.9 12183.1 13847.3 14029.4 14324.2 14641.6 13211.4 13703.0 13951.0 14316.4 14426.0 11232.9 11416.8 11503.2 11619.9 11711.5 9902.6 11576.5 11858.3 11861.2 11949.8 18:17:39 INFO - PROCESS | 1652 | -------- Summary: end -------- 18:17:39 INFO - PROCESS | 1652 | 18:17:39 INFO - TEST-INFO | 1652: exit 0 18:17:39 INFO - TEST-OK | dromaeo_css | took 1113767ms 18:17:39 INFO - TEST-START | kraken 18:17:39 INFO - operating with platform_type : mac_ 18:17:39 INFO - Initialising browser for kraken test... 18:17:39 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmpyvcsRg/profile http://localhost:49268/getInfo.html) 18:17:42 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 18:17:42 INFO - PROCESS | 1660 | colorDepth:24 18:17:42 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 18:17:42 INFO - PROCESS | 1660 | __metrics 18:17:42 ERROR - PROCESS | 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 18:17:42 INFO - TEST-INFO | 1660: exit 0 18:17:42 INFO - Browser initialized. 18:17:42 INFO - Running cycle 1/1 for kraken test... 18:17:42 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmpyvcsRg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:17:54 INFO - PROCESS | 1662 | RSS: Main: 237109248 18:17:54 INFO - PROCESS | 1662 | 18:17:57 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection) 18:17:58 INFO - PROCESS | 1662 | RSS: Main: 249806848 18:17:58 INFO - PROCESS | 1662 | 18:18:01 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-dft) 18:18:01 INFO - PROCESS | 1662 | RSS: Main: 258449408 18:18:01 INFO - PROCESS | 1662 | 18:18:05 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-fft) 18:18:05 INFO - PROCESS | 1662 | RSS: Main: 261124096 18:18:05 INFO - PROCESS | 1662 | 18:18:07 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator) 18:18:08 INFO - PROCESS | 1662 | RSS: Main: 262504448 18:18:08 INFO - PROCESS | 1662 | 18:18:10 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:18:11 INFO - PROCESS | 1662 | RSS: Main: 262959104 18:18:11 INFO - PROCESS | 1662 | 18:18:13 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom) 18:18:14 INFO - PROCESS | 1662 | RSS: Main: 263938048 18:18:14 INFO - PROCESS | 1662 | 18:18:17 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate) 18:18:18 INFO - PROCESS | 1662 | RSS: Main: 264237056 18:18:18 INFO - PROCESS | 1662 | 18:18:21 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial) 18:18:21 INFO - PROCESS | 1662 | RSS: Main: 264912896 18:18:21 INFO - PROCESS | 1662 | 18:18:23 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:18:23 INFO - PROCESS | 1662 | RSS: Main: 264527872 18:18:23 INFO - PROCESS | 1662 | 18:18:25 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:18:26 INFO - PROCESS | 1662 | RSS: Main: 264749056 18:18:26 INFO - PROCESS | 1662 | 18:18:28 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:18:29 INFO - PROCESS | 1662 | RSS: Main: 264986624 18:18:29 INFO - PROCESS | 1662 | 18:18:32 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:18:33 INFO - PROCESS | 1662 | RSS: Main: 264728576 18:18:33 INFO - PROCESS | 1662 | 18:18:35 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:18:36 INFO - PROCESS | 1662 | RSS: Main: 265027584 18:18:36 INFO - PROCESS | 1662 | 18:18:38 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49268/tests/kraken/driver.html?testName=ai-astar) 18:18:38 INFO - PROCESS | 1662 | RSS: Main: 266072064 18:18:38 INFO - PROCESS | 1662 | 18:18:38 INFO - PROCESS | 1662 | __start_tp_report 18:18:38 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 18:18:38 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 18:18:38 INFO - PROCESS | 1662 | |i|pagename|runs| 18:18:38 INFO - PROCESS | 1662 | |0;ai-astar;106;118;110;120;116;116;120;115;118;117 18:18:38 INFO - PROCESS | 1662 | |1;audio-beat-detection;145;129;134;159;110;134;128;111;157;111 18:18:38 INFO - PROCESS | 1662 | |2;audio-dft;195;200;203;212;215;194;195;201;197;200 18:18:38 INFO - PROCESS | 1662 | |3;audio-fft;70;82;77;142;60;59;68;64;148;84 18:18:38 INFO - PROCESS | 1662 | |4;audio-oscillator;70;73;129;72;71;87;114;70;73;115 18:18:38 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;90;88;89;88;90;86;91;87;90;85 18:18:38 INFO - PROCESS | 1662 | |6;imaging-darkroom;125;115;96;96;111;90;135;101;106;115 18:18:38 INFO - PROCESS | 1662 | |7;imaging-desaturate;92;91;110;99;91;100;92;137;116;98 18:18:38 INFO - PROCESS | 1662 | |8;json-parse-financial;54;56;58;58;56;61;56;54;58;58 18:18:38 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;66;73;66;77;73;73;74;72;70;70 18:18:38 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;108;108;83;87;88;109;76;98;113;109 18:18:38 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;140;140;150;151;140;151;157;139;150;150 18:18:38 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;172;175;172;166;170;172;171;169;174;173 18:18:38 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;69;71;69;67;71;67;68;67;70;66 18:18:38 INFO - PROCESS | 1662 | __end_tp_report 18:18:38 INFO - PROCESS | 1662 | __start_cc_report 18:18:38 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1007 18:18:38 INFO - PROCESS | 1662 | __end_cc_report 18:18:38 INFO - PROCESS | 1662 | __startTimestamp1471396718416__endTimestamp 18:18:38 INFO - PROCESS | 1662 | 18:18:38 INFO - PROCESS | 1662 | ------- Summary: start ------- 18:18:38 INFO - PROCESS | 1662 | Number of tests: 14 18:18:38 INFO - PROCESS | 1662 | 18:18:38 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:115.60 Median:117.50 stddev:4.43 (3.8%) stddev-sans-first:3.04 18:18:38 INFO - PROCESS | 1662 | Values: 106.0 118.0 110.0 120.0 116.0 116.0 120.0 115.0 118.0 117.0 18:18:38 INFO - PROCESS | 1662 | 18:18:38 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:131.80 Median:134.00 stddev:18.02 (13.4%) stddev-sans-first:18.47 18:18:38 INFO - PROCESS | 1662 | Values: 145.0 129.0 134.0 159.0 110.0 134.0 128.0 111.0 157.0 111.0 18:18:38 INFO - PROCESS | 1662 | 18:18:38 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:201.20 Median:200.50 stddev:7.15 (3.6%) stddev-sans-first:7.22 18:18:38 INFO - PROCESS | 1662 | Values: 195.0 200.0 203.0 212.0 215.0 194.0 195.0 201.0 197.0 200.0 18:18:38 INFO - PROCESS | 1662 | 18:18:38 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:85.40 Median:69.00 stddev:32.57 (47.2%) stddev-sans-first:34.06 18:18:38 INFO - PROCESS | 1662 | Values: 70.0 82.0 77.0 142.0 60.0 59.0 68.0 64.0 148.0 84.0 18:18:38 INFO - PROCESS | 1662 | 18:18:38 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:87.40 Median:71.50 stddev:22.92 (32.1%) stddev-sans-first:23.43 18:18:38 INFO - PROCESS | 1662 | Values: 70.0 73.0 129.0 72.0 71.0 87.0 114.0 70.0 73.0 115.0 18:18:38 INFO - PROCESS | 1662 | 18:18:38 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:88.40 Median:89.50 stddev:1.96 (2.2%) stddev-sans-first:1.99 18:18:38 INFO - PROCESS | 1662 | Values: 90.0 88.0 89.0 88.0 90.0 86.0 91.0 87.0 90.0 85.0 18:18:38 INFO - PROCESS | 1662 | 18:18:38 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:109.00 Median:130.00 stddev:14.06 (10.8%) stddev-sans-first:13.67 18:18:38 INFO - PROCESS | 1662 | Values: 125.0 115.0 96.0 96.0 111.0 90.0 135.0 101.0 106.0 115.0 18:18:38 INFO - PROCESS | 1662 | 18:18:38 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:102.60 Median:91.50 stddev:14.73 (16.1%) stddev-sans-first:15.11 18:18:38 INFO - PROCESS | 1662 | Values: 92.0 91.0 110.0 99.0 91.0 100.0 92.0 137.0 116.0 98.0 18:18:38 INFO - PROCESS | 1662 | 18:18:38 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:58.00 stddev:2.13 (3.7%) stddev-sans-first:1.99 18:18:38 INFO - PROCESS | 1662 | Values: 54.0 56.0 58.0 58.0 56.0 61.0 56.0 54.0 58.0 58.0 18:18:38 INFO - PROCESS | 1662 | 18:18:38 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:73.00 stddev:3.47 (4.8%) stddev-sans-first:3.08 18:18:38 INFO - PROCESS | 1662 | Values: 66.0 73.0 66.0 77.0 73.0 73.0 74.0 72.0 70.0 70.0 18:18:38 INFO - PROCESS | 1662 | 18:18:38 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:97.90 Median:79.50 stddev:13.32 (16.8%) stddev-sans-first:13.62 18:18:38 INFO - PROCESS | 1662 | Values: 108.0 108.0 83.0 87.0 88.0 109.0 76.0 98.0 113.0 109.0 18:18:38 INFO - PROCESS | 1662 | 18:18:38 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:146.80 Median:150.00 stddev:6.41 (4.3%) stddev-sans-first:6.31 18:18:38 INFO - PROCESS | 1662 | Values: 140.0 140.0 150.0 151.0 140.0 151.0 157.0 139.0 150.0 150.0 18:18:38 INFO - PROCESS | 1662 | 18:18:38 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:172.00 stddev:2.59 (1.5%) stddev-sans-first:2.74 18:18:38 INFO - PROCESS | 1662 | Values: 172.0 175.0 172.0 166.0 170.0 172.0 171.0 169.0 174.0 173.0 18:18:38 INFO - PROCESS | 1662 | 18:18:38 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.78 (2.6%) stddev-sans-first:1.88 18:18:38 INFO - PROCESS | 1662 | Values: 69.0 71.0 69.0 67.0 71.0 67.0 68.0 67.0 70.0 66.0 18:18:38 INFO - PROCESS | 1662 | -------- Summary: end -------- 18:18:38 INFO - PROCESS | 1662 | 18:18:39 INFO - TEST-INFO | 1662: exit 0 18:18:39 INFO - TEST-OK | kraken | took 59582ms 18:18:39 INFO - SUITE-END | took 1173s 18:18:39 INFO - Completed test suite (00:19:33) 18:18:39 INFO - javascript benchmark 18:18:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7276.188851781679, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3363.125587347289, 3366.444536651453, 3388.593368795744, 3418.7435942304332, 3425.4348032574626, 5677.57418193635, 5680.204771332012, 5695.7152142392815, 5699.0596551569, 5742.569307301948, 5591.888162236763, 5704.629199102055, 5734.197212390269, 5742.511886489643, 5764.106563482656, 5206.687598744069, 5224.346956630421, 5260.184671375943, 5293.602979776513, 5311.097113490697, 5194.0, 5335.573154147659, 5363.195520671891, 5369.2080118338445, 5384.138537833947, 5163.66436181647, 5265.842024739264, 5268.1834315681135, 5286.709230992313, 5314.335708036496, 5190.92213616796, 5224.843254702365, 5255.60582956276, 5271.367435907678, 5296.761645725913, 5158.432572417031, 5166.199239117943, 5171.250168725552, 5179.482051794828, 5236.659617124913, 5559.916601250984, 5623.775048998035, 5729.598928075036, 5740.4833564978935, 5768.509676677488, 6147.815565533041, 6167.568270221086, 6213.87572248557, 6224.844378890519, 6229.314775374751, 6224.408681175281, 6237.345078766755, 6237.812865614039, 6246.6252024878195, 6274.749010039593, 5674.886502269931, 5747.827565173052, 5790.189373487715, 5820.2724659418, 5864.120381942743, 5234.26720259164, 6338.904916426257, 6341.112244285804, 6346.0, 6346.0, 6174.660393678301, 6176.629402235881, 6177.2587289525545, 6182.567220294536, 6186.443220110122, 6105.702364394958, 6147.323794382703, 6163.0, 6227.06594010902, 6228.937710622927, 6104.3590423005835, 6219.222597175353, 6228.719707613168, 6235.345288744707, 6236.002239641635, 6206.937930620727, 6213.65824879627, 6239.344868788802, 6249.843753906098, 6278.372162783777, 4934.185859333242, 4957.157283261854, 4960.70235785854, 4974.751262436864, 5023.14606516893, 3554.413521768931, 3567.0, 3809.104860357814, 4377.883639671863, 4424.911501769947, 5684.573656975744, 5781.277340332458, 5810.622309549865, 5823.767049318065, 5871.941280587225, 6064.605800622945, 6143.634700640286, 6218.657973811393, 6218.906716399258, 6237.812865613948, 4906.484819094015, 5868.647881127146, 5945.16767652529, 5960.195373624505, 5963.701814909237, 4521.84173553924, 4591.288350305708, 5449.155380915964, 5470.56235501159, 5541.307336582927, 6183.690815459299, 6293.433590976834, 6384.744610215632, 6411.230652321751, 6432.099506069154, 6209.565330426827, 6214.844628884314, 6223.471004964447, 6231.688415579293, 6251.656158911122, 5652.689102099424, 6426.678666066585, 6433.29233784274, 6435.742570297136, 6527.184101987062, 5304.541251155963, 6039.849003774941, 6209.0996805462055, 6227.408396202353, 6230.096635987847, 6021.54838387114, 6103.664298463449, 6183.659898705614, 6265.780697675559, 6266.060090986389, 6154.753809847556, 6163.8150855474405, 6166.599171054047, 6168.982117950667, 6169.2288463942, 5929.555283353852, 6116.571839971337, 6140.846478838065, 6157.230346206724, 6189.845253868509, 5903.173555702119, 5925.792597259076, 6011.90982135277, 6034.758609655564, 6094.14681944537, 6079.209702738615, 6090.817275481742, 6142.723577439116, 6149.292831324455, 6186.350433204449, 5844.3571207168025, 5942.732577033958, 5954.732037058429, 6018.9398106020135, 6051.848703782441], "value": 5682.42263627305, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.9320048592952, 528.3342987835327, 534.369444056014, 540.8242321245593, 572.1160806553873, 38487.422688659695, 39568.80215598925, 39578.2084358313, 39607.0, 39639.0, 40655.796721016355, 41169.7941510292, 41203.381949270784, 41275.79362103185, 41346.966325841866, 9574.329796914219, 9781.657641982532, 9790.412575245473, 9801.019898010214, 9813.509324533781, 8560.785980350478, 9726.9513652432, 9819.754506137333, 9865.0, 9897.307188496809, 9754.561044753003, 9860.457674827881, 9861.063198996084, 9890.901090989106, 9897.4556399398, 9808.901910980905, 9820.852687209626, 9834.409935403863, 9850.50747462631, 9878.802423951482, 9663.565139568736, 9671.323007389485, 9732.2214222862, 9750.609975600968, 9752.756865920806, 38687.8065609673, 38818.417723734165, 38825.611743882764, 39014.0, 39153.60846391528, 2672.8396296222095, 3304.2069903223055, 3523.4186359250693, 3527.417976033951, 3546.8935931922083, 29027.709722902713, 29079.56380654292, 30494.695053049407, 30918.0, 31405.842970785, 2923.6491621005403, 2950.4236992084975, 3033.9393212135856, 3041.756659467237, 3082.9383412331854, 391168.0, 460811.0, 470367.99999999657, 470609.0, 471044.64477677736, 49073.0, 59614.70192649009, 59700.0, 59761.0, 60030.69984650049, 33404.66595334064, 34741.305173896886, 34882.0, 61958.69020654868, 62152.68923655443, 15696.529104126894, 15862.682746345008, 15906.045637261801, 15957.44148954781, 15959.521214363587, 12026.398680065962, 12187.39063046844, 12220.694482638006, 12229.960453361564, 12234.449449774782, 18441.631167376847, 18508.537286567942, 18528.0, 18544.629107417775, 18550.350737724115, 8046.436749427484, 8142.3486121111355, 8215.890854734655, 8217.58912054395, 8220.506769593843, 884.4781578868499, 1004.7287232447198, 1028.2134167361974, 1032.7314898126542, 1065.9093977012042, 30036.948706795596, 30038.849805750833, 30287.394252114835, 30669.8466507666, 31003.844980774953, 1007.1791489935825, 1040.9219308551737, 1099.8845121262311, 1102.5644870276196, 1120.1878637987556, 14333.140011599337, 15069.869759768062, 15132.848671513364, 15139.481931372546, 15380.615484612974, 658940.0, 665648.0, 667445.0, 668921.0, 669039.0, 46916.5308346919, 53959.73020134874, 54453.910921781346, 54493.63765905884, 54652.0, 1355.390074466494, 1363.236587510997, 1405.901586888908, 1408.7745960646248, 1410.9435622575188, 23124.768752312935, 23177.768222318235, 27855.860720696266, 28929.62955598397, 29491.262718432212, 45160.0, 47399.28901066418, 47895.281570777166, 48097.27854082262, 48307.27539086846, 496087.0, 514856.425717869, 515293.0, 517044.4147779237, 518891.0, 20461.693074603594, 25207.621885672095, 25251.0, 25323.366915827253, 25326.366840829127, 36160.81919590385, 43825.78087109544, 44246.0, 44862.55137448584, 45626.54373456223, 36528.634713653584, 36750.63249367579, 36865.0, 37854.242915142095, 38022.42966355452, 36498.635013649524, 36645.0, 37550.87347379583, 37627.43558846565, 37779.05552361103, 36635.08412289714, 37136.81431592825, 37785.433218501195, 38637.0, 39862.60480883155, 33011.174720631214, 33867.4919876207, 34466.82766586151, 34544.0, 34692.0, 25556.488870222118, 25671.87164064168, 25706.0, 25919.352016199748, 26297.474050519264], "value": 19401.875309782587, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.9200371920037, 373.13805110195466, 379.3134426687695, 383.97120215983807, 400.8196311659754, 19273.132709028094, 20366.898165509152, 21502.569948601038, 21696.566068678618, 21831.781682183195, 10839.0, 11114.0, 11995.10036747243, 12343.5062597496, 19083.42749717507, 5186.611004174692, 5626.859328516799, 5646.745896434671, 5655.4061823508555, 5671.376148623648, 5487.945120548783, 5505.862353441156, 5555.50000499955, 5562.0, 5573.164025396182, 5385.865353366158, 5504.724763761816, 5520.696361700105, 5560.304961879765, 5561.860953476175, 5542.2517960075475, 5908.67502287374, 6077.237601095677, 6148.477379422754, 6159.045347971071, 4619.607333376667, 5294.391145018295, 5347.812826551052, 5374.140137578008, 5438.809641662562, 13523.864761352359, 13870.791938120836, 23371.641783609568, 23802.047918083255, 24960.5007899841, 2030.3908827351736, 2277.7836105569945, 2413.4207790130417, 2656.0, 3027.0, 8311.750647480525, 10268.28122031458, 10381.169506439466, 10384.480775961172, 10396.0, 1800.5138612574663, 1875.1936667233085, 1941.4466876940146, 1943.6112777444425, 1958.5886963737632, 107370.0, 119418.40290798577, 121953.0, 122021.38989305086, 124703.41207349172, 11377.943110284561, 11404.0, 11636.709082272842, 11819.409029548488, 12111.394430278451, 11618.302901825917, 12046.518139274505, 13811.033227673966, 14554.0, 14570.781438278435, 6496.545241833026, 6822.249552549216, 7782.377409807202, 7811.296983271533, 7891.723789667334, 7327.413806895435, 7419.703211871572, 7485.401167906554, 7554.320111190019, 7598.430117741192, 4523.7285762854335, 4525.072360166158, 4534.36518887356, 4574.519675434098, 4655.953440465552, 1628.3974929276244, 1949.0, 1961.264525802824, 1997.5605366819277, 1998.8700734452505, 833.5790425834914, 839.6607411179159, 882.7075010211945, 932.9067093290753, 939.5161491831713, 18184.181711823, 20110.296139635044, 21650.783492165192, 21874.671879921814, 21890.562188756136, 883.8598208311206, 891.3225948279224, 915.514777168102, 925.726910561386, 942.0297093993198, 10901.01890829829, 11413.885861141449, 11515.424228788695, 11534.192606517463, 11564.710882228012, 454415.0, 459852.0, 460282.0, 565911.0, 571834.0, 115530.0, 126333.99999999817, 129106.0, 137692.0, 145174.0, 962.8748262725801, 983.3067687280593, 1014.1075853249093, 1014.4775440648073, 1017.6692574913183, 18011.639767204844, 19223.711644325627, 19668.803311966698, 19743.21027158955, 20006.89996550008, 38552.42171367376, 48250.0, 49890.501094988584, 55479.44520554904, 56265.43734562766, 76686.2331376679, 76785.464290715, 77720.61139694265, 77725.0, 78087.6095619541, 6848.863022739617, 7764.92235077642, 8267.793305167419, 8358.498490090615, 8381.95809020951, 9914.206863450763, 13032.934835325763, 13187.274699891213, 13480.86519134796, 13519.526816561372, 11004.229703920648, 11229.438528073728, 11233.213675042669, 11520.769584608428, 11597.59408420735, 10983.286086404358, 11118.61084862026, 11186.384748838893, 11196.216264861381, 11382.487788049391, 10554.419506927192, 10682.732931676459, 11302.0, 11665.125115616192, 11783.410829458322, 6913.274106218774, 8011.256473969432, 8200.42597018203, 8241.57756808189, 8380.958095209486, 10747.677569672922, 11255.549778008788, 11307.491162897853, 11421.486033128695, 11465.14011449128], "value": 9221.868294458849, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1523.740964036114, 1553.603831023089, 1730.351118330626, 1848.713449415341, 1864.6084322292309, 6590.308017658149, 7974.760757177287, 8001.8799718004275, 8584.313254939605, 8903.866442003375, 8666.176713212235, 8739.91260087399, 8748.125187481248, 8765.123487651232, 8768.605412756426, 2162.7296587926508, 2233.7877901599404, 2344.6834677318557, 2371.27676058802, 2376.7147942246957, 2019.0005947056227, 2303.28598134578, 2364.2788949370433, 2384.2966324934187, 2391.7249516305587, 2002.3392280547384, 2316.7104111986, 2351.47091904321, 2380.880955952204, 2390.4143484846236, 2342.6837376954063, 2355.4464700795297, 2358.716953965518, 2362.9763702363016, 2364.7871691547757, 2342.426105604121, 2344.10923848938, 2350.4476448034698, 2351.7413084560685, 2351.905923763047, 8701.7824554386, 8871.955640221757, 8876.201141897196, 8885.111488851127, 8886.822263554757, 5224.294720212761, 5358.115910874701, 5395.649282796606, 5406.459354064601, 5426.728663566806, 2872.8563571821323, 2997.8158627342295, 3437.7937323760652, 3597.964020359789, 3623.5832879218965, 864.3128712673376, 898.5731777405746, 929.2101713543501, 1093.7593729379603, 1098.0995583621434, 11512.366819824907, 11635.94182029093, 11683.240589361749, 11690.47392867323, 11717.17979741427, 4611.631069514431, 4675.275332323427, 4768.427788665383, 4829.2997515360075, 4830.9275360869615, 9774.218062554979, 9847.655332063343, 9847.803043939224, 9864.605415783288, 9897.554610042565, 5324.733763311819, 5345.839624811262, 5352.759125839269, 5357.7589008494715, 5365.678059316453, 3892.4745159403683, 4087.202995415865, 4401.625861801783, 4908.312836202863, 4978.178600530944, 3164.920876978048, 3205.406999705062, 3890.8832735017995, 3976.165005348851, 4089.1208390195657, 1293.1077556485996, 1296.4554886947317, 1305.1516514265613, 1306.1248963194682, 1315.967100822468, 792.7185849023629, 837.677494164751, 849.1338834389012, 874.8250349930039, 971.8347880860271, 5455.208994695747, 5837.9124313135335, 5979.282486101695, 6016.639001659827, 6250.124982502453, 426.86767102198417, 431.5662758927258, 444.7153821554208, 455.4352602772538, 456.9991718137335, 3352.96058221952, 3965.88102356924, 4042.333015052542, 4104.979475102665, 4138.668906487474, 10171.237157213238, 10425.530851111718, 10584.153267738562, 10652.360858348524, 10707.892921070845, 10662.253642245123, 10667.359958402521, 10675.039246467855, 10678.359298442118, 10702.411367374869, 7817.491863028885, 8052.718154864551, 8182.959085204536, 8276.668933242723, 8281.006279246409, 5954.19618351517, 6012.909806352821, 6067.332593414809, 6146.846328841814, 6147.631142131487, 9424.104710052534, 9933.950330248303, 10076.949615251877, 10136.797264054825, 10152.441615711206, 8059.3552515799765, 10214.591416343263, 10218.591256349662, 10231.232657550565, 10241.385516869012, 7009.754658587129, 7366.926330736624, 7544.396448284234, 7565.659545320584, 7674.2325767425045, 8454.281386082006, 8467.53428561435, 8538.829223415372, 8550.74347769568, 8564.486130831921, 7480.513766605153, 7553.471257011956, 7614.048243969504, 7664.048266180872, 7745.419093568117, 6603.603783772989, 7329.267073292628, 7341.70633174667, 7486.43851711113, 7550.7734767957045, 6981.895271571032, 6995.755148569776, 7056.0, 7057.788266352018, 7067.469939754436, 4979.825706100269, 5013.699178049329, 5035.773390197523, 5158.0, 5180.300659411082, 4257.8509752158525, 4922.062350119962, 5119.872003199801, 5214.0, 5258.263843062051], "value": 4452.625936220623, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.1686401595413, 302.06811985026195, 307.84453850805346, 309.5202436223854, 309.84817439454673, 4795.68828026178, 5210.879660872912, 5290.180022096576, 5568.331800183979, 5679.148127780835, 4226.725262857912, 4556.954430455695, 4720.504347043562, 5294.364676238857, 5561.499465048145, 3931.783751893645, 3971.642552170304, 4000.3996403237174, 4097.774622395767, 4186.555638304795, 3639.6178401267885, 4154.459920210384, 4156.854510092147, 4172.207280616688, 4175.4363160973335, 3633.273345330931, 4149.091417947732, 4175.331946888498, 4205.600467955539, 4212.178625168093, 3692.5568931728367, 4031.2743706132737, 4065.146319272956, 4142.772147531915, 4198.097409057053, 2990.7158819912074, 3079.969200307991, 3233.4503134467195, 3584.390653588896, 3596.406592912166, 3999.6400323970693, 5358.410574836765, 5384.434634363413, 5420.647657902224, 5424.077906755861, 4178.874633760992, 4468.93296600548, 4476.731396116211, 4819.481863213076, 4838.782254798507, 4812.831550895737, 5686.5735069869925, 5815.447532484407, 5835.387284335126, 5911.261092363455, 3854.8242785950274, 3880.941785873186, 3884.436756670267, 3904.3752999520225, 3904.941425878614, 5146.871328216787, 5391.838244852661, 5640.210370548127, 6161.599496032743, 6206.038064100072, 3904.4338570907626, 3935.976646072042, 3969.047428617111, 3969.7419667721506, 3990.0, 4033.7378070425916, 4039.313316736162, 4057.89855253621, 4063.090347536653, 4081.3061779497557, 4758.42898852133, 4775.976120119377, 4785.511534002299, 4796.184648609745, 4796.424429068534, 5320.0, 5662.348829884616, 5924.318703349084, 5949.345571987078, 5967.343592204854, 1275.2922128218743, 1346.5354452713798, 1377.4627895120911, 1377.5260471295817, 1380.4340220509544, 699.8033362949413, 738.5162718419336, 743.598456833304, 784.9332806711379, 843.3632607381388, 4448.621867141264, 5293.497117773805, 5492.588055895823, 5494.203340515603, 5646.6047376684055, 5254.579633629301, 5277.762500687479, 5347.732613369394, 6103.443621876482, 6161.151654503631, 4292.377605247221, 5470.522958801102, 5522.895420915833, 5526.751296191681, 5550.306211723535, 2990.925226869346, 3110.548970399325, 3171.7313074769813, 3193.6746250305864, 3290.8683652653626, 5313.256144139824, 5558.666480011212, 5706.002898985322, 6234.9688251558455, 6352.936470635327, 5707.885842283131, 5847.561432892465, 5965.463108320272, 6199.690015499207, 6271.43557079865, 5805.535557155333, 6347.71435285404, 6407.839804004844, 6415.807525774234, 6451.677416129269, 5333.8265581571995, 5512.629569285245, 5924.940750592611, 6053.515718742578, 6113.938860611337, 5706.942930570807, 6010.0, 6026.668533230714, 6028.558433834304, 6033.42682445167, 5677.261955945701, 6269.341719119427, 6313.842153946188, 6343.429091381798, 6354.332795056637, 3764.981175094107, 3887.572367039567, 4011.097503061788, 4056.5537790842395, 4108.6918481114635, 5286.255535673142, 5570.913671834115, 6050.9394906050375, 6071.666058366833, 6084.6349219047, 4854.563089321978, 5084.47465760263, 5690.687012214368, 5756.539476841926, 5868.2958045033165, 4776.761161941959, 5537.833864984057, 5725.942740572541, 5749.338826034892, 5780.826575202751, 5697.487226149667, 5736.569757268138, 5754.9424505754405, 5767.625104368202, 5777.931082749705, 5042.344495215599, 5130.948690513196, 5586.960759322899, 5649.051077378298, 5661.688607126647, 5062.873428164326, 5759.7665715698095, 5781.21953536284, 5796.420357964338, 5796.681182535001], "value": 4194.254390871439, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.2206297285823, 649.912261844651, 778.552332408865, 780.8438312337533, 805.2028491793122, 13310.667233319147, 15340.53978380649, 16048.27782749776, 16093.436729714462, 16126.838731612681, 14533.636659083528, 14658.0, 14683.33924973376, 14689.779653305182, 14708.338124784384, 670.4803777072759, 818.8648872935959, 822.198356602314, 843.4011851585382, 846.6571038729325, 845.2055068235869, 849.1254008371387, 849.2569002123142, 849.8215374771305, 859.4499520307008, 904.041715781274, 909.6543313540845, 909.6770646420524, 909.7361765088117, 911.694582314922, 687.22000529399, 769.9961500192519, 885.6103314541581, 902.9367944243905, 905.1943770044666, 655.3184687924553, 664.9035889796, 669.5112567825514, 672.3612568060313, 672.579637726421, 15189.088654680643, 15201.0, 15202.46791362297, 15244.847551524454, 15291.464798732102, 14687.412503499847, 14795.55613331591, 14833.0, 14883.851161488463, 14959.775603365959, 11173.033573081602, 11936.58221962227, 12157.148999570034, 12256.203346782431, 12401.317927513983, 3667.669909708139, 3822.9617703822883, 3996.6003399660094, 4032.4556184914954, 4034.4553485279407, 108045.0, 109739.0, 110522.26344155912, 110642.3403648946, 111003.0, 10944.616938407118, 11384.487698053608, 11393.772124557463, 11488.94255528717, 11883.940580297043, 23389.649155262345, 23427.531449370916, 23465.8267086645, 23509.41226469352, 23542.0, 7814.765557033298, 8133.877991830127, 8181.222783835645, 8200.384971127189, 8260.380471464665, 4403.647708183337, 4477.395551600493, 4498.2577874650315, 4537.523560026216, 4635.049814787961, 3632.8728494502566, 3698.093966978108, 3719.75821571597, 3746.550413950343, 3752.981235093807, 561.5956511311849, 649.2857856358063, 652.3085529338916, 662.2516556291456, 675.2774531251612, 529.1639210048115, 553.5690240727764, 604.7188057553259, 612.2672835874465, 635.3011687144104, 6924.723011079501, 7855.0570349770915, 8421.873671894926, 9407.952960235156, 9433.433993960385, 538.0959987221505, 561.8174093419655, 590.4892268187987, 607.3471018654964, 632.5888172687697, 3844.3464611016193, 4419.447569053868, 4610.907781844345, 4639.86080417588, 4694.225452800318, 101664.0, 116129.0, 118293.0, 130489.0, 142377.0, 126242.0, 127480.0, 129904.40191196123, 130207.0, 132227.0, 97776.02223977669, 102431.0, 115869.0, 117381.0, 117783.0, 9974.800503989734, 10015.39907605546, 10111.118331275551, 10114.241431892491, 10133.797324053625, 45423.54576454193, 55317.0, 61929.69035154796, 63742.0, 64799.02801458076, 92557.0, 95142.0, 96804.51597741967, 98439.50780246053, 101343.0, 12891.419886105336, 13184.868151318364, 13189.868101318863, 13390.799138012742, 13774.931125344308, 15124.54626361211, 15140.015898966532, 15206.16366099875, 15219.315130819361, 15241.3903443861, 13878.306084695927, 13937.930310348384, 13954.0, 14076.859231407554, 14118.929405352908, 12183.147179697691, 13847.30763461843, 14029.438822446988, 14324.212168330425, 14641.560753177422, 13211.405486753312, 13703.0, 13951.023428360324, 14316.355763990854, 14425.990180687251, 11232.887671123184, 11416.828747568627, 11503.194776365573, 11619.883801161881, 11711.531538738696, 9902.603895844086, 11576.536938522364, 11858.288502689866, 11861.229020113666, 11949.76100478003], "value": 7814.69823466473, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 110.0, 120.0, 116.0, 116.0, 120.0, 115.0, 118.0, 117.0], "value": 115.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 129.0, 134.0, 159.0, 110.0, 134.0, 128.0, 111.0, 157.0, 111.0], "value": 131.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 200.0, 203.0, 212.0, 215.0, 194.0, 195.0, 201.0, 197.0, 200.0], "value": 201.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 82.0, 77.0, 142.0, 60.0, 59.0, 68.0, 64.0, 148.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 129.0, 72.0, 71.0, 87.0, 114.0, 70.0, 73.0, 115.0], "value": 87.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 89.0, 88.0, 90.0, 86.0, 91.0, 87.0, 90.0, 85.0], "value": 88.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 115.0, 96.0, 96.0, 111.0, 90.0, 135.0, 101.0, 106.0, 115.0], "value": 109.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 110.0, 99.0, 91.0, 100.0, 92.0, 137.0, 116.0, 98.0], "value": 102.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 58.0, 58.0, 56.0, 61.0, 56.0, 54.0, 58.0, 58.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 73.0, 66.0, 77.0, 73.0, 73.0, 74.0, 72.0, 70.0, 70.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 108.0, 83.0, 87.0, 88.0, 109.0, 76.0, 98.0, 113.0, 109.0], "value": 97.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 140.0, 150.0, 151.0, 140.0, 151.0, 157.0, 139.0, 150.0, 150.0], "value": 146.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 175.0, 172.0, 166.0, 170.0, 172.0, 171.0, 169.0, 174.0, 173.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 69.0, 67.0, 71.0, 67.0, 68.0, 67.0, 70.0, 66.0], "value": 68.5, "unit": "score"}]}]} 18:18:39 INFO - Return code: 0 18:18:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:18:39 ERROR - # TBPL SUCCESS # 18:18:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:18:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:18:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:18:39 INFO - 2016-08-16 18:18:39.757 screenresolution[1667:11050] starting screenresolution argv=screenresolution get 18:18:39 INFO - 2016-08-16 18:18:39.760 screenresolution[1667:11050] Display 0: 1600x1200x32@60 18:18:39 INFO - 2016-08-16 18:18:39.766 screenresolution[1668:11053] starting screenresolution argv=screenresolution list 18:18:39 INFO - Available Modes on Display 0 18:18:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:18:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:18:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:18:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:18:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:18:39 INFO - Intel Iris: 18:18:39 INFO - Chipset Model: Intel Iris 18:18:39 INFO - Type: GPU 18:18:39 INFO - Bus: Built-In 18:18:39 INFO - VRAM (Dynamic, Max): 1536 MB 18:18:39 INFO - Vendor: Intel (0x8086) 18:18:39 INFO - Device ID: 0x0a2e 18:18:39 INFO - Revision ID: 0x0009 18:18:39 INFO - Displays: 18:18:39 INFO - Display: 18:18:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:18:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:18:39 INFO - Display Serial Number: 1600x1200 60 18:18:39 INFO - Main Display: Yes 18:18:39 INFO - Mirror: Off 18:18:39 INFO - Online: Yes 18:18:39 INFO - Rotation: Supported 18:18:40 INFO - Return code: 0 18:18:40 INFO - Running post-action listener: _resource_record_post_action 18:18:40 INFO - [mozharness: 2016-08-17 01:18:40.000435Z] Finished run-tests step (success) 18:18:40 INFO - Running post-run listener: _resource_record_post_run 18:18:40 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 31861760; Write bytes: 705758720; Read time: 198; Write time: 2016 18:18:40 INFO - TinderboxPrint: CPU usage
54.3% 18:18:40 INFO - TinderboxPrint: I/O read bytes / time
31,861,760 / 198 18:18:40 INFO - TinderboxPrint: I/O write bytes / time
705,758,720 / 2,016 18:18:40 INFO - TinderboxPrint: CPU idle
2,206.9 (45.7%) 18:18:40 INFO - TinderboxPrint: CPU system
978.9 (20.3%) 18:18:40 INFO - TinderboxPrint: CPU user
1,647.9 (34.1%) 18:18:40 INFO - TinderboxPrint: Swap in / out
432,525,312 / 0 18:18:40 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 402563584; Write bytes: 397489664; Read time: 29824; Write time: 848 18:18:40 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 29076480; Write bytes: 296366080; Read time: 173; Write time: 1134 18:18:40 INFO - Running post-run listener: _upload_blobber_files 18:18:40 INFO - Blob upload gear active. 18:18:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:18:40 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 18:18:40 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:18:40 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:18:41 INFO - (blobuploader) - INFO - Open directory for files ... 18:18:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:18:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:18:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:18:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:18:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:18:41 INFO - (blobuploader) - INFO - Done attempting. 18:18:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:18:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:18:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:18:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:18:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:18:48 INFO - (blobuploader) - INFO - Done attempting. 18:18:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:18:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:18:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:18:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:18:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:18:51 INFO - (blobuploader) - INFO - Done attempting. 18:18:51 INFO - (blobuploader) - INFO - Iteration through files over. 18:18:51 INFO - Return code: 0 18:18:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:18:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:18:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f8c859a1fd145db16d96f05c58a78b311e8c0c019367ee8671d05da7d3542af84fedc65b96f3ca0096e77d671453857d6a3ea2825625d39e0971393a25dae3ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f4411c5f4ac9cbaaa4a5ffedb6021bd3eb3390972af7b64a0890adc0fc01a74b7bfb95b0462428f7bcf5e566b77604600da658561db51e31341cf02d483c158", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dc132f292376e84dd00408ba6768c29241bc007b859cfb80678a5fe42d1e83567a2c5c2c35d9965713a3aded2f789b5df5aef1b50b5774590e1047f57287ed3e"} 18:18:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:18:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:18:51 INFO - Contents: 18:18:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f8c859a1fd145db16d96f05c58a78b311e8c0c019367ee8671d05da7d3542af84fedc65b96f3ca0096e77d671453857d6a3ea2825625d39e0971393a25dae3ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f4411c5f4ac9cbaaa4a5ffedb6021bd3eb3390972af7b64a0890adc0fc01a74b7bfb95b0462428f7bcf5e566b77604600da658561db51e31341cf02d483c158", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dc132f292376e84dd00408ba6768c29241bc007b859cfb80678a5fe42d1e83567a2c5c2c35d9965713a3aded2f789b5df5aef1b50b5774590e1047f57287ed3e"} 18:18:51 INFO - Running post-run listener: copy_logs_to_upload_dir 18:18:51 INFO - Copying logs to upload dir... 18:18:51 INFO - mkdir: /builds/slave/test/build/upload/logs 18:18:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.029955 ========= master_lag: 0.19 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-08-16 18:18:51.910569) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 18:18:51.914457) ========= 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.ONUgF9ri2R/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.IjUGrCA7cH/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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/Fx-Team/sha512/f8c859a1fd145db16d96f05c58a78b311e8c0c019367ee8671d05da7d3542af84fedc65b96f3ca0096e77d671453857d6a3ea2825625d39e0971393a25dae3ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f4411c5f4ac9cbaaa4a5ffedb6021bd3eb3390972af7b64a0890adc0fc01a74b7bfb95b0462428f7bcf5e566b77604600da658561db51e31341cf02d483c158", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dc132f292376e84dd00408ba6768c29241bc007b859cfb80678a5fe42d1e83567a2c5c2c35d9965713a3aded2f789b5df5aef1b50b5774590e1047f57287ed3e"} build_url:https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011159 build_url: 'https://queue.taskcluster.net/v1/task/J-2KD6-5RmCPTVZ4hQrcZQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f8c859a1fd145db16d96f05c58a78b311e8c0c019367ee8671d05da7d3542af84fedc65b96f3ca0096e77d671453857d6a3ea2825625d39e0971393a25dae3ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f4411c5f4ac9cbaaa4a5ffedb6021bd3eb3390972af7b64a0890adc0fc01a74b7bfb95b0462428f7bcf5e566b77604600da658561db51e31341cf02d483c158", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dc132f292376e84dd00408ba6768c29241bc007b859cfb80678a5fe42d1e83567a2c5c2c35d9965713a3aded2f789b5df5aef1b50b5774590e1047f57287ed3e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 18:18:51.948023) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 18:18:51.948370) ========= 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.ONUgF9ri2R/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.IjUGrCA7cH/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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.005138 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 18:18:51.997001) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 18:18:51.997372) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 18:18:51.997730) ========= ========= Total master_lag: 0.51 =========