builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0244 starttime: 1472301275.07 results: success (0) buildid: 20160827030436 builduid: 87000f71599a4d9ba69a1b6044284593 revision: c724ae8bb7b867b6bc65efa1049c0322457ff4b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-27 05:34:35.069414) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-27 05:34:35.069907) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-27 05:34:35.070250) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-27 05:34:35.225030) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 05:34:35.225372) ========= 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.2V1JQvigOw/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.WPM29hfZih/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-27 05:34:35-- 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% 26.3M=0s 2016-08-27 05:34:35 (26.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.611913 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 05:34:35.879246) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 05:34:35.879563) ========= 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.2V1JQvigOw/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.WPM29hfZih/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.026555 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 05:34:35.927802) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-27 05:34:35.928173) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c724ae8bb7b867b6bc65efa1049c0322457ff4b0 --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 c724ae8bb7b867b6bc65efa1049c0322457ff4b0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2V1JQvigOw/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.WPM29hfZih/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-27 05:34:36,012 truncating revision to first 12 chars 2016-08-27 05:34:36,012 Setting DEBUG logging. 2016-08-27 05:34:36,012 attempt 1/10 2016-08-27 05:34:36,012 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c724ae8bb7b8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-27 05:34:37,835 unpacking tar archive at: mozilla-central-c724ae8bb7b8/testing/mozharness/ program finished with exit code 0 elapsedTime=2.073319 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-27 05:34:38.027562) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-27 05:34:38.028323) ========= script_repo_revision: c724ae8bb7b867b6bc65efa1049c0322457ff4b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-27 05:34:38.029318) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-27 05:34:38.030032) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-27 05:34:38.050842) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-27 05:34:38.051646) ========= /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.2V1JQvigOw/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.WPM29hfZih/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:34:38 INFO - MultiFileLogger online at 20160827 05:34:38 in /builds/slave/test 05:34: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:34:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:34:38 INFO - {'append_to_log': False, 05:34:38 INFO - 'base_work_dir': '/builds/slave/test', 05:34:38 INFO - 'blob_upload_branch': 'Firefox', 05:34:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:34:38 INFO - 'branch': 'Firefox', 05:34:38 INFO - 'buildbot_json_path': 'buildprops.json', 05:34:38 INFO - 'config_files': ('talos/mac_config.py',), 05:34:38 INFO - 'default_actions': ('clobber', 05:34:38 INFO - 'read-buildbot-config', 05:34:38 INFO - 'download-and-extract', 05:34:38 INFO - 'populate-webroot', 05:34:38 INFO - 'create-virtualenv', 05:34:38 INFO - 'install', 05:34:38 INFO - 'run-tests'), 05:34:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:34:38 INFO - 'download_minidump_stackwalk': True, 05:34:38 INFO - 'download_symbols': 'ondemand', 05:34:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:34:38 INFO - 'tooltool.py': '/tools/tooltool.py', 05:34:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:34:38 INFO - '/tools/misc-python/virtualenv.py')}, 05:34:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:34:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:34:38 INFO - 'installer_path': 'installer.exe', 05:34:38 INFO - 'log_level': 'info', 05:34:38 INFO - 'log_name': 'talos', 05:34:38 INFO - 'log_to_console': True, 05:34:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:34:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:34:38 INFO - 'opt_config_files': (), 05:34:38 INFO - 'pip_index': False, 05:34:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:34:38 INFO - 'cmd': ('bash', 05:34:38 INFO - '-c', 05:34:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:34:38 INFO - 'enabled': True, 05:34:38 INFO - 'halt_on_failure': False, 05:34:38 INFO - 'name': 'check_screen_resolution'},), 05:34:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:34:38 INFO - 'cmd': ('bash', 05:34:38 INFO - '-c', 05:34:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:34:38 INFO - 'enabled': True, 05:34:38 INFO - 'halt_on_failure': False, 05:34:38 INFO - 'name': 'check_screen_resolution'},), 05:34:38 INFO - 'run_cmd_checks_enabled': True, 05:34:38 INFO - 'sps_profile': False, 05:34:38 INFO - 'sps_profile_interval': 0, 05:34:38 INFO - 'suite': 'dromaeojs-e10s', 05:34:38 INFO - 'system_bits': '32', 05:34:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:34:38 INFO - 'title': 't-yosemite-r7-0244', 05:34:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:34:38 INFO - 'use_talos_json': True, 05:34:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:34:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:34:38 INFO - 'work_dir': 'build'} 05:34:38 INFO - [mozharness: 2016-08-27 12:34:38.248569Z] Running clobber step. 05:34:38 INFO - Running pre-action listener: _resource_record_pre_action 05:34:38 INFO - Running main action method: clobber 05:34:38 INFO - rmtree: /builds/slave/test/build 05:34:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:34:40 INFO - Running post-action listener: _resource_record_post_action 05:34:40 INFO - [mozharness: 2016-08-27 12:34:40.349487Z] Finished clobber step (success) 05:34:40 INFO - [mozharness: 2016-08-27 12:34:40.349733Z] Running read-buildbot-config step. 05:34:40 INFO - Running pre-action listener: _resource_record_pre_action 05:34:40 INFO - Running main action method: read_buildbot_config 05:34:40 INFO - Using buildbot properties: 05:34:40 INFO - { 05:34:40 INFO - "project": "", 05:34:40 INFO - "product": "firefox", 05:34:40 INFO - "script_repo_revision": "production", 05:34:40 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:34:40 INFO - "repository": "", 05:34:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:34:40 INFO - "buildid": "20160827030436", 05:34:40 INFO - "stage_platform": "macosx64", 05:34:40 INFO - "basedir": "/builds/slave/test", 05:34:40 INFO - "nightly_build": "True", 05:34:40 INFO - "buildnumber": 71, 05:34:40 INFO - "slavename": "t-yosemite-r7-0244", 05:34:40 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 05:34:40 INFO - "platform": "yosemite_r7", 05:34:40 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:34:40 INFO - "branch": "mozilla-central", 05:34:40 INFO - "repo_path": "mozilla-central", 05:34:40 INFO - "revision": "c724ae8bb7b867b6bc65efa1049c0322457ff4b0", 05:34:40 INFO - "pgo_build": "False", 05:34:40 INFO - "builduid": "87000f71599a4d9ba69a1b6044284593", 05:34:40 INFO - "slavebuilddir": "test" 05:34:40 INFO - } 05:34:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/KXenkkpHSBm7k-GoCRm1bA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 05:34:40 INFO - Running post-action listener: _resource_record_post_action 05:34:40 INFO - [mozharness: 2016-08-27 12:34:40.355965Z] Finished read-buildbot-config step (success) 05:34:40 INFO - [mozharness: 2016-08-27 12:34:40.356182Z] Running download-and-extract step. 05:34:40 INFO - Running pre-action listener: _resource_record_pre_action 05:34:40 INFO - Running main action method: download_and_extract 05:34:40 INFO - mkdir: /builds/slave/test/build/tests 05:34: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:34:40 INFO - trying https://queue.taskcluster.net/v1/task/KXenkkpHSBm7k-GoCRm1bA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 05:34:40 INFO - Downloading https://queue.taskcluster.net/v1/task/KXenkkpHSBm7k-GoCRm1bA/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:34:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KXenkkpHSBm7k-GoCRm1bA/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:34:41 INFO - Downloaded 1199 bytes. 05:34:41 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:34:41 INFO - Using the following test package requirements: 05:34:41 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:34:41 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:34:41 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 05:34:41 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:34:41 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 05:34:41 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:34:41 INFO - u'jsshell-mac.zip'], 05:34:41 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:34:41 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 05:34:41 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:34:41 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:34:41 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 05:34:41 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:34:41 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 05:34:41 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:34:41 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 05:34:41 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:34:41 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 05:34:41 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:34:41 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:34:41 INFO - trying https://queue.taskcluster.net/v1/task/KXenkkpHSBm7k-GoCRm1bA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:34:41 INFO - Downloading https://queue.taskcluster.net/v1/task/KXenkkpHSBm7k-GoCRm1bA/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:34:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KXenkkpHSBm7k-GoCRm1bA/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:34:42 INFO - Downloaded 16369484 bytes. 05:34:42 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:34:49 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:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:34:49 INFO - trying https://queue.taskcluster.net/v1/task/KXenkkpHSBm7k-GoCRm1bA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:34:49 INFO - Downloading https://queue.taskcluster.net/v1/task/KXenkkpHSBm7k-GoCRm1bA/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:34:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KXenkkpHSBm7k-GoCRm1bA/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:34:50 INFO - Downloaded 16369484 bytes. 05:34:50 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:34: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:34:56 INFO - trying https://queue.taskcluster.net/v1/task/KXenkkpHSBm7k-GoCRm1bA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:34:56 INFO - Downloading https://queue.taskcluster.net/v1/task/KXenkkpHSBm7k-GoCRm1bA/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:34:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KXenkkpHSBm7k-GoCRm1bA/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:34:58 INFO - Downloaded 14413998 bytes. 05:34:58 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:34: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:34:58 INFO - trying https://queue.taskcluster.net/v1/task/KXenkkpHSBm7k-GoCRm1bA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:34:58 INFO - Downloading https://queue.taskcluster.net/v1/task/KXenkkpHSBm7k-GoCRm1bA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 05:34:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KXenkkpHSBm7k-GoCRm1bA/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:35:01 INFO - Downloaded 111685050 bytes. 05:35:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KXenkkpHSBm7k-GoCRm1bA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:35:01 INFO - mkdir: /builds/slave/test/properties 05:35:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:35:01 INFO - Writing to file /builds/slave/test/properties/build_url 05:35:01 INFO - Contents: 05:35:01 INFO - build_url:https://queue.taskcluster.net/v1/task/KXenkkpHSBm7k-GoCRm1bA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:35:01 INFO - Running post-action listener: _resource_record_post_action 05:35:01 INFO - Running post-action listener: set_extra_try_arguments 05:35:01 INFO - [mozharness: 2016-08-27 12:35:01.772447Z] Finished download-and-extract step (success) 05:35:01 INFO - [mozharness: 2016-08-27 12:35:01.772612Z] Running populate-webroot step. 05:35:01 INFO - Running pre-action listener: _resource_record_pre_action 05:35:01 INFO - Running main action method: populate_webroot 05:35:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:35:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:35:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:35:01 INFO - '--tppagecycles', 05:35:01 INFO - '7'], 05:35:01 INFO - 'tests': ['tsvgm']}}, 05:35:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:35:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:35:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:35:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:35:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:35:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:35:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:01 INFO - 'talos_options': ['--disable-e10s'], 05:35:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:01 INFO - 'talos_options': ['--disable-e10s'], 05:35:01 INFO - 'tests': ['damp', 'tps']}, 05:35:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:01 INFO - 'tests': ['damp', 'tps']}, 05:35:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:35:01 INFO - 'tests': ['dromaeo_dom']}, 05:35:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:35:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:35:01 INFO - 'tests': ['basic_compositor_video']}, 05:35:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:35:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:35:01 INFO - 'tests': ['a11yr', 05:35:01 INFO - 'ts_paint', 05:35:01 INFO - 'tpaint', 05:35:01 INFO - 'sessionrestore', 05:35:01 INFO - 'sessionrestore_no_auto_restore', 05:35:01 INFO - 'tabpaint']}, 05:35:01 INFO - 'other-e10s': {'tests': ['a11yr', 05:35:01 INFO - 'ts_paint', 05:35:01 INFO - 'tpaint', 05:35:01 INFO - 'sessionrestore', 05:35:01 INFO - 'sessionrestore_no_auto_restore', 05:35:01 INFO - 'tabpaint']}, 05:35:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:35:01 INFO - 'ts_paint', 05:35:01 INFO - 'tpaint', 05:35:01 INFO - 'sessionrestore', 05:35:01 INFO - 'sessionrestore_no_auto_restore', 05:35:01 INFO - 'tabpaint']}, 05:35:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:35:01 INFO - 'ts_paint', 05:35:01 INFO - 'tpaint', 05:35:01 INFO - 'sessionrestore', 05:35:01 INFO - 'sessionrestore_no_auto_restore', 05:35:01 INFO - 'tabpaint']}, 05:35:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:35:01 INFO - 'tests': ['a11yr', 05:35:01 INFO - 'ts_paint', 05:35:01 INFO - 'tpaint', 05:35:01 INFO - 'sessionrestore', 05:35:01 INFO - 'sessionrestore_no_auto_restore', 05:35:01 INFO - 'tabpaint']}, 05:35:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:35:01 INFO - 'tests': ['a11yr', 05:35:01 INFO - 'ts_paint', 05:35:01 INFO - 'tpaint', 05:35:01 INFO - 'sessionrestore', 05:35:01 INFO - 'sessionrestore_no_auto_restore', 05:35:01 INFO - 'tabpaint']}, 05:35:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:35:01 INFO - 'tests': ['tsvgx', 05:35:01 INFO - 'tsvgr_opacity', 05:35:01 INFO - 'tart', 05:35:01 INFO - 'tscrollx', 05:35:01 INFO - 'cart']}, 05:35:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:35:01 INFO - 'tsvgr_opacity', 05:35:01 INFO - 'tart', 05:35:01 INFO - 'tscrollx', 05:35:01 INFO - 'cart']}, 05:35:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:01 INFO - 'talos_options': ['--disable-e10s'], 05:35:01 INFO - 'tests': ['tp5o']}, 05:35:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:01 INFO - 'tests': ['tp5o']}, 05:35:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:01 INFO - 'talos_options': ['--disable-e10s', 05:35:01 INFO - '--xperf_path', 05:35:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:01 INFO - 'tests': ['tp5n']}, 05:35:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:01 INFO - 'talos_options': ['--xperf_path', 05:35:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:01 INFO - 'tests': ['tp5n']}}, 05:35:01 INFO - 'talos.zip': {'path': '', 05:35:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:35:01 INFO - Running post-action listener: _resource_record_post_action 05:35:01 INFO - [mozharness: 2016-08-27 12:35:01.791694Z] Finished populate-webroot step (success) 05:35:01 INFO - [mozharness: 2016-08-27 12:35:01.791820Z] Running create-virtualenv step. 05:35:01 INFO - Running pre-action listener: _resource_record_pre_action 05:35:01 INFO - Running main action method: create_virtualenv 05:35:01 INFO - Creating virtualenv /builds/slave/test/build/venv 05:35: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:35:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:35:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:35:01 INFO - Using real prefix '/tools/python27' 05:35:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:35:02 INFO - Installing distribute.............................................................................................................................................................................................done. 05:35:05 INFO - Installing pip.................done. 05:35:05 INFO - Return code: 0 05:35:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:35: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:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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:35:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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 0x10a5e4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a679618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe732dac070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a548d30>, '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 0x10a2addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a540b20>, '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.2V1JQvigOw/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.WPM29hfZih/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35: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:35: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:35:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2V1JQvigOw/Render', 05:35:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:05 INFO - 'HOME': '/Users/cltbld', 05:35:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:05 INFO - 'LOGNAME': 'cltbld', 05:35:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:05 INFO - 'MOZ_NO_REMOTE': '1', 05:35:05 INFO - 'NO_EM_RESTART': '1', 05:35:05 INFO - 'PAGER': '/bin/cat', 05:35:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:05 INFO - 'PWD': '/builds/slave/test', 05:35:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:05 INFO - 'SHELL': '/bin/bash', 05:35:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WPM29hfZih/Listeners', 05:35:05 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:35:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:05 INFO - 'USER': 'cltbld', 05:35:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:05 INFO - 'XPC_FLAGS': '0x0', 05:35:05 INFO - 'XPC_SERVICE_NAME': '0', 05:35:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35: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:35:05 INFO - Cleaning up... 05:35:05 INFO - Return code: 0 05:35:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:35: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:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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:35:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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 0x10a5e4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a679618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe732dac070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a548d30>, '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 0x10a2addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a540b20>, '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.2V1JQvigOw/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.WPM29hfZih/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35: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:35: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:35:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2V1JQvigOw/Render', 05:35:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:05 INFO - 'HOME': '/Users/cltbld', 05:35:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:05 INFO - 'LOGNAME': 'cltbld', 05:35:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:05 INFO - 'MOZ_NO_REMOTE': '1', 05:35:05 INFO - 'NO_EM_RESTART': '1', 05:35:05 INFO - 'PAGER': '/bin/cat', 05:35:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:05 INFO - 'PWD': '/builds/slave/test', 05:35:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:05 INFO - 'SHELL': '/bin/bash', 05:35:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WPM29hfZih/Listeners', 05:35:05 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:35:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:05 INFO - 'USER': 'cltbld', 05:35:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:05 INFO - 'XPC_FLAGS': '0x0', 05:35:05 INFO - 'XPC_SERVICE_NAME': '0', 05:35:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:06 INFO - Downloading/unpacking psutil>=3.1.1 05:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:35:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:35:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:35:09 INFO - Installing collected packages: psutil 05:35:09 INFO - Running setup.py install for psutil 05:35:09 INFO - building 'psutil._psutil_osx' extension 05:35: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_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:35:10 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:35:10 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:35:10 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:35:10 INFO - building 'psutil._psutil_posix' extension 05:35:10 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:35:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:35:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:35:10 INFO - ^ 05:35:10 INFO - 1 warning generated. 05:35:10 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:35:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:35:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:35:10 INFO - Successfully installed psutil 05:35:10 INFO - Cleaning up... 05:35:10 INFO - Return code: 0 05:35:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:35:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:35:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a5e4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a679618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe732dac070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a548d30>, '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 0x10a2addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a540b20>, '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.2V1JQvigOw/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.WPM29hfZih/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:35:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:35:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2V1JQvigOw/Render', 05:35:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:10 INFO - 'HOME': '/Users/cltbld', 05:35:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:10 INFO - 'LOGNAME': 'cltbld', 05:35:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:10 INFO - 'MOZ_NO_REMOTE': '1', 05:35:10 INFO - 'NO_EM_RESTART': '1', 05:35:10 INFO - 'PAGER': '/bin/cat', 05:35:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:10 INFO - 'PWD': '/builds/slave/test', 05:35:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:10 INFO - 'SHELL': '/bin/bash', 05:35:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WPM29hfZih/Listeners', 05:35:10 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:35:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:10 INFO - 'USER': 'cltbld', 05:35:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:10 INFO - 'XPC_FLAGS': '0x0', 05:35:10 INFO - 'XPC_SERVICE_NAME': '0', 05:35:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:35: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:35: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:35: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:35: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:35: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:35: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:35:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:35:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:35:13 INFO - Installing collected packages: mozsystemmonitor 05:35:13 INFO - Running setup.py install for mozsystemmonitor 05:35:13 INFO - Successfully installed mozsystemmonitor 05:35:13 INFO - Cleaning up... 05:35:13 INFO - Return code: 0 05:35:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:35:13 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:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:13 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:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:13 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 0x10a5e4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a679618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe732dac070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a548d30>, '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 0x10a2addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a540b20>, '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.2V1JQvigOw/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.WPM29hfZih/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:13 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:35:13 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:35:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2V1JQvigOw/Render', 05:35:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:13 INFO - 'HOME': '/Users/cltbld', 05:35:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:13 INFO - 'LOGNAME': 'cltbld', 05:35:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:13 INFO - 'MOZ_NO_REMOTE': '1', 05:35:13 INFO - 'NO_EM_RESTART': '1', 05:35:13 INFO - 'PAGER': '/bin/cat', 05:35:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:13 INFO - 'PWD': '/builds/slave/test', 05:35:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:13 INFO - 'SHELL': '/bin/bash', 05:35:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WPM29hfZih/Listeners', 05:35:13 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:35:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:13 INFO - 'USER': 'cltbld', 05:35:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:13 INFO - 'XPC_FLAGS': '0x0', 05:35:13 INFO - 'XPC_SERVICE_NAME': '0', 05:35:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:14 INFO - Downloading/unpacking jsonschema==2.5.1 05:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:35:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:35: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:35: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:35: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:35: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:35: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:35: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:35:16 INFO - Downloading functools32-3.2.3-2.tar.gz 05:35:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:35:17 INFO - warning: no files found matching '*.txt' 05:35:17 INFO - no previously-included directories found matching 'build' 05:35:17 INFO - no previously-included directories found matching 'dist' 05:35:17 INFO - no previously-included directories found matching '.git*' 05:35:17 INFO - Installing collected packages: jsonschema, functools32 05:35:17 INFO - Running setup.py install for functools32 05:35:17 INFO - warning: no files found matching '*.txt' 05:35:17 INFO - no previously-included directories found matching 'build' 05:35:17 INFO - no previously-included directories found matching 'dist' 05:35:17 INFO - no previously-included directories found matching '.git*' 05:35:17 INFO - Successfully installed jsonschema functools32 05:35:17 INFO - Cleaning up... 05:35:17 INFO - Return code: 0 05:35:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:35:17 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:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:17 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:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:17 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 0x10a5e4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a679618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe732dac070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a548d30>, '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 0x10a2addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a540b20>, '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.2V1JQvigOw/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.WPM29hfZih/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:17 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:35:17 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:35:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2V1JQvigOw/Render', 05:35:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:17 INFO - 'HOME': '/Users/cltbld', 05:35:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:17 INFO - 'LOGNAME': 'cltbld', 05:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:17 INFO - 'MOZ_NO_REMOTE': '1', 05:35:17 INFO - 'NO_EM_RESTART': '1', 05:35:17 INFO - 'PAGER': '/bin/cat', 05:35:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:17 INFO - 'PWD': '/builds/slave/test', 05:35:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:17 INFO - 'SHELL': '/bin/bash', 05:35:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WPM29hfZih/Listeners', 05:35:17 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:35:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:17 INFO - 'USER': 'cltbld', 05:35:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:17 INFO - 'XPC_FLAGS': '0x0', 05:35:17 INFO - 'XPC_SERVICE_NAME': '0', 05:35:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:35:17 INFO - Cleaning up... 05:35:17 INFO - Return code: 0 05:35:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:35:17 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:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:17 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:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:17 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 0x10a5e4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a679618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe732dac070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a548d30>, '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 0x10a2addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a540b20>, '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.2V1JQvigOw/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.WPM29hfZih/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:17 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:35:17 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:35:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2V1JQvigOw/Render', 05:35:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:17 INFO - 'HOME': '/Users/cltbld', 05:35:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:17 INFO - 'LOGNAME': 'cltbld', 05:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:17 INFO - 'MOZ_NO_REMOTE': '1', 05:35:17 INFO - 'NO_EM_RESTART': '1', 05:35:17 INFO - 'PAGER': '/bin/cat', 05:35:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:17 INFO - 'PWD': '/builds/slave/test', 05:35:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:17 INFO - 'SHELL': '/bin/bash', 05:35:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WPM29hfZih/Listeners', 05:35:17 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:35:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:17 INFO - 'USER': 'cltbld', 05:35:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:17 INFO - 'XPC_FLAGS': '0x0', 05:35:17 INFO - 'XPC_SERVICE_NAME': '0', 05:35:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:17 INFO - Downloading/unpacking blobuploader==1.2.4 05:35:17 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:35:17 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:35:17 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:35:17 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:35:17 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:35:17 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:35:20 INFO - Downloading blobuploader-1.2.4.tar.gz 05:35:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:35:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:35: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:35: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:35: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:35: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:35: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:35: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:35:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:35:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:35:21 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:35:21 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:35:21 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:35:21 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:35:21 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:35:21 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:35:21 INFO - Downloading docopt-0.6.1.tar.gz 05:35:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:35:21 INFO - Installing collected packages: blobuploader, requests, docopt 05:35:21 INFO - Running setup.py install for blobuploader 05:35:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:35:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:35:21 INFO - Running setup.py install for requests 05:35:22 INFO - Running setup.py install for docopt 05:35:22 INFO - Successfully installed blobuploader requests docopt 05:35:22 INFO - Cleaning up... 05:35:22 INFO - Return code: 0 05:35:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:35:22 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:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:22 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:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:22 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 0x10a5e4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a679618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe732dac070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a548d30>, '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 0x10a2addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a540b20>, '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.2V1JQvigOw/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.WPM29hfZih/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:22 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:35:22 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:35:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2V1JQvigOw/Render', 05:35:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:22 INFO - 'HOME': '/Users/cltbld', 05:35:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:22 INFO - 'LOGNAME': 'cltbld', 05:35:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:22 INFO - 'MOZ_NO_REMOTE': '1', 05:35:22 INFO - 'NO_EM_RESTART': '1', 05:35:22 INFO - 'PAGER': '/bin/cat', 05:35:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:22 INFO - 'PWD': '/builds/slave/test', 05:35:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:22 INFO - 'SHELL': '/bin/bash', 05:35:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WPM29hfZih/Listeners', 05:35:22 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:35:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:22 INFO - 'USER': 'cltbld', 05:35:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:22 INFO - 'XPC_FLAGS': '0x0', 05:35:22 INFO - 'XPC_SERVICE_NAME': '0', 05:35:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:35:22 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-C7IT4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:35:22 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-7jwzO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:35:22 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-nJHC22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:35:23 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-3F65nD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:35:23 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-pAlzXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:35:23 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-SPCIwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:35:23 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-ZnlMbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:35:23 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-7KXAL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:35:23 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-mWPN7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:35:23 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-o_nCX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:35:23 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-tm407i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:35:23 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-JiFlPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:35:23 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-hO1x1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:35:24 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-eu4X1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:35:24 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-EVGXoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:35:24 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-l3BL7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:35:24 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-jUTPOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:35:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:35:24 INFO - Running setup.py install for manifestparser 05:35:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:35:24 INFO - Running setup.py install for mozcrash 05:35:24 INFO - Running setup.py install for mozdebug 05:35:24 INFO - Running setup.py install for mozdevice 05:35:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:35:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:35:25 INFO - Running setup.py install for mozfile 05:35:25 INFO - Running setup.py install for mozhttpd 05:35:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:35:25 INFO - Running setup.py install for mozinfo 05:35:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:35:25 INFO - Running setup.py install for mozInstall 05:35:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:35:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:35:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:35:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:35:25 INFO - Running setup.py install for mozleak 05:35:25 INFO - Running setup.py install for mozlog 05:35:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:35:25 INFO - Running setup.py install for moznetwork 05:35:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:35:26 INFO - Running setup.py install for mozprocess 05:35:26 INFO - Running setup.py install for mozprofile 05:35:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:35:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:35:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:35:26 INFO - Running setup.py install for mozrunner 05:35:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:35:26 INFO - Running setup.py install for mozscreenshot 05:35:26 INFO - Running setup.py install for moztest 05:35:26 INFO - Running setup.py install for mozversion 05:35:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:35:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:35:27 INFO - Cleaning up... 05:35:27 INFO - Return code: 0 05:35:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:35:27 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:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:27 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:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:27 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 0x10a5e4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a679618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe732dac070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a548d30>, '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 0x10a2addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a540b20>, '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.2V1JQvigOw/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.WPM29hfZih/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:27 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:35:27 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:35:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2V1JQvigOw/Render', 05:35:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:27 INFO - 'HOME': '/Users/cltbld', 05:35:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:27 INFO - 'LOGNAME': 'cltbld', 05:35:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:27 INFO - 'MOZ_NO_REMOTE': '1', 05:35:27 INFO - 'NO_EM_RESTART': '1', 05:35:27 INFO - 'PAGER': '/bin/cat', 05:35:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:27 INFO - 'PWD': '/builds/slave/test', 05:35:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:27 INFO - 'SHELL': '/bin/bash', 05:35:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WPM29hfZih/Listeners', 05:35:27 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:35:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:27 INFO - 'USER': 'cltbld', 05:35:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:27 INFO - 'XPC_FLAGS': '0x0', 05:35:27 INFO - 'XPC_SERVICE_NAME': '0', 05:35:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:35:27 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-JegdRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:35:27 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:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:35:27 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-CF7tlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:35:27 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:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:35:27 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-pxCtCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:35:27 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:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:35:27 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-2FbKsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:35:27 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:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:35:27 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-MW0zYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:35:27 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:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:35:27 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-ZYm_UX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:35:27 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:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:35:27 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-JPiCTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:35:28 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:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:35:28 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-DC_k8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:35:28 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:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:35:28 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-XiwqHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:35:28 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:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:35:28 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-dHkZ4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:35:28 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:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:35:28 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-NU0p2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:35:28 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:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:35:28 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-TqpWus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:35:28 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:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:35:28 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-udIJbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:35:28 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:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:35:28 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-o7RouD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:35:28 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:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:35:28 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-hCGtVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:35:28 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:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:35:28 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-s4t4eN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:35:29 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:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:35:29 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-B9bMdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:35:29 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:35:29 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:35:29 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:35:29 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:35:29 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:35:29 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:35:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:35:29 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:35:29 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:35:29 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:35:29 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:35:29 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:35:29 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:35:31 INFO - Downloading blessings-1.6.tar.gz 05:35:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:35:31 INFO - Installing collected packages: blessings 05:35:31 INFO - Running setup.py install for blessings 05:35:31 INFO - Successfully installed blessings 05:35:31 INFO - Cleaning up... 05:35:31 INFO - Return code: 0 05:35:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:35:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:35:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:35:32 INFO - Reading from file tmpfile_stdout 05:35:32 INFO - Current package versions: 05:35:32 INFO - blessings == 1.6 05:35:32 INFO - blobuploader == 1.2.4 05:35:32 INFO - docopt == 0.6.1 05:35:32 INFO - functools32 == 3.2.3-2 05:35:32 INFO - jsonschema == 2.5.1 05:35:32 INFO - manifestparser == 1.1 05:35:32 INFO - mozInstall == 1.12 05:35:32 INFO - mozcrash == 0.17 05:35:32 INFO - mozdebug == 0.1 05:35:32 INFO - mozdevice == 0.48 05:35:32 INFO - mozfile == 1.2 05:35:32 INFO - mozhttpd == 0.7 05:35:32 INFO - mozinfo == 0.9 05:35:32 INFO - mozleak == 0.1 05:35:32 INFO - mozlog == 3.3 05:35:32 INFO - moznetwork == 0.27 05:35:32 INFO - mozprocess == 0.23 05:35:32 INFO - mozprofile == 0.28 05:35:32 INFO - mozrunner == 6.12 05:35:32 INFO - mozscreenshot == 0.1 05:35:32 INFO - mozsystemmonitor == 0.3 05:35:32 INFO - moztest == 0.7 05:35:32 INFO - mozversion == 1.4 05:35:32 INFO - psutil == 3.1.1 05:35:32 INFO - requests == 1.2.3 05:35:32 INFO - wsgiref == 0.1.2 05:35:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:35:32 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:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:32 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:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:32 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 0x10a5e4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a679618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe732dac070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a548d30>, '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 0x10a2addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a540b20>, '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.2V1JQvigOw/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.WPM29hfZih/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:32 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:35:32 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:35:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2V1JQvigOw/Render', 05:35:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:32 INFO - 'HOME': '/Users/cltbld', 05:35:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:32 INFO - 'LOGNAME': 'cltbld', 05:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:32 INFO - 'MOZ_NO_REMOTE': '1', 05:35:32 INFO - 'NO_EM_RESTART': '1', 05:35:32 INFO - 'PAGER': '/bin/cat', 05:35:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:32 INFO - 'PWD': '/builds/slave/test', 05:35:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:32 INFO - 'SHELL': '/bin/bash', 05:35:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WPM29hfZih/Listeners', 05:35:32 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:35:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:32 INFO - 'USER': 'cltbld', 05:35:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:32 INFO - 'XPC_FLAGS': '0x0', 05:35:32 INFO - 'XPC_SERVICE_NAME': '0', 05:35:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:32 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:35:32 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:35:32 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:35:32 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:35:32 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:35:32 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:35:32 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:35:32 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:35:32 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:35:32 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:35:32 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:35:32 INFO - Cleaning up... 05:35:32 INFO - Return code: 0 05:35:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:35:32 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:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:32 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:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:32 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 0x10a5e4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a679618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe732dac070>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a548d30>, '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 0x10a2addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a540b20>, '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.2V1JQvigOw/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.WPM29hfZih/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:32 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:35:32 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:35:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2V1JQvigOw/Render', 05:35:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:32 INFO - 'HOME': '/Users/cltbld', 05:35:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:32 INFO - 'LOGNAME': 'cltbld', 05:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:32 INFO - 'MOZ_NO_REMOTE': '1', 05:35:32 INFO - 'NO_EM_RESTART': '1', 05:35:32 INFO - 'PAGER': '/bin/cat', 05:35:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:32 INFO - 'PWD': '/builds/slave/test', 05:35:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:32 INFO - 'SHELL': '/bin/bash', 05:35:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WPM29hfZih/Listeners', 05:35:32 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:35:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:32 INFO - 'USER': 'cltbld', 05:35:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:32 INFO - 'XPC_FLAGS': '0x0', 05:35:32 INFO - 'XPC_SERVICE_NAME': '0', 05:35:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:35:32 INFO - Cleaning up... 05:35:32 INFO - Return code: 0 05:35:32 INFO - Running post-action listener: _resource_record_post_action 05:35:32 INFO - Running post-action listener: _start_resource_monitoring 05:35:32 INFO - Starting resource monitoring. 05:35:32 INFO - [mozharness: 2016-08-27 12:35:32.833699Z] Finished create-virtualenv step (success) 05:35:32 INFO - [mozharness: 2016-08-27 12:35:32.834675Z] Running install step. 05:35:32 INFO - Running pre-action listener: _resource_record_pre_action 05:35:32 INFO - Running main action method: install 05:35:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:35:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:35:33 INFO - Reading from file tmpfile_stdout 05:35:33 INFO - Detecting whether we're running mozinstall >=1.0... 05:35:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:35:33 INFO - Reading from file tmpfile_stdout 05:35:33 INFO - Output received: 05:35:33 INFO - Usage: mozinstall [options] installer 05:35:33 INFO - Options: 05:35:33 INFO - -h, --help show this help message and exit 05:35:33 INFO - -d DEST, --destination=DEST 05:35:33 INFO - Directory to install application into. [default: 05:35:33 INFO - "/builds/slave/test"] 05:35:33 INFO - --app=APP Application being installed. [default: firefox] 05:35:33 INFO - mkdir: /builds/slave/test/build/application 05:35:33 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:35:33 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:36:07 INFO - Reading from file tmpfile_stdout 05:36:07 INFO - Output received: 05:36:07 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:36:07 INFO - Running post-action listener: _resource_record_post_action 05:36:07 INFO - [mozharness: 2016-08-27 12:36:07.773436Z] Finished install step (success) 05:36:07 INFO - [mozharness: 2016-08-27 12:36:07.773569Z] Running run-tests step. 05:36:07 INFO - Running pre-action listener: _resource_record_pre_action 05:36:07 INFO - Running main action method: run_tests 05:36:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:36:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:36:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:36:07 INFO - 2016-08-27 05:36:07.788 screenresolution[1645:8131] starting screenresolution argv=screenresolution get 05:36:07 INFO - 2016-08-27 05:36:07.790 screenresolution[1645:8131] Display 0: 1600x1200x32@60 05:36:07 INFO - 2016-08-27 05:36:07.796 screenresolution[1646:8133] starting screenresolution argv=screenresolution list 05:36:07 INFO - Available Modes on Display 0 05:36:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:36:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:36:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:36:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:36:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:36:08 INFO - Intel Iris: 05:36:08 INFO - Chipset Model: Intel Iris 05:36:08 INFO - Type: GPU 05:36:08 INFO - Bus: Built-In 05:36:08 INFO - VRAM (Dynamic, Max): 1536 MB 05:36:08 INFO - Vendor: Intel (0x8086) 05:36:08 INFO - Device ID: 0x0a2e 05:36:08 INFO - Revision ID: 0x0009 05:36:08 INFO - Displays: 05:36:08 INFO - Display: 05:36:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:36:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:36:08 INFO - Display Serial Number: 1600x1200 60 05:36:08 INFO - Main Display: Yes 05:36:08 INFO - Mirror: Off 05:36:08 INFO - Online: Yes 05:36:08 INFO - Rotation: Supported 05:36:08 INFO - Return code: 0 05:36:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:36:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:36:08 INFO - Python 2.7.3 05:36:08 INFO - Return code: 0 05:36:08 INFO - grabbing minidump binary from tooltool 05:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:08 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 0x10a548d30>, '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 0x10a2addb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a540b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:36:08 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:36:08 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:36:08 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:36:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:36:08 INFO - Return code: 0 05:36:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:36:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:36:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:36:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:36:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:36:08 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/KXenkkpHSBm7k-GoCRm1bA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0244', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:36:08 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/KXenkkpHSBm7k-GoCRm1bA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0244 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:36:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2V1JQvigOw/Render', 05:36:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:08 INFO - 'HOME': '/Users/cltbld', 05:36:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:08 INFO - 'LOGNAME': 'cltbld', 05:36:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:36:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:08 INFO - 'MOZ_NO_REMOTE': '1', 05:36:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:36:08 INFO - 'NO_EM_RESTART': '1', 05:36:08 INFO - 'PAGER': '/bin/cat', 05:36:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:08 INFO - 'PWD': '/builds/slave/test', 05:36:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:36:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:08 INFO - 'SHELL': '/bin/bash', 05:36:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WPM29hfZih/Listeners', 05:36:08 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:36:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:08 INFO - 'USER': 'cltbld', 05:36:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:08 INFO - 'XPC_FLAGS': '0x0', 05:36:08 INFO - 'XPC_SERVICE_NAME': '0', 05:36:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:08 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/KXenkkpHSBm7k-GoCRm1bA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0244', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:36:08 INFO - mozversion application_buildid: 20160827030436 05:36:08 INFO - mozversion application_changeset: c724ae8bb7b867b6bc65efa1049c0322457ff4b0 05:36:08 INFO - mozversion application_display_name: Nightly 05:36:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:36:08 INFO - mozversion application_name: Firefox 05:36:08 INFO - mozversion application_remotingname: firefox 05:36:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:36:08 INFO - mozversion application_vendor: Mozilla 05:36:08 INFO - mozversion application_version: 51.0a1 05:36:08 INFO - mozversion platform_buildid: 20160827030436 05:36:08 INFO - mozversion platform_changeset: c724ae8bb7b867b6bc65efa1049c0322457ff4b0 05:36:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:36:08 INFO - mozversion platform_version: 51.0a1 05:36:08 INFO - using testdate: 1472301368 05:36:08 INFO - actual date: 1472301368 05:36:08 INFO - starting webserver on 'localhost:49267' 05:36:08 INFO - SUITE-START | Running 2 tests 05:36:08 INFO - TEST-START | dromaeo_css 05:36:08 INFO - operating with platform_type : mac_ 05:36:08 INFO - Initialising browser for dromaeo_css test... 05:36:08 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmpYyax2A/profile http://localhost:49267/getInfo.html) 05:36:11 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 05:36:11 INFO - PROCESS | 1656 | colorDepth:24 05:36:11 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 05:36:11 INFO - PROCESS | 1656 | __metrics 05:36:11 ERROR - PROCESS | 1656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 05:36:12 INFO - TEST-INFO | 1656: exit 0 05:36:12 INFO - Browser initialized. 05:36:12 INFO - Running cycle 1/1 for dromaeo_css test... 05:36:12 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmpYyax2A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:24 INFO - PROCESS | 1661 | RSS: Main: 243855360 05:36:24 INFO - PROCESS | 1661 | 05:37:13 INFO - PROCESS | 1661 | 1472301433888 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:39:26 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 05:39:27 INFO - PROCESS | 1661 | RSS: Main: 268210176 05:39:27 INFO - PROCESS | 1661 | 05:42:29 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 05:42:30 INFO - PROCESS | 1661 | RSS: Main: 273555456 05:42:30 INFO - PROCESS | 1661 | 05:45:32 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 05:45:33 INFO - PROCESS | 1661 | RSS: Main: 275595264 05:45:33 INFO - PROCESS | 1661 | 05:48:35 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 05:48:35 INFO - PROCESS | 1661 | RSS: Main: 270790656 05:48:35 INFO - PROCESS | 1661 | 05:51:38 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 05:51:39 INFO - PROCESS | 1661 | RSS: Main: 276238336 05:51:39 INFO - PROCESS | 1661 | 05:54:41 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 05:54:42 INFO - PROCESS | 1661 | RSS: Main: 279064576 05:54:42 INFO - PROCESS | 1661 | 05:54:42 INFO - PROCESS | 1661 | __start_tp_report 05:54:42 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 05:54:42 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 05:54:42 INFO - PROCESS | 1661 | |i|pagename|runs| 05:54:42 INFO - PROCESS | 1661 | |0;dojo.html;2774.6254255675485;3354.983225083874;3382.2728113455632;3417.9658203417976;3424;5183.377994640644;5210.505002024806;5651.463111004458;5666.206731057655;5711.2575365202465;5517.531009864157;5636;5656.858578535539;5709.343425506068;5755.856103597413;5089.3638295213095;5154.149565321717;5261.2371206175085;5262.605304602151;5303.575713942894;4067.90166655003;5142.228665700156;5268.8155914542995;5355.518003379695;5369.221462887879;5085.1355269604255;5150.871228219287;5190.2733617293425;5218.973905130488;5285.127953887604;5143.974280128613;5207.6354655174155;5209.114450543379;5211.296474975906;5227.555657769094;5170.663906846043;5171.250168725552;5179.067767801795;5198.844034678966;5220.582353411756;4576.7253964761885;5542.91685624716;5659.462351076682;5704.743286552115;5772.971135144339;6121.4490695837585;6206.689665516707;6210.441060304549;6222.906656400158;6237.750489980395;5248.973755131238;6014.939850601481;6197.230665315784;6226.688665566749;6241.87516249677;5689.6017278790505;5752.539796816244;5780.393058728857;5790.565707571865;5843.2695913010875;6245.9694150465575;6255.374462553708;6283.8114856554375;6311.652859092702;6350.364963503613;6060.151578778975;6117.051856962178;6129.356417576179;6145.477634401126;6206.782762603287;5029.974850125799;6091.269939592756;6110.315755985069;6143.296949342275;6155.47678447337;6133.539984501091;6135.969320153371;6145.647957449354;6156.5998210116195;6179.84550386244;5996.010658241428;6163.568550201532;6186.752529898844;6211.782587609412;6277.183966084471;4855.101806165871;4925.532074452921;4955.752212389366;4961.677490963076;5030.698158110525;4405.008873003549;4434.645228381722;4461.776911154429;4488.887777805581;4502.549745025472;5358.223057656618;5758.7696492140685;5759.280089988752;5767.596268261182;5821.446962538552;6119.015143218386;6170.784022559279;6192.442680158807;6195.4424101831055;6240.344763799826;5785.1611516329895;5792.507636850914;5793.826185214451;5797.797077102281;5866.325372582208;5435.755391007335;5455.09990851513;5456.317960254968;5503.670279480936;5513.58648101394;6124.930239974474;6214.285357183981;6245.437910588069;6372.139761132281;6389.137466441971;6209.068639704081;6224.128621992834;6227.314995350598;6265.937340626535;6281.214848143982;5503.587230957614;6319.146915166394;6349.587276826992;6356.0465930109;6377.075324078076;6051.062085376773;6131.938680613137;6135.631862088289;6210.782622608187;6224.2842073160355;6072.362401947732;6232.844178895564;6240.594361366497;6249.50003999688;6279.717412716347;6056.757729690763;6073.30157031947;6076.787312444043;6115.85679409286;6130.141780150871;5937.584369094122;6011.489023432882;6073.544484163794;6097.573080549832;6133.785317513865;4577.496475387771;4806.615470762261;4833.9033219334715;5701.774118564528;5959.22530071088;5999.280086389661;6014.308354539284;6048.830193202821;6056.06131049688;6061.6666083365835;5773.018586840163;5784.5083167929515;5821.417858214145;5889.204957330706;5917.349091600006 05:54:42 INFO - PROCESS | 1661 | |1;ext.html;474.90976714424255;495.79176745766773;504.7834718328828;527.831094049904;561.9859503512414;36849.26301473969;39304.60695393045;39316.21367572654;39408.620698275605;39484.80257598708;38962.41556376657;40298.194036119334;40488.987775305635;40697.18605627893;40920.79539602305;8641.697540586081;9039.593218305192;9318.11477909601;9542.999999999982;9785.657501987433;7581.545107293552;7674.232576742309;8427.410081294312;8677.783055423633;9677.56450959705;9629.951850240739;9671.70984870455;9707.077827606367;9725.416475011487;9742.659006934759;8146.551939643317;9672.129508344282;9672.274579406503;9690.75773105671;9716.708498745049;9582.089701478348;9686.70939871805;9698;9721.756956076084;9746.46394448305;38158;38207.426888596696;38273.6604218851;38547;38629.61370386288;3391.609964854024;3416.0605833395766;3420.504026916083;3425.3663072331697;3452.879149229765;29348;29705.70294297051;29756.851215744;29900.700992990227;30069;3181.6341120771176;3209.3741720364537;3220.3559288142233;3254.251522149895;3305.7190138837987;472248;476254;476677;479226;479716;56501;56985.715071424376;56999.43000570024;57119.71440142856;57211.713941430025;33826.83086584551;34943.475847862304;34990;58554;58817.411825881194;16064.036157830335;16160.191990400433;16231.918840405722;16259.918700406422;16289.941153824964;12401.317927513894;12530.624081277576;12615.243085414904;12619.936900315439;12644.747105057848;15163.469278575198;18345.633087338178;18462;18532.629347412978;18575.349862754738;7927.643256053491;8053.677852885936;8075.515469071875;8098.838023239502;8123.6750529978135;849.9107593702572;928.9163975242126;941.0730430525927;1010.434156872154;1064.2443864855884;27417.31456713598;28529.85735071353;29429.411411772075;29672;30123.548146777815;869.7825543614097;987.6493844685177;991.6281394477071;1095.2935356694886;1121.9607313744143;13252.469901204036;14770.48303309379;15134.243287835565;15784.368625254861;16088.034717916962;484430;560393;638873;642066.789666058;643836;44820.77589612031;44872.77563612161;55948.72025639846;56058.43941560614;56233.71883140558;1306.9542566010143;1320.2738493828356;1346.8249127613346;1347.8517363090052;1353.7427888701116;24982.62526062147;28308.292292692848;28541;29466;29793.70206297996;36208.63791362053;45393.773031135956;47793.52206477891;48088.75955620199;48318.79203019812;529658;532513;533632.3318383539;535523;538715;25325.493490130462;25478;26031.739682602933;26058.478830423664;26064.609030864172;44672.55327446684;46009;46052.7697361511;46558.53441465677;46669.29996049994;38079.42880856734;38211;38457.828449823195;39122.608773911896;39293.21413571655;37841.81079094587;38072.42891356687;38254.808725956194;38888.222235555695;39337.40993885151;32672.50991235086;35028;37807.24385512219;37956.24087518289;38334;31919.840400797846;33658.25459474521;34027.65972340245;34063;34142;25019.999200031794;25292.367690807878;25403.491930160922;25483.6177457342;26120 05:54:42 INFO - PROCESS | 1661 | |2;jquery.html;372.28707026045123;374.1208160822068;377.8923006943021;386.8394616234263;400.251529639574;17088.57278568038;19322.90338548307;20758.584828303425;21133.682994755072;22464.438389040282;20318.882461464615;20657.38027859163;20904.26835060773;21148.942552872333;21235.362939111812;5888.970555147218;5943.286805583336;6097;6197.349278325779;6199.411055949678;3589.94615080774;5875.559333050017;6145.078238264274;6174.382561743834;6175.505959523227;6104.786332478364;6204.162438070848;6211.602389462358;6217.813465596039;6223.937760622403;5918.4969277611235;6098.908516372236;6154.353792851731;6162.661053642048;6197.814065578017;5281.656692314988;5757.712114394305;5983.072623743326;6021.51827853775;6025.126356678257;22839.77160228393;23931.162409315766;24099.036038558435;24798.752012480007;24923.762960296794;1669.6410271791624;2142;2142.4858034071867;2208.112064185115;2210.292706333974;9774.31579789415;9830.311878168532;9983.450910199936;10049.296549241555;10371.94814025925;1772.6277481728853;1885.2364792259157;1891.4325702289395;1909.5798924236647;1923.0961448119501;96992;101021;108553.31573474182;118826;124188.9999999991;10812.972767587067;11109.555617775199;11124.332540047622;11275;11440.656780296438;11572.594959176557;14065;14200.715985680436;14211.78682319766;14236.43054277838;8144.226298501633;8305.252527272574;8387.538685372363;8542;8565.571721413904;8058.516489010561;8130.918690813134;8142.063662678867;8408.873866892001;8417.989841219092;3759.947214779866;4436.8447104351835;4488;4506.752128632891;4613.123506533748;1553.829078801331;1620.9513714588581;1857.8699491035768;1904.8476121910214;1907.4659095453296;773.532013132047;831.3930830493773;891.3315013739696;963.7735132243918;1034.3948789957808;13631;16963.915180424017;21454.57090858174;21607.56784864294;22526.986285617186;911.3210658059788;926.7219834049758;964.9903500965041;968.8304546704298;975.687779910436;8467.872981905277;8850.424722393023;10883.510242038968;11048;11331.130363490096;535983;538629;541702;542959;547775;101624;105097.47451262694;107278;116027;125309;909.0091799937967;985.3545927417553;994.3337963564429;1027.635189507714;1044.3055368180228;18639.534011649816;18944.25308330312;19159;19215.615687685888;19297.614047718685;50498;50994;51074.23388649099;51578.48421515737;52211.216831746795;69210.65394672994;71066;71506.92739608805;71724;72059.63970180115;7815.765527034198;7928.682852686059;7965.840683186188;7990.360771138178;8101.906242657402;10811.35131892089;12840.165389249669;12947.805782913076;13200.009999249902;13222.272774997467;8029.518228906284;10629.25595208328;11157.776844462904;11231.887681123411;11500.424978750862;10854.511546980248;10967.287126336763;10992.450377481255;11217.607383741857;11434.542618295174;9204.815903682023;11463.713407164554;11504.769904602028;11594.71013224676;11745.47145378443;6348.682565871595;6590.835229119119;6893.034975103389;7687.615619218905;8272.255497005299;9042.81914361696;10458.895411045793;10675.145988321072;11280.661580152608;11345.829812552653 05:54:42 INFO - PROCESS | 1661 | |3;mootools.html;1521.5207209728935;1540.1529158962571;1761.11944027986;1864;1886.8584856135794;7996.160403157672;8427.410081294303;8677.43806114899;9034.412763170398;9042.819143617133;8647.308215342773;8874.511901845412;8879.289656827454;8886.55567221638;8910.108989101087;2338.2634470141934;2384.904603815854;2386.1767690146958;2393.628987506939;2397.1609936522163;2340.6372012338115;2362.492064206195;2396.580598395283;2406.4344878953434;2408.1089996701244;2372.5492156490213;2379.892904819287;2381.9285421437385;2394.988025059872;2401.2796161151673;2061.185831596526;2341.75411581784;2369.680093187415;2387.6060450025725;2390.8565486070806;2368.27767530903;2370.277065495023;2374.2074733576214;2394.4133687246735;2394.461246219604;8821.382503224777;8964.50695211763;8971.372003959725;8973.955130224307;9005.324600654978;5221.269022336838;5345.705986170759;5385.461453854622;5408.567314614861;5415.296011518517;3658.1951970566433;3687.520622319108;3711.777293362407;3740.139767853409;3742.36379815432;1079.2876701377131;1080.3247970018738;1087.5377964365193;1094.3433939636234;1116.609186784627;11547.191696581243;11597.478113484913;11705.829417058396;11714.062874969983;11755.471003804763;4524.6832721709825;4634.119517291704;4765.332853400527;4789.808407663654;4806.591439727592;9878.407295562289;9992.300538962203;9999.450030248407;10000.299979001546;10036.949815250877;5364.275822763955;5374.946250537523;5376.596755243294;5393.27190829233;5395.838124856261;4437.29003359461;4788.353572267769;4883.609311255091;4913.877153071202;4943.604511639061;3872.593377695358;3911.843526258918;3965.2862484753023;4024.625470972082;4036.3340048891605;1105.8175401058736;1133.6485689436302;1216.9391530423443;1266.5567051531891;1292;694.6318451220861;716.5628966330535;785.8742601183783;863.4689665855453;906.8141031088611;5118.564921981599;5901.498587274485;5939.643621382731;5981.5214782817275;6044.788432404933;424.2829617945662;426.54359834976276;427.6279636716015;429.1203033780737;441.2851181086596;3557.573091229069;3687.465317528943;4030.234255491447;4038.8788336349958;4098.672106231495;9033.63865445388;9497.90502094984;9632.133108020313;9658.985806490358;9680.75798105053;9533.237341012702;9578.425294482215;9622.807543849083;9672.70981870545;9676.322657414054;7412.481126321213;7415;7598.316151546277;7613.238676132342;7618.847623047508;4967.05625931072;5474.069408200536;5496.230527726201;5540.7783688652;5562.653171805936;7571.318581327707;9163.037881022397;9712.902870971482;10085.949570252102;10099.091081802673;9855.782448948929;9998.900120986831;10136.138428233682;10227.693169204937;10229.641962531574;6978.162620485574;7380.335769780745;7564.357029652541;7573.734919277799;7736.651850666621;8450.450720703135;8455.8731619027;8540.530270834915;8550.91449085526;8594.183552562497;7491.400687945061;7595.620218988918;7617.885731714139;7677.577733224726;7754.418418618513;7359.77920662381;7475.401967842451;7491.4006879448425;7521.022267105242;7650.043744531934;6942.271061538466;7093.042439270633;7095.219525852255;7105.46708996817;7125.429965602843;4927.679700819435;5053.850055192688;5089.643724939218;5113.463086375877;5141.074606570854;4686.437627484724;4763.3807605011125;4842.975785121052;4862.31927530139;4965.925511117408 05:54:42 INFO - PROCESS | 1661 | |4;prototype.html;244.81638770921808;276.9903053393132;299.2414229927135;308.714439143792;310.4954449020341;4251.979524914022;4388.429504164462;4696.389469368982;5364.812231571896;5420.4850539198815;4677.789499472523;5524.922640085185;5537.307836520435;5541.89408024951;5551.9722401388035;3500.1449231907004;4220.26145424551;4246.299360605496;4246.554111818261;4281.550437204095;3417;3837.9808100959594;4054.5945405459515;4294.720843145201;4311.9784401078105;3511.3679537683206;3805.162864169878;3958.8614398496056;4071.145059537501;4124.896877578055;4112.650424713903;4115.773632450214;4171.311733563958;4176.519700234481;4205.306124489455;2978.2107741448535;3143.4813255812765;3402.183475965775;3608.6752192302556;3622.42041273395;4521.59305662492;4853.883606770462;5339;5342.572594192494;5395.919061214085;3807.0101773538804;3988.760674359548;4473.709208901411;4748.501407352247;4755.0489902019735;4830.73430961297;5283.709395983219;5770.394108618577;5834.97082514589;5894.3810899855325;3250.7236884864815;3601.6218297078954;3622.0039489140436;3782.2223554929137;4067.5525692173837;5116.718580478109;5381.515663590296;5557.916631250535;6240.843978900519;6287.931051721218;3515.402381595135;3616.403293456603;4187.350960601112;4199.139176468817;4222.387753775747;3979.5622481527007;4001.9799901000893;4179.811908464066;4213.557576454489;4263.4031235627035;4895.31465594817;4906.31311616374;4916.027027161944;4926.950730492721;4935.580475659537;4970;4971;6006.399360064046;6007.15899774032;6010.429009244115;1312.8971663802452;1344.8318960129984;1358.5380970470087;1431.957041288763;1435.067206315903;771.3559178086249;956.6986399284203;982.5234761140841;984.2716389871587;985.4973963278779;4687.086018226413;4852.17513022787;5200;5433.592480563973;5468.179773033997;5083;5119.44027986007;5618.747156377973;6008.519318454513;6073.544484163705;4642.628589712815;5503.3120859892515;5505.724713764296;5520.861978450571;5570.442955704478;3127.0931429885077;3201.567788348543;3207.4340527577842;3213.280894721313;3217.935641287208;5532.419095994943;6235.563510554218;6321.020241862519;6322.557420980487;6342.809715708536;5791.7683292667825;5883.705814709333;5979.6711180884595;6282.246130464374;6327.317784839186;5840.948629246692;5956.612820166675;6040.426159514927;6380.7128679209545;6439.7424103035355;4834.734089625104;5756.9061878243;6010.398960103955;6027.849303767441;6188.938110618837;4748.620110391092;6023.698815059317;6026.939730602638;6052.152698622109;6101.816945491642;5099.592032637454;5203.531682148625;5422.267993820941;6318.652474113968;6479.449246814073;3446.8621255150515;3534.2079756992716;3658.414653655402;3881.6118388160958;3971.7021223408938;5023.547880690755;5389.922015596818;5701.4298570142655;6088.808029109606;6125.497759146934;5297.073012222769;5658.745356458887;5800.796972105956;5864.560157988082;5880.617759845767;5058.570021548062;5876.7080838473885;5888.882222355614;5897.967855625334;5923.496502797138;5258.421573626822;5420.620556561161;5623.971880140573;5727.942720572741;5816.563757718272;5625.171819158708;5880.353161152184;5932.466078052996;5964;5968.70156492165;5304.859455217147;5496.148097044965;5763.559110222444;5813.128030795415;5835.649861008353 05:54:42 INFO - PROCESS | 1661 | |5;yui.html;734.2400615363097;748.7865958201913;771.240328276647;777.5917643237301;834.8145633200852;14692.559223223294;15353.078815271092;15440.613984650376;15822.525324240263;16017.279222434989;13904.93047534761;14146.938979576547;14159.433622655082;14167.574972750808;14179.78730319046;662.1954325494523;825.2078005115081;844.9493030418195;847.7922908887331;850.3962186847345;819.9877001844948;842.5913431985482;851.3317046118798;854.0989256334565;854.1031916487694;897.6544030548254;900.4867225681364;900.8873890763655;904.1004200820194;904.276578737011;863.2748491267365;892.6518657723493;898.8606765951288;899.0065977095313;901.364538000708;650.1742786660914;662.6885363878969;664.9560190500915;664.960102393853;664.9966750166267;15420.537383878502;15532.767008494882;15564.92217538905;15571.065736055873;15581.143037132953;11637.836216378379;14150.433982640681;14210.218437985906;14333.928330358385;14515.056521326185;11757.235779674294;11871.940640296829;11877.406129693567;11882.524699012029;11910.702232444171;3571.94642080369;3762.6685423869885;3768.471317029101;3795.4686343911876;3893.9026524336837;104824.47587762089;106222.46888765506;114086.85913140845;115619;116702;10620.157357824537;10690.51892664832;10784.676459706221;10808.297460665031;11075;20999.79000210009;21061.368158955254;21092.945352732608;21093.261735839173;21116.366509004754;6682.231543372477;7789.454738168274;8002.8799568006525;8094.797630059295;8132.268095871282;3709.332320182339;3750.5311836020496;4414.84548040817;4458.6878918475395;4466.441694788152;2893.2766808297924;3364.158960259935;3452.205992621711;3477.860885564549;3482.564679415073;608.1364462463313;647.4917190005823;654.7970129259945;655.9770408035696;672.7107343842097;612.5452051377978;615.4706952021259;655.1646650520624;657.1752450674373;686.3925425998028;7684.7310344138805;8604.13958604147;8641.783955401166;9708.951455242819;10111.443870587042;564.0552075273981;581.6858896196006;590.8965930962064;611.9816405507842;632.3274937789613;4361.258586040381;4763.595094416944;4918.803247870117;4952.455229924705;5089.51649593288;123776;148591;153716.2314188422;155201;161423.38576614318;111944;117022;120289;131576;136118.63881361258;110336.89663103267;113558.43220784009;114084;115160;115376.26935595972;9966;10053.145482634058;10062.295639305179;10165.186785057325;10194.949025254826;58809.70595146997;59586;60541;60852;61379.386206139156;61271.69364153151;92357;93290;94695;97391.0260897382;12756.298403587893;13087.934560327138;13111.60665180046;13252;13473.44363293081;14726.938228647783;14877;14959.775603366175;15036.849631503545;15559.377624894878;13564;13622.046456748329;13872.237026963614;13997.930010349883;14177.929110354795;13689.315534223448;13911.721765564429;13939.860601393857;14015.859841401863;14413.495527656902;10785.676429707122;12795.552155674506;12795.93602031984;13028.54400095992;13238.27189504548;10956.233063685784;11275.47026827592;11348.54605815758;11387.430628468377;11475.598354057902;7808.752251759191;7904.5481017637;11172.944135279271;11249.694545708639;11537.250078744855 05:54:42 INFO - PROCESS | 1661 | __end_tp_report 05:54:42 INFO - PROCESS | 1661 | __start_cc_report 05:54:42 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,386 05:54:42 INFO - PROCESS | 1661 | __end_cc_report 05:54:42 INFO - PROCESS | 1661 | __startTimestamp1472302482022__endTimestamp 05:54:42 INFO - PROCESS | 1661 | 05:54:42 INFO - PROCESS | 1661 | ------- Summary: start ------- 05:54:42 INFO - PROCESS | 1661 | Number of tests: 6 05:54:42 INFO - PROCESS | 1661 | 05:54:42 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5669.74 Median:5821.45 stddev:666.66 (11.5%) stddev-sans-first:628.83 05:54:42 INFO - PROCESS | 1661 | Values: 2774.6 3355.0 3382.3 3418.0 3424.0 5183.4 5210.5 5651.5 5666.2 5711.3 5517.5 5636.0 5656.9 5709.3 5755.9 5089.4 5154.1 5261.2 5262.6 5303.6 4067.9 5142.2 5268.8 5355.5 5369.2 5085.1 5150.9 5190.3 5219.0 5285.1 5144.0 5207.6 5209.1 5211.3 5227.6 5170.7 5171.3 5179.1 5198.8 5220.6 4576.7 5542.9 5659.5 5704.7 5773.0 6121.4 6206.7 6210.4 6222.9 6237.8 5249.0 6014.9 6197.2 6226.7 6241.9 5689.6 5752.5 5780.4 5790.6 5843.3 6246.0 6255.4 6283.8 6311.7 6350.4 6060.2 6117.1 6129.4 6145.5 6206.8 5030.0 6091.3 6110.3 6143.3 6155.5 6133.5 6136.0 6145.6 6156.6 6179.8 5996.0 6163.6 6186.8 6211.8 6277.2 4855.1 4925.5 4955.8 4961.7 5030.7 4405.0 4434.6 4461.8 4488.9 4502.5 5358.2 5758.8 5759.3 5767.6 5821.4 6119.0 6170.8 6192.4 6195.4 6240.3 5785.2 5792.5 5793.8 5797.8 5866.3 5435.8 5455.1 5456.3 5503.7 5513.6 6124.9 6214.3 6245.4 6372.1 6389.1 6209.1 6224.1 6227.3 6265.9 6281.2 5503.6 6319.1 6349.6 6356.0 6377.1 6051.1 6131.9 6135.6 6210.8 6224.3 6072.4 6232.8 6240.6 6249.5 6279.7 6056.8 6073.3 6076.8 6115.9 6130.1 5937.6 6011.5 6073.5 6097.6 6133.8 4577.5 4806.6 4833.9 5701.8 5959.2 5999.3 6014.3 6048.8 6056.1 6061.7 5773.0 5784.5 5821.4 5889.2 5917.3 05:54:42 INFO - PROCESS | 1661 | 05:54:42 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:66056.72 Median:38925.32 stddev:143748.78 (369.3%) stddev-sans-first:144067.70 05:54:42 INFO - PROCESS | 1661 | Values: 474.9 495.8 504.8 527.8 562.0 36849.3 39304.6 39316.2 39408.6 39484.8 38962.4 40298.2 40489.0 40697.2 40920.8 8641.7 9039.6 9318.1 9543.0 9785.7 7581.5 7674.2 8427.4 8677.8 9677.6 9630.0 9671.7 9707.1 9725.4 9742.7 8146.6 9672.1 9672.3 9690.8 9716.7 9582.1 9686.7 9698.0 9721.8 9746.5 38158.0 38207.4 38273.7 38547.0 38629.6 3391.6 3416.1 3420.5 3425.4 3452.9 29348.0 29705.7 29756.9 29900.7 30069.0 3181.6 3209.4 3220.4 3254.3 3305.7 472248.0 476254.0 476677.0 479226.0 479716.0 56501.0 56985.7 56999.4 57119.7 57211.7 33826.8 34943.5 34990.0 58554.0 58817.4 16064.0 16160.2 16231.9 16259.9 16289.9 12401.3 12530.6 12615.2 12619.9 12644.7 15163.5 18345.6 18462.0 18532.6 18575.3 7927.6 8053.7 8075.5 8098.8 8123.7 849.9 928.9 941.1 1010.4 1064.2 27417.3 28529.9 29429.4 29672.0 30123.5 869.8 987.6 991.6 1095.3 1122.0 13252.5 14770.5 15134.2 15784.4 16088.0 484430.0 560393.0 638873.0 642066.8 643836.0 44820.8 44872.8 55948.7 56058.4 56233.7 1307.0 1320.3 1346.8 1347.9 1353.7 24982.6 28308.3 28541.0 29466.0 29793.7 36208.6 45393.8 47793.5 48088.8 48318.8 529658.0 532513.0 533632.3 535523.0 538715.0 25325.5 25478.0 26031.7 26058.5 26064.6 44672.6 46009.0 46052.8 46558.5 46669.3 38079.4 38211.0 38457.8 39122.6 39293.2 37841.8 38072.4 38254.8 38888.2 39337.4 32672.5 35028.0 37807.2 37956.2 38334.0 31919.8 33658.3 34027.7 34063.0 34142.0 25020.0 25292.4 25403.5 25483.6 26120.0 05:54:42 INFO - PROCESS | 1661 | 05:54:42 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:32327.85 Median:373.20 stddev:90248.71 (24182.1%) stddev-sans-first:90469.98 05:54:42 INFO - PROCESS | 1661 | Values: 372.3 374.1 377.9 386.8 400.3 17088.6 19322.9 20758.6 21133.7 22464.4 20318.9 20657.4 20904.3 21148.9 21235.4 5889.0 5943.3 6097.0 6197.3 6199.4 3589.9 5875.6 6145.1 6174.4 6175.5 6104.8 6204.2 6211.6 6217.8 6223.9 5918.5 6098.9 6154.4 6162.7 6197.8 5281.7 5757.7 5983.1 6021.5 6025.1 22839.8 23931.2 24099.0 24798.8 24923.8 1669.6 2142.0 2142.5 2208.1 2210.3 9774.3 9830.3 9983.5 10049.3 10371.9 1772.6 1885.2 1891.4 1909.6 1923.1 96992.0 101021.0 108553.3 118826.0 124189.0 10813.0 11109.6 11124.3 11275.0 11440.7 11572.6 14065.0 14200.7 14211.8 14236.4 8144.2 8305.3 8387.5 8542.0 8565.6 8058.5 8130.9 8142.1 8408.9 8418.0 3759.9 4436.8 4488.0 4506.8 4613.1 1553.8 1621.0 1857.9 1904.8 1907.5 773.5 831.4 891.3 963.8 1034.4 13631.0 16963.9 21454.6 21607.6 22527.0 911.3 926.7 965.0 968.8 975.7 8467.9 8850.4 10883.5 11048.0 11331.1 535983.0 538629.0 541702.0 542959.0 547775.0 101624.0 105097.5 107278.0 116027.0 125309.0 909.0 985.4 994.3 1027.6 1044.3 18639.5 18944.3 19159.0 19215.6 19297.6 50498.0 50994.0 51074.2 51578.5 52211.2 69210.7 71066.0 71506.9 71724.0 72059.6 7815.8 7928.7 7965.8 7990.4 8101.9 10811.4 12840.2 12947.8 13200.0 13222.3 8029.5 10629.3 11157.8 11231.9 11500.4 10854.5 10967.3 10992.5 11217.6 11434.5 9204.8 11463.7 11504.8 11594.7 11745.5 6348.7 6590.8 6893.0 7687.6 8272.3 9042.8 10458.9 10675.1 11280.7 11345.8 05:54:42 INFO - PROCESS | 1661 | 05:54:42 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:5618.07 Median:5101.55 stddev:3117.61 (61.1%) stddev-sans-first:3111.15 05:54:42 INFO - PROCESS | 1661 | Values: 1521.5 1540.2 1761.1 1864.0 1886.9 7996.2 8427.4 8677.4 9034.4 9042.8 8647.3 8874.5 8879.3 8886.6 8910.1 2338.3 2384.9 2386.2 2393.6 2397.2 2340.6 2362.5 2396.6 2406.4 2408.1 2372.5 2379.9 2381.9 2395.0 2401.3 2061.2 2341.8 2369.7 2387.6 2390.9 2368.3 2370.3 2374.2 2394.4 2394.5 8821.4 8964.5 8971.4 8974.0 9005.3 5221.3 5345.7 5385.5 5408.6 5415.3 3658.2 3687.5 3711.8 3740.1 3742.4 1079.3 1080.3 1087.5 1094.3 1116.6 11547.2 11597.5 11705.8 11714.1 11755.5 4524.7 4634.1 4765.3 4789.8 4806.6 9878.4 9992.3 9999.5 10000.3 10036.9 5364.3 5374.9 5376.6 5393.3 5395.8 4437.3 4788.4 4883.6 4913.9 4943.6 3872.6 3911.8 3965.3 4024.6 4036.3 1105.8 1133.6 1216.9 1266.6 1292.0 694.6 716.6 785.9 863.5 906.8 5118.6 5901.5 5939.6 5981.5 6044.8 424.3 426.5 427.6 429.1 441.3 3557.6 3687.5 4030.2 4038.9 4098.7 9033.6 9497.9 9632.1 9659.0 9680.8 9533.2 9578.4 9622.8 9672.7 9676.3 7412.5 7415.0 7598.3 7613.2 7618.8 4967.1 5474.1 5496.2 5540.8 5562.7 7571.3 9163.0 9712.9 10085.9 10099.1 9855.8 9998.9 10136.1 10227.7 10229.6 6978.2 7380.3 7564.4 7573.7 7736.7 8450.5 8455.9 8540.5 8550.9 8594.2 7491.4 7595.6 7617.9 7677.6 7754.4 7359.8 7475.4 7491.4 7521.0 7650.0 6942.3 7093.0 7095.2 7105.5 7125.4 4927.7 5053.9 5089.6 5113.5 5141.1 4686.4 4763.4 4843.0 4862.3 4965.9 05:54:42 INFO - PROCESS | 1661 | 05:54:42 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:4664.89 Median:5201.77 stddev:1468.54 (28.2%) stddev-sans-first:1434.70 05:54:42 INFO - PROCESS | 1661 | Values: 244.8 277.0 299.2 308.7 310.5 4252.0 4388.4 4696.4 5364.8 5420.5 4677.8 5524.9 5537.3 5541.9 5552.0 3500.1 4220.3 4246.3 4246.6 4281.6 3417.0 3838.0 4054.6 4294.7 4312.0 3511.4 3805.2 3958.9 4071.1 4124.9 4112.7 4115.8 4171.3 4176.5 4205.3 2978.2 3143.5 3402.2 3608.7 3622.4 4521.6 4853.9 5339.0 5342.6 5395.9 3807.0 3988.8 4473.7 4748.5 4755.0 4830.7 5283.7 5770.4 5835.0 5894.4 3250.7 3601.6 3622.0 3782.2 4067.6 5116.7 5381.5 5557.9 6240.8 6287.9 3515.4 3616.4 4187.4 4199.1 4222.4 3979.6 4002.0 4179.8 4213.6 4263.4 4895.3 4906.3 4916.0 4927.0 4935.6 4970.0 4971.0 6006.4 6007.2 6010.4 1312.9 1344.8 1358.5 1432.0 1435.1 771.4 956.7 982.5 984.3 985.5 4687.1 4852.2 5200.0 5433.6 5468.2 5083.0 5119.4 5618.7 6008.5 6073.5 4642.6 5503.3 5505.7 5520.9 5570.4 3127.1 3201.6 3207.4 3213.3 3217.9 5532.4 6235.6 6321.0 6322.6 6342.8 5791.8 5883.7 5979.7 6282.2 6327.3 5840.9 5956.6 6040.4 6380.7 6439.7 4834.7 5756.9 6010.4 6027.8 6188.9 4748.6 6023.7 6026.9 6052.2 6101.8 5099.6 5203.5 5422.3 6318.7 6479.4 3446.9 3534.2 3658.4 3881.6 3971.7 5023.5 5389.9 5701.4 6088.8 6125.5 5297.1 5658.7 5800.8 5864.6 5880.6 5058.6 5876.7 5888.9 5898.0 5923.5 5258.4 5420.6 5624.0 5727.9 5816.6 5625.2 5880.4 5932.5 5964.0 5968.7 5304.9 5496.1 5763.6 5813.1 5835.6 05:54:42 INFO - PROCESS | 1661 | 05:54:42 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:24642.94 Median:21093.10 stddev:39424.03 (186.9%) stddev-sans-first:39493.75 05:54:42 INFO - PROCESS | 1661 | Values: 734.2 748.8 771.2 777.6 834.8 14692.6 15353.1 15440.6 15822.5 16017.3 13904.9 14146.9 14159.4 14167.6 14179.8 662.2 825.2 844.9 847.8 850.4 820.0 842.6 851.3 854.1 854.1 897.7 900.5 900.9 904.1 904.3 863.3 892.7 898.9 899.0 901.4 650.2 662.7 665.0 665.0 665.0 15420.5 15532.8 15564.9 15571.1 15581.1 11637.8 14150.4 14210.2 14333.9 14515.1 11757.2 11871.9 11877.4 11882.5 11910.7 3571.9 3762.7 3768.5 3795.5 3893.9 104824.5 106222.5 114086.9 115619.0 116702.0 10620.2 10690.5 10784.7 10808.3 11075.0 20999.8 21061.4 21092.9 21093.3 21116.4 6682.2 7789.5 8002.9 8094.8 8132.3 3709.3 3750.5 4414.8 4458.7 4466.4 2893.3 3364.2 3452.2 3477.9 3482.6 608.1 647.5 654.8 656.0 672.7 612.5 615.5 655.2 657.2 686.4 7684.7 8604.1 8641.8 9709.0 10111.4 564.1 581.7 590.9 612.0 632.3 4361.3 4763.6 4918.8 4952.5 5089.5 123776.0 148591.0 153716.2 155201.0 161423.4 111944.0 117022.0 120289.0 131576.0 136118.6 110336.9 113558.4 114084.0 115160.0 115376.3 9966.0 10053.1 10062.3 10165.2 10194.9 58809.7 59586.0 60541.0 60852.0 61379.4 61271.7 92357.0 93290.0 94695.0 97391.0 12756.3 13087.9 13111.6 13252.0 13473.4 14726.9 14877.0 14959.8 15036.8 15559.4 13564.0 13622.0 13872.2 13997.9 14177.9 13689.3 13911.7 13939.9 14015.9 14413.5 10785.7 12795.6 12795.9 13028.5 13238.3 10956.2 11275.5 11348.5 11387.4 11475.6 7808.8 7904.5 11172.9 11249.7 11537.3 05:54:42 INFO - PROCESS | 1661 | -------- Summary: end -------- 05:54:42 INFO - PROCESS | 1661 | 05:54:42 INFO - TEST-INFO | 1661: exit 0 05:54:42 INFO - TEST-OK | dromaeo_css | took 1114286ms 05:54:42 INFO - TEST-START | kraken 05:54:42 INFO - operating with platform_type : mac_ 05:54:42 INFO - Initialising browser for kraken test... 05:54:42 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmpxpU1Om/profile http://localhost:49267/getInfo.html) 05:54:45 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 05:54:45 INFO - PROCESS | 1669 | colorDepth:24 05:54:45 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 05:54:45 INFO - PROCESS | 1669 | __metrics 05:54:45 ERROR - PROCESS | 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 05:54:46 INFO - TEST-INFO | 1669: exit 0 05:54:46 INFO - Browser initialized. 05:54:46 INFO - Running cycle 1/1 for kraken test... 05:54:46 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmpxpU1Om/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:54:58 INFO - PROCESS | 1672 | RSS: Main: 243937280 05:54:58 INFO - PROCESS | 1672 | 05:55:01 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 05:55:02 INFO - PROCESS | 1672 | RSS: Main: 256679936 05:55:02 INFO - PROCESS | 1672 | 05:55:05 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 05:55:05 INFO - PROCESS | 1672 | RSS: Main: 265297920 05:55:05 INFO - PROCESS | 1672 | 05:55:09 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 05:55:09 INFO - PROCESS | 1672 | RSS: Main: 265154560 05:55:09 INFO - PROCESS | 1672 | 05:55:11 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 05:55:12 INFO - PROCESS | 1672 | RSS: Main: 266399744 05:55:12 INFO - PROCESS | 1672 | 05:55:14 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:55:15 INFO - PROCESS | 1672 | RSS: Main: 268013568 05:55:15 INFO - PROCESS | 1672 | 05:55:18 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 05:55:18 INFO - PROCESS | 1672 | RSS: Main: 268525568 05:55:18 INFO - PROCESS | 1672 | 05:55:21 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 05:55:22 INFO - PROCESS | 1672 | RSS: Main: 268840960 05:55:22 INFO - PROCESS | 1672 | 05:55:25 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 05:55:26 INFO - PROCESS | 1672 | RSS: Main: 269238272 05:55:26 INFO - PROCESS | 1672 | 05:55:27 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:55:28 INFO - PROCESS | 1672 | RSS: Main: 268709888 05:55:28 INFO - PROCESS | 1672 | 05:55:30 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:55:31 INFO - PROCESS | 1672 | RSS: Main: 268374016 05:55:31 INFO - PROCESS | 1672 | 05:55:33 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:55:34 INFO - PROCESS | 1672 | RSS: Main: 268693504 05:55:34 INFO - PROCESS | 1672 | 05:55:37 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:55:37 INFO - PROCESS | 1672 | RSS: Main: 268902400 05:55:37 INFO - PROCESS | 1672 | 05:55:40 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:55:41 INFO - PROCESS | 1672 | RSS: Main: 268849152 05:55:41 INFO - PROCESS | 1672 | 05:55:43 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 05:55:43 INFO - PROCESS | 1672 | RSS: Main: 270880768 05:55:43 INFO - PROCESS | 1672 | 05:55:43 INFO - PROCESS | 1672 | __start_tp_report 05:55:43 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 05:55:43 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 05:55:43 INFO - PROCESS | 1672 | |i|pagename|runs| 05:55:43 INFO - PROCESS | 1672 | |0;ai-astar;108;113;99;139;170;169;115;117;118;129 05:55:43 INFO - PROCESS | 1672 | |1;audio-beat-detection;145;138;167;148;99;158;162;141;174;111 05:55:43 INFO - PROCESS | 1672 | |2;audio-dft;255;221;204;203;200;205;208;290;234;204 05:55:43 INFO - PROCESS | 1672 | |3;audio-fft;68;84;73;143;59;50;71;85;158;51 05:55:43 INFO - PROCESS | 1672 | |4;audio-oscillator;72;94;99;97;92;89;112;71;72;114 05:55:43 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;90;86;90;86;90;95;130;90;85;114 05:55:43 INFO - PROCESS | 1672 | |6;imaging-darkroom;96;107;152;128;95;95;95;95;94;152 05:55:43 INFO - PROCESS | 1672 | |7;imaging-desaturate;141;92;89;91;134;75;140;143;136;92 05:55:43 INFO - PROCESS | 1672 | |8;json-parse-financial;58;59;58;57;63;53;57;57;59;57 05:55:43 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;69;73;96;62;84;115;77;107;105;105 05:55:43 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;91;91;89;85;101;89;87;87;88;87 05:55:43 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;139;140;138;148;139;153;146;164;190;164 05:55:43 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;172;171;232;216;206;241;169;222;239;176 05:55:43 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;67;70;72;67;70;68;69;69;67;67 05:55:43 INFO - PROCESS | 1672 | __end_tp_report 05:55:43 INFO - PROCESS | 1672 | __start_cc_report 05:55:43 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,962 05:55:43 INFO - PROCESS | 1672 | __end_cc_report 05:55:43 INFO - PROCESS | 1672 | __startTimestamp1472302543510__endTimestamp 05:55:43 INFO - PROCESS | 1672 | 05:55:43 INFO - PROCESS | 1672 | ------- Summary: start ------- 05:55:43 INFO - PROCESS | 1672 | Number of tests: 14 05:55:43 INFO - PROCESS | 1672 | 05:55:43 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:127.70 Median:134.00 stddev:24.54 (18.3%) stddev-sans-first:24.98 05:55:43 INFO - PROCESS | 1672 | Values: 108.0 113.0 99.0 139.0 170.0 169.0 115.0 117.0 118.0 129.0 05:55:43 INFO - PROCESS | 1672 | 05:55:43 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:160.00 stddev:23.86 (14.9%) stddev-sans-first:25.31 05:55:43 INFO - PROCESS | 1672 | Values: 145.0 138.0 167.0 148.0 99.0 158.0 162.0 141.0 174.0 111.0 05:55:43 INFO - PROCESS | 1672 | 05:55:43 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:222.40 Median:214.50 stddev:29.50 (13.8%) stddev-sans-first:28.84 05:55:43 INFO - PROCESS | 1672 | Values: 255.0 221.0 204.0 203.0 200.0 205.0 208.0 290.0 234.0 204.0 05:55:43 INFO - PROCESS | 1672 | 05:55:43 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:84.20 Median:69.50 stddev:37.08 (53.4%) stddev-sans-first:38.86 05:55:43 INFO - PROCESS | 1672 | Values: 68.0 84.0 73.0 143.0 59.0 50.0 71.0 85.0 158.0 51.0 05:55:43 INFO - PROCESS | 1672 | 05:55:43 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:90.50 stddev:15.65 (17.3%) stddev-sans-first:14.98 05:55:43 INFO - PROCESS | 1672 | Values: 72.0 94.0 99.0 97.0 92.0 89.0 112.0 71.0 72.0 114.0 05:55:43 INFO - PROCESS | 1672 | 05:55:43 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:95.60 Median:90.00 stddev:14.70 (16.3%) stddev-sans-first:15.45 05:55:43 INFO - PROCESS | 1672 | Values: 90.0 86.0 90.0 86.0 90.0 95.0 130.0 90.0 85.0 114.0 05:55:43 INFO - PROCESS | 1672 | 05:55:43 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:110.90 Median:95.00 stddev:24.05 (25.3%) stddev-sans-first:24.90 05:55:43 INFO - PROCESS | 1672 | Values: 96.0 107.0 152.0 128.0 95.0 95.0 95.0 95.0 94.0 152.0 05:55:43 INFO - PROCESS | 1672 | 05:55:43 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:113.30 Median:82.00 stddev:27.42 (33.4%) stddev-sans-first:27.19 05:55:43 INFO - PROCESS | 1672 | Values: 141.0 92.0 89.0 91.0 134.0 75.0 140.0 143.0 136.0 92.0 05:55:43 INFO - PROCESS | 1672 | 05:55:43 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:2.49 (4.3%) stddev-sans-first:2.64 05:55:43 INFO - PROCESS | 1672 | Values: 58.0 59.0 58.0 57.0 63.0 53.0 57.0 57.0 59.0 57.0 05:55:43 INFO - PROCESS | 1672 | 05:55:43 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:89.30 Median:71.00 stddev:18.60 (26.2%) stddev-sans-first:18.22 05:55:43 INFO - PROCESS | 1672 | Values: 69.0 73.0 96.0 62.0 84.0 115.0 77.0 107.0 105.0 105.0 05:55:43 INFO - PROCESS | 1672 | 05:55:43 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:89.50 Median:88.50 stddev:4.45 (5.0%) stddev-sans-first:4.69 05:55:43 INFO - PROCESS | 1672 | Values: 91.0 91.0 89.0 85.0 101.0 89.0 87.0 87.0 88.0 87.0 05:55:43 INFO - PROCESS | 1672 | 05:55:43 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:152.10 Median:150.50 stddev:16.54 (11.0%) stddev-sans-first:16.85 05:55:43 INFO - PROCESS | 1672 | Values: 139.0 140.0 138.0 148.0 139.0 153.0 146.0 164.0 190.0 164.0 05:55:43 INFO - PROCESS | 1672 | 05:55:43 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:204.40 Median:219.00 stddev:29.76 (13.6%) stddev-sans-first:29.16 05:55:43 INFO - PROCESS | 1672 | Values: 172.0 171.0 232.0 216.0 206.0 241.0 169.0 222.0 239.0 176.0 05:55:43 INFO - PROCESS | 1672 | 05:55:43 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.71 (2.5%) stddev-sans-first:1.72 05:55:43 INFO - PROCESS | 1672 | Values: 67.0 70.0 72.0 67.0 70.0 68.0 69.0 69.0 67.0 67.0 05:55:43 INFO - PROCESS | 1672 | -------- Summary: end -------- 05:55:43 INFO - PROCESS | 1672 | 05:55:44 INFO - TEST-INFO | 1672: exit 0 05:55:44 INFO - TEST-OK | kraken | took 61910ms 05:55:44 INFO - SUITE-END | took 1176s 05:55:44 INFO - Completed test suite (00:19:36) 05:55:44 INFO - javascript benchmark 05:55:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7248.499593976578, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2774.6254255675485, 3354.983225083874, 3382.2728113455632, 3417.9658203417976, 3424.0, 5183.377994640644, 5210.505002024806, 5651.463111004458, 5666.206731057655, 5711.2575365202465, 5517.531009864157, 5636.0, 5656.858578535539, 5709.343425506068, 5755.856103597413, 5089.3638295213095, 5154.149565321717, 5261.2371206175085, 5262.605304602151, 5303.575713942894, 4067.90166655003, 5142.228665700156, 5268.8155914542995, 5355.518003379695, 5369.221462887879, 5085.1355269604255, 5150.871228219287, 5190.2733617293425, 5218.973905130488, 5285.127953887604, 5143.974280128613, 5207.6354655174155, 5209.114450543379, 5211.296474975906, 5227.555657769094, 5170.663906846043, 5171.250168725552, 5179.067767801795, 5198.844034678966, 5220.582353411756, 4576.7253964761885, 5542.91685624716, 5659.462351076682, 5704.743286552115, 5772.971135144339, 6121.4490695837585, 6206.689665516707, 6210.441060304549, 6222.906656400158, 6237.750489980395, 5248.973755131238, 6014.939850601481, 6197.230665315784, 6226.688665566749, 6241.87516249677, 5689.6017278790505, 5752.539796816244, 5780.393058728857, 5790.565707571865, 5843.2695913010875, 6245.9694150465575, 6255.374462553708, 6283.8114856554375, 6311.652859092702, 6350.364963503613, 6060.151578778975, 6117.051856962178, 6129.356417576179, 6145.477634401126, 6206.782762603287, 5029.974850125799, 6091.269939592756, 6110.315755985069, 6143.296949342275, 6155.47678447337, 6133.539984501091, 6135.969320153371, 6145.647957449354, 6156.5998210116195, 6179.84550386244, 5996.010658241428, 6163.568550201532, 6186.752529898844, 6211.782587609412, 6277.183966084471, 4855.101806165871, 4925.532074452921, 4955.752212389366, 4961.677490963076, 5030.698158110525, 4405.008873003549, 4434.645228381722, 4461.776911154429, 4488.887777805581, 4502.549745025472, 5358.223057656618, 5758.7696492140685, 5759.280089988752, 5767.596268261182, 5821.446962538552, 6119.015143218386, 6170.784022559279, 6192.442680158807, 6195.4424101831055, 6240.344763799826, 5785.1611516329895, 5792.507636850914, 5793.826185214451, 5797.797077102281, 5866.325372582208, 5435.755391007335, 5455.09990851513, 5456.317960254968, 5503.670279480936, 5513.58648101394, 6124.930239974474, 6214.285357183981, 6245.437910588069, 6372.139761132281, 6389.137466441971, 6209.068639704081, 6224.128621992834, 6227.314995350598, 6265.937340626535, 6281.214848143982, 5503.587230957614, 6319.146915166394, 6349.587276826992, 6356.0465930109, 6377.075324078076, 6051.062085376773, 6131.938680613137, 6135.631862088289, 6210.782622608187, 6224.2842073160355, 6072.362401947732, 6232.844178895564, 6240.594361366497, 6249.50003999688, 6279.717412716347, 6056.757729690763, 6073.30157031947, 6076.787312444043, 6115.85679409286, 6130.141780150871, 5937.584369094122, 6011.489023432882, 6073.544484163794, 6097.573080549832, 6133.785317513865, 4577.496475387771, 4806.615470762261, 4833.9033219334715, 5701.774118564528, 5959.22530071088, 5999.280086389661, 6014.308354539284, 6048.830193202821, 6056.06131049688, 6061.6666083365835, 5773.018586840163, 5784.5083167929515, 5821.417858214145, 5889.204957330706, 5917.349091600006], "value": 5627.757486154805, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.90976714424255, 495.79176745766773, 504.7834718328828, 527.831094049904, 561.9859503512414, 36849.26301473969, 39304.60695393045, 39316.21367572654, 39408.620698275605, 39484.80257598708, 38962.41556376657, 40298.194036119334, 40488.987775305635, 40697.18605627893, 40920.79539602305, 8641.697540586081, 9039.593218305192, 9318.11477909601, 9542.999999999982, 9785.657501987433, 7581.545107293552, 7674.232576742309, 8427.410081294312, 8677.783055423633, 9677.56450959705, 9629.951850240739, 9671.70984870455, 9707.077827606367, 9725.416475011487, 9742.659006934759, 8146.551939643317, 9672.129508344282, 9672.274579406503, 9690.75773105671, 9716.708498745049, 9582.089701478348, 9686.70939871805, 9698.0, 9721.756956076084, 9746.46394448305, 38158.0, 38207.426888596696, 38273.6604218851, 38547.0, 38629.61370386288, 3391.609964854024, 3416.0605833395766, 3420.504026916083, 3425.3663072331697, 3452.879149229765, 29348.0, 29705.70294297051, 29756.851215744, 29900.700992990227, 30069.0, 3181.6341120771176, 3209.3741720364537, 3220.3559288142233, 3254.251522149895, 3305.7190138837987, 472248.0, 476254.0, 476677.0, 479226.0, 479716.0, 56501.0, 56985.715071424376, 56999.43000570024, 57119.71440142856, 57211.713941430025, 33826.83086584551, 34943.475847862304, 34990.0, 58554.0, 58817.411825881194, 16064.036157830335, 16160.191990400433, 16231.918840405722, 16259.918700406422, 16289.941153824964, 12401.317927513894, 12530.624081277576, 12615.243085414904, 12619.936900315439, 12644.747105057848, 15163.469278575198, 18345.633087338178, 18462.0, 18532.629347412978, 18575.349862754738, 7927.643256053491, 8053.677852885936, 8075.515469071875, 8098.838023239502, 8123.6750529978135, 849.9107593702572, 928.9163975242126, 941.0730430525927, 1010.434156872154, 1064.2443864855884, 27417.31456713598, 28529.85735071353, 29429.411411772075, 29672.0, 30123.548146777815, 869.7825543614097, 987.6493844685177, 991.6281394477071, 1095.2935356694886, 1121.9607313744143, 13252.469901204036, 14770.48303309379, 15134.243287835565, 15784.368625254861, 16088.034717916962, 484430.0, 560393.0, 638873.0, 642066.789666058, 643836.0, 44820.77589612031, 44872.77563612161, 55948.72025639846, 56058.43941560614, 56233.71883140558, 1306.9542566010143, 1320.2738493828356, 1346.8249127613346, 1347.8517363090052, 1353.7427888701116, 24982.62526062147, 28308.292292692848, 28541.0, 29466.0, 29793.70206297996, 36208.63791362053, 45393.773031135956, 47793.52206477891, 48088.75955620199, 48318.79203019812, 529658.0, 532513.0, 533632.3318383539, 535523.0, 538715.0, 25325.493490130462, 25478.0, 26031.739682602933, 26058.478830423664, 26064.609030864172, 44672.55327446684, 46009.0, 46052.7697361511, 46558.53441465677, 46669.29996049994, 38079.42880856734, 38211.0, 38457.828449823195, 39122.608773911896, 39293.21413571655, 37841.81079094587, 38072.42891356687, 38254.808725956194, 38888.222235555695, 39337.40993885151, 32672.50991235086, 35028.0, 37807.24385512219, 37956.24087518289, 38334.0, 31919.840400797846, 33658.25459474521, 34027.65972340245, 34063.0, 34142.0, 25019.999200031794, 25292.367690807878, 25403.491930160922, 25483.6177457342, 26120.0], "value": 19201.554874711932, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.28707026045123, 374.1208160822068, 377.8923006943021, 386.8394616234263, 400.251529639574, 17088.57278568038, 19322.90338548307, 20758.584828303425, 21133.682994755072, 22464.438389040282, 20318.882461464615, 20657.38027859163, 20904.26835060773, 21148.942552872333, 21235.362939111812, 5888.970555147218, 5943.286805583336, 6097.0, 6197.349278325779, 6199.411055949678, 3589.94615080774, 5875.559333050017, 6145.078238264274, 6174.382561743834, 6175.505959523227, 6104.786332478364, 6204.162438070848, 6211.602389462358, 6217.813465596039, 6223.937760622403, 5918.4969277611235, 6098.908516372236, 6154.353792851731, 6162.661053642048, 6197.814065578017, 5281.656692314988, 5757.712114394305, 5983.072623743326, 6021.51827853775, 6025.126356678257, 22839.77160228393, 23931.162409315766, 24099.036038558435, 24798.752012480007, 24923.762960296794, 1669.6410271791624, 2142.0, 2142.4858034071867, 2208.112064185115, 2210.292706333974, 9774.31579789415, 9830.311878168532, 9983.450910199936, 10049.296549241555, 10371.94814025925, 1772.6277481728853, 1885.2364792259157, 1891.4325702289395, 1909.5798924236647, 1923.0961448119501, 96992.0, 101021.0, 108553.31573474182, 118826.0, 124188.9999999991, 10812.972767587067, 11109.555617775199, 11124.332540047622, 11275.0, 11440.656780296438, 11572.594959176557, 14065.0, 14200.715985680436, 14211.78682319766, 14236.43054277838, 8144.226298501633, 8305.252527272574, 8387.538685372363, 8542.0, 8565.571721413904, 8058.516489010561, 8130.918690813134, 8142.063662678867, 8408.873866892001, 8417.989841219092, 3759.947214779866, 4436.8447104351835, 4488.0, 4506.752128632891, 4613.123506533748, 1553.829078801331, 1620.9513714588581, 1857.8699491035768, 1904.8476121910214, 1907.4659095453296, 773.532013132047, 831.3930830493773, 891.3315013739696, 963.7735132243918, 1034.3948789957808, 13631.0, 16963.915180424017, 21454.57090858174, 21607.56784864294, 22526.986285617186, 911.3210658059788, 926.7219834049758, 964.9903500965041, 968.8304546704298, 975.687779910436, 8467.872981905277, 8850.424722393023, 10883.510242038968, 11048.0, 11331.130363490096, 535983.0, 538629.0, 541702.0, 542959.0, 547775.0, 101624.0, 105097.47451262694, 107278.0, 116027.0, 125309.0, 909.0091799937967, 985.3545927417553, 994.3337963564429, 1027.635189507714, 1044.3055368180228, 18639.534011649816, 18944.25308330312, 19159.0, 19215.615687685888, 19297.614047718685, 50498.0, 50994.0, 51074.23388649099, 51578.48421515737, 52211.216831746795, 69210.65394672994, 71066.0, 71506.92739608805, 71724.0, 72059.63970180115, 7815.765527034198, 7928.682852686059, 7965.840683186188, 7990.360771138178, 8101.906242657402, 10811.35131892089, 12840.165389249669, 12947.805782913076, 13200.009999249902, 13222.272774997467, 8029.518228906284, 10629.25595208328, 11157.776844462904, 11231.887681123411, 11500.424978750862, 10854.511546980248, 10967.287126336763, 10992.450377481255, 11217.607383741857, 11434.542618295174, 9204.815903682023, 11463.713407164554, 11504.769904602028, 11594.71013224676, 11745.47145378443, 6348.682565871595, 6590.835229119119, 6893.034975103389, 7687.615619218905, 8272.255497005299, 9042.81914361696, 10458.895411045793, 10675.145988321072, 11280.661580152608, 11345.829812552653], "value": 9281.300149620638, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1521.5207209728935, 1540.1529158962571, 1761.11944027986, 1864.0, 1886.8584856135794, 7996.160403157672, 8427.410081294303, 8677.43806114899, 9034.412763170398, 9042.819143617133, 8647.308215342773, 8874.511901845412, 8879.289656827454, 8886.55567221638, 8910.108989101087, 2338.2634470141934, 2384.904603815854, 2386.1767690146958, 2393.628987506939, 2397.1609936522163, 2340.6372012338115, 2362.492064206195, 2396.580598395283, 2406.4344878953434, 2408.1089996701244, 2372.5492156490213, 2379.892904819287, 2381.9285421437385, 2394.988025059872, 2401.2796161151673, 2061.185831596526, 2341.75411581784, 2369.680093187415, 2387.6060450025725, 2390.8565486070806, 2368.27767530903, 2370.277065495023, 2374.2074733576214, 2394.4133687246735, 2394.461246219604, 8821.382503224777, 8964.50695211763, 8971.372003959725, 8973.955130224307, 9005.324600654978, 5221.269022336838, 5345.705986170759, 5385.461453854622, 5408.567314614861, 5415.296011518517, 3658.1951970566433, 3687.520622319108, 3711.777293362407, 3740.139767853409, 3742.36379815432, 1079.2876701377131, 1080.3247970018738, 1087.5377964365193, 1094.3433939636234, 1116.609186784627, 11547.191696581243, 11597.478113484913, 11705.829417058396, 11714.062874969983, 11755.471003804763, 4524.6832721709825, 4634.119517291704, 4765.332853400527, 4789.808407663654, 4806.591439727592, 9878.407295562289, 9992.300538962203, 9999.450030248407, 10000.299979001546, 10036.949815250877, 5364.275822763955, 5374.946250537523, 5376.596755243294, 5393.27190829233, 5395.838124856261, 4437.29003359461, 4788.353572267769, 4883.609311255091, 4913.877153071202, 4943.604511639061, 3872.593377695358, 3911.843526258918, 3965.2862484753023, 4024.625470972082, 4036.3340048891605, 1105.8175401058736, 1133.6485689436302, 1216.9391530423443, 1266.5567051531891, 1292.0, 694.6318451220861, 716.5628966330535, 785.8742601183783, 863.4689665855453, 906.8141031088611, 5118.564921981599, 5901.498587274485, 5939.643621382731, 5981.5214782817275, 6044.788432404933, 424.2829617945662, 426.54359834976276, 427.6279636716015, 429.1203033780737, 441.2851181086596, 3557.573091229069, 3687.465317528943, 4030.234255491447, 4038.8788336349958, 4098.672106231495, 9033.63865445388, 9497.90502094984, 9632.133108020313, 9658.985806490358, 9680.75798105053, 9533.237341012702, 9578.425294482215, 9622.807543849083, 9672.70981870545, 9676.322657414054, 7412.481126321213, 7415.0, 7598.316151546277, 7613.238676132342, 7618.847623047508, 4967.05625931072, 5474.069408200536, 5496.230527726201, 5540.7783688652, 5562.653171805936, 7571.318581327707, 9163.037881022397, 9712.902870971482, 10085.949570252102, 10099.091081802673, 9855.782448948929, 9998.900120986831, 10136.138428233682, 10227.693169204937, 10229.641962531574, 6978.162620485574, 7380.335769780745, 7564.357029652541, 7573.734919277799, 7736.651850666621, 8450.450720703135, 8455.8731619027, 8540.530270834915, 8550.91449085526, 8594.183552562497, 7491.400687945061, 7595.620218988918, 7617.885731714139, 7677.577733224726, 7754.418418618513, 7359.77920662381, 7475.401967842451, 7491.4006879448425, 7521.022267105242, 7650.043744531934, 6942.271061538466, 7093.042439270633, 7095.219525852255, 7105.46708996817, 7125.429965602843, 4927.679700819435, 5053.850055192688, 5089.643724939218, 5113.463086375877, 5141.074606570854, 4686.437627484724, 4763.3807605011125, 4842.975785121052, 4862.31927530139, 4965.925511117408], "value": 4447.716854437232, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [244.81638770921808, 276.9903053393132, 299.2414229927135, 308.714439143792, 310.4954449020341, 4251.979524914022, 4388.429504164462, 4696.389469368982, 5364.812231571896, 5420.4850539198815, 4677.789499472523, 5524.922640085185, 5537.307836520435, 5541.89408024951, 5551.9722401388035, 3500.1449231907004, 4220.26145424551, 4246.299360605496, 4246.554111818261, 4281.550437204095, 3417.0, 3837.9808100959594, 4054.5945405459515, 4294.720843145201, 4311.9784401078105, 3511.3679537683206, 3805.162864169878, 3958.8614398496056, 4071.145059537501, 4124.896877578055, 4112.650424713903, 4115.773632450214, 4171.311733563958, 4176.519700234481, 4205.306124489455, 2978.2107741448535, 3143.4813255812765, 3402.183475965775, 3608.6752192302556, 3622.42041273395, 4521.59305662492, 4853.883606770462, 5339.0, 5342.572594192494, 5395.919061214085, 3807.0101773538804, 3988.760674359548, 4473.709208901411, 4748.501407352247, 4755.0489902019735, 4830.73430961297, 5283.709395983219, 5770.394108618577, 5834.97082514589, 5894.3810899855325, 3250.7236884864815, 3601.6218297078954, 3622.0039489140436, 3782.2223554929137, 4067.5525692173837, 5116.718580478109, 5381.515663590296, 5557.916631250535, 6240.843978900519, 6287.931051721218, 3515.402381595135, 3616.403293456603, 4187.350960601112, 4199.139176468817, 4222.387753775747, 3979.5622481527007, 4001.9799901000893, 4179.811908464066, 4213.557576454489, 4263.4031235627035, 4895.31465594817, 4906.31311616374, 4916.027027161944, 4926.950730492721, 4935.580475659537, 4970.0, 4971.0, 6006.399360064046, 6007.15899774032, 6010.429009244115, 1312.8971663802452, 1344.8318960129984, 1358.5380970470087, 1431.957041288763, 1435.067206315903, 771.3559178086249, 956.6986399284203, 982.5234761140841, 984.2716389871587, 985.4973963278779, 4687.086018226413, 4852.17513022787, 5200.0, 5433.592480563973, 5468.179773033997, 5083.0, 5119.44027986007, 5618.747156377973, 6008.519318454513, 6073.544484163705, 4642.628589712815, 5503.3120859892515, 5505.724713764296, 5520.861978450571, 5570.442955704478, 3127.0931429885077, 3201.567788348543, 3207.4340527577842, 3213.280894721313, 3217.935641287208, 5532.419095994943, 6235.563510554218, 6321.020241862519, 6322.557420980487, 6342.809715708536, 5791.7683292667825, 5883.705814709333, 5979.6711180884595, 6282.246130464374, 6327.317784839186, 5840.948629246692, 5956.612820166675, 6040.426159514927, 6380.7128679209545, 6439.7424103035355, 4834.734089625104, 5756.9061878243, 6010.398960103955, 6027.849303767441, 6188.938110618837, 4748.620110391092, 6023.698815059317, 6026.939730602638, 6052.152698622109, 6101.816945491642, 5099.592032637454, 5203.531682148625, 5422.267993820941, 6318.652474113968, 6479.449246814073, 3446.8621255150515, 3534.2079756992716, 3658.414653655402, 3881.6118388160958, 3971.7021223408938, 5023.547880690755, 5389.922015596818, 5701.4298570142655, 6088.808029109606, 6125.497759146934, 5297.073012222769, 5658.745356458887, 5800.796972105956, 5864.560157988082, 5880.617759845767, 5058.570021548062, 5876.7080838473885, 5888.882222355614, 5897.967855625334, 5923.496502797138, 5258.421573626822, 5420.620556561161, 5623.971880140573, 5727.942720572741, 5816.563757718272, 5625.171819158708, 5880.353161152184, 5932.466078052996, 5964.0, 5968.70156492165, 5304.859455217147, 5496.148097044965, 5763.559110222444, 5813.128030795415, 5835.649861008353], "value": 4195.6566987704255, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.2400615363097, 748.7865958201913, 771.240328276647, 777.5917643237301, 834.8145633200852, 14692.559223223294, 15353.078815271092, 15440.613984650376, 15822.525324240263, 16017.279222434989, 13904.93047534761, 14146.938979576547, 14159.433622655082, 14167.574972750808, 14179.78730319046, 662.1954325494523, 825.2078005115081, 844.9493030418195, 847.7922908887331, 850.3962186847345, 819.9877001844948, 842.5913431985482, 851.3317046118798, 854.0989256334565, 854.1031916487694, 897.6544030548254, 900.4867225681364, 900.8873890763655, 904.1004200820194, 904.276578737011, 863.2748491267365, 892.6518657723493, 898.8606765951288, 899.0065977095313, 901.364538000708, 650.1742786660914, 662.6885363878969, 664.9560190500915, 664.960102393853, 664.9966750166267, 15420.537383878502, 15532.767008494882, 15564.92217538905, 15571.065736055873, 15581.143037132953, 11637.836216378379, 14150.433982640681, 14210.218437985906, 14333.928330358385, 14515.056521326185, 11757.235779674294, 11871.940640296829, 11877.406129693567, 11882.524699012029, 11910.702232444171, 3571.94642080369, 3762.6685423869885, 3768.471317029101, 3795.4686343911876, 3893.9026524336837, 104824.47587762089, 106222.46888765506, 114086.85913140845, 115619.0, 116702.0, 10620.157357824537, 10690.51892664832, 10784.676459706221, 10808.297460665031, 11075.0, 20999.79000210009, 21061.368158955254, 21092.945352732608, 21093.261735839173, 21116.366509004754, 6682.231543372477, 7789.454738168274, 8002.8799568006525, 8094.797630059295, 8132.268095871282, 3709.332320182339, 3750.5311836020496, 4414.84548040817, 4458.6878918475395, 4466.441694788152, 2893.2766808297924, 3364.158960259935, 3452.205992621711, 3477.860885564549, 3482.564679415073, 608.1364462463313, 647.4917190005823, 654.7970129259945, 655.9770408035696, 672.7107343842097, 612.5452051377978, 615.4706952021259, 655.1646650520624, 657.1752450674373, 686.3925425998028, 7684.7310344138805, 8604.13958604147, 8641.783955401166, 9708.951455242819, 10111.443870587042, 564.0552075273981, 581.6858896196006, 590.8965930962064, 611.9816405507842, 632.3274937789613, 4361.258586040381, 4763.595094416944, 4918.803247870117, 4952.455229924705, 5089.51649593288, 123776.0, 148591.0, 153716.2314188422, 155201.0, 161423.38576614318, 111944.0, 117022.0, 120289.0, 131576.0, 136118.63881361258, 110336.89663103267, 113558.43220784009, 114084.0, 115160.0, 115376.26935595972, 9966.0, 10053.145482634058, 10062.295639305179, 10165.186785057325, 10194.949025254826, 58809.70595146997, 59586.0, 60541.0, 60852.0, 61379.386206139156, 61271.69364153151, 92357.0, 93290.0, 94695.0, 97391.0260897382, 12756.298403587893, 13087.934560327138, 13111.60665180046, 13252.0, 13473.44363293081, 14726.938228647783, 14877.0, 14959.775603366175, 15036.849631503545, 15559.377624894878, 13564.0, 13622.046456748329, 13872.237026963614, 13997.930010349883, 14177.929110354795, 13689.315534223448, 13911.721765564429, 13939.860601393857, 14015.859841401863, 14413.495527656902, 10785.676429707122, 12795.552155674506, 12795.93602031984, 13028.54400095992, 13238.27189504548, 10956.233063685784, 11275.47026827592, 11348.54605815758, 11387.430628468377, 11475.598354057902, 7808.752251759191, 7904.5481017637, 11172.944135279271, 11249.694545708639, 11537.250078744855], "value": 7748.662872412464, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1651.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 113.0, 99.0, 139.0, 170.0, 169.0, 115.0, 117.0, 118.0, 129.0], "value": 127.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 138.0, 167.0, 148.0, 99.0, 158.0, 162.0, 141.0, 174.0, 111.0], "value": 144.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [255.0, 221.0, 204.0, 203.0, 200.0, 205.0, 208.0, 290.0, 234.0, 204.0], "value": 222.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 84.0, 73.0, 143.0, 59.0, 50.0, 71.0, 85.0, 158.0, 51.0], "value": 84.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 94.0, 99.0, 97.0, 92.0, 89.0, 112.0, 71.0, 72.0, 114.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 90.0, 86.0, 90.0, 95.0, 130.0, 90.0, 85.0, 114.0], "value": 95.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 107.0, 152.0, 128.0, 95.0, 95.0, 95.0, 95.0, 94.0, 152.0], "value": 110.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 92.0, 89.0, 91.0, 134.0, 75.0, 140.0, 143.0, 136.0, 92.0], "value": 113.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 57.0, 63.0, 53.0, 57.0, 57.0, 59.0, 57.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 96.0, 62.0, 84.0, 115.0, 77.0, 107.0, 105.0, 105.0], "value": 89.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 89.0, 85.0, 101.0, 89.0, 87.0, 87.0, 88.0, 87.0], "value": 89.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 140.0, 138.0, 148.0, 139.0, 153.0, 146.0, 164.0, 190.0, 164.0], "value": 152.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 171.0, 232.0, 216.0, 206.0, 241.0, 169.0, 222.0, 239.0, 176.0], "value": 204.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 72.0, 67.0, 70.0, 68.0, 69.0, 69.0, 67.0, 67.0], "value": 68.6, "unit": "score"}]}]} 05:55:44 INFO - Return code: 0 05:55:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:55:44 ERROR - # TBPL SUCCESS # 05:55:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:55:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:55:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:55:44 INFO - 2016-08-27 05:55:44.856 screenresolution[1677:11003] starting screenresolution argv=screenresolution get 05:55:44 INFO - 2016-08-27 05:55:44.859 screenresolution[1677:11003] Display 0: 1600x1200x32@60 05:55:44 INFO - 2016-08-27 05:55:44.865 screenresolution[1678:11006] starting screenresolution argv=screenresolution list 05:55:44 INFO - Available Modes on Display 0 05:55:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:55:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:55:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:55:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:55:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:55:45 INFO - Intel Iris: 05:55:45 INFO - Chipset Model: Intel Iris 05:55:45 INFO - Type: GPU 05:55:45 INFO - Bus: Built-In 05:55:45 INFO - VRAM (Dynamic, Max): 1536 MB 05:55:45 INFO - Vendor: Intel (0x8086) 05:55:45 INFO - Device ID: 0x0a2e 05:55:45 INFO - Revision ID: 0x0009 05:55:45 INFO - Displays: 05:55:45 INFO - Display: 05:55:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:55:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:55:45 INFO - Display Serial Number: 1600x1200 60 05:55:45 INFO - Main Display: Yes 05:55:45 INFO - Mirror: Off 05:55:45 INFO - Online: Yes 05:55:45 INFO - Rotation: Supported 05:55:45 INFO - Return code: 0 05:55:45 INFO - Running post-action listener: _resource_record_post_action 05:55:45 INFO - [mozharness: 2016-08-27 12:55:45.115327Z] Finished run-tests step (success) 05:55:45 INFO - Running post-run listener: _resource_record_post_run 05:55:45 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 32832512; Write bytes: 706301952; Read time: 201; Write time: 1990 05:55:45 INFO - TinderboxPrint: CPU usage
54.2% 05:55:45 INFO - TinderboxPrint: I/O read bytes / time
32,832,512 / 201 05:55:45 INFO - TinderboxPrint: I/O write bytes / time
706,301,952 / 1,990 05:55:45 INFO - TinderboxPrint: CPU idle
2,218.4 (45.8%) 05:55:45 INFO - TinderboxPrint: CPU system
976.0 (20.1%) 05:55:45 INFO - TinderboxPrint: CPU user
1,651.2 (34.1%) 05:55:45 INFO - TinderboxPrint: Swap in / out
435,154,944 / 0 05:55:45 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 386167296; Write bytes: 379168256; Read time: 29184; Write time: 767 05:55:45 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 31890432; Write bytes: 297456640; Read time: 188; Write time: 1151 05:55:45 INFO - Running post-run listener: _upload_blobber_files 05:55:45 INFO - Blob upload gear active. 05:55:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:55:45 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:55:45 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:55:45 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:55:46 INFO - (blobuploader) - INFO - Open directory for files ... 05:55:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:55:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:55:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:55:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:55:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:55:47 INFO - (blobuploader) - INFO - Done attempting. 05:55:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:55:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:55:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:55:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:55:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:55:47 INFO - (blobuploader) - INFO - Done attempting. 05:55:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:55:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:55:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:55:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:55:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:55:50 INFO - (blobuploader) - INFO - Done attempting. 05:55:50 INFO - (blobuploader) - INFO - Iteration through files over. 05:55:50 INFO - Return code: 0 05:55:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:55:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:55:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7ed89d314ef5486fe5ecafdfaba913315c8a4fab2d2c6d4d121351386c07df8e2e8fbbf182306e7556a7dcbb3d35d2fa027932d33ba1c45f5ffa5d9c0e0ff10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e121b575bd700e1ac3792a5bda20f872ef581404a4ae9d72cfdb2f08fd4f4a86b009cb8f5e7f392dee7a81e3e81c46584d6313a9f4ca8d57bea55269fc75ff8c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e53747030ffbf1cc21268688147bab988a7229708110f03757691def3af88e6a66f3eeae61a9a271e0f1d05678510751f2b66cc4dad04c9d7cbdbdd580d358c3"} 05:55:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:55:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:55:50 INFO - Contents: 05:55:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7ed89d314ef5486fe5ecafdfaba913315c8a4fab2d2c6d4d121351386c07df8e2e8fbbf182306e7556a7dcbb3d35d2fa027932d33ba1c45f5ffa5d9c0e0ff10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e121b575bd700e1ac3792a5bda20f872ef581404a4ae9d72cfdb2f08fd4f4a86b009cb8f5e7f392dee7a81e3e81c46584d6313a9f4ca8d57bea55269fc75ff8c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e53747030ffbf1cc21268688147bab988a7229708110f03757691def3af88e6a66f3eeae61a9a271e0f1d05678510751f2b66cc4dad04c9d7cbdbdd580d358c3"} 05:55:50 INFO - Running post-run listener: copy_logs_to_upload_dir 05:55:50 INFO - Copying logs to upload dir... 05:55:50 INFO - mkdir: /builds/slave/test/build/upload/logs 05:55:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.395514 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-27 05:55:50.500120) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-27 05:55:50.503417) ========= 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.2V1JQvigOw/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.WPM29hfZih/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7ed89d314ef5486fe5ecafdfaba913315c8a4fab2d2c6d4d121351386c07df8e2e8fbbf182306e7556a7dcbb3d35d2fa027932d33ba1c45f5ffa5d9c0e0ff10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e121b575bd700e1ac3792a5bda20f872ef581404a4ae9d72cfdb2f08fd4f4a86b009cb8f5e7f392dee7a81e3e81c46584d6313a9f4ca8d57bea55269fc75ff8c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e53747030ffbf1cc21268688147bab988a7229708110f03757691def3af88e6a66f3eeae61a9a271e0f1d05678510751f2b66cc4dad04c9d7cbdbdd580d358c3"} build_url:https://queue.taskcluster.net/v1/task/KXenkkpHSBm7k-GoCRm1bA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011224 build_url: 'https://queue.taskcluster.net/v1/task/KXenkkpHSBm7k-GoCRm1bA/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/a7ed89d314ef5486fe5ecafdfaba913315c8a4fab2d2c6d4d121351386c07df8e2e8fbbf182306e7556a7dcbb3d35d2fa027932d33ba1c45f5ffa5d9c0e0ff10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e121b575bd700e1ac3792a5bda20f872ef581404a4ae9d72cfdb2f08fd4f4a86b009cb8f5e7f392dee7a81e3e81c46584d6313a9f4ca8d57bea55269fc75ff8c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e53747030ffbf1cc21268688147bab988a7229708110f03757691def3af88e6a66f3eeae61a9a271e0f1d05678510751f2b66cc4dad04c9d7cbdbdd580d358c3"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-27 05:55:50.540070) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 05:55:50.540399) ========= 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.2V1JQvigOw/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.WPM29hfZih/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005285 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 05:55:50.591560) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-27 05:55:50.592292) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-27 05:55:50.593013) ========= ========= Total master_lag: 0.21 =========