builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0013 starttime: 1472042136.23 results: success (0) buildid: 20160824030337 builduid: c5f9edaf64374c3f9f1b9947a91d9334 revision: bd7645928990649c84609d3f531e803c2d41f269 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 05:35:36.232584) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 05:35:36.233083) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 05:35:36.233362) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 05:35:36.259701) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 05:35:36.260154) ========= 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.ewV8CiXKCH/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.AFQPQaJPMF/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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-24 05:35:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 190M=0s 2016-08-24 05:35:36 (190 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.141194 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 05:35:36.424950) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 05:35:36.425340) ========= 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.ewV8CiXKCH/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.AFQPQaJPMF/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.028678 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 05:35:36.474700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-24 05:35:36.475090) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bd7645928990649c84609d3f531e803c2d41f269 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev bd7645928990649c84609d3f531e803c2d41f269 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ewV8CiXKCH/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.AFQPQaJPMF/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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-24 05:35:36,549 truncating revision to first 12 chars 2016-08-24 05:35:36,549 Setting DEBUG logging. 2016-08-24 05:35:36,549 attempt 1/10 2016-08-24 05:35:36,549 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bd7645928990?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-24 05:35:37,616 unpacking tar archive at: mozilla-central-bd7645928990/testing/mozharness/ program finished with exit code 0 elapsedTime=1.314320 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-24 05:35:37.812369) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 05:35:37.812911) ========= script_repo_revision: bd7645928990649c84609d3f531e803c2d41f269 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 05:35:37.813571) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 05:35:37.814107) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 05:35:37.834603) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-24 05:35:37.835267) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ewV8CiXKCH/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.AFQPQaJPMF/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 05:35:38 INFO - MultiFileLogger online at 20160824 05:35:38 in /builds/slave/test 05:35:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:35:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:35:38 INFO - {'append_to_log': False, 05:35:38 INFO - 'base_work_dir': '/builds/slave/test', 05:35:38 INFO - 'blob_upload_branch': 'Firefox', 05:35:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:35:38 INFO - 'branch': 'Firefox', 05:35:38 INFO - 'buildbot_json_path': 'buildprops.json', 05:35:38 INFO - 'config_files': ('talos/mac_config.py',), 05:35:38 INFO - 'default_actions': ('clobber', 05:35:38 INFO - 'read-buildbot-config', 05:35:38 INFO - 'download-and-extract', 05:35:38 INFO - 'populate-webroot', 05:35:38 INFO - 'create-virtualenv', 05:35:38 INFO - 'install', 05:35:38 INFO - 'run-tests'), 05:35:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:35:38 INFO - 'download_minidump_stackwalk': True, 05:35:38 INFO - 'download_symbols': 'ondemand', 05:35:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:35:38 INFO - 'tooltool.py': '/tools/tooltool.py', 05:35:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:35:38 INFO - '/tools/misc-python/virtualenv.py')}, 05:35:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:35:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:35:38 INFO - 'installer_path': 'installer.exe', 05:35:38 INFO - 'log_level': 'info', 05:35:38 INFO - 'log_name': 'talos', 05:35:38 INFO - 'log_to_console': True, 05:35:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:35:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:35:38 INFO - 'opt_config_files': (), 05:35:38 INFO - 'pip_index': False, 05:35:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:35:38 INFO - 'cmd': ('bash', 05:35:38 INFO - '-c', 05:35:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:35:38 INFO - 'enabled': True, 05:35:38 INFO - 'halt_on_failure': False, 05:35:38 INFO - 'name': 'check_screen_resolution'},), 05:35:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:35:38 INFO - 'cmd': ('bash', 05:35:38 INFO - '-c', 05:35:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:35:38 INFO - 'enabled': True, 05:35:38 INFO - 'halt_on_failure': False, 05:35:38 INFO - 'name': 'check_screen_resolution'},), 05:35:38 INFO - 'run_cmd_checks_enabled': True, 05:35:38 INFO - 'sps_profile': False, 05:35:38 INFO - 'sps_profile_interval': 0, 05:35:38 INFO - 'suite': 'dromaeojs-e10s', 05:35:38 INFO - 'system_bits': '32', 05:35:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:35:38 INFO - 'title': 't-yosemite-r7-0013', 05:35:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:35:38 INFO - 'use_talos_json': True, 05:35:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:35:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:35:38 INFO - 'work_dir': 'build'} 05:35:38 INFO - [mozharness: 2016-08-24 12:35:38.014904Z] Running clobber step. 05:35:38 INFO - Running pre-action listener: _resource_record_pre_action 05:35:38 INFO - Running main action method: clobber 05:35:38 INFO - rmtree: /builds/slave/test/build 05:35:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:35:40 INFO - Running post-action listener: _resource_record_post_action 05:35:40 INFO - [mozharness: 2016-08-24 12:35:40.047938Z] Finished clobber step (success) 05:35:40 INFO - [mozharness: 2016-08-24 12:35:40.048071Z] Running read-buildbot-config step. 05:35:40 INFO - Running pre-action listener: _resource_record_pre_action 05:35:40 INFO - Running main action method: read_buildbot_config 05:35:40 INFO - Using buildbot properties: 05:35:40 INFO - { 05:35:40 INFO - "project": "", 05:35:40 INFO - "product": "firefox", 05:35:40 INFO - "script_repo_revision": "production", 05:35:40 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:35:40 INFO - "repository": "", 05:35:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:35:40 INFO - "buildid": "20160824030337", 05:35:40 INFO - "stage_platform": "macosx64", 05:35:40 INFO - "basedir": "/builds/slave/test", 05:35:40 INFO - "nightly_build": "True", 05:35:40 INFO - "buildnumber": 69, 05:35:40 INFO - "slavename": "t-yosemite-r7-0013", 05:35:40 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 05:35:40 INFO - "platform": "yosemite_r7", 05:35:40 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:35:40 INFO - "branch": "mozilla-central", 05:35:40 INFO - "repo_path": "mozilla-central", 05:35:40 INFO - "revision": "bd7645928990649c84609d3f531e803c2d41f269", 05:35:40 INFO - "pgo_build": "False", 05:35:40 INFO - "builduid": "c5f9edaf64374c3f9f1b9947a91d9334", 05:35:40 INFO - "slavebuilddir": "test" 05:35:40 INFO - } 05:35:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/cLoQDuiPRD6cmZyM0zlFXA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 05:35:40 INFO - Running post-action listener: _resource_record_post_action 05:35:40 INFO - [mozharness: 2016-08-24 12:35:40.051602Z] Finished read-buildbot-config step (success) 05:35:40 INFO - [mozharness: 2016-08-24 12:35:40.051717Z] Running download-and-extract step. 05:35:40 INFO - Running pre-action listener: _resource_record_pre_action 05:35:40 INFO - Running main action method: download_and_extract 05:35:40 INFO - mkdir: /builds/slave/test/build/tests 05:35:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:40 INFO - trying https://queue.taskcluster.net/v1/task/cLoQDuiPRD6cmZyM0zlFXA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 05:35:40 INFO - Downloading https://queue.taskcluster.net/v1/task/cLoQDuiPRD6cmZyM0zlFXA/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 05:35:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cLoQDuiPRD6cmZyM0zlFXA/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 05:35:40 INFO - Downloaded 1199 bytes. 05:35:40 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:35:40 INFO - Using the following test package requirements: 05:35:40 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:35:40 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:35:40 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 05:35:40 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:35:40 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 05:35:40 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:35:40 INFO - u'jsshell-mac.zip'], 05:35:40 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:35:40 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 05:35:40 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:35:40 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:35:40 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 05:35:40 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:35:40 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 05:35:40 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:35:40 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 05:35:40 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:35:40 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 05:35:40 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:35:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:40 INFO - trying https://queue.taskcluster.net/v1/task/cLoQDuiPRD6cmZyM0zlFXA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:35:40 INFO - Downloading https://queue.taskcluster.net/v1/task/cLoQDuiPRD6cmZyM0zlFXA/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 05:35:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cLoQDuiPRD6cmZyM0zlFXA/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 05:35:41 INFO - Downloaded 16346298 bytes. 05:35:41 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 05:35:48 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 05:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:48 INFO - trying https://queue.taskcluster.net/v1/task/cLoQDuiPRD6cmZyM0zlFXA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:35:48 INFO - Downloading https://queue.taskcluster.net/v1/task/cLoQDuiPRD6cmZyM0zlFXA/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 05:35:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cLoQDuiPRD6cmZyM0zlFXA/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 05:35:49 INFO - Downloaded 16346298 bytes. 05:35:49 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 05:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:56 INFO - trying https://queue.taskcluster.net/v1/task/cLoQDuiPRD6cmZyM0zlFXA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:35:56 INFO - Downloading https://queue.taskcluster.net/v1/task/cLoQDuiPRD6cmZyM0zlFXA/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 05:35:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cLoQDuiPRD6cmZyM0zlFXA/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 05:35:57 INFO - Downloaded 14413981 bytes. 05:35:57 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 05:35:58 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')]} 05:35:58 INFO - trying https://queue.taskcluster.net/v1/task/cLoQDuiPRD6cmZyM0zlFXA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:35:58 INFO - Downloading https://queue.taskcluster.net/v1/task/cLoQDuiPRD6cmZyM0zlFXA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 05:35:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cLoQDuiPRD6cmZyM0zlFXA/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 05:36:00 INFO - Downloaded 111643159 bytes. 05:36:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cLoQDuiPRD6cmZyM0zlFXA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:36:00 INFO - mkdir: /builds/slave/test/properties 05:36:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:36:00 INFO - Writing to file /builds/slave/test/properties/build_url 05:36:00 INFO - Contents: 05:36:00 INFO - build_url:https://queue.taskcluster.net/v1/task/cLoQDuiPRD6cmZyM0zlFXA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:36:01 INFO - Running post-action listener: _resource_record_post_action 05:36:01 INFO - Running post-action listener: set_extra_try_arguments 05:36:01 INFO - [mozharness: 2016-08-24 12:36:01.479507Z] Finished download-and-extract step (success) 05:36:01 INFO - [mozharness: 2016-08-24 12:36:01.479665Z] Running populate-webroot step. 05:36:01 INFO - Running pre-action listener: _resource_record_pre_action 05:36:01 INFO - Running main action method: populate_webroot 05:36:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:36:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:36:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:36:01 INFO - '--tppagecycles', 05:36:01 INFO - '7'], 05:36:01 INFO - 'tests': ['tsvgm']}}, 05:36:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:36:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:36:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:36:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:36:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:36:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:36:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:01 INFO - 'talos_options': ['--disable-e10s'], 05:36:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:36:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:36:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:01 INFO - 'talos_options': ['--disable-e10s'], 05:36:01 INFO - 'tests': ['damp', 'tps']}, 05:36:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:01 INFO - 'tests': ['damp', 'tps']}, 05:36:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:36:01 INFO - 'tests': ['dromaeo_dom']}, 05:36:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:36:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:36:01 INFO - 'tests': ['basic_compositor_video']}, 05:36:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:36:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:36:01 INFO - 'tests': ['a11yr', 05:36:01 INFO - 'ts_paint', 05:36:01 INFO - 'tpaint', 05:36:01 INFO - 'sessionrestore', 05:36:01 INFO - 'sessionrestore_no_auto_restore', 05:36:01 INFO - 'tabpaint']}, 05:36:01 INFO - 'other-e10s': {'tests': ['a11yr', 05:36:01 INFO - 'ts_paint', 05:36:01 INFO - 'tpaint', 05:36:01 INFO - 'sessionrestore', 05:36:01 INFO - 'sessionrestore_no_auto_restore', 05:36:01 INFO - 'tabpaint']}, 05:36:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:36:01 INFO - 'ts_paint', 05:36:01 INFO - 'tpaint', 05:36:01 INFO - 'sessionrestore', 05:36:01 INFO - 'sessionrestore_no_auto_restore', 05:36:01 INFO - 'tabpaint']}, 05:36:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:36:01 INFO - 'ts_paint', 05:36:01 INFO - 'tpaint', 05:36:01 INFO - 'sessionrestore', 05:36:01 INFO - 'sessionrestore_no_auto_restore', 05:36:01 INFO - 'tabpaint']}, 05:36:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:36:01 INFO - 'tests': ['a11yr', 05:36:01 INFO - 'ts_paint', 05:36:01 INFO - 'tpaint', 05:36:01 INFO - 'sessionrestore', 05:36:01 INFO - 'sessionrestore_no_auto_restore', 05:36:01 INFO - 'tabpaint']}, 05:36:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:36:01 INFO - 'tests': ['a11yr', 05:36:01 INFO - 'ts_paint', 05:36:01 INFO - 'tpaint', 05:36:01 INFO - 'sessionrestore', 05:36:01 INFO - 'sessionrestore_no_auto_restore', 05:36:01 INFO - 'tabpaint']}, 05:36:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:36:01 INFO - 'tests': ['tsvgx', 05:36:01 INFO - 'tsvgr_opacity', 05:36:01 INFO - 'tart', 05:36:01 INFO - 'tscrollx', 05:36:01 INFO - 'cart']}, 05:36:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:36:01 INFO - 'tsvgr_opacity', 05:36:01 INFO - 'tart', 05:36:01 INFO - 'tscrollx', 05:36:01 INFO - 'cart']}, 05:36:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:01 INFO - 'talos_options': ['--disable-e10s'], 05:36:01 INFO - 'tests': ['tp5o']}, 05:36:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:01 INFO - 'tests': ['tp5o']}, 05:36:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:01 INFO - 'talos_options': ['--disable-e10s', 05:36:01 INFO - '--xperf_path', 05:36:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:36:01 INFO - 'tests': ['tp5n']}, 05:36:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:01 INFO - 'talos_options': ['--xperf_path', 05:36:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:36:01 INFO - 'tests': ['tp5n']}}, 05:36:01 INFO - 'talos.zip': {'path': '', 05:36:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:36:01 INFO - Running post-action listener: _resource_record_post_action 05:36:01 INFO - [mozharness: 2016-08-24 12:36:01.498451Z] Finished populate-webroot step (success) 05:36:01 INFO - [mozharness: 2016-08-24 12:36:01.498583Z] Running create-virtualenv step. 05:36:01 INFO - Running pre-action listener: _resource_record_pre_action 05:36:01 INFO - Running main action method: create_virtualenv 05:36:01 INFO - Creating virtualenv /builds/slave/test/build/venv 05:36:01 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 05:36:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:36:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:36:01 INFO - Using real prefix '/tools/python27' 05:36:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:36:02 INFO - Installing distribute.............................................................................................................................................................................................done. 05:36:05 INFO - Installing pip.................done. 05:36:05 INFO - Return code: 0 05:36:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:05 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 0x10709fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107134618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe735877a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107003d30>, '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 0x106d68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ffbb20>, '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.ewV8CiXKCH/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.AFQPQaJPMF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 05:36:05 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 05:36:05 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 05:36:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ewV8CiXKCH/Render', 05:36:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:05 INFO - 'HOME': '/Users/cltbld', 05:36:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:05 INFO - 'LOGNAME': 'cltbld', 05:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:05 INFO - 'MOZ_NO_REMOTE': '1', 05:36:05 INFO - 'NO_EM_RESTART': '1', 05:36:05 INFO - 'PAGER': '/bin/cat', 05:36:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:05 INFO - 'PWD': '/builds/slave/test', 05:36:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:05 INFO - 'SHELL': '/bin/bash', 05:36:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AFQPQaJPMF/Listeners', 05:36:05 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 05:36:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:05 INFO - 'USER': 'cltbld', 05:36:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:05 INFO - 'XPC_FLAGS': '0x0', 05:36:05 INFO - 'XPC_SERVICE_NAME': '0', 05:36:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:05 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 05:36:05 INFO - Cleaning up... 05:36:05 INFO - Return code: 0 05:36:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:05 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 0x10709fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107134618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe735877a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107003d30>, '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 0x106d68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ffbb20>, '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.ewV8CiXKCH/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.AFQPQaJPMF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 05:36:05 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 05:36:05 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 05:36:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ewV8CiXKCH/Render', 05:36:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:05 INFO - 'HOME': '/Users/cltbld', 05:36:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:05 INFO - 'LOGNAME': 'cltbld', 05:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:05 INFO - 'MOZ_NO_REMOTE': '1', 05:36:05 INFO - 'NO_EM_RESTART': '1', 05:36:05 INFO - 'PAGER': '/bin/cat', 05:36:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:05 INFO - 'PWD': '/builds/slave/test', 05:36:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:05 INFO - 'SHELL': '/bin/bash', 05:36:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AFQPQaJPMF/Listeners', 05:36:05 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 05:36:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:05 INFO - 'USER': 'cltbld', 05:36:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:05 INFO - 'XPC_FLAGS': '0x0', 05:36:05 INFO - 'XPC_SERVICE_NAME': '0', 05:36:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:05 INFO - Downloading/unpacking psutil>=3.1.1 05:36:05 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 05:36:05 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 05:36:05 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 05:36:05 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 05:36:05 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 05:36:05 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 05:36:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:36:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:36:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:36:08 INFO - Installing collected packages: psutil 05:36:08 INFO - Running setup.py install for psutil 05:36:08 INFO - building 'psutil._psutil_osx' extension 05:36:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:36:09 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 05:36:09 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 05:36:09 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 05:36:09 INFO - building 'psutil._psutil_posix' extension 05:36:09 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 05:36:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:36:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:36:09 INFO - ^ 05:36:09 INFO - 1 warning generated. 05:36:09 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 05:36:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:36:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:36:09 INFO - Successfully installed psutil 05:36:09 INFO - Cleaning up... 05:36:09 INFO - Return code: 0 05:36:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:36: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')]} 05:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36: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')]} 05:36:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:09 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 0x10709fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107134618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe735877a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107003d30>, '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 0x106d68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ffbb20>, '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.ewV8CiXKCH/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.AFQPQaJPMF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 05:36:09 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 05:36:09 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 05:36:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ewV8CiXKCH/Render', 05:36:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:09 INFO - 'HOME': '/Users/cltbld', 05:36:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:09 INFO - 'LOGNAME': 'cltbld', 05:36:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:09 INFO - 'MOZ_NO_REMOTE': '1', 05:36:09 INFO - 'NO_EM_RESTART': '1', 05:36:09 INFO - 'PAGER': '/bin/cat', 05:36:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:09 INFO - 'PWD': '/builds/slave/test', 05:36:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:09 INFO - 'SHELL': '/bin/bash', 05:36:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AFQPQaJPMF/Listeners', 05:36:09 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 05:36:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:09 INFO - 'USER': 'cltbld', 05:36:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:09 INFO - 'XPC_FLAGS': '0x0', 05:36:09 INFO - 'XPC_SERVICE_NAME': '0', 05:36:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:36:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:36:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:36:12 INFO - Installing collected packages: mozsystemmonitor 05:36:12 INFO - Running setup.py install for mozsystemmonitor 05:36:12 INFO - Successfully installed mozsystemmonitor 05:36:12 INFO - Cleaning up... 05:36:12 INFO - Return code: 0 05:36:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:36: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')]} 05:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36: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')]} 05:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10709fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107134618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe735877a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107003d30>, '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 0x106d68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ffbb20>, '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.ewV8CiXKCH/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.AFQPQaJPMF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 05:36:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:36:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:36:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ewV8CiXKCH/Render', 05:36:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:12 INFO - 'HOME': '/Users/cltbld', 05:36:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:12 INFO - 'LOGNAME': 'cltbld', 05:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:12 INFO - 'MOZ_NO_REMOTE': '1', 05:36:12 INFO - 'NO_EM_RESTART': '1', 05:36:12 INFO - 'PAGER': '/bin/cat', 05:36:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:12 INFO - 'PWD': '/builds/slave/test', 05:36:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:12 INFO - 'SHELL': '/bin/bash', 05:36:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AFQPQaJPMF/Listeners', 05:36:12 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 05:36:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:12 INFO - 'USER': 'cltbld', 05:36:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:12 INFO - 'XPC_FLAGS': '0x0', 05:36:12 INFO - 'XPC_SERVICE_NAME': '0', 05:36:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:13 INFO - Downloading/unpacking jsonschema==2.5.1 05:36: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 05:36: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 05:36: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 05:36: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 05:36: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 05:36: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 05:36:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:36:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:36:15 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 05:36:15 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 05:36:15 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 05:36:15 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 05:36:15 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 05:36:15 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 05:36:15 INFO - Downloading functools32-3.2.3-2.tar.gz 05:36:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:36:16 INFO - warning: no files found matching '*.txt' 05:36:16 INFO - no previously-included directories found matching 'build' 05:36:16 INFO - no previously-included directories found matching 'dist' 05:36:16 INFO - no previously-included directories found matching '.git*' 05:36:16 INFO - Installing collected packages: jsonschema, functools32 05:36:16 INFO - Running setup.py install for functools32 05:36:16 INFO - warning: no files found matching '*.txt' 05:36:16 INFO - no previously-included directories found matching 'build' 05:36:16 INFO - no previously-included directories found matching 'dist' 05:36:16 INFO - no previously-included directories found matching '.git*' 05:36:16 INFO - Successfully installed jsonschema functools32 05:36:16 INFO - Cleaning up... 05:36:16 INFO - Return code: 0 05:36:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:36:16 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')]} 05:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:16 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')]} 05:36:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:16 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 0x10709fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107134618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe735877a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107003d30>, '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 0x106d68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ffbb20>, '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.ewV8CiXKCH/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.AFQPQaJPMF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 05:36:16 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 05:36:16 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 05:36:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ewV8CiXKCH/Render', 05:36:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:16 INFO - 'HOME': '/Users/cltbld', 05:36:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:16 INFO - 'LOGNAME': 'cltbld', 05:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:16 INFO - 'MOZ_NO_REMOTE': '1', 05:36:16 INFO - 'NO_EM_RESTART': '1', 05:36:16 INFO - 'PAGER': '/bin/cat', 05:36:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:16 INFO - 'PWD': '/builds/slave/test', 05:36:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:16 INFO - 'SHELL': '/bin/bash', 05:36:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AFQPQaJPMF/Listeners', 05:36:16 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 05:36:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:16 INFO - 'USER': 'cltbld', 05:36:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:16 INFO - 'XPC_FLAGS': '0x0', 05:36:16 INFO - 'XPC_SERVICE_NAME': '0', 05:36:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:36:16 INFO - Cleaning up... 05:36:16 INFO - Return code: 0 05:36:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:36:16 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')]} 05:36:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:16 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')]} 05:36:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:16 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 0x10709fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107134618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe735877a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107003d30>, '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 0x106d68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ffbb20>, '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.ewV8CiXKCH/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.AFQPQaJPMF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 05:36:16 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 05:36:16 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 05:36:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ewV8CiXKCH/Render', 05:36:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:16 INFO - 'HOME': '/Users/cltbld', 05:36:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:16 INFO - 'LOGNAME': 'cltbld', 05:36:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:16 INFO - 'MOZ_NO_REMOTE': '1', 05:36:16 INFO - 'NO_EM_RESTART': '1', 05:36:16 INFO - 'PAGER': '/bin/cat', 05:36:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:16 INFO - 'PWD': '/builds/slave/test', 05:36:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:16 INFO - 'SHELL': '/bin/bash', 05:36:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AFQPQaJPMF/Listeners', 05:36:16 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 05:36:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:16 INFO - 'USER': 'cltbld', 05:36:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:16 INFO - 'XPC_FLAGS': '0x0', 05:36:16 INFO - 'XPC_SERVICE_NAME': '0', 05:36:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:16 INFO - Downloading/unpacking blobuploader==1.2.4 05:36: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 05:36: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 05:36: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 05:36: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 05:36: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 05:36: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 05:36:19 INFO - Downloading blobuploader-1.2.4.tar.gz 05:36:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:36:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:36: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 05:36: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 05:36: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 05:36: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 05:36: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 05:36: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 05:36:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:36:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:36:20 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 05:36:20 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 05:36:20 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 05:36:20 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 05:36:20 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 05:36:20 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 05:36:20 INFO - Downloading docopt-0.6.1.tar.gz 05:36:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:36:20 INFO - Installing collected packages: blobuploader, requests, docopt 05:36:20 INFO - Running setup.py install for blobuploader 05:36:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:36:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:36:20 INFO - Running setup.py install for requests 05:36:21 INFO - Running setup.py install for docopt 05:36:21 INFO - Successfully installed blobuploader requests docopt 05:36:21 INFO - Cleaning up... 05:36:21 INFO - Return code: 0 05:36:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:21 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')]} 05:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:21 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')]} 05:36:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:21 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 0x10709fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107134618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe735877a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107003d30>, '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 0x106d68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ffbb20>, '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.ewV8CiXKCH/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.AFQPQaJPMF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 05:36:21 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 05:36:21 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 05:36:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ewV8CiXKCH/Render', 05:36:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:21 INFO - 'HOME': '/Users/cltbld', 05:36:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:21 INFO - 'LOGNAME': 'cltbld', 05:36:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:21 INFO - 'MOZ_NO_REMOTE': '1', 05:36:21 INFO - 'NO_EM_RESTART': '1', 05:36:21 INFO - 'PAGER': '/bin/cat', 05:36:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:21 INFO - 'PWD': '/builds/slave/test', 05:36:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:21 INFO - 'SHELL': '/bin/bash', 05:36:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AFQPQaJPMF/Listeners', 05:36:21 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 05:36:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:21 INFO - 'USER': 'cltbld', 05:36:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:21 INFO - 'XPC_FLAGS': '0x0', 05:36:21 INFO - 'XPC_SERVICE_NAME': '0', 05:36:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:36:21 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-rXMpoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:36:21 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-18hQvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:36:21 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-S11Rtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:36:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:36:21 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-d0aRjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:36:22 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-VsgjL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:36:22 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-WE67M4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:36:22 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-A5N3ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:36:22 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-3SYxV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:36:22 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-U45cJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:36:22 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-YBgpLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:36:22 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Ddg1Le-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:36:22 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-zuNupP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:36:22 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-oYAmN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:36:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:36:22 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-_kgEIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:23 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-9aukj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:36:23 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-h_ArUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:36:23 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-WA_OHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:36:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:36:23 INFO - Running setup.py install for manifestparser 05:36:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:36:23 INFO - Running setup.py install for mozcrash 05:36:23 INFO - Running setup.py install for mozdebug 05:36:23 INFO - Running setup.py install for mozdevice 05:36:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:36:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:36:24 INFO - Running setup.py install for mozfile 05:36:24 INFO - Running setup.py install for mozhttpd 05:36:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:36:24 INFO - Running setup.py install for mozinfo 05:36:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:36:24 INFO - Running setup.py install for mozInstall 05:36:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:36:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:36:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:36:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:36:24 INFO - Running setup.py install for mozleak 05:36:24 INFO - Running setup.py install for mozlog 05:36:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:36:24 INFO - Running setup.py install for moznetwork 05:36:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:36:25 INFO - Running setup.py install for mozprocess 05:36:25 INFO - Running setup.py install for mozprofile 05:36:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:36:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:36:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:36:25 INFO - Running setup.py install for mozrunner 05:36:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:36:25 INFO - Running setup.py install for mozscreenshot 05:36:25 INFO - Running setup.py install for moztest 05:36:25 INFO - Running setup.py install for mozversion 05:36:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:36:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:36:25 INFO - Cleaning up... 05:36:25 INFO - Return code: 0 05:36:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10709fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107134618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe735877a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107003d30>, '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 0x106d68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ffbb20>, '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.ewV8CiXKCH/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.AFQPQaJPMF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 05:36:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:36:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ewV8CiXKCH/Render', 05:36:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:25 INFO - 'HOME': '/Users/cltbld', 05:36:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:25 INFO - 'LOGNAME': 'cltbld', 05:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:25 INFO - 'MOZ_NO_REMOTE': '1', 05:36:25 INFO - 'NO_EM_RESTART': '1', 05:36:25 INFO - 'PAGER': '/bin/cat', 05:36:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:25 INFO - 'PWD': '/builds/slave/test', 05:36:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:25 INFO - 'SHELL': '/bin/bash', 05:36:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AFQPQaJPMF/Listeners', 05:36:25 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 05:36:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:25 INFO - 'USER': 'cltbld', 05:36:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:25 INFO - 'XPC_FLAGS': '0x0', 05:36:25 INFO - 'XPC_SERVICE_NAME': '0', 05:36:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:36:26 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-rpWSYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:36:26 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)) 05:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:36:26 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-PpWNvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:36:26 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)) 05:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:36:26 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-1wDTEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:36:26 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)) 05:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:36:26 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Wni8d0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:36:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:36:26 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-D9gnoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:36:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:36:26 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-zfeyxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:36:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:36:26 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-D3jty3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:36:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:36:26 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-XEBTbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:36:27 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)) 05:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:36:27 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-cVQGCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:36:27 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)) 05:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:36:27 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Go1SfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:36:27 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)) 05:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:36:27 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Pkqqwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:36:27 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)) 05:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:36:27 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-cyzWcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:36:27 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)) 05:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:36:27 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-FzJmyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:36:27 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)) 05:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:36:27 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-an9Uyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:36:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:27 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Zm88Bn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:36:27 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-0ckMy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:36:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:36:27 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-GgclRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:36:28 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)) 05:36:28 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)) 05:36:28 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)) 05:36:28 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)) 05:36:28 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)) 05:36:28 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)) 05:36:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:36:28 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 05:36:28 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 05:36:28 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 05:36:28 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 05:36:28 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 05:36:28 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 05:36:30 INFO - Downloading blessings-1.6.tar.gz 05:36:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:36:30 INFO - Installing collected packages: blessings 05:36:30 INFO - Running setup.py install for blessings 05:36:30 INFO - Successfully installed blessings 05:36:30 INFO - Cleaning up... 05:36:30 INFO - Return code: 0 05:36:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:36:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:36:31 INFO - Reading from file tmpfile_stdout 05:36:31 INFO - Current package versions: 05:36:31 INFO - blessings == 1.6 05:36:31 INFO - blobuploader == 1.2.4 05:36:31 INFO - docopt == 0.6.1 05:36:31 INFO - functools32 == 3.2.3-2 05:36:31 INFO - jsonschema == 2.5.1 05:36:31 INFO - manifestparser == 1.1 05:36:31 INFO - mozInstall == 1.12 05:36:31 INFO - mozcrash == 0.17 05:36:31 INFO - mozdebug == 0.1 05:36:31 INFO - mozdevice == 0.48 05:36:31 INFO - mozfile == 1.2 05:36:31 INFO - mozhttpd == 0.7 05:36:31 INFO - mozinfo == 0.9 05:36:31 INFO - mozleak == 0.1 05:36:31 INFO - mozlog == 3.3 05:36:31 INFO - moznetwork == 0.27 05:36:31 INFO - mozprocess == 0.23 05:36:31 INFO - mozprofile == 0.28 05:36:31 INFO - mozrunner == 6.12 05:36:31 INFO - mozscreenshot == 0.1 05:36:31 INFO - mozsystemmonitor == 0.3 05:36:31 INFO - moztest == 0.7 05:36:31 INFO - mozversion == 1.4 05:36:31 INFO - psutil == 3.1.1 05:36:31 INFO - requests == 1.2.3 05:36:31 INFO - wsgiref == 0.1.2 05:36:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:31 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')]} 05:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:31 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')]} 05:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:31 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 0x10709fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107134618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe735877a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107003d30>, '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 0x106d68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ffbb20>, '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.ewV8CiXKCH/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.AFQPQaJPMF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 05:36:31 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 05:36:31 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 05:36:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ewV8CiXKCH/Render', 05:36:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:31 INFO - 'HOME': '/Users/cltbld', 05:36:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:31 INFO - 'LOGNAME': 'cltbld', 05:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:31 INFO - 'MOZ_NO_REMOTE': '1', 05:36:31 INFO - 'NO_EM_RESTART': '1', 05:36:31 INFO - 'PAGER': '/bin/cat', 05:36:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:31 INFO - 'PWD': '/builds/slave/test', 05:36:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:31 INFO - 'SHELL': '/bin/bash', 05:36:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AFQPQaJPMF/Listeners', 05:36:31 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 05:36:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:31 INFO - 'USER': 'cltbld', 05:36:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:31 INFO - 'XPC_FLAGS': '0x0', 05:36:31 INFO - 'XPC_SERVICE_NAME': '0', 05:36:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:31 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)) 05:36:31 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)) 05:36:31 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)) 05:36:31 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)) 05:36:31 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)) 05:36:31 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)) 05:36:31 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)) 05:36:31 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)) 05:36:31 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)) 05:36:31 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)) 05:36:31 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)) 05:36:31 INFO - Cleaning up... 05:36:31 INFO - Return code: 0 05:36:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:36:31 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')]} 05:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:31 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')]} 05:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:31 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 0x10709fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107134618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe735877a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107003d30>, '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 0x106d68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ffbb20>, '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.ewV8CiXKCH/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.AFQPQaJPMF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 05:36:31 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 05:36:31 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 05:36:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ewV8CiXKCH/Render', 05:36:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:31 INFO - 'HOME': '/Users/cltbld', 05:36:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:31 INFO - 'LOGNAME': 'cltbld', 05:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:31 INFO - 'MOZ_NO_REMOTE': '1', 05:36:31 INFO - 'NO_EM_RESTART': '1', 05:36:31 INFO - 'PAGER': '/bin/cat', 05:36:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:31 INFO - 'PWD': '/builds/slave/test', 05:36:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:31 INFO - 'SHELL': '/bin/bash', 05:36:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AFQPQaJPMF/Listeners', 05:36:31 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 05:36:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:31 INFO - 'USER': 'cltbld', 05:36:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:31 INFO - 'XPC_FLAGS': '0x0', 05:36:31 INFO - 'XPC_SERVICE_NAME': '0', 05:36:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:36:31 INFO - Cleaning up... 05:36:31 INFO - Return code: 0 05:36:31 INFO - Running post-action listener: _resource_record_post_action 05:36:31 INFO - Running post-action listener: _start_resource_monitoring 05:36:31 INFO - Starting resource monitoring. 05:36:31 INFO - [mozharness: 2016-08-24 12:36:31.666699Z] Finished create-virtualenv step (success) 05:36:31 INFO - [mozharness: 2016-08-24 12:36:31.667635Z] Running install step. 05:36:31 INFO - Running pre-action listener: _resource_record_pre_action 05:36:31 INFO - Running main action method: install 05:36:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:36:31 INFO - Reading from file tmpfile_stdout 05:36:31 INFO - Detecting whether we're running mozinstall >=1.0... 05:36:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:36:32 INFO - Reading from file tmpfile_stdout 05:36:32 INFO - Output received: 05:36:32 INFO - Usage: mozinstall [options] installer 05:36:32 INFO - Options: 05:36:32 INFO - -h, --help show this help message and exit 05:36:32 INFO - -d DEST, --destination=DEST 05:36:32 INFO - Directory to install application into. [default: 05:36:32 INFO - "/builds/slave/test"] 05:36:32 INFO - --app=APP Application being installed. [default: firefox] 05:36:32 INFO - mkdir: /builds/slave/test/build/application 05:36:32 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'] 05:36:32 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 05:37:06 INFO - Reading from file tmpfile_stdout 05:37:06 INFO - Output received: 05:37:06 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:37:06 INFO - Running post-action listener: _resource_record_post_action 05:37:06 INFO - [mozharness: 2016-08-24 12:37:06.121107Z] Finished install step (success) 05:37:06 INFO - [mozharness: 2016-08-24 12:37:06.121250Z] Running run-tests step. 05:37:06 INFO - Running pre-action listener: _resource_record_pre_action 05:37:06 INFO - Running main action method: run_tests 05:37:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:37:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:37:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:37:06 INFO - 2016-08-24 05:37:06.135 screenresolution[1637:7381] starting screenresolution argv=screenresolution get 05:37:06 INFO - 2016-08-24 05:37:06.138 screenresolution[1637:7381] Display 0: 1600x1200x32@60 05:37:06 INFO - 2016-08-24 05:37:06.144 screenresolution[1638:7383] starting screenresolution argv=screenresolution list 05:37:06 INFO - Available Modes on Display 0 05:37:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:37:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:37:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:37:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:37:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:37:06 INFO - Intel Iris: 05:37:06 INFO - Chipset Model: Intel Iris 05:37:06 INFO - Type: GPU 05:37:06 INFO - Bus: Built-In 05:37:06 INFO - VRAM (Dynamic, Max): 1536 MB 05:37:06 INFO - Vendor: Intel (0x8086) 05:37:06 INFO - Device ID: 0x0a2e 05:37:06 INFO - Revision ID: 0x0009 05:37:06 INFO - Displays: 05:37:06 INFO - Display: 05:37:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:37:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:37:06 INFO - Display Serial Number: 1600x1200 60 05:37:06 INFO - Main Display: Yes 05:37:06 INFO - Mirror: Off 05:37:06 INFO - Online: Yes 05:37:06 INFO - Rotation: Supported 05:37:06 INFO - Return code: 0 05:37:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:37:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:37:06 INFO - Python 2.7.3 05:37:06 INFO - Return code: 0 05:37:06 INFO - grabbing minidump binary from tooltool 05:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:06 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 0x107003d30>, '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 0x106d68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ffbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:37:06 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 05:37:06 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 05:37:06 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 05:37:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:37:06 INFO - Return code: 0 05:37:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:37:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:37:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:37:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:37:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:37:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cLoQDuiPRD6cmZyM0zlFXA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0013', '--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 05:37:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cLoQDuiPRD6cmZyM0zlFXA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0013 --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 05:37:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ewV8CiXKCH/Render', 05:37:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:06 INFO - 'HOME': '/Users/cltbld', 05:37:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:06 INFO - 'LOGNAME': 'cltbld', 05:37:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:37:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:06 INFO - 'MOZ_NO_REMOTE': '1', 05:37:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:37:06 INFO - 'NO_EM_RESTART': '1', 05:37:06 INFO - 'PAGER': '/bin/cat', 05:37:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:06 INFO - 'PWD': '/builds/slave/test', 05:37:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:37:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:06 INFO - 'SHELL': '/bin/bash', 05:37:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AFQPQaJPMF/Listeners', 05:37:06 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 05:37:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:06 INFO - 'USER': 'cltbld', 05:37:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:06 INFO - 'XPC_FLAGS': '0x0', 05:37:06 INFO - 'XPC_SERVICE_NAME': '0', 05:37:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cLoQDuiPRD6cmZyM0zlFXA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0013', '--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 05:37:06 INFO - mozversion application_buildid: 20160824030337 05:37:06 INFO - mozversion application_changeset: bd7645928990649c84609d3f531e803c2d41f269 05:37:06 INFO - mozversion application_display_name: Nightly 05:37:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:37:06 INFO - mozversion application_name: Firefox 05:37:06 INFO - mozversion application_remotingname: firefox 05:37:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:37:06 INFO - mozversion application_vendor: Mozilla 05:37:06 INFO - mozversion application_version: 51.0a1 05:37:06 INFO - mozversion platform_buildid: 20160824030337 05:37:06 INFO - mozversion platform_changeset: bd7645928990649c84609d3f531e803c2d41f269 05:37:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:37:06 INFO - mozversion platform_version: 51.0a1 05:37:06 INFO - using testdate: 1472042226 05:37:06 INFO - actual date: 1472042226 05:37:06 INFO - starting webserver on 'localhost:49262' 05:37:06 INFO - SUITE-START | Running 2 tests 05:37:06 INFO - TEST-START | dromaeo_css 05:37:06 INFO - operating with platform_type : mac_ 05:37:06 INFO - Initialising browser for dromaeo_css test... 05:37:06 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpnt5Rpa/profile http://localhost:49262/getInfo.html) 05:37:09 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 05:37:09 INFO - PROCESS | 1648 | colorDepth:24 05:37:09 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 05:37:09 INFO - PROCESS | 1648 | __metrics 05:37:09 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 05:37:10 INFO - TEST-INFO | 1648: exit 0 05:37:10 INFO - Browser initialized. 05:37:10 INFO - Running cycle 1/1 for dromaeo_css test... 05:37:10 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpnt5Rpa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:37:22 INFO - PROCESS | 1652 | RSS: Main: 247074816 05:37:22 INFO - PROCESS | 1652 | 05:38:12 INFO - PROCESS | 1652 | 1472042292244 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] 05:40:24 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49262/tests/dromaeo/cssquery-ext.html) 05:40:25 INFO - PROCESS | 1652 | RSS: Main: 267395072 05:40:25 INFO - PROCESS | 1652 | 05:43:27 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-ext.html (next: http://localhost:49262/tests/dromaeo/cssquery-jquery.html) 05:43:28 INFO - PROCESS | 1652 | RSS: Main: 271798272 05:43:28 INFO - PROCESS | 1652 | 05:46:30 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49262/tests/dromaeo/cssquery-mootools.html) 05:46:31 INFO - PROCESS | 1652 | RSS: Main: 279425024 05:46:31 INFO - PROCESS | 1652 | 05:49:32 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49262/tests/dromaeo/cssquery-prototype.html) 05:49:33 INFO - PROCESS | 1652 | RSS: Main: 275197952 05:49:33 INFO - PROCESS | 1652 | 05:52:36 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49262/tests/dromaeo/cssquery-yui.html) 05:52:37 INFO - PROCESS | 1652 | RSS: Main: 280109056 05:52:37 INFO - PROCESS | 1652 | 05:55:39 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-yui.html (next: http://localhost:49262/tests/dromaeo/cssquery-dojo.html) 05:55:40 INFO - PROCESS | 1652 | RSS: Main: 282869760 05:55:40 INFO - PROCESS | 1652 | 05:55:40 INFO - PROCESS | 1652 | __start_tp_report 05:55:40 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 05:55:40 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 05:55:40 INFO - PROCESS | 1652 | |i|pagename|runs| 05:55:40 INFO - PROCESS | 1652 | |0;dojo.html;2586.9870650646744;3329.2176338560434;3424.7260219182454;3450.758446908716;3457.0320310313123;5760.279965004374;5794.39158888317;5830.30036395632;5848.883022339551;5881.705914704269;5620.100783874581;5846.386129456409;5858.853528661785;5953.404659534044;5982.79060232892;5238.345206849144;5243.868903277429;5307.071262529062;5367.46325367464;5370.382406023318;5243.449437809013;5387.19192121181;5405.324334458192;5425.945740542603;5427.62006659534;5147.433782283946;5288.947110528922;5296.3909150447425;5335.386430560497;5342.626016178869;5187.221916712486;5205.947940520584;5224.399194092652;5231.529162375405;5259.973700131513;5171.534561889411;5183.481651834824;5218.6868787872845;5247.895042099175;5328.413874473805;5686.658800471943;5717.028105222123;5862.853428664317;5863.618864773819;5889.941100588982;5293.920591191135;6233.158523599302;6271.184745983039;6286.685665716695;6299.433051025384;6212.502999760009;6222.5644204905675;6286.308506064329;6289.654069026202;6301.212348456443;5744.8851022979725;5909.084091965752;5938.317093534212;5992.9700351498395;6079.361667024943;6326.49388048955;6328.367163283635;6341.524385671093;6346;6355.904661430082;6217.626942383471;6236.532260080421;6237.438630523184;6246.219222597176;6253.187085678833;6183.412575805291;6223.813285601439;6241.469475094577;6302.369763023753;6307.148534947815;6147.72335244915;6191.1641928339095;6236.095766113888;6248;6282.623042617458;5559.861003474945;6194.659293738798;6263.592866463665;6265.780697675651;6276.843078922972;3934.213157368538;4052.1895620875944;4053.2906741320153;5074.4671809460215;5081.4918508148885;4405.801738921757;4491.775411229425;4498.50516443191;4566.70316429431;4589.701669391479;5831.679257640785;5926.555508336892;5927.110933359944;5929.37741537141;5981.910271345933;6260.655663938436;6274.152989346379;6284.717187726564;6334.683265836689;6343.651099189589;5748.31020277561;5820.534357251409;5837.09525023622;5902.940970590239;5907.911381329283;5363.704996225245;5397.4062853086125;5404.621676482609;5509.779608815683;5515.61390702655;6244.812655620339;6286.717097730613;6298.779542715983;6300.338464461257;6303.243610766737;6194.659293738888;6226;6250.249970003629;6285.371462853678;6301.527385446201;6194.783182588588;6275.309715931336;6282.528810339151;6309.274433440213;6350.428461438492;6227.906581401192;6231.594946328474;6238.563300568917;6265.310815810349;6270.0908368287255;6208.286047104641;6244.687765611792;6249.843753906189;6253.687315634291;6255.093011513396;4515.729056256635;6067;6086.786962456293;6103.328633850362;6236.501079913687;5092.694438333712;6007.12896629995;6184.6598437086395;6268.310485846644;6277.027060805583;5411.241346562304;5992.64044157352;6047.244094488189;6058.787942421994;6136.20229370179;6040.463005537773;6142.355052719578;6200.831563518753;6229.626222426669;6238.376162383725;5225.451327610546;6084.148219249397;6095.939040609537;6120.203342909657;6135.508280839814 05:55:40 INFO - PROCESS | 1652 | |1;ext.html;463.4855310605228;472.09829226178005;499.78259457136147;534.9408171819797;539.8893226888488;33702.831485842566;41750;41880.5341813037;41955.79022104893;42064;42530;42965.570344296546;43044.78477607615;43064.56935430645;43118.568814311846;9636.66271680493;9817.410955342702;9826.50867456628;9855;9864.062914023156;9694.127528522431;9783.168430683401;9807.950960245189;9810.068043535854;9818.852717209247;8363.330933525303;9755.609775608968;9780.41317520951;9808.381617033181;9818.45998470084;8201.58992050398;9732.318737688365;9789.657361992297;9794.608215671364;9800.754981125529;9648.90351096487;9734.123928846439;9748.050389921973;9754.804903901953;9768.413895166243;41036.79481602603;41106.38340424896;41126.38310425346;41370;41544.792276038424;3391.71170450512;3452.482127680843;3711.5546134463766;3997.2605068062503;4164.214683968536;28835.990740324196;29152.688129034243;30092.8495357524;30235.697643023508;32416.513752293733;3198.5202219667003;3327.7337812975147;3409.8124603146816;3447.5690538682666;3464.3244567309384;508772;515651.9999999963;516648.9183527559;517075;517451;50929;60867.69566152141;61338.079928801104;61395;61604.69197653983;63717.45130194833;63877;64140;64365.678171609776;64735.67632161903;16281;16482.83517164813;16505.917470412813;16534.421295254608;16593.917030415014;12765.489380424864;12791.680207994874;12835.358232088358;12866.228026318451;12925.806112908314;13946.860531394555;17379.13104344778;17545.035023073597;17578.91210543939;17590.92158872192;6191.566590338633;6214.130021796952;6250.718717657716;6295.433410993032;6296.43332100104;807.9394045446497;851.642310229705;909.0999910089097;922.3359181389388;940.9764755881158;29525;30581.541276880864;30678.619462124258;31729.682703173134;31890.2027449311;1018.3940555369543;1039.859618951432;1120.3781901045;1148.7989601819647;1180.0500597019482;15657.451989180325;15773.921130394274;15933.283002264925;15977.920110399373;16228.83771162297;681399;688760;690105;693557;693916.0608393851;60156.39843601595;60697.69651151716;60744.088838667456;61316;61455.69272153611;1356.1862882270757;1376.3393571085935;1413.1026797983354;1415.775354318507;1423.665438621923;27079;31140.844295778377;32255.516167257978;32419.35161296808;32972.67027329696;52039.219411708094;52758;56792;57292.42707572871;62491.43771405751;625130;639597;640764.7961760161;643528;644636;21898;22108.55782884301;23630;25807.870960645076;27325.86337068302;38363.80818095891;48883.511164887896;49438.75280623574;50355;53182;39946.800265998485;40300.79849600733;40562.2190025237;40871.77384678464;41970;30350.241243968194;40546.59453405428;40569.98575035648;40797;42139;39256.2148757029;39965.8010259681;40250.79247622576;40455;40663.39004914988;32465.837670812438;35874.54656734717;35942;36140.91577252687;36275;25656.819170370727;26261.606075908494;26474.602880957187;26493.60259596146;26812.06157784468 05:55:40 INFO - PROCESS | 1652 | |2;jquery.html;367.86572900891184;375.54558983629806;381.73278704906556;382.1973854904702;400.7555391211362;18866.811331886678;21129.47176320593;21304.57390852184;21382.465438364048;21543.784562154393;19759.604807903834;20094.899525502387;20721.378358649228;20966.26618068368;21315.680264796003;5830.5044071254;5862.179294898718;5942.5840191186635;5958.897603943263;6018.398160183969;4166.9791651041705;5899.0266606009955;6017.849553761147;6019.337872833985;6326.715297811609;6313.968430157865;6708.36270554299;6709.496787740914;6715.395614394703;6739;6606.702698378561;6671.799846004627;6679.833004174886;6710.966445167792;6711.4295284900845;5029.497050294978;5726.942730572682;5827.737751801179;5830.212921255618;5848.181254624356;12972.80540791889;13094.934525327313;13303.60089197316;13387;13394.799078013837;2116.809487146149;2205.38249290199;2238.2949370948263;2301.1255722825385;2309.145616122029;9893.208543316518;10110.342827716175;10169.186465082776;10170.033846784618;10206.132478739317;1853.7775466944054;1861.9906900465546;1872.87826291292;1900.5818719881604;1972.1716878910893;100319.49201269954;106311;124185.75814241833;125039;126637;9599.904000960041;11016.11871050314;11239.887601123884;11568.88431115695;11993.580224692269;14409.927950360181;14470.927645361706;14487.20320382389;14512.85487145115;14519.92740036293;8321.500709957421;8583.613737381833;8598.011228708778;8713.085126061798;8727.519986400683;8427.747167584983;8583.442076265022;8619.267362274277;8712.956435217784;8713.651453941771;3851.8651847185774;4444.244478438609;4597.770111494478;4602.1025899949855;4607.476169087162;1598.5763772600271;1663.7338025916038;1925.315349069564;1934.458351661537;1986.3147214211074;826.1531929772032;869.7869022089502;879.4811061473761;923.5243849417556;1013.422349260929;14705;20692.896535517528;21134.682979755315;21372.145114195257;21378.037988290565;784.7253461288617;900.9728909043696;935.3873213045466;940.3793496292415;948.6821914658667;8697.782555436164;8915.197632213132;11418.828717569244;11520.308781473139;11564.884351156381;607020.9648951727;609302;612927;620635;622727;109579;128134;131005.68994310126;134219;135754.6424535742;427.5574780102579;449.3641497281376;458.7591514454938;927.7912469694264;948.2935213266023;10843.024127828534;10851.511681974487;11329.263597866113;11446.313221206754;11760.941195294312;53938;54776.726116369166;57926;58954.70522647359;60057;64690.67654661885;67799.98300025602;84863.5756821212;86120.13879861371;87859;7957.801054973672;8172.060213075572;8296.87554686668;8304.584770761317;8323.750287491384;9124.406913550598;12087.818682719942;12657.556985505464;12906.612801615967;13100.344982750634;8588.398812083095;11192.384418856715;11211;11331.32012079278;11402.82895756581;11160.609378671708;11392.487338069972;11418.371989540656;11478.885211148116;11717.941410292893;11259.211855170059;11340.886591134313;11565.074794016291;11607.36159511235;11671.12466564994;7702.499337543042;8059.3955453342405;8155.877661834958;8417.410781245255;8443.113473085483;10482.266241363031;10583.62957296491;10713.517891694737;10927;11290.379029153148 05:55:40 INFO - PROCESS | 1652 | |3;mootools.html;1336.6925607110365;1493.5220729366604;1684.8315168483145;1833.4774589242068;1876.3526583328755;7903.92096079039;8452.408331416804;8588.355873309496;8976.461412315257;8977.461352318856;8587.699430519933;8679.175478329564;8776.648934042647;8795.340349473783;8812.515311657857;2342.636891281854;2380.571497130516;2381.7499162587937;2382.4520360317138;2391.7608239176116;2353.2351985604746;2363.3737059679197;2389.6057150570136;2397.208921056056;2414.7947424468853;2385.2128797496785;2388.176079252655;2389.199618127929;2411.553862535428;2419.201663451057;1745.4065617690046;1960.8235058964578;2027.9657374738842;2369.4194922244073;2387.140629373424;1990.8506861985409;2319.0375993962484;2368.6920700309024;2377.9881100594557;2380.773826486481;8907.821843563157;8964.731058068268;8965.731028069169;8974.14745599167;8976.012638609747;4524.411826462571;5174.327337446146;5364.785408583652;5379.892402151974;5382.596305277119;3515.156362473014;3575.946360804564;3662.7252956028406;3682.6317368263226;3717.498137751396;1076.4671487613602;1092.6995076354067;1107.7839821234863;1118.0943435817014;1120.8598925134359;11465.942670286679;11586.710332241677;11603.477843497063;11647.359395233174;11664.59173928917;4535.092981403733;4654.2785868190485;4792.376990991149;4833.589144922651;4840.491748366441;9777.217822574177;9903.851442228372;9906.05892440217;9915.454649994175;9923.900760992297;5360.16917377807;5372.194170874322;5374.140137577969;5383.946160538345;5387.057264978613;4405.339199120158;4762.119007983534;4869.342638743724;4912.557869791736;4923.0153969205585;3431.897043088711;3875.6899448044087;3977.940330895039;4000.2599519089063;4027.9798601006805;1294.5792617399384;1309.1359702596242;1310.377570653951;1314.750197462479;1314.8035287887976;838.6980686952692;839.8278352937755;923.7644400677784;940.1867384712175;975.9365641233297;5820.447057529528;5978.940210597925;6041.78853740117;6100.969495152496;6201.348858369806;413.5099906610676;442.40717438632385;444.11399258478895;447.4004833523095;456.04003572480116;3533.664301891368;4023.6177563131455;4027.8791636250958;4138.193052354822;4149.107941792468;10471.057604815604;10691.30506517074;10786.56853725858;10814.675559733221;10838.891611083945;10732.624358147428;10765.730856728644;10782.406967616856;10805.40570268627;10806.18953578469;7845.293923546908;8157.632906519221;8209.507429554245;8237.46456480327;8250.46371985819;5465.196485159809;5761.596688231783;5982.038890749107;6060.424259695322;6261.749530018748;9608.183304419203;9982.700518984442;10048;10087;10099.091081802673;8172.673093076448;10186.949065254626;10221.080102790784;10395.740106497096;10427.739306517398;7528.397728181842;7629.0845098588525;7720.652570634447;7750.418718596241;7753.844923101394;8268.297194738514;8309.33525317961;8398.202170793766;8439.915600843913;8448.704295349633;5789.928863160329;7072.363487285963;7357.926420735724;7516.962415187889;7644.961775191088;6191.226096737908;6731.831704207434;6749.966250168718;7292.890606641011;7370.742024029133;6001.669908155093;6973.442124629916;6987.161540615159;7069.293070692889;7078.221395646578;5047.343845300087;5089.185730283285;5106.821261255986;5154.14956532168;5157.561607263275;4750.6199504038905;5062.367204099488;5144.125498665161;5194.584433245256;5202.453742357149 05:55:40 INFO - PROCESS | 1652 | |4;prototype.html;302.3348633007383;308.45711547676086;316.1164545096455;316.3262251404508;320.677718892513;4774.824741546871;5498.945010549894;5601.663900165993;5720.4565566271185;5823.941760582393;5222.451642577522;5597.7201139943045;5686.744096515657;5747.59766816323;5767.250257466523;4327.350897365389;4332.740035597859;4360.146937551528;4374.540673229313;4385.675591936279;3630.6187850275737;3852.9807350963206;3986.561478237406;4379.9926017016105;4412.205802955466;3721.553413590373;4123.134141830219;4217.789110544476;4248.87253382399;4267.530571637118;3980.3233450313373;4230.329020037084;4243.8090285937205;4268.850590229327;4312.870613881589;3060.5256185291314;3662;3671.4859919611276;3682.4476328550663;3700.4264339027495;5135.38375394955;5272.472752724735;5410.810621628224;5555.444455554452;5669.291338582677;4849.418069831643;4881.609471242292;4892.700430797519;4908.558229759339;4967.925481117786;5013.949860501385;5078.111330517182;5593.468620481048;5594.860128496779;5972.581919265654;3499.4051011328133;3771.8311970617005;4030.052937559671;4038.1116154445976;4087.162131763011;5104.69830193302;5281.540590912959;5595.384507704109;6416.422521972998;6425.8393540161405;3295.0279667498144;3447.4311738563356;3782.884049205491;3813.84744610218;4129.91740165201;3886.4170374443493;4127.484064491939;4152.190322887008;4167.540941018947;4180.707350485498;4210.978945105316;4766.118268120409;4906.89594841165;4918.631102667314;4941.827036053721;5329.9467005330225;5770.942290577124;6095.451409373178;6116.449519543263;6124.785632502841;1383.2599559235962;1413.406369324886;1415.4338264694;1417.6461479287257;1424.9715005699827;834.5390529710055;837.2255663511228;840.7309660908572;858.553552152877;866.3935245328296;4208.663306935499;4385.473743150842;4738.407699037621;4788.802799300175;4789.592884604847;4869.561739443397;5140.046782222731;5189.42916279209;5249.265102885599;5311.061462566213;3778.6977041836585;4085.673146148301;4612.976935115303;4778.546038126373;4834.250691142878;2379.892904819287;2623.81633285672;2648.1790644899756;2745.203890871665;2755.1540467886566;4289.463817022872;4704.388429504211;5096.770645320969;5353.411124776271;5372.8656783579945;4999.779982300778;5206.349206349207;5336.546393556514;5398.973005134949;5451.127819548853;5212.296339994128;5398.623351045537;5402.945970540323;5408.755366523006;5454.945450545444;4732.858014259577;5175.0167468180925;5221.399539053057;5224.537129603717;5272.604554658339;4079.6124368184974;4343.934840977325;4531.750753708578;5169.948300516947;5179.611529135405;4610.631149508098;5073.619478539198;5419.674819510842;5430.13117901134;5439.972800135974;3150.9369812604077;3447.4484082547674;3506.684398404054;3590.8025058622025;3636.563557394867;4378.75916824565;4663.647542212856;4763.476017637988;4937.77779999908;5270.657407268515;4517.232070548081;4579.816807327669;4789.407944041968;4809.374781278411;5127.974450092118;4969.900601987868;5099.3370861787735;5114.667546609458;5125.872308092363;5174.63777535584;4622.722636641813;4966.850994470172;4981.427135879276;5002.499750024968;6004.189434426296;5307.363116426053;6136.969315153396;6149.815505534841;6151;6202.255729312511;5515.310586176728;5979.043353063489;6032.607880487754;6037.577369584087;6224.439800417984 05:55:40 INFO - PROCESS | 1652 | |5;yui.html;753.4273951796633;754.9282818132278;771.9884201736975;772.6523064620918;872.0581771686577;15629;16650.1674916254;16744;16777.748333774973;16778.91610541947;15142.242887855618;15293.617659558517;15310.770338444905;15322;15377;750.4821673045594;794.2295972906301;858.7423772868145;897.3942588752599;900.1493588558815;865.212656482601;879.8636211387245;883.041899539001;887.7603047177258;887.9600417981175;869.9434536755123;927.7634203278188;928.9256859451227;929.586334081334;930.1675000874213;897.8339007283673;921.0375157959915;925.9768505787342;926.073926073926;929.0245242495387;676.7834293026234;685.2701872505816;689.9344562266576;692.0553444548156;694.0664805836142;14141.575752727435;14852.2573871306;15504.069755814575;15634.687306253925;15802.683946321009;14321.14073155614;14340.856591434162;14451.566453006322;14555.636109097251;14632.561023169323;11860.584879529262;12015.699607509794;12027.819582706266;12223.69440763979;12318;3796.7532110412735;3799.088218827489;3849.364854798983;3874.5350557932948;3994.8601798936897;117054.82945170524;127510;129457;129509.05736413962;131233.56430792605;11136.888631113585;11243.66269011931;11244.606438774603;11350.375729334966;11581.88418115808;22511;22588.66117008246;22592.096316147497;22646.320610381714;22684.432889177904;6515.674216289167;7415.962920185365;7455.85088298231;7502.4748267621835;7748.225177482207;3761.9435708464393;4691.179043667413;4702.036082603058;4781.282807578891;4782.713037217778;3657.7805331680183;3707.943236177676;3708.38811596089;3777.773333599993;3783.8297276622066;663.7112855907695;673.2089794491453;674.723363420995;682.2801943949181;689.2280645676874;588.7527238559816;679.1725365166398;692.6398272898166;694.3232094491746;701.8244440562038;9109.635614575343;9676.371035882787;9814.852777208347;9831.950840245896;9949.502524873727;509.39890928704483;628.2660155726578;665.7736369634348;667.1693741292122;690.1097584116534;4353.455818022747;4859.028194361142;4876.731779752147;4980.368257520468;5059.848204553869;133365;150523.24738376457;159107;160380;161273.19363403108;138816;139680;141000.2949985264;142007;142955;112952;114991;116418;116945;117765.82234177549;9286.72139835806;9335.53870985481;9397.389169703947;9402.012788657366;9543.761405964906;51788.74105629448;58126.709366452895;59793;61813.690931545054;63687.04469433055;54050.91898161936;78929;90910.09089909017;93691;94137.529312353;11707.121965852766;13327.533536326182;13737.175769453865;13741.450341986209;14198.077124986843;12646.747065058831;12842.67893302675;12915.612531624067;12976.610701678965;15757.684846303238;11885.821712674144;14079;14100.576982690536;14269.304913251313;14540.272986350852;13778;14025.719485610434;14656.955309774523;14882.776758348416;15129.47046853355;13339.333033348099;14045.227512486912;14177.787333189804;14223.288835558387;14341;9560.85658715106;9933.679568644513;10869.641294838146;11613.535458581562;11888.821667674818;8129.79675508117;9876.40741555509;11615.593454229062;11715.941420292844;12003.63989080329 05:55:40 INFO - PROCESS | 1652 | __end_tp_report 05:55:40 INFO - PROCESS | 1652 | __start_cc_report 05:55:40 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,425 05:55:40 INFO - PROCESS | 1652 | __end_cc_report 05:55:40 INFO - PROCESS | 1652 | __startTimestamp1472043340143__endTimestamp 05:55:40 INFO - PROCESS | 1652 | 05:55:40 INFO - PROCESS | 1652 | ------- Summary: start ------- 05:55:40 INFO - PROCESS | 1652 | Number of tests: 6 05:55:40 INFO - PROCESS | 1652 | 05:55:40 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5761.85 Median:6040.46 stddev:693.45 (11.5%) stddev-sans-first:649.31 05:55:40 INFO - PROCESS | 1652 | Values: 2587.0 3329.2 3424.7 3450.8 3457.0 5760.3 5794.4 5830.3 5848.9 5881.7 5620.1 5846.4 5858.9 5953.4 5982.8 5238.3 5243.9 5307.1 5367.5 5370.4 5243.4 5387.2 5405.3 5425.9 5427.6 5147.4 5288.9 5296.4 5335.4 5342.6 5187.2 5205.9 5224.4 5231.5 5260.0 5171.5 5183.5 5218.7 5247.9 5328.4 5686.7 5717.0 5862.9 5863.6 5889.9 5293.9 6233.2 6271.2 6286.7 6299.4 6212.5 6222.6 6286.3 6289.7 6301.2 5744.9 5909.1 5938.3 5993.0 6079.4 6326.5 6328.4 6341.5 6346.0 6355.9 6217.6 6236.5 6237.4 6246.2 6253.2 6183.4 6223.8 6241.5 6302.4 6307.1 6147.7 6191.2 6236.1 6248.0 6282.6 5559.9 6194.7 6263.6 6265.8 6276.8 3934.2 4052.2 4053.3 5074.5 5081.5 4405.8 4491.8 4498.5 4566.7 4589.7 5831.7 5926.6 5927.1 5929.4 5981.9 6260.7 6274.2 6284.7 6334.7 6343.7 5748.3 5820.5 5837.1 5902.9 5907.9 5363.7 5397.4 5404.6 5509.8 5515.6 6244.8 6286.7 6298.8 6300.3 6303.2 6194.7 6226.0 6250.2 6285.4 6301.5 6194.8 6275.3 6282.5 6309.3 6350.4 6227.9 6231.6 6238.6 6265.3 6270.1 6208.3 6244.7 6249.8 6253.7 6255.1 4515.7 6067.0 6086.8 6103.3 6236.5 5092.7 6007.1 6184.7 6268.3 6277.0 5411.2 5992.6 6047.2 6058.8 6136.2 6040.5 6142.4 6200.8 6229.6 6238.4 5225.5 6084.1 6095.9 6120.2 6135.5 05:55:40 INFO - PROCESS | 1652 | 05:55:40 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:74493.69 Median:41815.27 stddev:165690.60 (396.2%) stddev-sans-first:166062.18 05:55:40 INFO - PROCESS | 1652 | Values: 463.5 472.1 499.8 534.9 539.9 33702.8 41750.0 41880.5 41955.8 42064.0 42530.0 42965.6 43044.8 43064.6 43118.6 9636.7 9817.4 9826.5 9855.0 9864.1 9694.1 9783.2 9808.0 9810.1 9818.9 8363.3 9755.6 9780.4 9808.4 9818.5 8201.6 9732.3 9789.7 9794.6 9800.8 9648.9 9734.1 9748.1 9754.8 9768.4 41036.8 41106.4 41126.4 41370.0 41544.8 3391.7 3452.5 3711.6 3997.3 4164.2 28836.0 29152.7 30092.8 30235.7 32416.5 3198.5 3327.7 3409.8 3447.6 3464.3 508772.0 515652.0 516648.9 517075.0 517451.0 50929.0 60867.7 61338.1 61395.0 61604.7 63717.5 63877.0 64140.0 64365.7 64735.7 16281.0 16482.8 16505.9 16534.4 16593.9 12765.5 12791.7 12835.4 12866.2 12925.8 13946.9 17379.1 17545.0 17578.9 17590.9 6191.6 6214.1 6250.7 6295.4 6296.4 807.9 851.6 909.1 922.3 941.0 29525.0 30581.5 30678.6 31729.7 31890.2 1018.4 1039.9 1120.4 1148.8 1180.1 15657.5 15773.9 15933.3 15977.9 16228.8 681399.0 688760.0 690105.0 693557.0 693916.1 60156.4 60697.7 60744.1 61316.0 61455.7 1356.2 1376.3 1413.1 1415.8 1423.7 27079.0 31140.8 32255.5 32419.4 32972.7 52039.2 52758.0 56792.0 57292.4 62491.4 625130.0 639597.0 640764.8 643528.0 644636.0 21898.0 22108.6 23630.0 25807.9 27325.9 38363.8 48883.5 49438.8 50355.0 53182.0 39946.8 40300.8 40562.2 40871.8 41970.0 30350.2 40546.6 40570.0 40797.0 42139.0 39256.2 39965.8 40250.8 40455.0 40663.4 32465.8 35874.5 35942.0 36140.9 36275.0 25656.8 26261.6 26474.6 26493.6 26812.1 05:55:40 INFO - PROCESS | 1652 | 05:55:40 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:34994.02 Median:371.71 stddev:102542.61 (27587.0%) stddev-sans-first:102797.31 05:55:40 INFO - PROCESS | 1652 | Values: 367.9 375.5 381.7 382.2 400.8 18866.8 21129.5 21304.6 21382.5 21543.8 19759.6 20094.9 20721.4 20966.3 21315.7 5830.5 5862.2 5942.6 5958.9 6018.4 4167.0 5899.0 6017.8 6019.3 6326.7 6314.0 6708.4 6709.5 6715.4 6739.0 6606.7 6671.8 6679.8 6711.0 6711.4 5029.5 5726.9 5827.7 5830.2 5848.2 12972.8 13094.9 13303.6 13387.0 13394.8 2116.8 2205.4 2238.3 2301.1 2309.1 9893.2 10110.3 10169.2 10170.0 10206.1 1853.8 1862.0 1872.9 1900.6 1972.2 100319.5 106311.0 124185.8 125039.0 126637.0 9599.9 11016.1 11239.9 11568.9 11993.6 14409.9 14470.9 14487.2 14512.9 14519.9 8321.5 8583.6 8598.0 8713.1 8727.5 8427.7 8583.4 8619.3 8713.0 8713.7 3851.9 4444.2 4597.8 4602.1 4607.5 1598.6 1663.7 1925.3 1934.5 1986.3 826.2 869.8 879.5 923.5 1013.4 14705.0 20692.9 21134.7 21372.1 21378.0 784.7 901.0 935.4 940.4 948.7 8697.8 8915.2 11418.8 11520.3 11564.9 607021.0 609302.0 612927.0 620635.0 622727.0 109579.0 128134.0 131005.7 134219.0 135754.6 427.6 449.4 458.8 927.8 948.3 10843.0 10851.5 11329.3 11446.3 11760.9 53938.0 54776.7 57926.0 58954.7 60057.0 64690.7 67800.0 84863.6 86120.1 87859.0 7957.8 8172.1 8296.9 8304.6 8323.8 9124.4 12087.8 12657.6 12906.6 13100.3 8588.4 11192.4 11211.0 11331.3 11402.8 11160.6 11392.5 11418.4 11478.9 11717.9 11259.2 11340.9 11565.1 11607.4 11671.1 7702.5 8059.4 8155.9 8417.4 8443.1 10482.3 10583.6 10713.5 10927.0 11290.4 05:55:40 INFO - PROCESS | 1652 | 05:55:40 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5683.96 Median:4854.92 stddev:3213.28 (66.2%) stddev-sans-first:3205.68 05:55:40 INFO - PROCESS | 1652 | Values: 1336.7 1493.5 1684.8 1833.5 1876.4 7903.9 8452.4 8588.4 8976.5 8977.5 8587.7 8679.2 8776.6 8795.3 8812.5 2342.6 2380.6 2381.7 2382.5 2391.8 2353.2 2363.4 2389.6 2397.2 2414.8 2385.2 2388.2 2389.2 2411.6 2419.2 1745.4 1960.8 2028.0 2369.4 2387.1 1990.9 2319.0 2368.7 2378.0 2380.8 8907.8 8964.7 8965.7 8974.1 8976.0 4524.4 5174.3 5364.8 5379.9 5382.6 3515.2 3575.9 3662.7 3682.6 3717.5 1076.5 1092.7 1107.8 1118.1 1120.9 11465.9 11586.7 11603.5 11647.4 11664.6 4535.1 4654.3 4792.4 4833.6 4840.5 9777.2 9903.9 9906.1 9915.5 9923.9 5360.2 5372.2 5374.1 5383.9 5387.1 4405.3 4762.1 4869.3 4912.6 4923.0 3431.9 3875.7 3977.9 4000.3 4028.0 1294.6 1309.1 1310.4 1314.8 1314.8 838.7 839.8 923.8 940.2 975.9 5820.4 5978.9 6041.8 6101.0 6201.3 413.5 442.4 444.1 447.4 456.0 3533.7 4023.6 4027.9 4138.2 4149.1 10471.1 10691.3 10786.6 10814.7 10838.9 10732.6 10765.7 10782.4 10805.4 10806.2 7845.3 8157.6 8209.5 8237.5 8250.5 5465.2 5761.6 5982.0 6060.4 6261.7 9608.2 9982.7 10048.0 10087.0 10099.1 8172.7 10186.9 10221.1 10395.7 10427.7 7528.4 7629.1 7720.7 7750.4 7753.8 8268.3 8309.3 8398.2 8439.9 8448.7 5789.9 7072.4 7357.9 7517.0 7645.0 6191.2 6731.8 6750.0 7292.9 7370.7 6001.7 6973.4 6987.2 7069.3 7078.2 5047.3 5089.2 5106.8 5154.1 5157.6 4750.6 5062.4 5144.1 5194.6 5202.5 05:55:40 INFO - PROCESS | 1652 | 05:55:40 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4454.55 Median:4887.15 stddev:1355.99 (27.7%) stddev-sans-first:1323.49 05:55:40 INFO - PROCESS | 1652 | Values: 302.3 308.5 316.1 316.3 320.7 4774.8 5498.9 5601.7 5720.5 5823.9 5222.5 5597.7 5686.7 5747.6 5767.3 4327.4 4332.7 4360.1 4374.5 4385.7 3630.6 3853.0 3986.6 4380.0 4412.2 3721.6 4123.1 4217.8 4248.9 4267.5 3980.3 4230.3 4243.8 4268.9 4312.9 3060.5 3662.0 3671.5 3682.4 3700.4 5135.4 5272.5 5410.8 5555.4 5669.3 4849.4 4881.6 4892.7 4908.6 4967.9 5013.9 5078.1 5593.5 5594.9 5972.6 3499.4 3771.8 4030.1 4038.1 4087.2 5104.7 5281.5 5595.4 6416.4 6425.8 3295.0 3447.4 3782.9 3813.8 4129.9 3886.4 4127.5 4152.2 4167.5 4180.7 4211.0 4766.1 4906.9 4918.6 4941.8 5329.9 5770.9 6095.5 6116.4 6124.8 1383.3 1413.4 1415.4 1417.6 1425.0 834.5 837.2 840.7 858.6 866.4 4208.7 4385.5 4738.4 4788.8 4789.6 4869.6 5140.0 5189.4 5249.3 5311.1 3778.7 4085.7 4613.0 4778.5 4834.3 2379.9 2623.8 2648.2 2745.2 2755.2 4289.5 4704.4 5096.8 5353.4 5372.9 4999.8 5206.3 5336.5 5399.0 5451.1 5212.3 5398.6 5402.9 5408.8 5454.9 4732.9 5175.0 5221.4 5224.5 5272.6 4079.6 4343.9 4531.8 5169.9 5179.6 4610.6 5073.6 5419.7 5430.1 5440.0 3150.9 3447.4 3506.7 3590.8 3636.6 4378.8 4663.6 4763.5 4937.8 5270.7 4517.2 4579.8 4789.4 4809.4 5128.0 4969.9 5099.3 5114.7 5125.9 5174.6 4622.7 4966.9 4981.4 5002.5 6004.2 5307.4 6137.0 6149.8 6151.0 6202.3 5515.3 5979.0 6032.6 6037.6 6224.4 05:55:40 INFO - PROCESS | 1652 | 05:55:40 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:25730.73 Median:3780.80 stddev:41891.75 (1108.0%) stddev-sans-first:41967.29 05:55:40 INFO - PROCESS | 1652 | Values: 753.4 754.9 772.0 772.7 872.1 15629.0 16650.2 16744.0 16777.7 16778.9 15142.2 15293.6 15310.8 15322.0 15377.0 750.5 794.2 858.7 897.4 900.1 865.2 879.9 883.0 887.8 888.0 869.9 927.8 928.9 929.6 930.2 897.8 921.0 926.0 926.1 929.0 676.8 685.3 689.9 692.1 694.1 14141.6 14852.3 15504.1 15634.7 15802.7 14321.1 14340.9 14451.6 14555.6 14632.6 11860.6 12015.7 12027.8 12223.7 12318.0 3796.8 3799.1 3849.4 3874.5 3994.9 117054.8 127510.0 129457.0 129509.1 131233.6 11136.9 11243.7 11244.6 11350.4 11581.9 22511.0 22588.7 22592.1 22646.3 22684.4 6515.7 7416.0 7455.9 7502.5 7748.2 3761.9 4691.2 4702.0 4781.3 4782.7 3657.8 3707.9 3708.4 3777.8 3783.8 663.7 673.2 674.7 682.3 689.2 588.8 679.2 692.6 694.3 701.8 9109.6 9676.4 9814.9 9832.0 9949.5 509.4 628.3 665.8 667.2 690.1 4353.5 4859.0 4876.7 4980.4 5059.8 133365.0 150523.2 159107.0 160380.0 161273.2 138816.0 139680.0 141000.3 142007.0 142955.0 112952.0 114991.0 116418.0 116945.0 117765.8 9286.7 9335.5 9397.4 9402.0 9543.8 51788.7 58126.7 59793.0 61813.7 63687.0 54050.9 78929.0 90910.1 93691.0 94137.5 11707.1 13327.5 13737.2 13741.5 14198.1 12646.7 12842.7 12915.6 12976.6 15757.7 11885.8 14079.0 14100.6 14269.3 14540.3 13778.0 14025.7 14657.0 14882.8 15129.5 13339.3 14045.2 14177.8 14223.3 14341.0 9560.9 9933.7 10869.6 11613.5 11888.8 8129.8 9876.4 11615.6 11715.9 12003.6 05:55:40 INFO - PROCESS | 1652 | -------- Summary: end -------- 05:55:40 INFO - PROCESS | 1652 | 05:55:40 INFO - TEST-INFO | 1652: exit 0 05:55:40 INFO - TEST-OK | dromaeo_css | took 1114029ms 05:55:40 INFO - TEST-START | kraken 05:55:40 INFO - operating with platform_type : mac_ 05:55:40 INFO - Initialising browser for kraken test... 05:55:40 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpXgIbnO/profile http://localhost:49262/getInfo.html) 05:55:43 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 05:55:43 INFO - PROCESS | 1663 | colorDepth:24 05:55:43 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 05:55:43 INFO - PROCESS | 1663 | __metrics 05:55:43 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 05:55:44 INFO - TEST-INFO | 1663: exit 0 05:55:44 INFO - Browser initialized. 05:55:44 INFO - Running cycle 1/1 for kraken test... 05:55:44 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpXgIbnO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:56 INFO - PROCESS | 1666 | RSS: Main: 247222272 05:55:56 INFO - PROCESS | 1666 | 05:55:59 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection) 05:56:00 INFO - PROCESS | 1666 | RSS: Main: 260059136 05:56:00 INFO - PROCESS | 1666 | 05:56:03 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-dft) 05:56:03 INFO - PROCESS | 1666 | RSS: Main: 269164544 05:56:03 INFO - PROCESS | 1666 | 05:56:07 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-fft) 05:56:07 INFO - PROCESS | 1666 | RSS: Main: 265428992 05:56:07 INFO - PROCESS | 1666 | 05:56:09 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator) 05:56:10 INFO - PROCESS | 1666 | RSS: Main: 267739136 05:56:10 INFO - PROCESS | 1666 | 05:56:12 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:56:13 INFO - PROCESS | 1666 | RSS: Main: 268316672 05:56:13 INFO - PROCESS | 1666 | 05:56:16 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom) 05:56:17 INFO - PROCESS | 1666 | RSS: Main: 269500416 05:56:17 INFO - PROCESS | 1666 | 05:56:20 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate) 05:56:20 INFO - PROCESS | 1666 | RSS: Main: 269688832 05:56:20 INFO - PROCESS | 1666 | 05:56:23 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial) 05:56:24 INFO - PROCESS | 1666 | RSS: Main: 269758464 05:56:24 INFO - PROCESS | 1666 | 05:56:25 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:56:26 INFO - PROCESS | 1666 | RSS: Main: 269864960 05:56:26 INFO - PROCESS | 1666 | 05:56:28 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:56:28 INFO - PROCESS | 1666 | RSS: Main: 270196736 05:56:28 INFO - PROCESS | 1666 | 05:56:31 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:56:31 INFO - PROCESS | 1666 | RSS: Main: 270282752 05:56:31 INFO - PROCESS | 1666 | 05:56:34 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:56:35 INFO - PROCESS | 1666 | RSS: Main: 270131200 05:56:35 INFO - PROCESS | 1666 | 05:56:38 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:56:38 INFO - PROCESS | 1666 | RSS: Main: 270155776 05:56:38 INFO - PROCESS | 1666 | 05:56:40 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49262/tests/kraken/driver.html?testName=ai-astar) 05:56:40 INFO - PROCESS | 1666 | RSS: Main: 272130048 05:56:40 INFO - PROCESS | 1666 | 05:56:40 INFO - PROCESS | 1666 | __start_tp_report 05:56:40 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 05:56:40 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 05:56:40 INFO - PROCESS | 1666 | |i|pagename|runs| 05:56:40 INFO - PROCESS | 1666 | |0;ai-astar;107;117;116;92;171;173;114;169;164;131 05:56:40 INFO - PROCESS | 1666 | |1;audio-beat-detection;142;110;133;157;107;133;126;109;151;136 05:56:40 INFO - PROCESS | 1666 | |2;audio-dft;212;252;177;271;285;204;198;198;192;227 05:56:40 INFO - PROCESS | 1666 | |3;audio-fft;69;82;75;147;58;60;59;63;157;53 05:56:40 INFO - PROCESS | 1666 | |4;audio-oscillator;72;71;116;71;70;81;116;106;106;150 05:56:40 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;105;132;134;88;88;85;91;116;135;97 05:56:40 INFO - PROCESS | 1666 | |6;imaging-darkroom;94;94;115;120;95;151;132;95;95;95 05:56:40 INFO - PROCESS | 1666 | |7;imaging-desaturate;91;102;89;102;91;91;91;92;91;91 05:56:40 INFO - PROCESS | 1666 | |8;json-parse-financial;56;57;59;58;56;58;58;57;57;62 05:56:40 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;69;68;74;69;77;75;69;68;66;69 05:56:40 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;91;88;90;89;88;86;90;86;86;84 05:56:40 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;141;133;134;154;153;159;137;153;176;152 05:56:40 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;171;178;162;148;229;234;179;171;172;172 05:56:40 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;68;70;71;68;72;66;70;84;95;86 05:56:40 INFO - PROCESS | 1666 | __end_tp_report 05:56:40 INFO - PROCESS | 1666 | __start_cc_report 05:56:40 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1081 05:56:40 INFO - PROCESS | 1666 | __end_cc_report 05:56:40 INFO - PROCESS | 1666 | __startTimestamp1472043400959__endTimestamp 05:56:40 INFO - PROCESS | 1666 | 05:56:40 INFO - PROCESS | 1666 | ------- Summary: start ------- 05:56:40 INFO - PROCESS | 1666 | Number of tests: 14 05:56:40 INFO - PROCESS | 1666 | 05:56:40 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:135.40 Median:166.50 stddev:30.75 (18.5%) stddev-sans-first:30.85 05:56:40 INFO - PROCESS | 1666 | Values: 107.0 117.0 116.0 92.0 171.0 173.0 114.0 169.0 164.0 131.0 05:56:40 INFO - PROCESS | 1666 | 05:56:40 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:130.40 Median:134.50 stddev:17.49 (13.0%) stddev-sans-first:18.04 05:56:40 INFO - PROCESS | 1666 | Values: 142.0 110.0 133.0 157.0 107.0 133.0 126.0 109.0 151.0 136.0 05:56:40 INFO - PROCESS | 1666 | 05:56:40 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:221.60 Median:219.50 stddev:36.20 (16.5%) stddev-sans-first:38.23 05:56:40 INFO - PROCESS | 1666 | Values: 212.0 252.0 177.0 271.0 285.0 204.0 198.0 198.0 192.0 227.0 05:56:40 INFO - PROCESS | 1666 | 05:56:40 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:82.30 Median:61.50 stddev:37.80 (61.5%) stddev-sans-first:39.78 05:56:40 INFO - PROCESS | 1666 | Values: 69.0 82.0 75.0 147.0 58.0 60.0 59.0 63.0 157.0 53.0 05:56:40 INFO - PROCESS | 1666 | 05:56:40 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:70.50 stddev:27.17 (38.5%) stddev-sans-first:27.40 05:56:40 INFO - PROCESS | 1666 | Values: 72.0 71.0 116.0 71.0 70.0 81.0 116.0 106.0 106.0 150.0 05:56:40 INFO - PROCESS | 1666 | 05:56:40 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:107.10 Median:86.50 stddev:20.51 (23.7%) stddev-sans-first:21.74 05:56:40 INFO - PROCESS | 1666 | Values: 105.0 132.0 134.0 88.0 88.0 85.0 91.0 116.0 135.0 97.0 05:56:40 INFO - PROCESS | 1666 | 05:56:40 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:108.60 Median:94.50 stddev:20.23 (21.4%) stddev-sans-first:20.75 05:56:40 INFO - PROCESS | 1666 | Values: 94.0 94.0 115.0 120.0 95.0 151.0 132.0 95.0 95.0 95.0 05:56:40 INFO - PROCESS | 1666 | 05:56:40 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:93.10 Median:91.00 stddev:4.75 (5.2%) stddev-sans-first:4.97 05:56:40 INFO - PROCESS | 1666 | Values: 91.0 102.0 89.0 102.0 91.0 91.0 91.0 92.0 91.0 91.0 05:56:40 INFO - PROCESS | 1666 | 05:56:40 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:1.75 (3.0%) stddev-sans-first:1.73 05:56:40 INFO - PROCESS | 1666 | Values: 56.0 57.0 59.0 58.0 56.0 58.0 58.0 57.0 57.0 62.0 05:56:40 INFO - PROCESS | 1666 | 05:56:40 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:69.00 stddev:3.60 (5.2%) stddev-sans-first:3.78 05:56:40 INFO - PROCESS | 1666 | Values: 69.0 68.0 74.0 69.0 77.0 75.0 69.0 68.0 66.0 69.0 05:56:40 INFO - PROCESS | 1666 | 05:56:40 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:88.50 stddev:2.25 (2.5%) stddev-sans-first:2.07 05:56:40 INFO - PROCESS | 1666 | Values: 91.0 88.0 90.0 89.0 88.0 86.0 90.0 86.0 86.0 84.0 05:56:40 INFO - PROCESS | 1666 | 05:56:40 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:149.20 Median:153.00 stddev:13.26 (8.7%) stddev-sans-first:13.73 05:56:40 INFO - PROCESS | 1666 | Values: 141.0 133.0 134.0 154.0 153.0 159.0 137.0 153.0 176.0 152.0 05:56:40 INFO - PROCESS | 1666 | 05:56:40 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.60 Median:175.00 stddev:27.76 (15.9%) stddev-sans-first:29.18 05:56:40 INFO - PROCESS | 1666 | Values: 171.0 178.0 162.0 148.0 229.0 234.0 179.0 171.0 172.0 172.0 05:56:40 INFO - PROCESS | 1666 | 05:56:40 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.00 Median:71.50 stddev:9.75 (13.6%) stddev-sans-first:10.01 05:56:40 INFO - PROCESS | 1666 | Values: 68.0 70.0 71.0 68.0 72.0 66.0 70.0 84.0 95.0 86.0 05:56:40 INFO - PROCESS | 1666 | -------- Summary: end -------- 05:56:40 INFO - PROCESS | 1666 | 05:56:41 INFO - TEST-INFO | 1666: exit 0 05:56:41 INFO - TEST-OK | kraken | took 61020ms 05:56:41 INFO - SUITE-END | took 1175s 05:56:42 INFO - Completed test suite (00:19:35) 05:56:42 INFO - javascript benchmark 05:56:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7318.209797475948, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2586.9870650646744, 3329.2176338560434, 3424.7260219182454, 3450.758446908716, 3457.0320310313123, 5760.279965004374, 5794.39158888317, 5830.30036395632, 5848.883022339551, 5881.705914704269, 5620.100783874581, 5846.386129456409, 5858.853528661785, 5953.404659534044, 5982.79060232892, 5238.345206849144, 5243.868903277429, 5307.071262529062, 5367.46325367464, 5370.382406023318, 5243.449437809013, 5387.19192121181, 5405.324334458192, 5425.945740542603, 5427.62006659534, 5147.433782283946, 5288.947110528922, 5296.3909150447425, 5335.386430560497, 5342.626016178869, 5187.221916712486, 5205.947940520584, 5224.399194092652, 5231.529162375405, 5259.973700131513, 5171.534561889411, 5183.481651834824, 5218.6868787872845, 5247.895042099175, 5328.413874473805, 5686.658800471943, 5717.028105222123, 5862.853428664317, 5863.618864773819, 5889.941100588982, 5293.920591191135, 6233.158523599302, 6271.184745983039, 6286.685665716695, 6299.433051025384, 6212.502999760009, 6222.5644204905675, 6286.308506064329, 6289.654069026202, 6301.212348456443, 5744.8851022979725, 5909.084091965752, 5938.317093534212, 5992.9700351498395, 6079.361667024943, 6326.49388048955, 6328.367163283635, 6341.524385671093, 6346.0, 6355.904661430082, 6217.626942383471, 6236.532260080421, 6237.438630523184, 6246.219222597176, 6253.187085678833, 6183.412575805291, 6223.813285601439, 6241.469475094577, 6302.369763023753, 6307.148534947815, 6147.72335244915, 6191.1641928339095, 6236.095766113888, 6248.0, 6282.623042617458, 5559.861003474945, 6194.659293738798, 6263.592866463665, 6265.780697675651, 6276.843078922972, 3934.213157368538, 4052.1895620875944, 4053.2906741320153, 5074.4671809460215, 5081.4918508148885, 4405.801738921757, 4491.775411229425, 4498.50516443191, 4566.70316429431, 4589.701669391479, 5831.679257640785, 5926.555508336892, 5927.110933359944, 5929.37741537141, 5981.910271345933, 6260.655663938436, 6274.152989346379, 6284.717187726564, 6334.683265836689, 6343.651099189589, 5748.31020277561, 5820.534357251409, 5837.09525023622, 5902.940970590239, 5907.911381329283, 5363.704996225245, 5397.4062853086125, 5404.621676482609, 5509.779608815683, 5515.61390702655, 6244.812655620339, 6286.717097730613, 6298.779542715983, 6300.338464461257, 6303.243610766737, 6194.659293738888, 6226.0, 6250.249970003629, 6285.371462853678, 6301.527385446201, 6194.783182588588, 6275.309715931336, 6282.528810339151, 6309.274433440213, 6350.428461438492, 6227.906581401192, 6231.594946328474, 6238.563300568917, 6265.310815810349, 6270.0908368287255, 6208.286047104641, 6244.687765611792, 6249.843753906189, 6253.687315634291, 6255.093011513396, 4515.729056256635, 6067.0, 6086.786962456293, 6103.328633850362, 6236.501079913687, 5092.694438333712, 6007.12896629995, 6184.6598437086395, 6268.310485846644, 6277.027060805583, 5411.241346562304, 5992.64044157352, 6047.244094488189, 6058.787942421994, 6136.20229370179, 6040.463005537773, 6142.355052719578, 6200.831563518753, 6229.626222426669, 6238.376162383725, 5225.451327610546, 6084.148219249397, 6095.939040609537, 6120.203342909657, 6135.508280839814], "value": 5715.971390676972, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.4855310605228, 472.09829226178005, 499.78259457136147, 534.9408171819797, 539.8893226888488, 33702.831485842566, 41750.0, 41880.5341813037, 41955.79022104893, 42064.0, 42530.0, 42965.570344296546, 43044.78477607615, 43064.56935430645, 43118.568814311846, 9636.66271680493, 9817.410955342702, 9826.50867456628, 9855.0, 9864.062914023156, 9694.127528522431, 9783.168430683401, 9807.950960245189, 9810.068043535854, 9818.852717209247, 8363.330933525303, 9755.609775608968, 9780.41317520951, 9808.381617033181, 9818.45998470084, 8201.58992050398, 9732.318737688365, 9789.657361992297, 9794.608215671364, 9800.754981125529, 9648.90351096487, 9734.123928846439, 9748.050389921973, 9754.804903901953, 9768.413895166243, 41036.79481602603, 41106.38340424896, 41126.38310425346, 41370.0, 41544.792276038424, 3391.71170450512, 3452.482127680843, 3711.5546134463766, 3997.2605068062503, 4164.214683968536, 28835.990740324196, 29152.688129034243, 30092.8495357524, 30235.697643023508, 32416.513752293733, 3198.5202219667003, 3327.7337812975147, 3409.8124603146816, 3447.5690538682666, 3464.3244567309384, 508772.0, 515651.9999999963, 516648.9183527559, 517075.0, 517451.0, 50929.0, 60867.69566152141, 61338.079928801104, 61395.0, 61604.69197653983, 63717.45130194833, 63877.0, 64140.0, 64365.678171609776, 64735.67632161903, 16281.0, 16482.83517164813, 16505.917470412813, 16534.421295254608, 16593.917030415014, 12765.489380424864, 12791.680207994874, 12835.358232088358, 12866.228026318451, 12925.806112908314, 13946.860531394555, 17379.13104344778, 17545.035023073597, 17578.91210543939, 17590.92158872192, 6191.566590338633, 6214.130021796952, 6250.718717657716, 6295.433410993032, 6296.43332100104, 807.9394045446497, 851.642310229705, 909.0999910089097, 922.3359181389388, 940.9764755881158, 29525.0, 30581.541276880864, 30678.619462124258, 31729.682703173134, 31890.2027449311, 1018.3940555369543, 1039.859618951432, 1120.3781901045, 1148.7989601819647, 1180.0500597019482, 15657.451989180325, 15773.921130394274, 15933.283002264925, 15977.920110399373, 16228.83771162297, 681399.0, 688760.0, 690105.0, 693557.0, 693916.0608393851, 60156.39843601595, 60697.69651151716, 60744.088838667456, 61316.0, 61455.69272153611, 1356.1862882270757, 1376.3393571085935, 1413.1026797983354, 1415.775354318507, 1423.665438621923, 27079.0, 31140.844295778377, 32255.516167257978, 32419.35161296808, 32972.67027329696, 52039.219411708094, 52758.0, 56792.0, 57292.42707572871, 62491.43771405751, 625130.0, 639597.0, 640764.7961760161, 643528.0, 644636.0, 21898.0, 22108.55782884301, 23630.0, 25807.870960645076, 27325.86337068302, 38363.80818095891, 48883.511164887896, 49438.75280623574, 50355.0, 53182.0, 39946.800265998485, 40300.79849600733, 40562.2190025237, 40871.77384678464, 41970.0, 30350.241243968194, 40546.59453405428, 40569.98575035648, 40797.0, 42139.0, 39256.2148757029, 39965.8010259681, 40250.79247622576, 40455.0, 40663.39004914988, 32465.837670812438, 35874.54656734717, 35942.0, 36140.91577252687, 36275.0, 25656.819170370727, 26261.606075908494, 26474.602880957187, 26493.60259596146, 26812.06157784468], "value": 20253.157291200623, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.86572900891184, 375.54558983629806, 381.73278704906556, 382.1973854904702, 400.7555391211362, 18866.811331886678, 21129.47176320593, 21304.57390852184, 21382.465438364048, 21543.784562154393, 19759.604807903834, 20094.899525502387, 20721.378358649228, 20966.26618068368, 21315.680264796003, 5830.5044071254, 5862.179294898718, 5942.5840191186635, 5958.897603943263, 6018.398160183969, 4166.9791651041705, 5899.0266606009955, 6017.849553761147, 6019.337872833985, 6326.715297811609, 6313.968430157865, 6708.36270554299, 6709.496787740914, 6715.395614394703, 6739.0, 6606.702698378561, 6671.799846004627, 6679.833004174886, 6710.966445167792, 6711.4295284900845, 5029.497050294978, 5726.942730572682, 5827.737751801179, 5830.212921255618, 5848.181254624356, 12972.80540791889, 13094.934525327313, 13303.60089197316, 13387.0, 13394.799078013837, 2116.809487146149, 2205.38249290199, 2238.2949370948263, 2301.1255722825385, 2309.145616122029, 9893.208543316518, 10110.342827716175, 10169.186465082776, 10170.033846784618, 10206.132478739317, 1853.7775466944054, 1861.9906900465546, 1872.87826291292, 1900.5818719881604, 1972.1716878910893, 100319.49201269954, 106311.0, 124185.75814241833, 125039.0, 126637.0, 9599.904000960041, 11016.11871050314, 11239.887601123884, 11568.88431115695, 11993.580224692269, 14409.927950360181, 14470.927645361706, 14487.20320382389, 14512.85487145115, 14519.92740036293, 8321.500709957421, 8583.613737381833, 8598.011228708778, 8713.085126061798, 8727.519986400683, 8427.747167584983, 8583.442076265022, 8619.267362274277, 8712.956435217784, 8713.651453941771, 3851.8651847185774, 4444.244478438609, 4597.770111494478, 4602.1025899949855, 4607.476169087162, 1598.5763772600271, 1663.7338025916038, 1925.315349069564, 1934.458351661537, 1986.3147214211074, 826.1531929772032, 869.7869022089502, 879.4811061473761, 923.5243849417556, 1013.422349260929, 14705.0, 20692.896535517528, 21134.682979755315, 21372.145114195257, 21378.037988290565, 784.7253461288617, 900.9728909043696, 935.3873213045466, 940.3793496292415, 948.6821914658667, 8697.782555436164, 8915.197632213132, 11418.828717569244, 11520.308781473139, 11564.884351156381, 607020.9648951727, 609302.0, 612927.0, 620635.0, 622727.0, 109579.0, 128134.0, 131005.68994310126, 134219.0, 135754.6424535742, 427.5574780102579, 449.3641497281376, 458.7591514454938, 927.7912469694264, 948.2935213266023, 10843.024127828534, 10851.511681974487, 11329.263597866113, 11446.313221206754, 11760.941195294312, 53938.0, 54776.726116369166, 57926.0, 58954.70522647359, 60057.0, 64690.67654661885, 67799.98300025602, 84863.5756821212, 86120.13879861371, 87859.0, 7957.801054973672, 8172.060213075572, 8296.87554686668, 8304.584770761317, 8323.750287491384, 9124.406913550598, 12087.818682719942, 12657.556985505464, 12906.612801615967, 13100.344982750634, 8588.398812083095, 11192.384418856715, 11211.0, 11331.32012079278, 11402.82895756581, 11160.609378671708, 11392.487338069972, 11418.371989540656, 11478.885211148116, 11717.941410292893, 11259.211855170059, 11340.886591134313, 11565.074794016291, 11607.36159511235, 11671.12466564994, 7702.499337543042, 8059.3955453342405, 8155.877661834958, 8417.410781245255, 8443.113473085483, 10482.266241363031, 10583.62957296491, 10713.517891694737, 10927.0, 11290.379029153148], "value": 9178.571656464139, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.6925607110365, 1493.5220729366604, 1684.8315168483145, 1833.4774589242068, 1876.3526583328755, 7903.92096079039, 8452.408331416804, 8588.355873309496, 8976.461412315257, 8977.461352318856, 8587.699430519933, 8679.175478329564, 8776.648934042647, 8795.340349473783, 8812.515311657857, 2342.636891281854, 2380.571497130516, 2381.7499162587937, 2382.4520360317138, 2391.7608239176116, 2353.2351985604746, 2363.3737059679197, 2389.6057150570136, 2397.208921056056, 2414.7947424468853, 2385.2128797496785, 2388.176079252655, 2389.199618127929, 2411.553862535428, 2419.201663451057, 1745.4065617690046, 1960.8235058964578, 2027.9657374738842, 2369.4194922244073, 2387.140629373424, 1990.8506861985409, 2319.0375993962484, 2368.6920700309024, 2377.9881100594557, 2380.773826486481, 8907.821843563157, 8964.731058068268, 8965.731028069169, 8974.14745599167, 8976.012638609747, 4524.411826462571, 5174.327337446146, 5364.785408583652, 5379.892402151974, 5382.596305277119, 3515.156362473014, 3575.946360804564, 3662.7252956028406, 3682.6317368263226, 3717.498137751396, 1076.4671487613602, 1092.6995076354067, 1107.7839821234863, 1118.0943435817014, 1120.8598925134359, 11465.942670286679, 11586.710332241677, 11603.477843497063, 11647.359395233174, 11664.59173928917, 4535.092981403733, 4654.2785868190485, 4792.376990991149, 4833.589144922651, 4840.491748366441, 9777.217822574177, 9903.851442228372, 9906.05892440217, 9915.454649994175, 9923.900760992297, 5360.16917377807, 5372.194170874322, 5374.140137577969, 5383.946160538345, 5387.057264978613, 4405.339199120158, 4762.119007983534, 4869.342638743724, 4912.557869791736, 4923.0153969205585, 3431.897043088711, 3875.6899448044087, 3977.940330895039, 4000.2599519089063, 4027.9798601006805, 1294.5792617399384, 1309.1359702596242, 1310.377570653951, 1314.750197462479, 1314.8035287887976, 838.6980686952692, 839.8278352937755, 923.7644400677784, 940.1867384712175, 975.9365641233297, 5820.447057529528, 5978.940210597925, 6041.78853740117, 6100.969495152496, 6201.348858369806, 413.5099906610676, 442.40717438632385, 444.11399258478895, 447.4004833523095, 456.04003572480116, 3533.664301891368, 4023.6177563131455, 4027.8791636250958, 4138.193052354822, 4149.107941792468, 10471.057604815604, 10691.30506517074, 10786.56853725858, 10814.675559733221, 10838.891611083945, 10732.624358147428, 10765.730856728644, 10782.406967616856, 10805.40570268627, 10806.18953578469, 7845.293923546908, 8157.632906519221, 8209.507429554245, 8237.46456480327, 8250.46371985819, 5465.196485159809, 5761.596688231783, 5982.038890749107, 6060.424259695322, 6261.749530018748, 9608.183304419203, 9982.700518984442, 10048.0, 10087.0, 10099.091081802673, 8172.673093076448, 10186.949065254626, 10221.080102790784, 10395.740106497096, 10427.739306517398, 7528.397728181842, 7629.0845098588525, 7720.652570634447, 7750.418718596241, 7753.844923101394, 8268.297194738514, 8309.33525317961, 8398.202170793766, 8439.915600843913, 8448.704295349633, 5789.928863160329, 7072.363487285963, 7357.926420735724, 7516.962415187889, 7644.961775191088, 6191.226096737908, 6731.831704207434, 6749.966250168718, 7292.890606641011, 7370.742024029133, 6001.669908155093, 6973.442124629916, 6987.161540615159, 7069.293070692889, 7078.221395646578, 5047.343845300087, 5089.185730283285, 5106.821261255986, 5154.14956532168, 5157.561607263275, 4750.6199504038905, 5062.367204099488, 5144.125498665161, 5194.584433245256, 5202.453742357149], "value": 4490.187542593178, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.3348633007383, 308.45711547676086, 316.1164545096455, 316.3262251404508, 320.677718892513, 4774.824741546871, 5498.945010549894, 5601.663900165993, 5720.4565566271185, 5823.941760582393, 5222.451642577522, 5597.7201139943045, 5686.744096515657, 5747.59766816323, 5767.250257466523, 4327.350897365389, 4332.740035597859, 4360.146937551528, 4374.540673229313, 4385.675591936279, 3630.6187850275737, 3852.9807350963206, 3986.561478237406, 4379.9926017016105, 4412.205802955466, 3721.553413590373, 4123.134141830219, 4217.789110544476, 4248.87253382399, 4267.530571637118, 3980.3233450313373, 4230.329020037084, 4243.8090285937205, 4268.850590229327, 4312.870613881589, 3060.5256185291314, 3662.0, 3671.4859919611276, 3682.4476328550663, 3700.4264339027495, 5135.38375394955, 5272.472752724735, 5410.810621628224, 5555.444455554452, 5669.291338582677, 4849.418069831643, 4881.609471242292, 4892.700430797519, 4908.558229759339, 4967.925481117786, 5013.949860501385, 5078.111330517182, 5593.468620481048, 5594.860128496779, 5972.581919265654, 3499.4051011328133, 3771.8311970617005, 4030.052937559671, 4038.1116154445976, 4087.162131763011, 5104.69830193302, 5281.540590912959, 5595.384507704109, 6416.422521972998, 6425.8393540161405, 3295.0279667498144, 3447.4311738563356, 3782.884049205491, 3813.84744610218, 4129.91740165201, 3886.4170374443493, 4127.484064491939, 4152.190322887008, 4167.540941018947, 4180.707350485498, 4210.978945105316, 4766.118268120409, 4906.89594841165, 4918.631102667314, 4941.827036053721, 5329.9467005330225, 5770.942290577124, 6095.451409373178, 6116.449519543263, 6124.785632502841, 1383.2599559235962, 1413.406369324886, 1415.4338264694, 1417.6461479287257, 1424.9715005699827, 834.5390529710055, 837.2255663511228, 840.7309660908572, 858.553552152877, 866.3935245328296, 4208.663306935499, 4385.473743150842, 4738.407699037621, 4788.802799300175, 4789.592884604847, 4869.561739443397, 5140.046782222731, 5189.42916279209, 5249.265102885599, 5311.061462566213, 3778.6977041836585, 4085.673146148301, 4612.976935115303, 4778.546038126373, 4834.250691142878, 2379.892904819287, 2623.81633285672, 2648.1790644899756, 2745.203890871665, 2755.1540467886566, 4289.463817022872, 4704.388429504211, 5096.770645320969, 5353.411124776271, 5372.8656783579945, 4999.779982300778, 5206.349206349207, 5336.546393556514, 5398.973005134949, 5451.127819548853, 5212.296339994128, 5398.623351045537, 5402.945970540323, 5408.755366523006, 5454.945450545444, 4732.858014259577, 5175.0167468180925, 5221.399539053057, 5224.537129603717, 5272.604554658339, 4079.6124368184974, 4343.934840977325, 4531.750753708578, 5169.948300516947, 5179.611529135405, 4610.631149508098, 5073.619478539198, 5419.674819510842, 5430.13117901134, 5439.972800135974, 3150.9369812604077, 3447.4484082547674, 3506.684398404054, 3590.8025058622025, 3636.563557394867, 4378.75916824565, 4663.647542212856, 4763.476017637988, 4937.77779999908, 5270.657407268515, 4517.232070548081, 4579.816807327669, 4789.407944041968, 4809.374781278411, 5127.974450092118, 4969.900601987868, 5099.3370861787735, 5114.667546609458, 5125.872308092363, 5174.63777535584, 4622.722636641813, 4966.850994470172, 4981.427135879276, 5002.499750024968, 6004.189434426296, 5307.363116426053, 6136.969315153396, 6149.815505534841, 6151.0, 6202.255729312511, 5515.310586176728, 5979.043353063489, 6032.607880487754, 6037.577369584087, 6224.439800417984], "value": 4028.1965967880033, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.4273951796633, 754.9282818132278, 771.9884201736975, 772.6523064620918, 872.0581771686577, 15629.0, 16650.1674916254, 16744.0, 16777.748333774973, 16778.91610541947, 15142.242887855618, 15293.617659558517, 15310.770338444905, 15322.0, 15377.0, 750.4821673045594, 794.2295972906301, 858.7423772868145, 897.3942588752599, 900.1493588558815, 865.212656482601, 879.8636211387245, 883.041899539001, 887.7603047177258, 887.9600417981175, 869.9434536755123, 927.7634203278188, 928.9256859451227, 929.586334081334, 930.1675000874213, 897.8339007283673, 921.0375157959915, 925.9768505787342, 926.073926073926, 929.0245242495387, 676.7834293026234, 685.2701872505816, 689.9344562266576, 692.0553444548156, 694.0664805836142, 14141.575752727435, 14852.2573871306, 15504.069755814575, 15634.687306253925, 15802.683946321009, 14321.14073155614, 14340.856591434162, 14451.566453006322, 14555.636109097251, 14632.561023169323, 11860.584879529262, 12015.699607509794, 12027.819582706266, 12223.69440763979, 12318.0, 3796.7532110412735, 3799.088218827489, 3849.364854798983, 3874.5350557932948, 3994.8601798936897, 117054.82945170524, 127510.0, 129457.0, 129509.05736413962, 131233.56430792605, 11136.888631113585, 11243.66269011931, 11244.606438774603, 11350.375729334966, 11581.88418115808, 22511.0, 22588.66117008246, 22592.096316147497, 22646.320610381714, 22684.432889177904, 6515.674216289167, 7415.962920185365, 7455.85088298231, 7502.4748267621835, 7748.225177482207, 3761.9435708464393, 4691.179043667413, 4702.036082603058, 4781.282807578891, 4782.713037217778, 3657.7805331680183, 3707.943236177676, 3708.38811596089, 3777.773333599993, 3783.8297276622066, 663.7112855907695, 673.2089794491453, 674.723363420995, 682.2801943949181, 689.2280645676874, 588.7527238559816, 679.1725365166398, 692.6398272898166, 694.3232094491746, 701.8244440562038, 9109.635614575343, 9676.371035882787, 9814.852777208347, 9831.950840245896, 9949.502524873727, 509.39890928704483, 628.2660155726578, 665.7736369634348, 667.1693741292122, 690.1097584116534, 4353.455818022747, 4859.028194361142, 4876.731779752147, 4980.368257520468, 5059.848204553869, 133365.0, 150523.24738376457, 159107.0, 160380.0, 161273.19363403108, 138816.0, 139680.0, 141000.2949985264, 142007.0, 142955.0, 112952.0, 114991.0, 116418.0, 116945.0, 117765.82234177549, 9286.72139835806, 9335.53870985481, 9397.389169703947, 9402.012788657366, 9543.761405964906, 51788.74105629448, 58126.709366452895, 59793.0, 61813.690931545054, 63687.04469433055, 54050.91898161936, 78929.0, 90910.09089909017, 93691.0, 94137.529312353, 11707.121965852766, 13327.533536326182, 13737.175769453865, 13741.450341986209, 14198.077124986843, 12646.747065058831, 12842.67893302675, 12915.612531624067, 12976.610701678965, 15757.684846303238, 11885.821712674144, 14079.0, 14100.576982690536, 14269.304913251313, 14540.272986350852, 13778.0, 14025.719485610434, 14656.955309774523, 14882.776758348416, 15129.47046853355, 13339.333033348099, 14045.227512486912, 14177.787333189804, 14223.288835558387, 14341.0, 9560.85658715106, 9933.679568644513, 10869.641294838146, 11613.535458581562, 11888.821667674818, 8129.79675508117, 9876.40741555509, 11615.593454229062, 11715.941420292844, 12003.63989080329], "value": 7991.873008677578, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1596.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 117.0, 116.0, 92.0, 171.0, 173.0, 114.0, 169.0, 164.0, 131.0], "value": 135.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 110.0, 133.0, 157.0, 107.0, 133.0, 126.0, 109.0, 151.0, 136.0], "value": 130.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [212.0, 252.0, 177.0, 271.0, 285.0, 204.0, 198.0, 198.0, 192.0, 227.0], "value": 221.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 82.0, 75.0, 147.0, 58.0, 60.0, 59.0, 63.0, 157.0, 53.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 116.0, 71.0, 70.0, 81.0, 116.0, 106.0, 106.0, 150.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 132.0, 134.0, 88.0, 88.0, 85.0, 91.0, 116.0, 135.0, 97.0], "value": 107.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 115.0, 120.0, 95.0, 151.0, 132.0, 95.0, 95.0, 95.0], "value": 108.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 102.0, 89.0, 102.0, 91.0, 91.0, 91.0, 92.0, 91.0, 91.0], "value": 93.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 59.0, 58.0, 56.0, 58.0, 58.0, 57.0, 57.0, 62.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 74.0, 69.0, 77.0, 75.0, 69.0, 68.0, 66.0, 69.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 90.0, 89.0, 88.0, 86.0, 90.0, 86.0, 86.0, 84.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 133.0, 134.0, 154.0, 153.0, 159.0, 137.0, 153.0, 176.0, 152.0], "value": 149.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 178.0, 162.0, 148.0, 229.0, 234.0, 179.0, 171.0, 172.0, 172.0], "value": 181.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 71.0, 68.0, 72.0, 66.0, 70.0, 84.0, 95.0, 86.0], "value": 75.0, "unit": "score"}]}]} 05:56:42 INFO - Return code: 0 05:56:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:56:42 ERROR - # TBPL SUCCESS # 05:56:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:56:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:56:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:56:42 INFO - 2016-08-24 05:56:42.288 screenresolution[1671:10457] starting screenresolution argv=screenresolution get 05:56:42 INFO - 2016-08-24 05:56:42.291 screenresolution[1671:10457] Display 0: 1600x1200x32@60 05:56:42 INFO - 2016-08-24 05:56:42.297 screenresolution[1672:10460] starting screenresolution argv=screenresolution list 05:56:42 INFO - Available Modes on Display 0 05:56:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:56:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:56:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:56:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:56:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:56:42 INFO - Intel Iris: 05:56:42 INFO - Chipset Model: Intel Iris 05:56:42 INFO - Type: GPU 05:56:42 INFO - Bus: Built-In 05:56:42 INFO - VRAM (Dynamic, Max): 1536 MB 05:56:42 INFO - Vendor: Intel (0x8086) 05:56:42 INFO - Device ID: 0x0a2e 05:56:42 INFO - Revision ID: 0x0009 05:56:42 INFO - Displays: 05:56:42 INFO - Display: 05:56:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:56:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:56:42 INFO - Display Serial Number: 1600x1200 60 05:56:42 INFO - Main Display: Yes 05:56:42 INFO - Mirror: Off 05:56:42 INFO - Online: Yes 05:56:42 INFO - Rotation: Supported 05:56:42 INFO - Return code: 0 05:56:42 INFO - Running post-action listener: _resource_record_post_action 05:56:42 INFO - [mozharness: 2016-08-24 12:56:42.529599Z] Finished run-tests step (success) 05:56:42 INFO - Running post-run listener: _resource_record_post_run 05:56:42 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 39384064; Write bytes: 709710336; Read time: 383; Write time: 2579 05:56:42 INFO - TinderboxPrint: CPU usage
54.9% 05:56:42 INFO - TinderboxPrint: I/O read bytes / time
39,384,064 / 383 05:56:42 INFO - TinderboxPrint: I/O write bytes / time
709,710,336 / 2,579 05:56:42 INFO - TinderboxPrint: CPU idle
2,185.9 (45.1%) 05:56:42 INFO - TinderboxPrint: CPU system
983.1 (20.3%) 05:56:42 INFO - TinderboxPrint: CPU user
1,672.7 (34.5%) 05:56:42 INFO - TinderboxPrint: Swap in / out
444,698,624 / 0 05:56:42 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 399077888; Write bytes: 392476160; Read time: 29590; Write time: 641 05:56:42 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 37364736; Write bytes: 298849280; Read time: 360; Write time: 1825 05:56:43 INFO - Running post-run listener: _upload_blobber_files 05:56:43 INFO - Blob upload gear active. 05:56:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:56:43 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 05:56:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:56:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:56:43 INFO - (blobuploader) - INFO - Open directory for files ... 05:56:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:56:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:56:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:44 INFO - (blobuploader) - INFO - Done attempting. 05:56:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:56:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:56:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:45 INFO - (blobuploader) - INFO - Done attempting. 05:56:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:56:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:56:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:47 INFO - (blobuploader) - INFO - Done attempting. 05:56:47 INFO - (blobuploader) - INFO - Iteration through files over. 05:56:47 INFO - Return code: 0 05:56:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:56:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:56:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a189fd69962c319fff9293ef7bd687c470c80d50f1b48641b8a552d4c0d370f54d266ba5c522e75dd38b73535a86830df35476a68627bca1e32d8390994d5648", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33aad40ad895da4db9813f1c09caad2ce099bed56bae010f0b01db1f898733b165359e8dc20ef03e22f6a4221009dac48e05bf658ff56f4e6eaeca42f89a31fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea174897ac5cd5b1608361cf758fe80db94421434304861890ced9f7d022091e3f449d41013f33bba797e1631bb519978523ecad4ac2230def1ad0e59ab857bb"} 05:56:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:56:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:56:47 INFO - Contents: 05:56:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a189fd69962c319fff9293ef7bd687c470c80d50f1b48641b8a552d4c0d370f54d266ba5c522e75dd38b73535a86830df35476a68627bca1e32d8390994d5648", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33aad40ad895da4db9813f1c09caad2ce099bed56bae010f0b01db1f898733b165359e8dc20ef03e22f6a4221009dac48e05bf658ff56f4e6eaeca42f89a31fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea174897ac5cd5b1608361cf758fe80db94421434304861890ced9f7d022091e3f449d41013f33bba797e1631bb519978523ecad4ac2230def1ad0e59ab857bb"} 05:56:47 INFO - Running post-run listener: copy_logs_to_upload_dir 05:56:47 INFO - Copying logs to upload dir... 05:56:47 INFO - mkdir: /builds/slave/test/build/upload/logs 05:56:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.022643 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-24 05:56:47.898408) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 05:56:47.902412) ========= 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.ewV8CiXKCH/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.AFQPQaJPMF/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a189fd69962c319fff9293ef7bd687c470c80d50f1b48641b8a552d4c0d370f54d266ba5c522e75dd38b73535a86830df35476a68627bca1e32d8390994d5648", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33aad40ad895da4db9813f1c09caad2ce099bed56bae010f0b01db1f898733b165359e8dc20ef03e22f6a4221009dac48e05bf658ff56f4e6eaeca42f89a31fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea174897ac5cd5b1608361cf758fe80db94421434304861890ced9f7d022091e3f449d41013f33bba797e1631bb519978523ecad4ac2230def1ad0e59ab857bb"} build_url:https://queue.taskcluster.net/v1/task/cLoQDuiPRD6cmZyM0zlFXA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011222 build_url: 'https://queue.taskcluster.net/v1/task/cLoQDuiPRD6cmZyM0zlFXA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a189fd69962c319fff9293ef7bd687c470c80d50f1b48641b8a552d4c0d370f54d266ba5c522e75dd38b73535a86830df35476a68627bca1e32d8390994d5648", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33aad40ad895da4db9813f1c09caad2ce099bed56bae010f0b01db1f898733b165359e8dc20ef03e22f6a4221009dac48e05bf658ff56f4e6eaeca42f89a31fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea174897ac5cd5b1608361cf758fe80db94421434304861890ced9f7d022091e3f449d41013f33bba797e1631bb519978523ecad4ac2230def1ad0e59ab857bb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 05:56:47.935947) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 05:56:47.936329) ========= 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.ewV8CiXKCH/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.AFQPQaJPMF/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.005179 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 05:56:47.985066) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 05:56:47.985400) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 05:56:47.985743) ========= ========= Total master_lag: 0.17 =========