builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0382 starttime: 1471309479.42 results: success (0) buildid: 20160815144333 builduid: 28afb5a3c2634df6bde9d75e4932fae5 revision: 794db78767b9f9ec7714c74cd3ae38b561196b6d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 18:04:39.423895) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 18:04:39.424286) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 18:04:39.424573) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 18:04:39.460082) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 18:04:39.460344) ========= 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.vxjFhjkf9E/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.clzN5gpKiq/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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-15 18:04:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.04M=0.001s 2016-08-15 18:04:40 (8.04 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.739529 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 18:04:40.221596) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 18:04:40.221902) ========= 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.vxjFhjkf9E/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.clzN5gpKiq/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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.020652 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 18:04:40.270228) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-15 18:04:40.270585) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 794db78767b9f9ec7714c74cd3ae38b561196b6d --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 794db78767b9f9ec7714c74cd3ae38b561196b6d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vxjFhjkf9E/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.clzN5gpKiq/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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-15 18:04:40,356 truncating revision to first 12 chars 2016-08-15 18:04:40,356 Setting DEBUG logging. 2016-08-15 18:04:40,356 attempt 1/10 2016-08-15 18:04:40,356 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/794db78767b9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-15 18:04:40,974 unpacking tar archive at: fx-team-794db78767b9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.893951 ========= master_lag: 0.71 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-15 18:04:41.879025) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 18:04:41.879326) ========= script_repo_revision: 794db78767b9f9ec7714c74cd3ae38b561196b6d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 18:04:41.879711) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 18:04:41.879972) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 18:04:41.900050) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-08-15 18:04:41.900345) ========= /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.vxjFhjkf9E/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.clzN5gpKiq/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 18:04:42 INFO - MultiFileLogger online at 20160815 18:04:42 in /builds/slave/test 18:04:42 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 18:04:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:04:42 INFO - {'append_to_log': False, 18:04:42 INFO - 'base_work_dir': '/builds/slave/test', 18:04:42 INFO - 'blob_upload_branch': 'Fx-Team', 18:04:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:04:42 INFO - 'branch': 'Fx-Team', 18:04:42 INFO - 'buildbot_json_path': 'buildprops.json', 18:04:42 INFO - 'config_files': ('talos/mac_config.py',), 18:04:42 INFO - 'default_actions': ('clobber', 18:04:42 INFO - 'read-buildbot-config', 18:04:42 INFO - 'download-and-extract', 18:04:42 INFO - 'populate-webroot', 18:04:42 INFO - 'create-virtualenv', 18:04:42 INFO - 'install', 18:04:42 INFO - 'run-tests'), 18:04:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:04:42 INFO - 'download_minidump_stackwalk': True, 18:04:42 INFO - 'download_symbols': 'ondemand', 18:04:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:04:42 INFO - 'tooltool.py': '/tools/tooltool.py', 18:04:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:04:42 INFO - '/tools/misc-python/virtualenv.py')}, 18:04:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:04:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:04:42 INFO - 'installer_path': 'installer.exe', 18:04:42 INFO - 'log_level': 'info', 18:04:42 INFO - 'log_name': 'talos', 18:04:42 INFO - 'log_to_console': True, 18:04:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:04:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:04:42 INFO - 'opt_config_files': (), 18:04:42 INFO - 'pip_index': False, 18:04:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:04:42 INFO - 'cmd': ('bash', 18:04:42 INFO - '-c', 18:04:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:04:42 INFO - 'enabled': True, 18:04:42 INFO - 'halt_on_failure': False, 18:04:42 INFO - 'name': 'check_screen_resolution'},), 18:04:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:04:42 INFO - 'cmd': ('bash', 18:04:42 INFO - '-c', 18:04:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:04:42 INFO - 'enabled': True, 18:04:42 INFO - 'halt_on_failure': False, 18:04:42 INFO - 'name': 'check_screen_resolution'},), 18:04:42 INFO - 'run_cmd_checks_enabled': True, 18:04:42 INFO - 'sps_profile': False, 18:04:42 INFO - 'sps_profile_interval': 0, 18:04:42 INFO - 'suite': 'dromaeojs-e10s', 18:04:42 INFO - 'system_bits': '32', 18:04:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:04:42 INFO - 'title': 't-yosemite-r7-0382', 18:04:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:04:42 INFO - 'use_talos_json': True, 18:04:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:04:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:04:42 INFO - 'work_dir': 'build'} 18:04:42 INFO - [mozharness: 2016-08-16 01:04:42.099953Z] Running clobber step. 18:04:42 INFO - Running pre-action listener: _resource_record_pre_action 18:04:42 INFO - Running main action method: clobber 18:04:42 INFO - rmtree: /builds/slave/test/build 18:04:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:04:43 INFO - Running post-action listener: _resource_record_post_action 18:04:43 INFO - [mozharness: 2016-08-16 01:04:43.628621Z] Finished clobber step (success) 18:04:43 INFO - [mozharness: 2016-08-16 01:04:43.628709Z] Running read-buildbot-config step. 18:04:43 INFO - Running pre-action listener: _resource_record_pre_action 18:04:43 INFO - Running main action method: read_buildbot_config 18:04:43 INFO - Using buildbot properties: 18:04:43 INFO - { 18:04:43 INFO - "project": "", 18:04:43 INFO - "product": "firefox", 18:04:43 INFO - "script_repo_revision": "production", 18:04:43 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 18:04:43 INFO - "repository": "", 18:04:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 18:04:43 INFO - "buildid": "20160815144333", 18:04:43 INFO - "pgo_build": "False", 18:04:43 INFO - "basedir": "/builds/slave/test", 18:04:43 INFO - "buildnumber": 9, 18:04:43 INFO - "slavename": "t-yosemite-r7-0382", 18:04:43 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 18:04:43 INFO - "platform": "yosemite_r7", 18:04:43 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 18:04:43 INFO - "branch": "fx-team", 18:04:43 INFO - "repo_path": "integration/fx-team", 18:04:43 INFO - "revision": "794db78767b9f9ec7714c74cd3ae38b561196b6d", 18:04:43 INFO - "stage_platform": "macosx64", 18:04:43 INFO - "builduid": "28afb5a3c2634df6bde9d75e4932fae5", 18:04:43 INFO - "slavebuilddir": "test" 18:04:43 INFO - } 18:04:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/GQK2wVtsQEySu7dndY03lA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 18:04:43 INFO - Running post-action listener: _resource_record_post_action 18:04:43 INFO - [mozharness: 2016-08-16 01:04:43.634557Z] Finished read-buildbot-config step (success) 18:04:43 INFO - [mozharness: 2016-08-16 01:04:43.634784Z] Running download-and-extract step. 18:04:43 INFO - Running pre-action listener: _resource_record_pre_action 18:04:43 INFO - Running main action method: download_and_extract 18:04:43 INFO - mkdir: /builds/slave/test/build/tests 18:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:04:43 INFO - trying https://queue.taskcluster.net/v1/task/GQK2wVtsQEySu7dndY03lA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 18:04:43 INFO - Downloading https://queue.taskcluster.net/v1/task/GQK2wVtsQEySu7dndY03lA/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 18:04:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GQK2wVtsQEySu7dndY03lA/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 18:04:44 INFO - Downloaded 1199 bytes. 18:04:44 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 18:04:44 INFO - Using the following test package requirements: 18:04:44 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 18:04:44 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:04:44 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 18:04:44 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:04:44 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 18:04:44 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:04:44 INFO - u'jsshell-mac.zip'], 18:04:44 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:04:44 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 18:04:44 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 18:04:44 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:04:44 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 18:04:44 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:04:44 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 18:04:44 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:04:44 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 18:04:44 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 18:04:44 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 18:04:44 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:04:44 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')]} 18:04:44 INFO - trying https://queue.taskcluster.net/v1/task/GQK2wVtsQEySu7dndY03lA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 18:04:44 INFO - Downloading https://queue.taskcluster.net/v1/task/GQK2wVtsQEySu7dndY03lA/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 18:04:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GQK2wVtsQEySu7dndY03lA/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 18:04:45 INFO - Downloaded 16330419 bytes. 18:04:45 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 18:04:52 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 18:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:04:52 INFO - trying https://queue.taskcluster.net/v1/task/GQK2wVtsQEySu7dndY03lA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 18:04:52 INFO - Downloading https://queue.taskcluster.net/v1/task/GQK2wVtsQEySu7dndY03lA/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 18:04:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GQK2wVtsQEySu7dndY03lA/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 18:04:53 INFO - Downloaded 16330419 bytes. 18:04:53 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 18:04:59 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')]} 18:04:59 INFO - trying https://queue.taskcluster.net/v1/task/GQK2wVtsQEySu7dndY03lA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 18:04:59 INFO - Downloading https://queue.taskcluster.net/v1/task/GQK2wVtsQEySu7dndY03lA/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 18:04:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GQK2wVtsQEySu7dndY03lA/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 18:05:00 INFO - Downloaded 14413719 bytes. 18:05:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 18:05:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:00 INFO - trying https://queue.taskcluster.net/v1/task/GQK2wVtsQEySu7dndY03lA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 18:05:00 INFO - Downloading https://queue.taskcluster.net/v1/task/GQK2wVtsQEySu7dndY03lA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 18:05:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GQK2wVtsQEySu7dndY03lA/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 18:05:03 INFO - Downloaded 111048679 bytes. 18:05:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GQK2wVtsQEySu7dndY03lA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 18:05:03 INFO - mkdir: /builds/slave/test/properties 18:05:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:05:03 INFO - Writing to file /builds/slave/test/properties/build_url 18:05:03 INFO - Contents: 18:05:03 INFO - build_url:https://queue.taskcluster.net/v1/task/GQK2wVtsQEySu7dndY03lA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 18:05:04 INFO - Running post-action listener: _resource_record_post_action 18:05:04 INFO - Running post-action listener: set_extra_try_arguments 18:05:04 INFO - [mozharness: 2016-08-16 01:05:04.289229Z] Finished download-and-extract step (success) 18:05:04 INFO - [mozharness: 2016-08-16 01:05:04.289352Z] Running populate-webroot step. 18:05:04 INFO - Running pre-action listener: _resource_record_pre_action 18:05:04 INFO - Running main action method: populate_webroot 18:05:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:05:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:05:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:05:04 INFO - '--tppagecycles', 18:05:04 INFO - '7'], 18:05:04 INFO - 'tests': ['tsvgm']}}, 18:05:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:05:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:05:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:05:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:05:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:05:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:05:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:05:04 INFO - 'talos_options': ['--disable-e10s'], 18:05:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:05:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:05:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:05:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:05:04 INFO - 'talos_options': ['--disable-e10s'], 18:05:04 INFO - 'tests': ['damp', 'tps']}, 18:05:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:05:04 INFO - 'tests': ['damp', 'tps']}, 18:05:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:05:04 INFO - 'tests': ['dromaeo_dom']}, 18:05:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:05:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:05:04 INFO - 'tests': ['basic_compositor_video']}, 18:05:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:05:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:05:04 INFO - 'tests': ['a11yr', 18:05:04 INFO - 'ts_paint', 18:05:04 INFO - 'tpaint', 18:05:04 INFO - 'sessionrestore', 18:05:04 INFO - 'sessionrestore_no_auto_restore', 18:05:04 INFO - 'tabpaint']}, 18:05:04 INFO - 'other-e10s': {'tests': ['a11yr', 18:05:04 INFO - 'ts_paint', 18:05:04 INFO - 'tpaint', 18:05:04 INFO - 'sessionrestore', 18:05:04 INFO - 'sessionrestore_no_auto_restore', 18:05:04 INFO - 'tabpaint']}, 18:05:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:05:04 INFO - 'ts_paint', 18:05:04 INFO - 'tpaint', 18:05:04 INFO - 'sessionrestore', 18:05:04 INFO - 'sessionrestore_no_auto_restore', 18:05:04 INFO - 'tabpaint']}, 18:05:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:05:04 INFO - 'ts_paint', 18:05:04 INFO - 'tpaint', 18:05:04 INFO - 'sessionrestore', 18:05:04 INFO - 'sessionrestore_no_auto_restore', 18:05:04 INFO - 'tabpaint']}, 18:05:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:05:04 INFO - 'tests': ['a11yr', 18:05:04 INFO - 'ts_paint', 18:05:04 INFO - 'tpaint', 18:05:04 INFO - 'sessionrestore', 18:05:04 INFO - 'sessionrestore_no_auto_restore', 18:05:04 INFO - 'tabpaint']}, 18:05:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:05:04 INFO - 'tests': ['a11yr', 18:05:04 INFO - 'ts_paint', 18:05:04 INFO - 'tpaint', 18:05:04 INFO - 'sessionrestore', 18:05:04 INFO - 'sessionrestore_no_auto_restore', 18:05:04 INFO - 'tabpaint']}, 18:05:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:05:04 INFO - 'tests': ['tsvgx', 18:05:04 INFO - 'tsvgr_opacity', 18:05:04 INFO - 'tart', 18:05:04 INFO - 'tscrollx', 18:05:04 INFO - 'cart']}, 18:05:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:05:04 INFO - 'tsvgr_opacity', 18:05:04 INFO - 'tart', 18:05:04 INFO - 'tscrollx', 18:05:04 INFO - 'cart']}, 18:05:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:05:04 INFO - 'talos_options': ['--disable-e10s'], 18:05:04 INFO - 'tests': ['tp5o']}, 18:05:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:05:04 INFO - 'tests': ['tp5o']}, 18:05:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:05:04 INFO - 'talos_options': ['--disable-e10s', 18:05:04 INFO - '--xperf_path', 18:05:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:05:04 INFO - 'tests': ['tp5n']}, 18:05:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:05:04 INFO - 'talos_options': ['--xperf_path', 18:05:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:05:04 INFO - 'tests': ['tp5n']}}, 18:05:04 INFO - 'talos.zip': {'path': '', 18:05:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:05:04 INFO - Running post-action listener: _resource_record_post_action 18:05:04 INFO - [mozharness: 2016-08-16 01:05:04.308428Z] Finished populate-webroot step (success) 18:05:04 INFO - [mozharness: 2016-08-16 01:05:04.308559Z] Running create-virtualenv step. 18:05:04 INFO - Running pre-action listener: _resource_record_pre_action 18:05:04 INFO - Running main action method: create_virtualenv 18:05:04 INFO - Creating virtualenv /builds/slave/test/build/venv 18:05:04 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 18:05:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:05:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:05:04 INFO - Using real prefix '/tools/python27' 18:05:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:05:05 INFO - Installing distribute.............................................................................................................................................................................................done. 18:05:08 INFO - Installing pip.................done. 18:05:08 INFO - Return code: 0 18:05:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:05: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')]} 18:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05: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')]} 18:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1042d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104369618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc4046a610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104238d30>, '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 0x103f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104230b20>, '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.vxjFhjkf9E/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.clzN5gpKiq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 18:05: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', 'pip>=1.5'] in /builds/slave/test/build 18:05: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 pip>=1.5 18:05:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vxjFhjkf9E/Render', 18:05:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:08 INFO - 'HOME': '/Users/cltbld', 18:05:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:08 INFO - 'LOGNAME': 'cltbld', 18:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:08 INFO - 'MOZ_NO_REMOTE': '1', 18:05:08 INFO - 'NO_EM_RESTART': '1', 18:05:08 INFO - 'PAGER': '/bin/cat', 18:05:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:08 INFO - 'PWD': '/builds/slave/test', 18:05:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:08 INFO - 'SHELL': '/bin/bash', 18:05:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.clzN5gpKiq/Listeners', 18:05:08 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 18:05:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:08 INFO - 'USER': 'cltbld', 18:05:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:08 INFO - 'XPC_FLAGS': '0x0', 18:05:08 INFO - 'XPC_SERVICE_NAME': '0', 18:05:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:08 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 18:05:08 INFO - Cleaning up... 18:05:08 INFO - Return code: 0 18:05:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:05: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')]} 18:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05: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')]} 18:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05: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', '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 0x1042d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104369618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc4046a610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104238d30>, '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 0x103f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104230b20>, '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.vxjFhjkf9E/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.clzN5gpKiq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 18:05: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', 'psutil>=3.1.1'] in /builds/slave/test/build 18:05: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 psutil>=3.1.1 18:05:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vxjFhjkf9E/Render', 18:05:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:08 INFO - 'HOME': '/Users/cltbld', 18:05:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:08 INFO - 'LOGNAME': 'cltbld', 18:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:08 INFO - 'MOZ_NO_REMOTE': '1', 18:05:08 INFO - 'NO_EM_RESTART': '1', 18:05:08 INFO - 'PAGER': '/bin/cat', 18:05:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:08 INFO - 'PWD': '/builds/slave/test', 18:05:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:08 INFO - 'SHELL': '/bin/bash', 18:05:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.clzN5gpKiq/Listeners', 18:05:08 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 18:05:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:08 INFO - 'USER': 'cltbld', 18:05:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:08 INFO - 'XPC_FLAGS': '0x0', 18:05:08 INFO - 'XPC_SERVICE_NAME': '0', 18:05:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:08 INFO - Downloading/unpacking psutil>=3.1.1 18:05:08 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 18:05:08 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 18:05:08 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 18:05:08 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 18:05:08 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 18:05:08 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 18:05:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:05:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:05:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:05:11 INFO - Installing collected packages: psutil 18:05:11 INFO - Running setup.py install for psutil 18:05:11 INFO - building 'psutil._psutil_osx' extension 18:05:11 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 18:05:12 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 18:05:12 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 18:05:12 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 18:05:12 INFO - building 'psutil._psutil_posix' extension 18:05:12 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 18:05:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:05:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:05:12 INFO - ^ 18:05:12 INFO - 1 warning generated. 18:05:12 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 18:05:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:05:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:05:12 INFO - Successfully installed psutil 18:05:12 INFO - Cleaning up... 18:05:12 INFO - Return code: 0 18:05:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:05: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')]} 18:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05: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')]} 18:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1042d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104369618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc4046a610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104238d30>, '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 0x103f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104230b20>, '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.vxjFhjkf9E/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.clzN5gpKiq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 18:05: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:05: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 mozsystemmonitor==0.3 18:05:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vxjFhjkf9E/Render', 18:05:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:12 INFO - 'HOME': '/Users/cltbld', 18:05:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:12 INFO - 'LOGNAME': 'cltbld', 18:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:12 INFO - 'MOZ_NO_REMOTE': '1', 18:05:12 INFO - 'NO_EM_RESTART': '1', 18:05:12 INFO - 'PAGER': '/bin/cat', 18:05:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:12 INFO - 'PWD': '/builds/slave/test', 18:05:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:12 INFO - 'SHELL': '/bin/bash', 18:05:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.clzN5gpKiq/Listeners', 18:05:12 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 18:05:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:12 INFO - 'USER': 'cltbld', 18:05:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:12 INFO - 'XPC_FLAGS': '0x0', 18:05:12 INFO - 'XPC_SERVICE_NAME': '0', 18:05:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:05:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:05:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:05:15 INFO - Installing collected packages: mozsystemmonitor 18:05:15 INFO - Running setup.py install for mozsystemmonitor 18:05:15 INFO - Successfully installed mozsystemmonitor 18:05:15 INFO - Cleaning up... 18:05:15 INFO - Return code: 0 18:05:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:05: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')]} 18:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05: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')]} 18:05:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05: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', '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 0x1042d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104369618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc4046a610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104238d30>, '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 0x103f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104230b20>, '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.vxjFhjkf9E/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.clzN5gpKiq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 18:05: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:05: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 jsonschema==2.5.1 18:05:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vxjFhjkf9E/Render', 18:05:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:15 INFO - 'HOME': '/Users/cltbld', 18:05:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:15 INFO - 'LOGNAME': 'cltbld', 18:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:15 INFO - 'MOZ_NO_REMOTE': '1', 18:05:15 INFO - 'NO_EM_RESTART': '1', 18:05:15 INFO - 'PAGER': '/bin/cat', 18:05:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:15 INFO - 'PWD': '/builds/slave/test', 18:05:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:15 INFO - 'SHELL': '/bin/bash', 18:05:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.clzN5gpKiq/Listeners', 18:05:15 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 18:05:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:15 INFO - 'USER': 'cltbld', 18:05:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:15 INFO - 'XPC_FLAGS': '0x0', 18:05:15 INFO - 'XPC_SERVICE_NAME': '0', 18:05:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:16 INFO - Downloading/unpacking jsonschema==2.5.1 18:05: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 18:05: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 18:05: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 18:05: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 18:05: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 18:05: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 18:05:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:05:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:05: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 18:05: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 18:05: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 18:05: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 18:05: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 18:05: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 18:05:18 INFO - Downloading functools32-3.2.3-2.tar.gz 18:05:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:05:18 INFO - warning: no files found matching '*.txt' 18:05:18 INFO - no previously-included directories found matching 'build' 18:05:18 INFO - no previously-included directories found matching 'dist' 18:05:18 INFO - no previously-included directories found matching '.git*' 18:05:18 INFO - Installing collected packages: jsonschema, functools32 18:05:19 INFO - Running setup.py install for functools32 18:05:19 INFO - warning: no files found matching '*.txt' 18:05:19 INFO - no previously-included directories found matching 'build' 18:05:19 INFO - no previously-included directories found matching 'dist' 18:05:19 INFO - no previously-included directories found matching '.git*' 18:05:19 INFO - Successfully installed jsonschema functools32 18:05:19 INFO - Cleaning up... 18:05:19 INFO - Return code: 0 18:05:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1042d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104369618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc4046a610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104238d30>, '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 0x103f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104230b20>, '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.vxjFhjkf9E/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.clzN5gpKiq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 18:05:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:05:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vxjFhjkf9E/Render', 18:05:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:19 INFO - 'HOME': '/Users/cltbld', 18:05:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:19 INFO - 'LOGNAME': 'cltbld', 18:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:19 INFO - 'MOZ_NO_REMOTE': '1', 18:05:19 INFO - 'NO_EM_RESTART': '1', 18:05:19 INFO - 'PAGER': '/bin/cat', 18:05:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:19 INFO - 'PWD': '/builds/slave/test', 18:05:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:19 INFO - 'SHELL': '/bin/bash', 18:05:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.clzN5gpKiq/Listeners', 18:05:19 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 18:05:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:19 INFO - 'USER': 'cltbld', 18:05:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:19 INFO - 'XPC_FLAGS': '0x0', 18:05:19 INFO - 'XPC_SERVICE_NAME': '0', 18:05:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:05:19 INFO - Cleaning up... 18:05:19 INFO - Return code: 0 18:05:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1042d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104369618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc4046a610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104238d30>, '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 0x103f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104230b20>, '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.vxjFhjkf9E/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.clzN5gpKiq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 18:05:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:05:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vxjFhjkf9E/Render', 18:05:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:19 INFO - 'HOME': '/Users/cltbld', 18:05:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:19 INFO - 'LOGNAME': 'cltbld', 18:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:19 INFO - 'MOZ_NO_REMOTE': '1', 18:05:19 INFO - 'NO_EM_RESTART': '1', 18:05:19 INFO - 'PAGER': '/bin/cat', 18:05:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:19 INFO - 'PWD': '/builds/slave/test', 18:05:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:19 INFO - 'SHELL': '/bin/bash', 18:05:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.clzN5gpKiq/Listeners', 18:05:19 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 18:05:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:19 INFO - 'USER': 'cltbld', 18:05:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:19 INFO - 'XPC_FLAGS': '0x0', 18:05:19 INFO - 'XPC_SERVICE_NAME': '0', 18:05:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:19 INFO - Downloading/unpacking blobuploader==1.2.4 18:05: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 18:05: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 18:05: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 18:05: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 18:05: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 18:05: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 18:05:22 INFO - Downloading blobuploader-1.2.4.tar.gz 18:05:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:05:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:05:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:05:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:05:23 INFO - Downloading docopt-0.6.1.tar.gz 18:05:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:05:23 INFO - Installing collected packages: blobuploader, requests, docopt 18:05:23 INFO - Running setup.py install for blobuploader 18:05:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:05:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:05:23 INFO - Running setup.py install for requests 18:05:24 INFO - Running setup.py install for docopt 18:05:24 INFO - Successfully installed blobuploader requests docopt 18:05:24 INFO - Cleaning up... 18:05:24 INFO - Return code: 0 18:05:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:24 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 0x1042d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104369618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc4046a610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104238d30>, '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 0x103f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104230b20>, '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.vxjFhjkf9E/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.clzN5gpKiq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 18:05:24 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 18:05:24 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 18:05:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vxjFhjkf9E/Render', 18:05:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:24 INFO - 'HOME': '/Users/cltbld', 18:05:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:24 INFO - 'LOGNAME': 'cltbld', 18:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:24 INFO - 'MOZ_NO_REMOTE': '1', 18:05:24 INFO - 'NO_EM_RESTART': '1', 18:05:24 INFO - 'PAGER': '/bin/cat', 18:05:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:24 INFO - 'PWD': '/builds/slave/test', 18:05:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:24 INFO - 'SHELL': '/bin/bash', 18:05:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.clzN5gpKiq/Listeners', 18:05:24 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 18:05:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:24 INFO - 'USER': 'cltbld', 18:05:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:24 INFO - 'XPC_FLAGS': '0x0', 18:05:24 INFO - 'XPC_SERVICE_NAME': '0', 18:05:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:05:24 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-8Ar8ne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:05:24 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-kB0g0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:05:24 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-SpHL9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:05:24 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-afTV6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:05:25 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-VLTSXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:05:25 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-CazwDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:05:25 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-fISDZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:05:25 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-ReiDpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:05:25 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-93pVKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:05:25 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-jtqX8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:05:25 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-4hoK0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:05:25 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-76r6zE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:05:25 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-FvanJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:05:25 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-amgoHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:05:26 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-mW_7mN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:05:26 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-Jz3zHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:05:26 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-wYixLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:05:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:05:26 INFO - Running setup.py install for manifestparser 18:05:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:05:26 INFO - Running setup.py install for mozcrash 18:05:26 INFO - Running setup.py install for mozdebug 18:05:26 INFO - Running setup.py install for mozdevice 18:05:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:05:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:05:27 INFO - Running setup.py install for mozfile 18:05:27 INFO - Running setup.py install for mozhttpd 18:05:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:05:27 INFO - Running setup.py install for mozinfo 18:05:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:05:27 INFO - Running setup.py install for mozInstall 18:05:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:05:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:05:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:05:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:05:27 INFO - Running setup.py install for mozleak 18:05:27 INFO - Running setup.py install for mozlog 18:05:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:05:27 INFO - Running setup.py install for moznetwork 18:05:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:05:28 INFO - Running setup.py install for mozprocess 18:05:28 INFO - Running setup.py install for mozprofile 18:05:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:05:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:05:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:05:28 INFO - Running setup.py install for mozrunner 18:05:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:05:28 INFO - Running setup.py install for mozscreenshot 18:05:28 INFO - Running setup.py install for moztest 18:05:28 INFO - Running setup.py install for mozversion 18:05:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:05:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:05:28 INFO - Cleaning up... 18:05:28 INFO - Return code: 0 18:05:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:05:28 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')]} 18:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:28 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')]} 18:05:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:28 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 0x1042d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104369618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc4046a610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104238d30>, '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 0x103f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104230b20>, '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.vxjFhjkf9E/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.clzN5gpKiq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 18:05:28 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 18:05:28 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 18:05:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vxjFhjkf9E/Render', 18:05:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:28 INFO - 'HOME': '/Users/cltbld', 18:05:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:28 INFO - 'LOGNAME': 'cltbld', 18:05:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:28 INFO - 'MOZ_NO_REMOTE': '1', 18:05:28 INFO - 'NO_EM_RESTART': '1', 18:05:28 INFO - 'PAGER': '/bin/cat', 18:05:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:28 INFO - 'PWD': '/builds/slave/test', 18:05:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:28 INFO - 'SHELL': '/bin/bash', 18:05:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.clzN5gpKiq/Listeners', 18:05:28 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 18:05:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:28 INFO - 'USER': 'cltbld', 18:05:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:28 INFO - 'XPC_FLAGS': '0x0', 18:05:28 INFO - 'XPC_SERVICE_NAME': '0', 18:05:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:05:29 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-t51TIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:05:29 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)) 18:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:05:29 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-FXWcZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:05:29 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)) 18:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:05:29 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-RLu9lD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:05:29 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)) 18:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:05:29 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-HrRCjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:05:29 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)) 18:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:05:29 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-W9IU1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:05:29 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)) 18:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:05:29 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-hzZiz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:05:29 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)) 18:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:05:29 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-OUYSgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:05:30 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)) 18:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:05:30 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-DJwW0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:05:30 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)) 18:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:05:30 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-mCuYMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:05:30 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)) 18:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:05:30 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-r7aSMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:05:30 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)) 18:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:05:30 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-mdYbHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:05:30 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)) 18:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:05:30 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-wI0Uun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:05:30 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)) 18:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:05:30 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-m8GjWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:05:30 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)) 18:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:05:30 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-hlf0RA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:05:30 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)) 18:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:05:30 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-bqm8U1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:05:30 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)) 18:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:05:30 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-fMInd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:05:30 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)) 18:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:05:30 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-1FezvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:05:31 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)) 18:05:31 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)) 18:05:31 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)) 18:05:31 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)) 18:05:31 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)) 18:05:31 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)) 18:05:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:05:31 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 18:05:31 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 18:05:31 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 18:05:31 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 18:05:31 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 18:05:31 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 18:05:33 INFO - Downloading blessings-1.6.tar.gz 18:05:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:05:33 INFO - Installing collected packages: blessings 18:05:33 INFO - Running setup.py install for blessings 18:05:33 INFO - Successfully installed blessings 18:05:33 INFO - Cleaning up... 18:05:33 INFO - Return code: 0 18:05:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:05:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:05:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:05:34 INFO - Reading from file tmpfile_stdout 18:05:34 INFO - Current package versions: 18:05:34 INFO - blessings == 1.6 18:05:34 INFO - blobuploader == 1.2.4 18:05:34 INFO - docopt == 0.6.1 18:05:34 INFO - functools32 == 3.2.3-2 18:05:34 INFO - jsonschema == 2.5.1 18:05:34 INFO - manifestparser == 1.1 18:05:34 INFO - mozInstall == 1.12 18:05:34 INFO - mozcrash == 0.17 18:05:34 INFO - mozdebug == 0.1 18:05:34 INFO - mozdevice == 0.48 18:05:34 INFO - mozfile == 1.2 18:05:34 INFO - mozhttpd == 0.7 18:05:34 INFO - mozinfo == 0.9 18:05:34 INFO - mozleak == 0.1 18:05:34 INFO - mozlog == 3.3 18:05:34 INFO - moznetwork == 0.27 18:05:34 INFO - mozprocess == 0.23 18:05:34 INFO - mozprofile == 0.28 18:05:34 INFO - mozrunner == 6.12 18:05:34 INFO - mozscreenshot == 0.1 18:05:34 INFO - mozsystemmonitor == 0.3 18:05:34 INFO - moztest == 0.7 18:05:34 INFO - mozversion == 1.4 18:05:34 INFO - psutil == 3.1.1 18:05:34 INFO - requests == 1.2.3 18:05:34 INFO - wsgiref == 0.1.2 18:05:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:34 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 0x1042d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104369618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc4046a610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104238d30>, '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 0x103f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104230b20>, '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.vxjFhjkf9E/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.clzN5gpKiq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 18:05:34 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 18:05:34 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 18:05:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vxjFhjkf9E/Render', 18:05:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:34 INFO - 'HOME': '/Users/cltbld', 18:05:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:34 INFO - 'LOGNAME': 'cltbld', 18:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:34 INFO - 'MOZ_NO_REMOTE': '1', 18:05:34 INFO - 'NO_EM_RESTART': '1', 18:05:34 INFO - 'PAGER': '/bin/cat', 18:05:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:34 INFO - 'PWD': '/builds/slave/test', 18:05:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:34 INFO - 'SHELL': '/bin/bash', 18:05:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.clzN5gpKiq/Listeners', 18:05:34 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 18:05:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:34 INFO - 'USER': 'cltbld', 18:05:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:34 INFO - 'XPC_FLAGS': '0x0', 18:05:34 INFO - 'XPC_SERVICE_NAME': '0', 18:05:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:34 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)) 18:05:34 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)) 18:05:34 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)) 18:05:34 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)) 18:05:34 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)) 18:05:34 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)) 18:05:34 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)) 18:05:34 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)) 18:05:34 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)) 18:05:34 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)) 18:05:34 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)) 18:05:34 INFO - Cleaning up... 18:05:34 INFO - Return code: 0 18:05:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:05:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:05:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:05:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:05:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1042d4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104369618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc4046a610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104238d30>, '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 0x103f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104230b20>, '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.vxjFhjkf9E/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.clzN5gpKiq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 18:05:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:05:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:05:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vxjFhjkf9E/Render', 18:05:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:05:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:05:34 INFO - 'HOME': '/Users/cltbld', 18:05:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:05:34 INFO - 'LOGNAME': 'cltbld', 18:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:05:34 INFO - 'MOZ_NO_REMOTE': '1', 18:05:34 INFO - 'NO_EM_RESTART': '1', 18:05:34 INFO - 'PAGER': '/bin/cat', 18:05:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:05:34 INFO - 'PWD': '/builds/slave/test', 18:05:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:05:34 INFO - 'SHELL': '/bin/bash', 18:05:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.clzN5gpKiq/Listeners', 18:05:34 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 18:05:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:05:34 INFO - 'USER': 'cltbld', 18:05:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:05:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:05:34 INFO - 'XPC_FLAGS': '0x0', 18:05:34 INFO - 'XPC_SERVICE_NAME': '0', 18:05:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:05:34 INFO - Cleaning up... 18:05:34 INFO - Return code: 0 18:05:34 INFO - Running post-action listener: _resource_record_post_action 18:05:34 INFO - Running post-action listener: _start_resource_monitoring 18:05:34 INFO - Starting resource monitoring. 18:05:34 INFO - [mozharness: 2016-08-16 01:05:34.709015Z] Finished create-virtualenv step (success) 18:05:34 INFO - [mozharness: 2016-08-16 01:05:34.709993Z] Running install step. 18:05:34 INFO - Running pre-action listener: _resource_record_pre_action 18:05:34 INFO - Running main action method: install 18:05:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:05:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:05:34 INFO - Reading from file tmpfile_stdout 18:05:34 INFO - Detecting whether we're running mozinstall >=1.0... 18:05:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:05:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:05:35 INFO - Reading from file tmpfile_stdout 18:05:35 INFO - Output received: 18:05:35 INFO - Usage: mozinstall [options] installer 18:05:35 INFO - Options: 18:05:35 INFO - -h, --help show this help message and exit 18:05:35 INFO - -d DEST, --destination=DEST 18:05:35 INFO - Directory to install application into. [default: 18:05:35 INFO - "/builds/slave/test"] 18:05:35 INFO - --app=APP Application being installed. [default: firefox] 18:05:35 INFO - mkdir: /builds/slave/test/build/application 18:05:35 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'] 18:05:35 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 18:06:09 INFO - Reading from file tmpfile_stdout 18:06:09 INFO - Output received: 18:06:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:06:09 INFO - Running post-action listener: _resource_record_post_action 18:06:09 INFO - [mozharness: 2016-08-16 01:06:09.019113Z] Finished install step (success) 18:06:09 INFO - [mozharness: 2016-08-16 01:06:09.019283Z] Running run-tests step. 18:06:09 INFO - Running pre-action listener: _resource_record_pre_action 18:06:09 INFO - Running main action method: run_tests 18:06:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:06:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:06:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:06:09 INFO - 2016-08-15 18:06:09.034 screenresolution[2498:29819] starting screenresolution argv=screenresolution get 18:06:09 INFO - 2016-08-15 18:06:09.037 screenresolution[2498:29819] Display 0: 1600x1200x32@60 18:06:09 INFO - 2016-08-15 18:06:09.043 screenresolution[2499:29827] starting screenresolution argv=screenresolution list 18:06:09 INFO - Available Modes on Display 0 18:06:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:06:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:06:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:06:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:06:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:06:09 INFO - Intel Iris: 18:06:09 INFO - Chipset Model: Intel Iris 18:06:09 INFO - Type: GPU 18:06:09 INFO - Bus: Built-In 18:06:09 INFO - VRAM (Dynamic, Max): 1536 MB 18:06:09 INFO - Vendor: Intel (0x8086) 18:06:09 INFO - Device ID: 0x0a2e 18:06:09 INFO - Revision ID: 0x0009 18:06:09 INFO - Displays: 18:06:09 INFO - Display: 18:06:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:06:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:06:09 INFO - Display Serial Number: 1600x1200 60 18:06:09 INFO - Main Display: Yes 18:06:09 INFO - Mirror: Off 18:06:09 INFO - Online: Yes 18:06:09 INFO - Rotation: Supported 18:06:09 INFO - Return code: 0 18:06:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:06:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:06:09 INFO - Python 2.7.3 18:06:09 INFO - Return code: 0 18:06:09 INFO - grabbing minidump binary from tooltool 18:06:09 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')]} 18:06:09 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 0x104238d30>, '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 0x103f9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104230b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:06:09 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 18:06:09 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 18:06:09 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 18:06:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:06:09 INFO - Return code: 0 18:06:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:06:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:06:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:06:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:06:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:06:09 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/GQK2wVtsQEySu7dndY03lA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0382', '--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 18:06:09 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/GQK2wVtsQEySu7dndY03lA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0382 --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 18:06:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vxjFhjkf9E/Render', 18:06:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:06:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:06:09 INFO - 'HOME': '/Users/cltbld', 18:06:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:06:09 INFO - 'LOGNAME': 'cltbld', 18:06:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:06:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:09 INFO - 'MOZ_NO_REMOTE': '1', 18:06:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:06:09 INFO - 'NO_EM_RESTART': '1', 18:06:09 INFO - 'PAGER': '/bin/cat', 18:06:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:09 INFO - 'PWD': '/builds/slave/test', 18:06:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:06:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:06:09 INFO - 'SHELL': '/bin/bash', 18:06:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.clzN5gpKiq/Listeners', 18:06:09 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 18:06:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:06:09 INFO - 'USER': 'cltbld', 18:06:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:06:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:09 INFO - 'XPC_FLAGS': '0x0', 18:06:09 INFO - 'XPC_SERVICE_NAME': '0', 18:06:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:06:09 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/GQK2wVtsQEySu7dndY03lA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0382', '--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 18:06:09 INFO - mozversion application_buildid: 20160815144333 18:06:09 INFO - mozversion application_changeset: 794db78767b9f9ec7714c74cd3ae38b561196b6d 18:06:09 INFO - mozversion application_display_name: Nightly 18:06:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:06:09 INFO - mozversion application_name: Firefox 18:06:09 INFO - mozversion application_remotingname: firefox 18:06:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:06:09 INFO - mozversion application_vendor: Mozilla 18:06:09 INFO - mozversion application_version: 51.0a1 18:06:09 INFO - mozversion platform_buildid: 20160815144333 18:06:09 INFO - mozversion platform_changeset: 794db78767b9f9ec7714c74cd3ae38b561196b6d 18:06:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:06:09 INFO - mozversion platform_version: 51.0a1 18:06:09 INFO - using testdate: 1471309569 18:06:09 INFO - actual date: 1471309569 18:06:09 INFO - starting webserver on 'localhost:60241' 18:06:09 INFO - SUITE-START | Running 2 tests 18:06:09 INFO - TEST-START | dromaeo_css 18:06:09 INFO - operating with platform_type : mac_ 18:06:09 INFO - Initialising browser for dromaeo_css test... 18:06:09 INFO - TEST-INFO | started process 2509 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/tmpuAqT2M/profile http://localhost:60241/getInfo.html) 18:06:12 INFO - PROCESS | 2509 | __metrics Screen width/height:1600/1200 18:06:12 INFO - PROCESS | 2509 | colorDepth:24 18:06:12 INFO - PROCESS | 2509 | Browser inner width/height: 1024/689 18:06:12 INFO - PROCESS | 2509 | __metrics 18:06:12 ERROR - PROCESS | 2509 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 18:06:13 INFO - TEST-INFO | 2509: exit 0 18:06:13 INFO - Browser initialized. 18:06:13 INFO - Running cycle 1/1 for dromaeo_css test... 18:06:13 INFO - TEST-INFO | started process 2512 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/tmpuAqT2M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:06:25 INFO - PROCESS | 2512 | RSS: Main: 239927296 18:06:25 INFO - PROCESS | 2512 | 18:07:14 INFO - PROCESS | 2512 | 1471309634840 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:09:26 INFO - PROCESS | 2512 | Cycle 1(1): loaded http://localhost:60241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60241/tests/dromaeo/cssquery-ext.html) 18:09:28 INFO - PROCESS | 2512 | RSS: Main: 254742528 18:09:28 INFO - PROCESS | 2512 | 18:12:30 INFO - PROCESS | 2512 | Cycle 1(1): loaded http://localhost:60241/tests/dromaeo/cssquery-ext.html (next: http://localhost:60241/tests/dromaeo/cssquery-jquery.html) 18:12:31 INFO - PROCESS | 2512 | RSS: Main: 267657216 18:12:31 INFO - PROCESS | 2512 | 18:15:32 INFO - PROCESS | 2512 | Cycle 1(1): loaded http://localhost:60241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60241/tests/dromaeo/cssquery-mootools.html) 18:15:33 INFO - PROCESS | 2512 | RSS: Main: 272388096 18:15:33 INFO - PROCESS | 2512 | 18:18:35 INFO - PROCESS | 2512 | Cycle 1(1): loaded http://localhost:60241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60241/tests/dromaeo/cssquery-prototype.html) 18:18:36 INFO - PROCESS | 2512 | RSS: Main: 271966208 18:18:36 INFO - PROCESS | 2512 | 18:21:38 INFO - PROCESS | 2512 | Cycle 1(1): loaded http://localhost:60241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60241/tests/dromaeo/cssquery-yui.html) 18:21:39 INFO - PROCESS | 2512 | RSS: Main: 277331968 18:21:39 INFO - PROCESS | 2512 | 18:24:41 INFO - PROCESS | 2512 | Cycle 1(1): loaded http://localhost:60241/tests/dromaeo/cssquery-yui.html (next: http://localhost:60241/tests/dromaeo/cssquery-dojo.html) 18:24:42 INFO - PROCESS | 2512 | RSS: Main: 279904256 18:24:42 INFO - PROCESS | 2512 | 18:24:42 INFO - PROCESS | 2512 | __start_tp_report 18:24:42 INFO - PROCESS | 2512 | _x_x_mozilla_page_load 18:24:42 INFO - PROCESS | 2512 | _x_x_mozilla_page_load_details 18:24:42 INFO - PROCESS | 2512 | |i|pagename|runs| 18:24:42 INFO - PROCESS | 2512 | |0;dojo.html;3371.0729549373937;3376.476646119849;3383.407903616867;3415.7438192135587;3432.244906120654;5701.9736447439445;5812.796552120677;5879.11813228016;5881.147233651118;5950.761969521214;4765.714057156573;5691.630044047144;5792.739326730297;5805.071188609823;5902.409759024106;4080.6327430531246;5147.330846989886;5194.480551944795;5261.789528418878;5350.91973620396;4417.558244175589;5439.619226654136;5467.808626698066;5507.614466987313;5515.696636684981;4701.623870090384;4925.473103337977;5365.114756065244;5376.677399356051;5401.405845357008;5340.759665815048;5352.143657014898;5359.276497672803;5376.542993845489;5416.593755468316;5250.05499010178;5263.973680131575;5306.495882891119;5314.0700377433795;5367.704776237305;5702.686352250625;5805.477507024388;5838.620489668158;5861.706914654293;5959.0763431668165;6207.689615519206;6219.657918814463;6247.718852651642;6286.559940804145;6296.401841825019;6298.937010629927;6302;6322.589031712924;6324.873502529924;6333.366663333676;4867.70793752376;5957.463828255478;6004.579679422399;6049.667268300242;6063.727132279014;6298.559100862987;6353.809385718436;6360.363963603602;6366.490680745529;6377.1390862233;6297;6304.5586808922935;6314;6329.525285603506;6332.081848131995;5175;5243.711595862188;6189.412005859436;6247.09417134522;6318.178636777189;4465.352523884018;6216.471599913967;6272.3100458949475;6275.497960163176;6280.089387038854;6200;6214.658193799384;6268.122462855204;6275.34108918557;6282.183316168869;4993.950060499348;5016.372953380827;5066.442691303953;5122.282880396748;5148.176291793295;4504.391907092566;4542.1824071667415;4564.748938808398;4566.954330456653;4595.517470665532;5825.446582574648;5919.733611987471;5933.406659334032;5936.198613187251;5964.075568286922;6169.784057557964;6201.844953876099;6247.219097612799;6293.968530157412;6317.652529110943;5880.529557635465;5882.352941176553;5912.526997840162;5940.405959404025;5942.37605051472;5524.3370795504;5524.4199359066715;5526.557875369961;5526.972365138148;5543.417941116206;6204.317525072239;6229.968850155901;6234.719437625408;6366.808995730135;6380.84047898797;6231.501479881508;6271.247450305992;6285.717142728679;6288.748450061947;6294.339094395023;6352.841178970378;6390.90413643805;6393.552451328363;6403.583767055126;6405.967970160119;6133.785317513865;6202.751889924352;6225.190725205694;6293.779717709858;6313.715882785377;6167.290761562478;6284.057391391328;6312.873742525216;6314.368563143649;6345.587536810092;6144.385561443999;6222.62664240147;6226.875462490815;6298.622082675054;6302.180716506825;5005.77474013663;5007.649464537448;5435.864103397446;5844.444777746107;6082.452579267887;5096.566791822736;6002.789902353396;6117.096718007379;6117.571769976059;6154.230721159855;5395.568354531707;6219.346968568235;6264.21697287839;6287.402696743802;6296.779612713533;5916.55625828056;6036.9094463582205;6102.816915492543;6140.1710769047395;6187 18:24:42 INFO - PROCESS | 2512 | |1;ext.html;466.29356524864835;477.8948631301113;496.6821234409976;525.9979738597971;530.7160669042063;38811.22377552447;41867.48795072298;41957;42005.369919451194;42015.369769453406;42857.14285714284;43306;43345.6996290111;43379.56620433795;43447.56552434475;8758.386912916098;9654.565544550494;9915.801683966316;9917.75205619858;9917.950410247939;9831.459269740162;9952.253580981456;9961.701148965543;9969.950150249239;9992.100710936014;9942;9973.850392244121;9977.401355918668;9978.600855965753;10010.749731256705;9865.999999999964;9887.357321774098;9893.703188904345;9908.90091099087;9929.65246216379;7688.231176882323;9291.628334866597;9845.113939745457;9872.802543949152;9995.500224988722;36820.63179368199;36863.262734745156;37031;37057.81471092627;37279.25441491182;2568.9082140090572;2965.303153758865;3230.935381292361;3335.0995231287416;3429.416999110157;29609.851950740325;29683.851580742175;29941.850290748625;31076.378472430424;31771.205719856956;3127.390158919012;3178.713915747571;3187.378461200067;3191.12244132863;3192.2817366092677;459589;459791;460587;462079;464316.67841660575;33753.662463375054;33970.98087057392;34250.48624270638;34290;34321;34169.82915085458;34807.30385392278;34993.475097873554;35035;35482.64517354845;16275;16663.0835304057;16733.247003884855;16742.162891855358;16760.916195418944;12843.357832108544;12938.029647776266;12942.676433089247;12953.935230323788;12959.416826242654;19046.809531904782;19079.236830526625;19097.904510477358;19101;19156.808431915782;7967.123616402191;8127.634256458474;8144.470609410369;8165.305948994402;8213.548254845922;880.3749337970113;915.2037727177399;984.4585477987079;1028.1671845804922;1043.8225501664735;29606.407871842443;30251.394972100436;30686.693133068384;31015.759369625415;31169.68830311668;1011.2971484817981;1019.9694009179588;1062.0866055192528;1078.7680648660576;1095.8630171228597;16023;16037;16223.675526489404;16226.188690565425;16280.43018494347;598605;619858;637691.2885889264;678585;691229;60122.69938650279;60317.095243571384;60753.69623151856;60877.69561152166;61282;1351.0812647399862;1378.8896888248917;1393.2197969137314;1399.8180236569385;1403.1791402029926;29433.264168395963;30976;31689;31957;32622.045592978284;58161.709191453774;58791.4120858786;58922.410775891694;59001.70499147477;59032.1145182814;636783;640472;643966;644679;645037;43899.34150987674;44029;44096.55903441053;44503.33245001392;44558.77720611376;48907;49728;49791.50208497869;50465.74767126288;50605.24092138695;34339.79810706613;40265.59734402619;40363.596364035984;41547.58452415437;41846.790766045975;39166.24290827902;39981.600183998955;40065;41270.58729412667;41425.37861932013;39295.41056884206;39708.205835883695;39991;40075.198496029334;40224.1955160901;31568;32934.05989101654;35486.64513354937;35906.92279231627;36266.4560031605;25931.22206333813;25990;26239.95040198447;26536.734632653428;26681.19956401311 18:24:42 INFO - PROCESS | 2512 | |2;jquery.html;315.61179748908836;343.178088478095;358.3907357492264;364.62261559286134;392.952845658521;20432.99999999998;21671.56656866862;21768.564628707416;21827.799471029088;22026;20180.697289540632;20314.781113133224;20589.27937522187;20944.790552094473;21541.353759387206;5346.973265133669;5524.640898341615;5766.596338256324;5933.940660593382;5951.434613711691;5855.912161317584;5895.764169433218;6007.249093863267;6027.5479339049525;6058.091286307045;5815.127730840365;5837.09525023622;5857.150713146591;5865.413458654143;5957.731902064395;5062.139436295838;5682.630629009122;5759.439330711041;5827.038538641119;5841.503472204868;5091.159958606825;5110.897782044375;5115.053715062725;5127.53852153308;5152.639315247934;25641.35896602581;25654.102106426373;25747.356316092246;25906.870465647553;25928.740712592822;2135.562209746998;2419.129113519132;2454.5949918263464;2643.960340594893;2855.4431885782283;15443.691126177526;15562.688746225125;15945.681086378323;15956;16486.422975195812;1839.2826797548967;1920.4142736465371;1935.138863205874;1942.4269840397117;1967.980320196794;118492.40753796262;120021;122582;122595.38702306521;123067;10375.118114960162;10459.738506537398;10459.790804183875;10524.842127368096;10763.515641796137;13375;13467.86532134666;13488.258145802076;13497.190168589916;13507.662308442368;7052.400545953549;7106.680199391039;8347.54088525137;8585.82828343442;8696.086910874394;7605.201453847377;8049.436539442183;8717.520536370434;8736.257418119403;8966.372353935161;5443.836684899459;6232.781852635136;6475.287718350977;6594.641484139398;6614.7023383947835;1866.7479890214647;1894.5547796267865;1909.8472122230467;1927.4795805132535;1946.639871623754;872.2716531696104;887.973360799177;935.7052528453515;981.842905135175;1091.946271847671;18767.812321876605;20334.389968300973;21141;21217.322090391324;23981.760182398302;778.7741554949001;924.7688077980505;941.2517048946104;951.7477868364889;1017.9847302290472;9755.463449510346;11343.149263805248;11779.528818847322;11916.52333906634;12008.159428839897;601981;605206;605553;613898;621656;120523;122898.3855080719;124111.75888241002;125362.3731881353;126660;967.9032096790405;974.4299584742863;1004.467632154959;1008.9798204035878;1012.1396812709138;19592.706109408085;19688.901555492703;19788.802111979272;19820.801791982474;19978.10098545598;52383.476165239386;52605;53905.46094539004;54312.65498760169;54854.177187341425;74692;74765.62617186879;74913.6254318725;75602.24397755953;76556.61721691355;7767.961160194162;7950;8068.878966815385;8102.298517311195;8194.67221311141;12291.877081229073;13156.934215328862;13256.403461844047;13468.393922273326;13502.662433439242;11559.826602601135;11707.473163707484;11793.41032948332;11842.881571184178;11881.990030847475;10910.781784364426;11150.832737509107;11399.601013964471;11537.884621154017;11668.183227174355;11604.883951160718;11610.606727192791;11694.415279235835;11825.586104486301;11868;7265.09186351706;7827.139014708491;7944.483608565425;7953.6818527258265;8038.67845286182;10645.787084258427;11318.660440186808;11474.368909710047;11635.301881887113;11802.82295765547 18:24:42 INFO - PROCESS | 2512 | |3;mootools.html;1520.8555187257207;1550.906945583265;1770.3449723602268;1778.5731424458133;1870.2986380107452;7850.960745196266;8270.545120018403;8498;8856.158664926837;8871.55642217889;8479.024912135106;8726.1710137537;8731;8739.431936924095;8764.03595604483;1977.3968939473455;2305.170138750049;2347.272345572869;2354.776296251862;2359.6696462495265;2312.7340355859124;2331.3588763090115;2359.528094381122;2362.681038059857;2374.180907586888;2357.363511851799;2359.8938047787806;2363.9881800590974;2368.159303447277;2375.5011447596025;2318.8840557972203;2324.8488848224897;2343.61330380487;2349.7767712067325;2353.5410594933996;2344.601417758985;2347.9060837566476;2349.5770761262966;2349.6945397098266;2352.752960939094;8766;8876.556172191365;8894.155055269805;8926.86609700855;8940.016598174196;5211.400688920785;5377.8117765878005;5379.300690910196;5392.05639013175;5393.622446428752;3419.6580341965605;3503.334366470388;3593.0658028912408;3620.9094772630633;3661.7070634349457;871.0752069157516;1030.855680204772;1104.221523825709;1109.5894519027931;1129.2941911305434;11293.265937714104;11443.828342574869;11462.312261264351;11483.598074067451;11485.942570287096;4561.2245918193985;4740.506740376839;4802.327674125625;4808.3989501312335;4810.687305325143;9781.46201958885;9860.654877079267;9884.011598840203;9886.752831179134;9893.604255829687;4588.311753237042;5331.44019877915;5338.599605029561;5347.919781203285;5353.491418315254;4392.099619577979;4721.905561888743;4888.266759986031;4905.730184839868;4905.779239934212;3864.6908247340143;3927.4108883667677;4011.8796436106963;4042.171354872244;4047.332190188586;1108.8170451875512;1286.5561381323428;1295.371744703818;1300.5253082624774;1310.541310541303;786.3080489169608;825.5665775467927;884.8320217313213;965.4641673870929;992.7964767222702;5499.450054994549;5675.574331925122;6058.818235452944;6244.250689917239;6347.492200623939;921.6083164654995;923.5890028937058;945.6690158444627;967.351874244258;988.3970777825521;3429.7084747796716;4051.6353528182603;4132.318167502389;4150.335946248586;4184.4141820145205;10239;10689.144868410664;10703.304285221435;10713.625023124154;10734.087602553715;10706.982836630508;10725.78548429027;10726;10741.301815381976;10750.569977200825;8176.959115204505;8274.958625206957;8282.378821588405;8292.958535207285;8295.129011453831;5141.331626888481;5763.7118144093465;5860.765569377178;6018.729157188025;6132.325444201224;9970.700878973643;9988.950055249677;10022.849657255292;10052.648157314752;10069.194464442973;9608.567614457226;10069.093781559695;10091.091801737879;10176.135028522362;10210.438425886647;6977.058097157022;7360.043194384696;7481.812954676177;7527.88708169367;7689.769306920802;8424.326053915795;8503.149685031447;8513.36149788756;8516.361272904433;8517.44636598619;7343.192248852515;7509.774706758806;7552.131504877009;7632.694692212472;7749.496282741829;7307.634618269171;7468.3278504934815;7483.700651974078;7587.924120758943;7605.733799316998;6977.232504424408;7123.82190445243;7131.393831524171;7160.785176444715;7181.317774811385;5018.42288136869;5113.8977220454635;5122.8207012755865;5226.921596175985;5245.423003469692;5138.3063286457345;5231.843044708513;5240.554552863049;5243.764030618555;5377.408485066561 18:24:42 INFO - PROCESS | 2512 | |4;prototype.html;247.1251768738665;292.549473810332;306.87724910035996;323.18718423165734;333.18369993515876;5161.587073034158;5402.621816472849;5774.105013722874;5866.677332746703;5871.7100330871;5576.27135587968;5642.858928526779;5647.802326918559;5659.8585035374135;5672.858178545538;3765.811709414532;3825.5791862895057;4308.956910430887;4395.758233297167;4404.8017839197155;3520.366334059868;4168.958310416887;4229.682773791963;4384.101259241864;4399.626031787302;3833.3483307837732;3858.82635281413;4281.293586558214;4336.21948049351;4357.150355680644;3965.147493288957;3976.681865450757;4295.742255464682;4341.804618792162;4353.325234588644;3624.930645459596;3764.3976963685677;3772.9248913097686;3783.6946253542483;3806.4480650305827;4552.52198519154;5333.439988801198;5480.451954804527;5496.945030549683;5544.750486228129;4512.593866551993;4596.954030459686;4706.717596944194;4942.827001054946;5015.22264049073;5833.854153646151;5965.313988891289;6063.757449702007;6076.605020673642;6098.664573448458;3450.8447119879415;4049.104890003632;4083.795810209507;4093.4678491796176;4093.713440059197;5512.779488820443;5881.2356293112325;6360.7737291947915;6410.391012853818;6418.518611104186;4032.91934161321;4159.563245859141;4173.332266837291;4180.728252663567;4184.99120422199;3659.597444281127;3838.8848334550007;4109.705357901001;4267.5732426757695;4293.549177336335;4358.5205627380965;4470.5976462117915;4879.731614761222;5001.174806156943;5004.199328107486;5599.776008959678;5907.763689452374;6024.313192306161;6137.355577664281;6168.383161683796;1400.8669176428223;1440.2510694438834;1440.7478691228994;1444.1154293646682;1444.8193975753031;768.9000429944072;836.4354061008795;846.4371193156481;846.886344457037;888.2760550151605;4363.585459381354;4540;4629.513901040342;4705.4588722296685;4799.592289474443;4739.795994862406;4752.645496033683;5143.8199663012365;5204.583633309327;5207.531322181022;4217.641500472494;4296.2266791977745;4424.354906304287;4741.146593613183;4747.691400058985;2517.5342561626157;2618.5254934087484;2631.2502186046063;2761.743406749924;2776.1255204610484;4909.631777616693;4914.533119353656;5087.618428617869;5160.780864228418;5336.132353676182;4937.950620493749;5147.742612869341;5178.741062946838;5281.60387970896;5340.172273297645;4597.448306203277;5003.574696150868;5328.573714102862;5329.600279979017;5338.679679219337;4147.0461793787;4987.351644286219;5066.290719299374;5117.162128403697;5174.482551744795;4324.9783751082305;4715.787789549547;4717.9056418872115;5060.898782024413;5138.511841375063;4772.305831429792;5228.2617928181535;5240.536947634606;5246.42289348179;5267.73661316925;3578.9105272368397;3907.492026036597;4101.630853223224;4136.669066474615;4231.672580080882;5865.824025279248;6035.460957455821;6099.889056581087;6309.873802524015;6316.463100636497;5730.541556675373;5866.472017518444;6063.242094738158;6069.969650151721;6089.451949324582;5983.965451746427;5989.670568118795;6015.293118096786;6026.15633811258;6049.546284028804;5575.498205161555;5637.746301416364;5888.17565540816;5889.823305300848;5931.1992880960515;5774.624649397776;6018.608790428608;6023.6385816851125;6031.396860313934;6064.211652485149;5658.85852853682;5907.881842363215;5925.259342582177;5946.524278057832;5959.553033522417 18:24:42 INFO - PROCESS | 2512 | |5;yui.html;673.9460843132549;684.6747794797469;778.9639779093806;799.5322736199323;829.9087100418955;12204.633860984162;15713.742900567955;15720.37118515261;15724.213789310517;15732.449364272254;14243.14541127533;14351.856481435183;14354.641133971656;14362.28188590569;14366.856331436682;669.2571245917028;827.1191181391813;829.9377546683993;864.8918885139358;869.7347309070731;813.4828544764032;844.8310337932407;854.1415877043562;860.1785295043219;863.5552690364436;823.6697733160962;871.4205053639322;908.2597682888457;917.4311926605513;921.1663444582664;882.7748924024397;892.0321451225428;899.9010108888017;907.8683590879318;912.1881525442361;672.0322735261257;676.364217635426;681.2710399872138;690.023616582535;690.3234829866759;15026.549203523911;15079.924600377037;15214;15219.771703424458;15244.466443674419;10378.584856605727;14772;14836.480723174745;14888.330025148894;14936.178510181935;12027.579034733742;12099.334536600483;12145.635630931087;12152.21010634306;12165.087618428654;3550.5384300041087;3875.2830726315724;3904.1020565270146;3939.72421930465;3963.147923196527;100361.4945775814;105275;120500.39749801283;122012;122604;9272.953635231916;9312.580933857993;10955.616553420752;11200.271982321123;11473.139514536444;22121.446963826034;22522.774772252396;22798;23130.884345578164;23426.297211083696;8141.837163256701;8272.669093236324;8277.958610207032;8293.668253269921;8316.293115085286;4572.542745725401;4572.817087316536;4573.359729637853;4582.381378513858;4643.419572553431;2926.400087982001;3025.8638361273797;3529.417646088418;3542.6634469725336;3562.6437356264164;622.9906551401733;635.8251480842805;636.6752955992384;641.7400952614199;690.2200513419904;612.2285919741158;633.3729607688448;642.7139922734432;664.465105589995;681.5603935461698;8501.61742721579;9598.280128990353;9727.708168754949;9763.218942484584;9856.556454959544;598.6916737879995;639.2073828452778;641.9582727122722;656.566666000447;664.8504086580481;4695.154872123051;4706.10583989041;4710.411198600175;4710.858674239778;4722.5513576210205;103535;131833;140270.2986485061;158638;161100;122800;125330;127979;130041;130137;77571.2242877564;99981.50009250053;101594.4920275394;115259;118547.40726296313;9268.768280793034;10053.849192261976;10152.340097893613;10185;10255.33340332876;60977.39022609717;60991;61728;63824.68087659532;66375.66812165908;96965;98243;98852.50573747086;98995.50502247443;103818;12232.543162170936;12473.313967731861;12502.987571701677;12505.748505388483;12813.295268760308;14983.400663973754;15038.323275452412;15038.909152346938;15059.397624094914;15087.924560377129;13940.233287168898;14093.083949543658;14164.433422662978;14230.857691423367;14242.145471271757;13972.720545589234;13996;14010.579682609537;14028.719425611227;14404.783928240875;11538.538458461568;13400.128991615515;13537.864621353661;13798.93100534531;13946.79079813824;10992.505337260003;11536.219464194033;11617.825732613848;12021.338826364634;12187.329696866758;11666.75801043308;11741.706457338634;11927.46326415296;11950.880491194977;11972.281663100242 18:24:42 INFO - PROCESS | 2512 | __end_tp_report 18:24:42 INFO - PROCESS | 2512 | __start_cc_report 18:24:42 INFO - PROCESS | 2512 | _x_x_mozilla_cycle_collect,403 18:24:42 INFO - PROCESS | 2512 | __end_cc_report 18:24:42 INFO - PROCESS | 2512 | __startTimestamp1471310682198__endTimestamp 18:24:42 INFO - PROCESS | 2512 | 18:24:42 INFO - PROCESS | 2512 | ------- Summary: start ------- 18:24:42 INFO - PROCESS | 2512 | Number of tests: 6 18:24:42 INFO - PROCESS | 2512 | 18:24:42 INFO - PROCESS | 2512 | [#0] dojo.html Cycles:165 Average:5765.09 Median:6002.79 stddev:677.76 (11.3%) stddev-sans-first:653.30 18:24:42 INFO - PROCESS | 2512 | Values: 3371.1 3376.5 3383.4 3415.7 3432.2 5702.0 5812.8 5879.1 5881.1 5950.8 4765.7 5691.6 5792.7 5805.1 5902.4 4080.6 5147.3 5194.5 5261.8 5350.9 4417.6 5439.6 5467.8 5507.6 5515.7 4701.6 4925.5 5365.1 5376.7 5401.4 5340.8 5352.1 5359.3 5376.5 5416.6 5250.1 5264.0 5306.5 5314.1 5367.7 5702.7 5805.5 5838.6 5861.7 5959.1 6207.7 6219.7 6247.7 6286.6 6296.4 6298.9 6302.0 6322.6 6324.9 6333.4 4867.7 5957.5 6004.6 6049.7 6063.7 6298.6 6353.8 6360.4 6366.5 6377.1 6297.0 6304.6 6314.0 6329.5 6332.1 5175.0 5243.7 6189.4 6247.1 6318.2 4465.4 6216.5 6272.3 6275.5 6280.1 6200.0 6214.7 6268.1 6275.3 6282.2 4994.0 5016.4 5066.4 5122.3 5148.2 4504.4 4542.2 4564.7 4567.0 4595.5 5825.4 5919.7 5933.4 5936.2 5964.1 6169.8 6201.8 6247.2 6294.0 6317.7 5880.5 5882.4 5912.5 5940.4 5942.4 5524.3 5524.4 5526.6 5527.0 5543.4 6204.3 6230.0 6234.7 6366.8 6380.8 6231.5 6271.2 6285.7 6288.7 6294.3 6352.8 6390.9 6393.6 6403.6 6406.0 6133.8 6202.8 6225.2 6293.8 6313.7 6167.3 6284.1 6312.9 6314.4 6345.6 6144.4 6222.6 6226.9 6298.6 6302.2 5005.8 5007.6 5435.9 5844.4 6082.5 5096.6 6002.8 6117.1 6117.6 6154.2 5395.6 6219.3 6264.2 6287.4 6296.8 5916.6 6036.9 6102.8 6140.2 6187.0 18:24:42 INFO - PROCESS | 2512 | 18:24:42 INFO - PROCESS | 2512 | [#1] ext.html Cycles:180 Average:71046.76 Median:40070.10 stddev:157764.30 (393.7%) stddev-sans-first:158117.87 18:24:42 INFO - PROCESS | 2512 | Values: 466.3 477.9 496.7 526.0 530.7 38811.2 41867.5 41957.0 42005.4 42015.4 42857.1 43306.0 43345.7 43379.6 43447.6 8758.4 9654.6 9915.8 9917.8 9918.0 9831.5 9952.3 9961.7 9970.0 9992.1 9942.0 9973.9 9977.4 9978.6 10010.7 9866.0 9887.4 9893.7 9908.9 9929.7 7688.2 9291.6 9845.1 9872.8 9995.5 36820.6 36863.3 37031.0 37057.8 37279.3 2568.9 2965.3 3230.9 3335.1 3429.4 29609.9 29683.9 29941.9 31076.4 31771.2 3127.4 3178.7 3187.4 3191.1 3192.3 459589.0 459791.0 460587.0 462079.0 464316.7 33753.7 33971.0 34250.5 34290.0 34321.0 34169.8 34807.3 34993.5 35035.0 35482.6 16275.0 16663.1 16733.2 16742.2 16760.9 12843.4 12938.0 12942.7 12953.9 12959.4 19046.8 19079.2 19097.9 19101.0 19156.8 7967.1 8127.6 8144.5 8165.3 8213.5 880.4 915.2 984.5 1028.2 1043.8 29606.4 30251.4 30686.7 31015.8 31169.7 1011.3 1020.0 1062.1 1078.8 1095.9 16023.0 16037.0 16223.7 16226.2 16280.4 598605.0 619858.0 637691.3 678585.0 691229.0 60122.7 60317.1 60753.7 60877.7 61282.0 1351.1 1378.9 1393.2 1399.8 1403.2 29433.3 30976.0 31689.0 31957.0 32622.0 58161.7 58791.4 58922.4 59001.7 59032.1 636783.0 640472.0 643966.0 644679.0 645037.0 43899.3 44029.0 44096.6 44503.3 44558.8 48907.0 49728.0 49791.5 50465.7 50605.2 34339.8 40265.6 40363.6 41547.6 41846.8 39166.2 39981.6 40065.0 41270.6 41425.4 39295.4 39708.2 39991.0 40075.2 40224.2 31568.0 32934.1 35486.6 35906.9 36266.5 25931.2 25990.0 26240.0 26536.7 26681.2 18:24:42 INFO - PROCESS | 2512 | 18:24:42 INFO - PROCESS | 2512 | [#2] jquery.html Cycles:180 Average:35544.48 Median:2436.86 stddev:101544.14 (4167.0%) stddev-sans-first:101794.54 18:24:42 INFO - PROCESS | 2512 | Values: 315.6 343.2 358.4 364.6 393.0 20433.0 21671.6 21768.6 21827.8 22026.0 20180.7 20314.8 20589.3 20944.8 21541.4 5347.0 5524.6 5766.6 5933.9 5951.4 5855.9 5895.8 6007.2 6027.5 6058.1 5815.1 5837.1 5857.2 5865.4 5957.7 5062.1 5682.6 5759.4 5827.0 5841.5 5091.2 5110.9 5115.1 5127.5 5152.6 25641.4 25654.1 25747.4 25906.9 25928.7 2135.6 2419.1 2454.6 2644.0 2855.4 15443.7 15562.7 15945.7 15956.0 16486.4 1839.3 1920.4 1935.1 1942.4 1968.0 118492.4 120021.0 122582.0 122595.4 123067.0 10375.1 10459.7 10459.8 10524.8 10763.5 13375.0 13467.9 13488.3 13497.2 13507.7 7052.4 7106.7 8347.5 8585.8 8696.1 7605.2 8049.4 8717.5 8736.3 8966.4 5443.8 6232.8 6475.3 6594.6 6614.7 1866.7 1894.6 1909.8 1927.5 1946.6 872.3 888.0 935.7 981.8 1091.9 18767.8 20334.4 21141.0 21217.3 23981.8 778.8 924.8 941.3 951.7 1018.0 9755.5 11343.1 11779.5 11916.5 12008.2 601981.0 605206.0 605553.0 613898.0 621656.0 120523.0 122898.4 124111.8 125362.4 126660.0 967.9 974.4 1004.5 1009.0 1012.1 19592.7 19688.9 19788.8 19820.8 19978.1 52383.5 52605.0 53905.5 54312.7 54854.2 74692.0 74765.6 74913.6 75602.2 76556.6 7768.0 7950.0 8068.9 8102.3 8194.7 12291.9 13156.9 13256.4 13468.4 13502.7 11559.8 11707.5 11793.4 11842.9 11882.0 10910.8 11150.8 11399.6 11537.9 11668.2 11604.9 11610.6 11694.4 11825.6 11868.0 7265.1 7827.1 7944.5 7953.7 8038.7 10645.8 11318.7 11474.4 11635.3 11802.8 18:24:42 INFO - PROCESS | 2512 | 18:24:42 INFO - PROCESS | 2512 | [#3] mootools.html Cycles:180 Average:5730.45 Median:5139.82 stddev:3186.75 (62.0%) stddev-sans-first:3179.99 18:24:42 INFO - PROCESS | 2512 | Values: 1520.9 1550.9 1770.3 1778.6 1870.3 7851.0 8270.5 8498.0 8856.2 8871.6 8479.0 8726.2 8731.0 8739.4 8764.0 1977.4 2305.2 2347.3 2354.8 2359.7 2312.7 2331.4 2359.5 2362.7 2374.2 2357.4 2359.9 2364.0 2368.2 2375.5 2318.9 2324.8 2343.6 2349.8 2353.5 2344.6 2347.9 2349.6 2349.7 2352.8 8766.0 8876.6 8894.2 8926.9 8940.0 5211.4 5377.8 5379.3 5392.1 5393.6 3419.7 3503.3 3593.1 3620.9 3661.7 871.1 1030.9 1104.2 1109.6 1129.3 11293.3 11443.8 11462.3 11483.6 11485.9 4561.2 4740.5 4802.3 4808.4 4810.7 9781.5 9860.7 9884.0 9886.8 9893.6 4588.3 5331.4 5338.6 5347.9 5353.5 4392.1 4721.9 4888.3 4905.7 4905.8 3864.7 3927.4 4011.9 4042.2 4047.3 1108.8 1286.6 1295.4 1300.5 1310.5 786.3 825.6 884.8 965.5 992.8 5499.5 5675.6 6058.8 6244.3 6347.5 921.6 923.6 945.7 967.4 988.4 3429.7 4051.6 4132.3 4150.3 4184.4 10239.0 10689.1 10703.3 10713.6 10734.1 10707.0 10725.8 10726.0 10741.3 10750.6 8177.0 8275.0 8282.4 8293.0 8295.1 5141.3 5763.7 5860.8 6018.7 6132.3 9970.7 9989.0 10022.8 10052.6 10069.2 9608.6 10069.1 10091.1 10176.1 10210.4 6977.1 7360.0 7481.8 7527.9 7689.8 8424.3 8503.1 8513.4 8516.4 8517.4 7343.2 7509.8 7552.1 7632.7 7749.5 7307.6 7468.3 7483.7 7587.9 7605.7 6977.2 7123.8 7131.4 7160.8 7181.3 5018.4 5113.9 5122.8 5226.9 5245.4 5138.3 5231.8 5240.6 5243.8 5377.4 18:24:42 INFO - PROCESS | 2512 | 18:24:42 INFO - PROCESS | 2512 | [#4] prototype.html Cycles:180 Average:4608.55 Median:5002.37 stddev:1420.29 (28.4%) stddev-sans-first:1386.04 18:24:42 INFO - PROCESS | 2512 | Values: 247.1 292.5 306.9 323.2 333.2 5161.6 5402.6 5774.1 5866.7 5871.7 5576.3 5642.9 5647.8 5659.9 5672.9 3765.8 3825.6 4309.0 4395.8 4404.8 3520.4 4169.0 4229.7 4384.1 4399.6 3833.3 3858.8 4281.3 4336.2 4357.2 3965.1 3976.7 4295.7 4341.8 4353.3 3624.9 3764.4 3772.9 3783.7 3806.4 4552.5 5333.4 5480.5 5496.9 5544.8 4512.6 4597.0 4706.7 4942.8 5015.2 5833.9 5965.3 6063.8 6076.6 6098.7 3450.8 4049.1 4083.8 4093.5 4093.7 5512.8 5881.2 6360.8 6410.4 6418.5 4032.9 4159.6 4173.3 4180.7 4185.0 3659.6 3838.9 4109.7 4267.6 4293.5 4358.5 4470.6 4879.7 5001.2 5004.2 5599.8 5907.8 6024.3 6137.4 6168.4 1400.9 1440.3 1440.7 1444.1 1444.8 768.9 836.4 846.4 846.9 888.3 4363.6 4540.0 4629.5 4705.5 4799.6 4739.8 4752.6 5143.8 5204.6 5207.5 4217.6 4296.2 4424.4 4741.1 4747.7 2517.5 2618.5 2631.3 2761.7 2776.1 4909.6 4914.5 5087.6 5160.8 5336.1 4938.0 5147.7 5178.7 5281.6 5340.2 4597.4 5003.6 5328.6 5329.6 5338.7 4147.0 4987.4 5066.3 5117.2 5174.5 4325.0 4715.8 4717.9 5060.9 5138.5 4772.3 5228.3 5240.5 5246.4 5267.7 3578.9 3907.5 4101.6 4136.7 4231.7 5865.8 6035.5 6099.9 6309.9 6316.5 5730.5 5866.5 6063.2 6070.0 6089.5 5984.0 5989.7 6015.3 6026.2 6049.5 5575.5 5637.7 5888.2 5889.8 5931.2 5774.6 6018.6 6023.6 6031.4 6064.2 5658.9 5907.9 5925.3 5946.5 5959.6 18:24:42 INFO - PROCESS | 2512 | 18:24:42 INFO - PROCESS | 2512 | [#5] yui.html Cycles:180 Average:24794.55 Median:13176.35 stddev:39100.90 (296.8%) stddev-sans-first:39168.64 18:24:42 INFO - PROCESS | 2512 | Values: 673.9 684.7 779.0 799.5 829.9 12204.6 15713.7 15720.4 15724.2 15732.4 14243.1 14351.9 14354.6 14362.3 14366.9 669.3 827.1 829.9 864.9 869.7 813.5 844.8 854.1 860.2 863.6 823.7 871.4 908.3 917.4 921.2 882.8 892.0 899.9 907.9 912.2 672.0 676.4 681.3 690.0 690.3 15026.5 15079.9 15214.0 15219.8 15244.5 10378.6 14772.0 14836.5 14888.3 14936.2 12027.6 12099.3 12145.6 12152.2 12165.1 3550.5 3875.3 3904.1 3939.7 3963.1 100361.5 105275.0 120500.4 122012.0 122604.0 9273.0 9312.6 10955.6 11200.3 11473.1 22121.4 22522.8 22798.0 23130.9 23426.3 8141.8 8272.7 8278.0 8293.7 8316.3 4572.5 4572.8 4573.4 4582.4 4643.4 2926.4 3025.9 3529.4 3542.7 3562.6 623.0 635.8 636.7 641.7 690.2 612.2 633.4 642.7 664.5 681.6 8501.6 9598.3 9727.7 9763.2 9856.6 598.7 639.2 642.0 656.6 664.9 4695.2 4706.1 4710.4 4710.9 4722.6 103535.0 131833.0 140270.3 158638.0 161100.0 122800.0 125330.0 127979.0 130041.0 130137.0 77571.2 99981.5 101594.5 115259.0 118547.4 9268.8 10053.8 10152.3 10185.0 10255.3 60977.4 60991.0 61728.0 63824.7 66375.7 96965.0 98243.0 98852.5 98995.5 103818.0 12232.5 12473.3 12503.0 12505.7 12813.3 14983.4 15038.3 15038.9 15059.4 15087.9 13940.2 14093.1 14164.4 14230.9 14242.1 13972.7 13996.0 14010.6 14028.7 14404.8 11538.5 13400.1 13537.9 13798.9 13946.8 10992.5 11536.2 11617.8 12021.3 12187.3 11666.8 11741.7 11927.5 11950.9 11972.3 18:24:42 INFO - PROCESS | 2512 | -------- Summary: end -------- 18:24:42 INFO - PROCESS | 2512 | 18:24:42 INFO - TEST-INFO | 2512: exit 0 18:24:42 INFO - TEST-OK | dromaeo_css | took 1113199ms 18:24:42 INFO - TEST-START | kraken 18:24:42 INFO - operating with platform_type : mac_ 18:24:42 INFO - Initialising browser for kraken test... 18:24:42 INFO - TEST-INFO | started process 2516 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/tmp4w03QP/profile http://localhost:60241/getInfo.html) 18:24:45 INFO - PROCESS | 2516 | __metrics Screen width/height:1600/1200 18:24:45 INFO - PROCESS | 2516 | colorDepth:24 18:24:45 INFO - PROCESS | 2516 | Browser inner width/height: 1024/689 18:24:45 INFO - PROCESS | 2516 | __metrics 18:24:45 ERROR - PROCESS | 2516 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 18:24:46 INFO - TEST-INFO | 2516: exit 0 18:24:46 INFO - Browser initialized. 18:24:46 INFO - Running cycle 1/1 for kraken test... 18:24:46 INFO - TEST-INFO | started process 2518 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/tmp4w03QP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:24:58 INFO - PROCESS | 2518 | RSS: Main: 239476736 18:24:58 INFO - PROCESS | 2518 | 18:25:01 INFO - PROCESS | 2518 | Cycle 1(1): loaded http://localhost:60241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60241/tests/kraken/driver.html?testName=audio-beat-detection) 18:25:01 INFO - PROCESS | 2518 | RSS: Main: 252633088 18:25:01 INFO - PROCESS | 2518 | 18:25:04 INFO - PROCESS | 2518 | Cycle 1(1): loaded http://localhost:60241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60241/tests/kraken/driver.html?testName=audio-dft) 18:25:05 INFO - PROCESS | 2518 | RSS: Main: 261353472 18:25:05 INFO - PROCESS | 2518 | 18:25:08 INFO - PROCESS | 2518 | Cycle 1(1): loaded http://localhost:60241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60241/tests/kraken/driver.html?testName=audio-fft) 18:25:09 INFO - PROCESS | 2518 | RSS: Main: 264077312 18:25:09 INFO - PROCESS | 2518 | 18:25:11 INFO - PROCESS | 2518 | Cycle 1(1): loaded http://localhost:60241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60241/tests/kraken/driver.html?testName=audio-oscillator) 18:25:12 INFO - PROCESS | 2518 | RSS: Main: 266518528 18:25:12 INFO - PROCESS | 2518 | 18:25:14 INFO - PROCESS | 2518 | Cycle 1(1): loaded http://localhost:60241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:25:14 INFO - PROCESS | 2518 | RSS: Main: 267218944 18:25:14 INFO - PROCESS | 2518 | 18:25:17 INFO - PROCESS | 2518 | Cycle 1(1): loaded http://localhost:60241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60241/tests/kraken/driver.html?testName=imaging-darkroom) 18:25:18 INFO - PROCESS | 2518 | RSS: Main: 267788288 18:25:18 INFO - PROCESS | 2518 | 18:25:21 INFO - PROCESS | 2518 | Cycle 1(1): loaded http://localhost:60241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60241/tests/kraken/driver.html?testName=imaging-desaturate) 18:25:22 INFO - PROCESS | 2518 | RSS: Main: 268062720 18:25:22 INFO - PROCESS | 2518 | 18:25:24 INFO - PROCESS | 2518 | Cycle 1(1): loaded http://localhost:60241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60241/tests/kraken/driver.html?testName=json-parse-financial) 18:25:25 INFO - PROCESS | 2518 | RSS: Main: 268046336 18:25:25 INFO - PROCESS | 2518 | 18:25:26 INFO - PROCESS | 2518 | Cycle 1(1): loaded http://localhost:60241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:25:27 INFO - PROCESS | 2518 | RSS: Main: 267808768 18:25:27 INFO - PROCESS | 2518 | 18:25:29 INFO - PROCESS | 2518 | Cycle 1(1): loaded http://localhost:60241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60241/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:25:30 INFO - PROCESS | 2518 | RSS: Main: 267522048 18:25:30 INFO - PROCESS | 2518 | 18:25:32 INFO - PROCESS | 2518 | Cycle 1(1): loaded http://localhost:60241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:25:33 INFO - PROCESS | 2518 | RSS: Main: 267866112 18:25:33 INFO - PROCESS | 2518 | 18:25:36 INFO - PROCESS | 2518 | Cycle 1(1): loaded http://localhost:60241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:25:36 INFO - PROCESS | 2518 | RSS: Main: 267624448 18:25:36 INFO - PROCESS | 2518 | 18:25:39 INFO - PROCESS | 2518 | Cycle 1(1): loaded http://localhost:60241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:25:40 INFO - PROCESS | 2518 | RSS: Main: 268263424 18:25:40 INFO - PROCESS | 2518 | 18:25:42 INFO - PROCESS | 2518 | Cycle 1(1): loaded http://localhost:60241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60241/tests/kraken/driver.html?testName=ai-astar) 18:25:42 INFO - PROCESS | 2518 | RSS: Main: 269381632 18:25:42 INFO - PROCESS | 2518 | 18:25:42 INFO - PROCESS | 2518 | __start_tp_report 18:25:42 INFO - PROCESS | 2518 | _x_x_mozilla_page_load 18:25:42 INFO - PROCESS | 2518 | _x_x_mozilla_page_load_details 18:25:42 INFO - PROCESS | 2518 | |i|pagename|runs| 18:25:42 INFO - PROCESS | 2518 | |0;ai-astar;106;121;109;117;118;117;119;117;120;115 18:25:42 INFO - PROCESS | 2518 | |1;audio-beat-detection;152;112;135;174;146;125;123;112;164;99 18:25:42 INFO - PROCESS | 2518 | |2;audio-dft;195;201;207;249;250;273;214;189;271;278 18:25:42 INFO - PROCESS | 2518 | |3;audio-fft;75;88;81;150;59;61;58;61;135;60 18:25:42 INFO - PROCESS | 2518 | |4;audio-oscillator;71;75;136;73;73;78;115;71;74;117 18:25:42 INFO - PROCESS | 2518 | |5;imaging-gaussian-blur;81;123;135;88;76;105;136;128;88;85 18:25:42 INFO - PROCESS | 2518 | |6;imaging-darkroom;95;95;94;99;151;120;94;94;94;94 18:25:42 INFO - PROCESS | 2518 | |7;imaging-desaturate;108;96;92;91;94;93;91;93;92;91 18:25:42 INFO - PROCESS | 2518 | |8;json-parse-financial;55;56;61;57;54;61;56;54;57;59 18:25:42 INFO - PROCESS | 2518 | |9;json-stringify-tinderbox;80;103;106;107;114;77;71;69;68;68 18:25:42 INFO - PROCESS | 2518 | |10;stanford-crypto-aes;90;85;81;115;110;105;94;92;89;84 18:25:42 INFO - PROCESS | 2518 | |11;stanford-crypto-ccm;139;141;135;137;139;151;154;140;162;143 18:25:42 INFO - PROCESS | 2518 | |12;stanford-crypto-pbkdf2;168;171;170;166;172;168;179;169;171;168 18:25:42 INFO - PROCESS | 2518 | |13;stanford-crypto-sha256-iterative;71;68;70;67;70;66;72;93;91;87 18:25:42 INFO - PROCESS | 2518 | __end_tp_report 18:25:42 INFO - PROCESS | 2518 | __start_cc_report 18:25:42 INFO - PROCESS | 2518 | _x_x_mozilla_cycle_collect,1049 18:25:42 INFO - PROCESS | 2518 | __end_cc_report 18:25:42 INFO - PROCESS | 2518 | __startTimestamp1471310742310__endTimestamp 18:25:42 INFO - PROCESS | 2518 | 18:25:42 INFO - PROCESS | 2518 | ------- Summary: start ------- 18:25:42 INFO - PROCESS | 2518 | Number of tests: 14 18:25:42 INFO - PROCESS | 2518 | 18:25:42 INFO - PROCESS | 2518 | [#0] ai-astar Cycles:10 Average:115.90 Median:117.50 stddev:4.79 (4.1%) stddev-sans-first:3.50 18:25:42 INFO - PROCESS | 2518 | Values: 106.0 121.0 109.0 117.0 118.0 117.0 119.0 117.0 120.0 115.0 18:25:42 INFO - PROCESS | 2518 | 18:25:42 INFO - PROCESS | 2518 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:149.00 stddev:24.41 (16.4%) stddev-sans-first:25.03 18:25:42 INFO - PROCESS | 2518 | Values: 152.0 112.0 135.0 174.0 146.0 125.0 123.0 112.0 164.0 99.0 18:25:42 INFO - PROCESS | 2518 | 18:25:42 INFO - PROCESS | 2518 | [#2] audio-dft Cycles:10 Average:232.70 Median:249.50 stddev:35.05 (14.0%) stddev-sans-first:34.41 18:25:42 INFO - PROCESS | 2518 | Values: 195.0 201.0 207.0 249.0 250.0 273.0 214.0 189.0 271.0 278.0 18:25:42 INFO - PROCESS | 2518 | 18:25:42 INFO - PROCESS | 2518 | [#3] audio-fft Cycles:10 Average:82.80 Median:61.00 stddev:33.31 (54.6%) stddev-sans-first:35.21 18:25:42 INFO - PROCESS | 2518 | Values: 75.0 88.0 81.0 150.0 59.0 61.0 58.0 61.0 135.0 60.0 18:25:42 INFO - PROCESS | 2518 | 18:25:42 INFO - PROCESS | 2518 | [#4] audio-oscillator Cycles:10 Average:88.30 Median:73.00 stddev:24.42 (33.4%) stddev-sans-first:25.08 18:25:42 INFO - PROCESS | 2518 | Values: 71.0 75.0 136.0 73.0 73.0 78.0 115.0 71.0 74.0 117.0 18:25:42 INFO - PROCESS | 2518 | 18:25:42 INFO - PROCESS | 2518 | [#5] imaging-gaussian-blur Cycles:10 Average:104.50 Median:78.50 stddev:23.82 (30.3%) stddev-sans-first:23.70 18:25:42 INFO - PROCESS | 2518 | Values: 81.0 123.0 135.0 88.0 76.0 105.0 136.0 128.0 88.0 85.0 18:25:42 INFO - PROCESS | 2518 | 18:25:42 INFO - PROCESS | 2518 | [#6] imaging-darkroom Cycles:10 Average:103.00 Median:94.00 stddev:18.68 (19.9%) stddev-sans-first:19.59 18:25:42 INFO - PROCESS | 2518 | Values: 95.0 95.0 94.0 99.0 151.0 120.0 94.0 94.0 94.0 94.0 18:25:42 INFO - PROCESS | 2518 | 18:25:42 INFO - PROCESS | 2518 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:92.50 stddev:5.13 (5.5%) stddev-sans-first:1.67 18:25:42 INFO - PROCESS | 2518 | Values: 108.0 96.0 92.0 91.0 94.0 93.0 91.0 93.0 92.0 91.0 18:25:42 INFO - PROCESS | 2518 | 18:25:42 INFO - PROCESS | 2518 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.00 stddev:2.58 (4.5%) stddev-sans-first:2.64 18:25:42 INFO - PROCESS | 2518 | Values: 55.0 56.0 61.0 57.0 54.0 61.0 56.0 54.0 57.0 59.0 18:25:42 INFO - PROCESS | 2518 | 18:25:42 INFO - PROCESS | 2518 | [#9] json-stringify-tinderbox Cycles:10 Average:86.30 Median:68.50 stddev:18.83 (27.5%) stddev-sans-first:19.84 18:25:42 INFO - PROCESS | 2518 | Values: 80.0 103.0 106.0 107.0 114.0 77.0 71.0 69.0 68.0 68.0 18:25:42 INFO - PROCESS | 2518 | 18:25:42 INFO - PROCESS | 2518 | [#10] stanford-crypto-aes Cycles:10 Average:94.50 Median:87.00 stddev:11.60 (13.3%) stddev-sans-first:12.19 18:25:42 INFO - PROCESS | 2518 | Values: 90.0 85.0 81.0 115.0 110.0 105.0 94.0 92.0 89.0 84.0 18:25:42 INFO - PROCESS | 2518 | 18:25:42 INFO - PROCESS | 2518 | [#11] stanford-crypto-ccm Cycles:10 Average:144.10 Median:142.00 stddev:8.69 (6.1%) stddev-sans-first:9.01 18:25:42 INFO - PROCESS | 2518 | Values: 139.0 141.0 135.0 137.0 139.0 151.0 154.0 140.0 162.0 143.0 18:25:42 INFO - PROCESS | 2518 | 18:25:42 INFO - PROCESS | 2518 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.20 Median:170.50 stddev:3.58 (2.1%) stddev-sans-first:3.71 18:25:42 INFO - PROCESS | 2518 | Values: 168.0 171.0 170.0 166.0 172.0 168.0 179.0 169.0 171.0 168.0 18:25:42 INFO - PROCESS | 2518 | 18:25:42 INFO - PROCESS | 2518 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.50 Median:71.50 stddev:10.49 (14.7%) stddev-sans-first:11.00 18:25:42 INFO - PROCESS | 2518 | Values: 71.0 68.0 70.0 67.0 70.0 66.0 72.0 93.0 91.0 87.0 18:25:42 INFO - PROCESS | 2518 | -------- Summary: end -------- 18:25:42 INFO - PROCESS | 2518 | 18:25:43 INFO - TEST-INFO | 2518: exit 0 18:25:43 INFO - TEST-OK | kraken | took 60293ms 18:25:43 INFO - SUITE-END | took 1173s 18:25:43 INFO - Completed test suite (00:19:33) 18:25:43 INFO - javascript benchmark 18:25:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7433.860613375279, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3371.0729549373937, 3376.476646119849, 3383.407903616867, 3415.7438192135587, 3432.244906120654, 5701.9736447439445, 5812.796552120677, 5879.11813228016, 5881.147233651118, 5950.761969521214, 4765.714057156573, 5691.630044047144, 5792.739326730297, 5805.071188609823, 5902.409759024106, 4080.6327430531246, 5147.330846989886, 5194.480551944795, 5261.789528418878, 5350.91973620396, 4417.558244175589, 5439.619226654136, 5467.808626698066, 5507.614466987313, 5515.696636684981, 4701.623870090384, 4925.473103337977, 5365.114756065244, 5376.677399356051, 5401.405845357008, 5340.759665815048, 5352.143657014898, 5359.276497672803, 5376.542993845489, 5416.593755468316, 5250.05499010178, 5263.973680131575, 5306.495882891119, 5314.0700377433795, 5367.704776237305, 5702.686352250625, 5805.477507024388, 5838.620489668158, 5861.706914654293, 5959.0763431668165, 6207.689615519206, 6219.657918814463, 6247.718852651642, 6286.559940804145, 6296.401841825019, 6298.937010629927, 6302.0, 6322.589031712924, 6324.873502529924, 6333.366663333676, 4867.70793752376, 5957.463828255478, 6004.579679422399, 6049.667268300242, 6063.727132279014, 6298.559100862987, 6353.809385718436, 6360.363963603602, 6366.490680745529, 6377.1390862233, 6297.0, 6304.5586808922935, 6314.0, 6329.525285603506, 6332.081848131995, 5175.0, 5243.711595862188, 6189.412005859436, 6247.09417134522, 6318.178636777189, 4465.352523884018, 6216.471599913967, 6272.3100458949475, 6275.497960163176, 6280.089387038854, 6200.0, 6214.658193799384, 6268.122462855204, 6275.34108918557, 6282.183316168869, 4993.950060499348, 5016.372953380827, 5066.442691303953, 5122.282880396748, 5148.176291793295, 4504.391907092566, 4542.1824071667415, 4564.748938808398, 4566.954330456653, 4595.517470665532, 5825.446582574648, 5919.733611987471, 5933.406659334032, 5936.198613187251, 5964.075568286922, 6169.784057557964, 6201.844953876099, 6247.219097612799, 6293.968530157412, 6317.652529110943, 5880.529557635465, 5882.352941176553, 5912.526997840162, 5940.405959404025, 5942.37605051472, 5524.3370795504, 5524.4199359066715, 5526.557875369961, 5526.972365138148, 5543.417941116206, 6204.317525072239, 6229.968850155901, 6234.719437625408, 6366.808995730135, 6380.84047898797, 6231.501479881508, 6271.247450305992, 6285.717142728679, 6288.748450061947, 6294.339094395023, 6352.841178970378, 6390.90413643805, 6393.552451328363, 6403.583767055126, 6405.967970160119, 6133.785317513865, 6202.751889924352, 6225.190725205694, 6293.779717709858, 6313.715882785377, 6167.290761562478, 6284.057391391328, 6312.873742525216, 6314.368563143649, 6345.587536810092, 6144.385561443999, 6222.62664240147, 6226.875462490815, 6298.622082675054, 6302.180716506825, 5005.77474013663, 5007.649464537448, 5435.864103397446, 5844.444777746107, 6082.452579267887, 5096.566791822736, 6002.789902353396, 6117.096718007379, 6117.571769976059, 6154.230721159855, 5395.568354531707, 6219.346968568235, 6264.21697287839, 6287.402696743802, 6296.779612713533, 5916.55625828056, 6036.9094463582205, 6102.816915492543, 6140.1710769047395, 6187.0], "value": 5724.899433531718, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.29356524864835, 477.8948631301113, 496.6821234409976, 525.9979738597971, 530.7160669042063, 38811.22377552447, 41867.48795072298, 41957.0, 42005.369919451194, 42015.369769453406, 42857.14285714284, 43306.0, 43345.6996290111, 43379.56620433795, 43447.56552434475, 8758.386912916098, 9654.565544550494, 9915.801683966316, 9917.75205619858, 9917.950410247939, 9831.459269740162, 9952.253580981456, 9961.701148965543, 9969.950150249239, 9992.100710936014, 9942.0, 9973.850392244121, 9977.401355918668, 9978.600855965753, 10010.749731256705, 9865.999999999964, 9887.357321774098, 9893.703188904345, 9908.90091099087, 9929.65246216379, 7688.231176882323, 9291.628334866597, 9845.113939745457, 9872.802543949152, 9995.500224988722, 36820.63179368199, 36863.262734745156, 37031.0, 37057.81471092627, 37279.25441491182, 2568.9082140090572, 2965.303153758865, 3230.935381292361, 3335.0995231287416, 3429.416999110157, 29609.851950740325, 29683.851580742175, 29941.850290748625, 31076.378472430424, 31771.205719856956, 3127.390158919012, 3178.713915747571, 3187.378461200067, 3191.12244132863, 3192.2817366092677, 459589.0, 459791.0, 460587.0, 462079.0, 464316.67841660575, 33753.662463375054, 33970.98087057392, 34250.48624270638, 34290.0, 34321.0, 34169.82915085458, 34807.30385392278, 34993.475097873554, 35035.0, 35482.64517354845, 16275.0, 16663.0835304057, 16733.247003884855, 16742.162891855358, 16760.916195418944, 12843.357832108544, 12938.029647776266, 12942.676433089247, 12953.935230323788, 12959.416826242654, 19046.809531904782, 19079.236830526625, 19097.904510477358, 19101.0, 19156.808431915782, 7967.123616402191, 8127.634256458474, 8144.470609410369, 8165.305948994402, 8213.548254845922, 880.3749337970113, 915.2037727177399, 984.4585477987079, 1028.1671845804922, 1043.8225501664735, 29606.407871842443, 30251.394972100436, 30686.693133068384, 31015.759369625415, 31169.68830311668, 1011.2971484817981, 1019.9694009179588, 1062.0866055192528, 1078.7680648660576, 1095.8630171228597, 16023.0, 16037.0, 16223.675526489404, 16226.188690565425, 16280.43018494347, 598605.0, 619858.0, 637691.2885889264, 678585.0, 691229.0, 60122.69938650279, 60317.095243571384, 60753.69623151856, 60877.69561152166, 61282.0, 1351.0812647399862, 1378.8896888248917, 1393.2197969137314, 1399.8180236569385, 1403.1791402029926, 29433.264168395963, 30976.0, 31689.0, 31957.0, 32622.045592978284, 58161.709191453774, 58791.4120858786, 58922.410775891694, 59001.70499147477, 59032.1145182814, 636783.0, 640472.0, 643966.0, 644679.0, 645037.0, 43899.34150987674, 44029.0, 44096.55903441053, 44503.33245001392, 44558.77720611376, 48907.0, 49728.0, 49791.50208497869, 50465.74767126288, 50605.24092138695, 34339.79810706613, 40265.59734402619, 40363.596364035984, 41547.58452415437, 41846.790766045975, 39166.24290827902, 39981.600183998955, 40065.0, 41270.58729412667, 41425.37861932013, 39295.41056884206, 39708.205835883695, 39991.0, 40075.198496029334, 40224.1955160901, 31568.0, 32934.05989101654, 35486.64513354937, 35906.92279231627, 36266.4560031605, 25931.22206333813, 25990.0, 26239.95040198447, 26536.734632653428, 26681.19956401311], "value": 19981.982813500766, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.61179748908836, 343.178088478095, 358.3907357492264, 364.62261559286134, 392.952845658521, 20432.99999999998, 21671.56656866862, 21768.564628707416, 21827.799471029088, 22026.0, 20180.697289540632, 20314.781113133224, 20589.27937522187, 20944.790552094473, 21541.353759387206, 5346.973265133669, 5524.640898341615, 5766.596338256324, 5933.940660593382, 5951.434613711691, 5855.912161317584, 5895.764169433218, 6007.249093863267, 6027.5479339049525, 6058.091286307045, 5815.127730840365, 5837.09525023622, 5857.150713146591, 5865.413458654143, 5957.731902064395, 5062.139436295838, 5682.630629009122, 5759.439330711041, 5827.038538641119, 5841.503472204868, 5091.159958606825, 5110.897782044375, 5115.053715062725, 5127.53852153308, 5152.639315247934, 25641.35896602581, 25654.102106426373, 25747.356316092246, 25906.870465647553, 25928.740712592822, 2135.562209746998, 2419.129113519132, 2454.5949918263464, 2643.960340594893, 2855.4431885782283, 15443.691126177526, 15562.688746225125, 15945.681086378323, 15956.0, 16486.422975195812, 1839.2826797548967, 1920.4142736465371, 1935.138863205874, 1942.4269840397117, 1967.980320196794, 118492.40753796262, 120021.0, 122582.0, 122595.38702306521, 123067.0, 10375.118114960162, 10459.738506537398, 10459.790804183875, 10524.842127368096, 10763.515641796137, 13375.0, 13467.86532134666, 13488.258145802076, 13497.190168589916, 13507.662308442368, 7052.400545953549, 7106.680199391039, 8347.54088525137, 8585.82828343442, 8696.086910874394, 7605.201453847377, 8049.436539442183, 8717.520536370434, 8736.257418119403, 8966.372353935161, 5443.836684899459, 6232.781852635136, 6475.287718350977, 6594.641484139398, 6614.7023383947835, 1866.7479890214647, 1894.5547796267865, 1909.8472122230467, 1927.4795805132535, 1946.639871623754, 872.2716531696104, 887.973360799177, 935.7052528453515, 981.842905135175, 1091.946271847671, 18767.812321876605, 20334.389968300973, 21141.0, 21217.322090391324, 23981.760182398302, 778.7741554949001, 924.7688077980505, 941.2517048946104, 951.7477868364889, 1017.9847302290472, 9755.463449510346, 11343.149263805248, 11779.528818847322, 11916.52333906634, 12008.159428839897, 601981.0, 605206.0, 605553.0, 613898.0, 621656.0, 120523.0, 122898.3855080719, 124111.75888241002, 125362.3731881353, 126660.0, 967.9032096790405, 974.4299584742863, 1004.467632154959, 1008.9798204035878, 1012.1396812709138, 19592.706109408085, 19688.901555492703, 19788.802111979272, 19820.801791982474, 19978.10098545598, 52383.476165239386, 52605.0, 53905.46094539004, 54312.65498760169, 54854.177187341425, 74692.0, 74765.62617186879, 74913.6254318725, 75602.24397755953, 76556.61721691355, 7767.961160194162, 7950.0, 8068.878966815385, 8102.298517311195, 8194.67221311141, 12291.877081229073, 13156.934215328862, 13256.403461844047, 13468.393922273326, 13502.662433439242, 11559.826602601135, 11707.473163707484, 11793.41032948332, 11842.881571184178, 11881.990030847475, 10910.781784364426, 11150.832737509107, 11399.601013964471, 11537.884621154017, 11668.183227174355, 11604.883951160718, 11610.606727192791, 11694.415279235835, 11825.586104486301, 11868.0, 7265.09186351706, 7827.139014708491, 7944.483608565425, 7953.6818527258265, 8038.67845286182, 10645.787084258427, 11318.660440186808, 11474.368909710047, 11635.301881887113, 11802.82295765547], "value": 9786.353609229995, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1520.8555187257207, 1550.906945583265, 1770.3449723602268, 1778.5731424458133, 1870.2986380107452, 7850.960745196266, 8270.545120018403, 8498.0, 8856.158664926837, 8871.55642217889, 8479.024912135106, 8726.1710137537, 8731.0, 8739.431936924095, 8764.03595604483, 1977.3968939473455, 2305.170138750049, 2347.272345572869, 2354.776296251862, 2359.6696462495265, 2312.7340355859124, 2331.3588763090115, 2359.528094381122, 2362.681038059857, 2374.180907586888, 2357.363511851799, 2359.8938047787806, 2363.9881800590974, 2368.159303447277, 2375.5011447596025, 2318.8840557972203, 2324.8488848224897, 2343.61330380487, 2349.7767712067325, 2353.5410594933996, 2344.601417758985, 2347.9060837566476, 2349.5770761262966, 2349.6945397098266, 2352.752960939094, 8766.0, 8876.556172191365, 8894.155055269805, 8926.86609700855, 8940.016598174196, 5211.400688920785, 5377.8117765878005, 5379.300690910196, 5392.05639013175, 5393.622446428752, 3419.6580341965605, 3503.334366470388, 3593.0658028912408, 3620.9094772630633, 3661.7070634349457, 871.0752069157516, 1030.855680204772, 1104.221523825709, 1109.5894519027931, 1129.2941911305434, 11293.265937714104, 11443.828342574869, 11462.312261264351, 11483.598074067451, 11485.942570287096, 4561.2245918193985, 4740.506740376839, 4802.327674125625, 4808.3989501312335, 4810.687305325143, 9781.46201958885, 9860.654877079267, 9884.011598840203, 9886.752831179134, 9893.604255829687, 4588.311753237042, 5331.44019877915, 5338.599605029561, 5347.919781203285, 5353.491418315254, 4392.099619577979, 4721.905561888743, 4888.266759986031, 4905.730184839868, 4905.779239934212, 3864.6908247340143, 3927.4108883667677, 4011.8796436106963, 4042.171354872244, 4047.332190188586, 1108.8170451875512, 1286.5561381323428, 1295.371744703818, 1300.5253082624774, 1310.541310541303, 786.3080489169608, 825.5665775467927, 884.8320217313213, 965.4641673870929, 992.7964767222702, 5499.450054994549, 5675.574331925122, 6058.818235452944, 6244.250689917239, 6347.492200623939, 921.6083164654995, 923.5890028937058, 945.6690158444627, 967.351874244258, 988.3970777825521, 3429.7084747796716, 4051.6353528182603, 4132.318167502389, 4150.335946248586, 4184.4141820145205, 10239.0, 10689.144868410664, 10703.304285221435, 10713.625023124154, 10734.087602553715, 10706.982836630508, 10725.78548429027, 10726.0, 10741.301815381976, 10750.569977200825, 8176.959115204505, 8274.958625206957, 8282.378821588405, 8292.958535207285, 8295.129011453831, 5141.331626888481, 5763.7118144093465, 5860.765569377178, 6018.729157188025, 6132.325444201224, 9970.700878973643, 9988.950055249677, 10022.849657255292, 10052.648157314752, 10069.194464442973, 9608.567614457226, 10069.093781559695, 10091.091801737879, 10176.135028522362, 10210.438425886647, 6977.058097157022, 7360.043194384696, 7481.812954676177, 7527.88708169367, 7689.769306920802, 8424.326053915795, 8503.149685031447, 8513.36149788756, 8516.361272904433, 8517.44636598619, 7343.192248852515, 7509.774706758806, 7552.131504877009, 7632.694692212472, 7749.496282741829, 7307.634618269171, 7468.3278504934815, 7483.700651974078, 7587.924120758943, 7605.733799316998, 6977.232504424408, 7123.82190445243, 7131.393831524171, 7160.785176444715, 7181.317774811385, 5018.42288136869, 5113.8977220454635, 5122.8207012755865, 5226.921596175985, 5245.423003469692, 5138.3063286457345, 5231.843044708513, 5240.554552863049, 5243.764030618555, 5377.408485066561], "value": 4607.905063132556, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [247.1251768738665, 292.549473810332, 306.87724910035996, 323.18718423165734, 333.18369993515876, 5161.587073034158, 5402.621816472849, 5774.105013722874, 5866.677332746703, 5871.7100330871, 5576.27135587968, 5642.858928526779, 5647.802326918559, 5659.8585035374135, 5672.858178545538, 3765.811709414532, 3825.5791862895057, 4308.956910430887, 4395.758233297167, 4404.8017839197155, 3520.366334059868, 4168.958310416887, 4229.682773791963, 4384.101259241864, 4399.626031787302, 3833.3483307837732, 3858.82635281413, 4281.293586558214, 4336.21948049351, 4357.150355680644, 3965.147493288957, 3976.681865450757, 4295.742255464682, 4341.804618792162, 4353.325234588644, 3624.930645459596, 3764.3976963685677, 3772.9248913097686, 3783.6946253542483, 3806.4480650305827, 4552.52198519154, 5333.439988801198, 5480.451954804527, 5496.945030549683, 5544.750486228129, 4512.593866551993, 4596.954030459686, 4706.717596944194, 4942.827001054946, 5015.22264049073, 5833.854153646151, 5965.313988891289, 6063.757449702007, 6076.605020673642, 6098.664573448458, 3450.8447119879415, 4049.104890003632, 4083.795810209507, 4093.4678491796176, 4093.713440059197, 5512.779488820443, 5881.2356293112325, 6360.7737291947915, 6410.391012853818, 6418.518611104186, 4032.91934161321, 4159.563245859141, 4173.332266837291, 4180.728252663567, 4184.99120422199, 3659.597444281127, 3838.8848334550007, 4109.705357901001, 4267.5732426757695, 4293.549177336335, 4358.5205627380965, 4470.5976462117915, 4879.731614761222, 5001.174806156943, 5004.199328107486, 5599.776008959678, 5907.763689452374, 6024.313192306161, 6137.355577664281, 6168.383161683796, 1400.8669176428223, 1440.2510694438834, 1440.7478691228994, 1444.1154293646682, 1444.8193975753031, 768.9000429944072, 836.4354061008795, 846.4371193156481, 846.886344457037, 888.2760550151605, 4363.585459381354, 4540.0, 4629.513901040342, 4705.4588722296685, 4799.592289474443, 4739.795994862406, 4752.645496033683, 5143.8199663012365, 5204.583633309327, 5207.531322181022, 4217.641500472494, 4296.2266791977745, 4424.354906304287, 4741.146593613183, 4747.691400058985, 2517.5342561626157, 2618.5254934087484, 2631.2502186046063, 2761.743406749924, 2776.1255204610484, 4909.631777616693, 4914.533119353656, 5087.618428617869, 5160.780864228418, 5336.132353676182, 4937.950620493749, 5147.742612869341, 5178.741062946838, 5281.60387970896, 5340.172273297645, 4597.448306203277, 5003.574696150868, 5328.573714102862, 5329.600279979017, 5338.679679219337, 4147.0461793787, 4987.351644286219, 5066.290719299374, 5117.162128403697, 5174.482551744795, 4324.9783751082305, 4715.787789549547, 4717.9056418872115, 5060.898782024413, 5138.511841375063, 4772.305831429792, 5228.2617928181535, 5240.536947634606, 5246.42289348179, 5267.73661316925, 3578.9105272368397, 3907.492026036597, 4101.630853223224, 4136.669066474615, 4231.672580080882, 5865.824025279248, 6035.460957455821, 6099.889056581087, 6309.873802524015, 6316.463100636497, 5730.541556675373, 5866.472017518444, 6063.242094738158, 6069.969650151721, 6089.451949324582, 5983.965451746427, 5989.670568118795, 6015.293118096786, 6026.15633811258, 6049.546284028804, 5575.498205161555, 5637.746301416364, 5888.17565540816, 5889.823305300848, 5931.1992880960515, 5774.624649397776, 6018.608790428608, 6023.6385816851125, 6031.396860313934, 6064.211652485149, 5658.85852853682, 5907.881842363215, 5925.259342582177, 5946.524278057832, 5959.553033522417], "value": 4149.181940291265, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.9460843132549, 684.6747794797469, 778.9639779093806, 799.5322736199323, 829.9087100418955, 12204.633860984162, 15713.742900567955, 15720.37118515261, 15724.213789310517, 15732.449364272254, 14243.14541127533, 14351.856481435183, 14354.641133971656, 14362.28188590569, 14366.856331436682, 669.2571245917028, 827.1191181391813, 829.9377546683993, 864.8918885139358, 869.7347309070731, 813.4828544764032, 844.8310337932407, 854.1415877043562, 860.1785295043219, 863.5552690364436, 823.6697733160962, 871.4205053639322, 908.2597682888457, 917.4311926605513, 921.1663444582664, 882.7748924024397, 892.0321451225428, 899.9010108888017, 907.8683590879318, 912.1881525442361, 672.0322735261257, 676.364217635426, 681.2710399872138, 690.023616582535, 690.3234829866759, 15026.549203523911, 15079.924600377037, 15214.0, 15219.771703424458, 15244.466443674419, 10378.584856605727, 14772.0, 14836.480723174745, 14888.330025148894, 14936.178510181935, 12027.579034733742, 12099.334536600483, 12145.635630931087, 12152.21010634306, 12165.087618428654, 3550.5384300041087, 3875.2830726315724, 3904.1020565270146, 3939.72421930465, 3963.147923196527, 100361.4945775814, 105275.0, 120500.39749801283, 122012.0, 122604.0, 9272.953635231916, 9312.580933857993, 10955.616553420752, 11200.271982321123, 11473.139514536444, 22121.446963826034, 22522.774772252396, 22798.0, 23130.884345578164, 23426.297211083696, 8141.837163256701, 8272.669093236324, 8277.958610207032, 8293.668253269921, 8316.293115085286, 4572.542745725401, 4572.817087316536, 4573.359729637853, 4582.381378513858, 4643.419572553431, 2926.400087982001, 3025.8638361273797, 3529.417646088418, 3542.6634469725336, 3562.6437356264164, 622.9906551401733, 635.8251480842805, 636.6752955992384, 641.7400952614199, 690.2200513419904, 612.2285919741158, 633.3729607688448, 642.7139922734432, 664.465105589995, 681.5603935461698, 8501.61742721579, 9598.280128990353, 9727.708168754949, 9763.218942484584, 9856.556454959544, 598.6916737879995, 639.2073828452778, 641.9582727122722, 656.566666000447, 664.8504086580481, 4695.154872123051, 4706.10583989041, 4710.411198600175, 4710.858674239778, 4722.5513576210205, 103535.0, 131833.0, 140270.2986485061, 158638.0, 161100.0, 122800.0, 125330.0, 127979.0, 130041.0, 130137.0, 77571.2242877564, 99981.50009250053, 101594.4920275394, 115259.0, 118547.40726296313, 9268.768280793034, 10053.849192261976, 10152.340097893613, 10185.0, 10255.33340332876, 60977.39022609717, 60991.0, 61728.0, 63824.68087659532, 66375.66812165908, 96965.0, 98243.0, 98852.50573747086, 98995.50502247443, 103818.0, 12232.543162170936, 12473.313967731861, 12502.987571701677, 12505.748505388483, 12813.295268760308, 14983.400663973754, 15038.323275452412, 15038.909152346938, 15059.397624094914, 15087.924560377129, 13940.233287168898, 14093.083949543658, 14164.433422662978, 14230.857691423367, 14242.145471271757, 13972.720545589234, 13996.0, 14010.579682609537, 14028.719425611227, 14404.783928240875, 11538.538458461568, 13400.128991615515, 13537.864621353661, 13798.93100534531, 13946.79079813824, 10992.505337260003, 11536.219464194033, 11617.825732613848, 12021.338826364634, 12187.329696866758, 11666.75801043308, 11741.706457338634, 11927.46326415296, 11950.880491194977, 11972.281663100242], "value": 7884.0195896523965, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1583.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 121.0, 109.0, 117.0, 118.0, 117.0, 119.0, 117.0, 120.0, 115.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 112.0, 135.0, 174.0, 146.0, 125.0, 123.0, 112.0, 164.0, 99.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 201.0, 207.0, 249.0, 250.0, 273.0, 214.0, 189.0, 271.0, 278.0], "value": 232.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 88.0, 81.0, 150.0, 59.0, 61.0, 58.0, 61.0, 135.0, 60.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 75.0, 136.0, 73.0, 73.0, 78.0, 115.0, 71.0, 74.0, 117.0], "value": 88.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 123.0, 135.0, 88.0, 76.0, 105.0, 136.0, 128.0, 88.0, 85.0], "value": 104.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 99.0, 151.0, 120.0, 94.0, 94.0, 94.0, 94.0], "value": 103.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 96.0, 92.0, 91.0, 94.0, 93.0, 91.0, 93.0, 92.0, 91.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 61.0, 57.0, 54.0, 61.0, 56.0, 54.0, 57.0, 59.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 103.0, 106.0, 107.0, 114.0, 77.0, 71.0, 69.0, 68.0, 68.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 85.0, 81.0, 115.0, 110.0, 105.0, 94.0, 92.0, 89.0, 84.0], "value": 94.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 141.0, 135.0, 137.0, 139.0, 151.0, 154.0, 140.0, 162.0, 143.0], "value": 144.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 171.0, 170.0, 166.0, 172.0, 168.0, 179.0, 169.0, 171.0, 168.0], "value": 170.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 70.0, 67.0, 70.0, 66.0, 72.0, 93.0, 91.0, 87.0], "value": 75.5, "unit": "score"}]}]} 18:25:43 INFO - Return code: 0 18:25:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:25:43 ERROR - # TBPL SUCCESS # 18:25:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:25:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:25:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:25:43 INFO - 2016-08-15 18:25:43.611 screenresolution[2523:32486] starting screenresolution argv=screenresolution get 18:25:43 INFO - 2016-08-15 18:25:43.613 screenresolution[2523:32486] Display 0: 1600x1200x32@60 18:25:43 INFO - 2016-08-15 18:25:43.619 screenresolution[2524:32489] starting screenresolution argv=screenresolution list 18:25:43 INFO - Available Modes on Display 0 18:25:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:25:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:25:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:25:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:25:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:25:43 INFO - Intel Iris: 18:25:43 INFO - Chipset Model: Intel Iris 18:25:43 INFO - Type: GPU 18:25:43 INFO - Bus: Built-In 18:25:43 INFO - VRAM (Dynamic, Max): 1536 MB 18:25:43 INFO - Vendor: Intel (0x8086) 18:25:43 INFO - Device ID: 0x0a2e 18:25:43 INFO - Revision ID: 0x0009 18:25:43 INFO - Displays: 18:25:43 INFO - Display: 18:25:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:25:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:25:43 INFO - Display Serial Number: 1600x1200 60 18:25:43 INFO - Main Display: Yes 18:25:43 INFO - Mirror: Off 18:25:43 INFO - Online: Yes 18:25:43 INFO - Rotation: Supported 18:25:43 INFO - Return code: 0 18:25:43 INFO - Running post-action listener: _resource_record_post_action 18:25:43 INFO - [mozharness: 2016-08-16 01:25:43.852698Z] Finished run-tests step (success) 18:25:43 INFO - Running post-run listener: _resource_record_post_run 18:25:43 INFO - Total resource usage - Wall time: 1208s; CPU: 55.0%; Read bytes: 278528; Write bytes: 710217728; Read time: 2; Write time: 2085 18:25:43 INFO - TinderboxPrint: CPU usage
54.6% 18:25:43 INFO - TinderboxPrint: I/O read bytes / time
278,528 / 2 18:25:43 INFO - TinderboxPrint: I/O write bytes / time
710,217,728 / 2,085 18:25:43 INFO - TinderboxPrint: CPU idle
2,193.6 (45.4%) 18:25:43 INFO - TinderboxPrint: CPU system
979.7 (20.3%) 18:25:43 INFO - TinderboxPrint: CPU user
1,660.4 (34.4%) 18:25:43 INFO - TinderboxPrint: Swap in / out
404,492,288 / 0 18:25:43 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 400204288; Write bytes: 396679168; Read time: 29892; Write time: 871 18:25:43 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 233472; Write bytes: 299558912; Read time: 1; Write time: 1172 18:25:44 INFO - Running post-run listener: _upload_blobber_files 18:25:44 INFO - Blob upload gear active. 18:25:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:25:44 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:25:44 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:25:44 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:25:44 INFO - (blobuploader) - INFO - Open directory for files ... 18:25:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:25:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:25:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:25:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:25:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:25:45 INFO - (blobuploader) - INFO - Done attempting. 18:25:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:25:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:25:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:25:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:25:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:25:46 INFO - (blobuploader) - INFO - Done attempting. 18:25:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:25:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:25:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:25:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:25:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:25:48 INFO - (blobuploader) - INFO - Done attempting. 18:25:48 INFO - (blobuploader) - INFO - Iteration through files over. 18:25:48 INFO - Return code: 0 18:25:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:25:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:25:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fdff738ab6727daa8c87658eefd2078f95a9b982d651e7762769de418d274311917552b11b96c4ded551897e47e5157f98b7284ecefbfc2ee9939bb3cb726182", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2950defe4337aab04c9e2027ef949fa397303e27a3372163edb26fa56dcf3cd0912485f3b23c2a452de73f1df2d394881a4babe3b134d31ff88cdfd82f7c4521", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71a82efe50b3f90d966cbdd7532126585fc9b2b093f8f45f454f8b42cd06d7f002a580107bdb9b1003370b47f480576c6a793599eb85815ee9745b8410398917"} 18:25:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:25:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:25:48 INFO - Contents: 18:25:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fdff738ab6727daa8c87658eefd2078f95a9b982d651e7762769de418d274311917552b11b96c4ded551897e47e5157f98b7284ecefbfc2ee9939bb3cb726182", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2950defe4337aab04c9e2027ef949fa397303e27a3372163edb26fa56dcf3cd0912485f3b23c2a452de73f1df2d394881a4babe3b134d31ff88cdfd82f7c4521", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71a82efe50b3f90d966cbdd7532126585fc9b2b093f8f45f454f8b42cd06d7f002a580107bdb9b1003370b47f480576c6a793599eb85815ee9745b8410398917"} 18:25:48 INFO - Running post-run listener: copy_logs_to_upload_dir 18:25:48 INFO - Copying logs to upload dir... 18:25:48 INFO - mkdir: /builds/slave/test/build/upload/logs 18:25:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.837850 ========= master_lag: 1.86 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-08-15 18:25:50.603029) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 5 secs) (at 2016-08-15 18:25:50.604124) ========= 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.vxjFhjkf9E/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.clzN5gpKiq/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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/fdff738ab6727daa8c87658eefd2078f95a9b982d651e7762769de418d274311917552b11b96c4ded551897e47e5157f98b7284ecefbfc2ee9939bb3cb726182", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2950defe4337aab04c9e2027ef949fa397303e27a3372163edb26fa56dcf3cd0912485f3b23c2a452de73f1df2d394881a4babe3b134d31ff88cdfd82f7c4521", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71a82efe50b3f90d966cbdd7532126585fc9b2b093f8f45f454f8b42cd06d7f002a580107bdb9b1003370b47f480576c6a793599eb85815ee9745b8410398917"} build_url:https://queue.taskcluster.net/v1/task/GQK2wVtsQEySu7dndY03lA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/GQK2wVtsQEySu7dndY03lA/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/fdff738ab6727daa8c87658eefd2078f95a9b982d651e7762769de418d274311917552b11b96c4ded551897e47e5157f98b7284ecefbfc2ee9939bb3cb726182", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2950defe4337aab04c9e2027ef949fa397303e27a3372163edb26fa56dcf3cd0912485f3b23c2a452de73f1df2d394881a4babe3b134d31ff88cdfd82f7c4521", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71a82efe50b3f90d966cbdd7532126585fc9b2b093f8f45f454f8b42cd06d7f002a580107bdb9b1003370b47f480576c6a793599eb85815ee9745b8410398917"}' ========= master_lag: 5.38 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 5 secs) (at 2016-08-15 18:25:55.994297) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-08-15 18:25:55.998830) ========= 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.vxjFhjkf9E/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.clzN5gpKiq/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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.005132 ========= master_lag: 1.30 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-08-15 18:25:57.308454) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 18:25:57.313021) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 18:25:57.325605) ========= ========= Total master_lag: 9.31 =========