builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0037 starttime: 1471869167.43 results: success (0) buildid: 20160822030424 builduid: bb42ec39b374476a942c1687ab561f4a revision: f97a056ae6235de7855fd8aaa04fb1c8d183bd06 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 05:32:47.427774) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 05:32:47.428344) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 05:32:47.428766) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 05:32:47.492816) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 05:32:47.493220) ========= 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.bkQSBltUmz/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.snW51QOBTQ/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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-22 05:32:47-- 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% 15.7M=0.001s 2016-08-22 05:32:47 (15.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160035 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 05:32:47.710426) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 05:32:47.710836) ========= 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.bkQSBltUmz/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.snW51QOBTQ/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.027631 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 05:32:47.774183) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 05:32:47.774545) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f97a056ae6235de7855fd8aaa04fb1c8d183bd06 --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 f97a056ae6235de7855fd8aaa04fb1c8d183bd06 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bkQSBltUmz/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.snW51QOBTQ/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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-22 05:32:47,882 truncating revision to first 12 chars 2016-08-22 05:32:47,883 Setting DEBUG logging. 2016-08-22 05:32:47,883 attempt 1/10 2016-08-22 05:32:47,883 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f97a056ae623?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 05:32:48,881 unpacking tar archive at: mozilla-central-f97a056ae623/testing/mozharness/ program finished with exit code 0 elapsedTime=1.253223 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 05:32:49.083791) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 05:32:49.084131) ========= script_repo_revision: f97a056ae6235de7855fd8aaa04fb1c8d183bd06 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 05:32:49.084579) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 05:32:49.084900) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 05:32:49.109323) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-22 05:32:49.109896) ========= /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.bkQSBltUmz/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.snW51QOBTQ/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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:32:49 INFO - MultiFileLogger online at 20160822 05:32:49 in /builds/slave/test 05:32:49 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:32:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:32:49 INFO - {'append_to_log': False, 05:32:49 INFO - 'base_work_dir': '/builds/slave/test', 05:32:49 INFO - 'blob_upload_branch': 'Firefox', 05:32:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:32:49 INFO - 'branch': 'Firefox', 05:32:49 INFO - 'buildbot_json_path': 'buildprops.json', 05:32:49 INFO - 'config_files': ('talos/mac_config.py',), 05:32:49 INFO - 'default_actions': ('clobber', 05:32:49 INFO - 'read-buildbot-config', 05:32:49 INFO - 'download-and-extract', 05:32:49 INFO - 'populate-webroot', 05:32:49 INFO - 'create-virtualenv', 05:32:49 INFO - 'install', 05:32:49 INFO - 'run-tests'), 05:32:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:32:49 INFO - 'download_minidump_stackwalk': True, 05:32:49 INFO - 'download_symbols': 'ondemand', 05:32:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:32:49 INFO - 'tooltool.py': '/tools/tooltool.py', 05:32:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:32:49 INFO - '/tools/misc-python/virtualenv.py')}, 05:32:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:32:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:32:49 INFO - 'installer_path': 'installer.exe', 05:32:49 INFO - 'log_level': 'info', 05:32:49 INFO - 'log_name': 'talos', 05:32:49 INFO - 'log_to_console': True, 05:32:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:32:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:32:49 INFO - 'opt_config_files': (), 05:32:49 INFO - 'pip_index': False, 05:32:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:32:49 INFO - 'cmd': ('bash', 05:32:49 INFO - '-c', 05:32:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:32:49 INFO - 'enabled': True, 05:32:49 INFO - 'halt_on_failure': False, 05:32:49 INFO - 'name': 'check_screen_resolution'},), 05:32:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:32:49 INFO - 'cmd': ('bash', 05:32:49 INFO - '-c', 05:32:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:32:49 INFO - 'enabled': True, 05:32:49 INFO - 'halt_on_failure': False, 05:32:49 INFO - 'name': 'check_screen_resolution'},), 05:32:49 INFO - 'run_cmd_checks_enabled': True, 05:32:49 INFO - 'sps_profile': False, 05:32:49 INFO - 'sps_profile_interval': 0, 05:32:49 INFO - 'suite': 'dromaeojs-e10s', 05:32:49 INFO - 'system_bits': '32', 05:32:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:32:49 INFO - 'title': 't-yosemite-r7-0037', 05:32:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:32:49 INFO - 'use_talos_json': True, 05:32:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:32:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:32:49 INFO - 'work_dir': 'build'} 05:32:49 INFO - [mozharness: 2016-08-22 12:32:49.313963Z] Running clobber step. 05:32:49 INFO - Running pre-action listener: _resource_record_pre_action 05:32:49 INFO - Running main action method: clobber 05:32:49 INFO - rmtree: /builds/slave/test/build 05:32:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:32:51 INFO - Running post-action listener: _resource_record_post_action 05:32:51 INFO - [mozharness: 2016-08-22 12:32:51.461206Z] Finished clobber step (success) 05:32:51 INFO - [mozharness: 2016-08-22 12:32:51.461386Z] Running read-buildbot-config step. 05:32:51 INFO - Running pre-action listener: _resource_record_pre_action 05:32:51 INFO - Running main action method: read_buildbot_config 05:32:51 INFO - Using buildbot properties: 05:32:51 INFO - { 05:32:51 INFO - "project": "", 05:32:51 INFO - "product": "firefox", 05:32:51 INFO - "script_repo_revision": "production", 05:32:51 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:32:51 INFO - "repository": "", 05:32:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:32:51 INFO - "buildid": "20160822030424", 05:32:51 INFO - "stage_platform": "macosx64", 05:32:51 INFO - "basedir": "/builds/slave/test", 05:32:51 INFO - "nightly_build": "True", 05:32:51 INFO - "buildnumber": 35, 05:32:51 INFO - "slavename": "t-yosemite-r7-0037", 05:32:51 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 05:32:51 INFO - "platform": "yosemite_r7", 05:32:51 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:32:51 INFO - "branch": "mozilla-central", 05:32:51 INFO - "repo_path": "mozilla-central", 05:32:51 INFO - "revision": "f97a056ae6235de7855fd8aaa04fb1c8d183bd06", 05:32:51 INFO - "pgo_build": "False", 05:32:51 INFO - "builduid": "bb42ec39b374476a942c1687ab561f4a", 05:32:51 INFO - "slavebuilddir": "test" 05:32:51 INFO - } 05:32:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/IHEybdxTRwGpBIczZfEdlw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 05:32:51 INFO - Running post-action listener: _resource_record_post_action 05:32:51 INFO - [mozharness: 2016-08-22 12:32:51.464890Z] Finished read-buildbot-config step (success) 05:32:51 INFO - [mozharness: 2016-08-22 12:32:51.465031Z] Running download-and-extract step. 05:32:51 INFO - Running pre-action listener: _resource_record_pre_action 05:32:51 INFO - Running main action method: download_and_extract 05:32:51 INFO - mkdir: /builds/slave/test/build/tests 05:32:51 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:32:51 INFO - trying https://queue.taskcluster.net/v1/task/IHEybdxTRwGpBIczZfEdlw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 05:32:51 INFO - Downloading https://queue.taskcluster.net/v1/task/IHEybdxTRwGpBIczZfEdlw/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:32:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IHEybdxTRwGpBIczZfEdlw/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:32:52 INFO - Downloaded 1199 bytes. 05:32:52 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:32:52 INFO - Using the following test package requirements: 05:32:52 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:32:52 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:32:52 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 05:32:52 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:32:52 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 05:32:52 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:32:52 INFO - u'jsshell-mac.zip'], 05:32:52 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:32:52 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 05:32:52 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:32:52 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:32:52 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 05:32:52 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:32:52 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 05:32:52 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:32:52 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 05:32:52 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:32:52 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 05:32:52 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:52 INFO - trying https://queue.taskcluster.net/v1/task/IHEybdxTRwGpBIczZfEdlw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:32:52 INFO - Downloading https://queue.taskcluster.net/v1/task/IHEybdxTRwGpBIczZfEdlw/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:32:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IHEybdxTRwGpBIczZfEdlw/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:32:52 INFO - Downloaded 16351959 bytes. 05:32:52 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:32:59 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:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:59 INFO - trying https://queue.taskcluster.net/v1/task/IHEybdxTRwGpBIczZfEdlw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:32:59 INFO - Downloading https://queue.taskcluster.net/v1/task/IHEybdxTRwGpBIczZfEdlw/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:32:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IHEybdxTRwGpBIczZfEdlw/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:33:00 INFO - Downloaded 16351959 bytes. 05:33:00 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:33:07 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:33:07 INFO - trying https://queue.taskcluster.net/v1/task/IHEybdxTRwGpBIczZfEdlw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:33:07 INFO - Downloading https://queue.taskcluster.net/v1/task/IHEybdxTRwGpBIczZfEdlw/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:33:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IHEybdxTRwGpBIczZfEdlw/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:33:08 INFO - Downloaded 14413981 bytes. 05:33:08 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:33:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:09 INFO - trying https://queue.taskcluster.net/v1/task/IHEybdxTRwGpBIczZfEdlw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:33:09 INFO - Downloading https://queue.taskcluster.net/v1/task/IHEybdxTRwGpBIczZfEdlw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 05:33:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IHEybdxTRwGpBIczZfEdlw/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:33:12 INFO - Downloaded 111615747 bytes. 05:33:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IHEybdxTRwGpBIczZfEdlw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:33:12 INFO - mkdir: /builds/slave/test/properties 05:33:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:33:12 INFO - Writing to file /builds/slave/test/properties/build_url 05:33:12 INFO - Contents: 05:33:12 INFO - build_url:https://queue.taskcluster.net/v1/task/IHEybdxTRwGpBIczZfEdlw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:33:13 INFO - Running post-action listener: _resource_record_post_action 05:33:13 INFO - Running post-action listener: set_extra_try_arguments 05:33:13 INFO - [mozharness: 2016-08-22 12:33:13.115033Z] Finished download-and-extract step (success) 05:33:13 INFO - [mozharness: 2016-08-22 12:33:13.115141Z] Running populate-webroot step. 05:33:13 INFO - Running pre-action listener: _resource_record_pre_action 05:33:13 INFO - Running main action method: populate_webroot 05:33:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:33:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:33:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:33:13 INFO - '--tppagecycles', 05:33:13 INFO - '7'], 05:33:13 INFO - 'tests': ['tsvgm']}}, 05:33:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:33:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:33:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:33:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:33:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:33:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:33:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:13 INFO - 'talos_options': ['--disable-e10s'], 05:33:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:33:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:33:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:13 INFO - 'talos_options': ['--disable-e10s'], 05:33:13 INFO - 'tests': ['damp', 'tps']}, 05:33:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:13 INFO - 'tests': ['damp', 'tps']}, 05:33:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:33:13 INFO - 'tests': ['dromaeo_dom']}, 05:33:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:33:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:33:13 INFO - 'tests': ['basic_compositor_video']}, 05:33:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:33:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:33:13 INFO - 'tests': ['a11yr', 05:33:13 INFO - 'ts_paint', 05:33:13 INFO - 'tpaint', 05:33:13 INFO - 'sessionrestore', 05:33:13 INFO - 'sessionrestore_no_auto_restore', 05:33:13 INFO - 'tabpaint']}, 05:33:13 INFO - 'other-e10s': {'tests': ['a11yr', 05:33:13 INFO - 'ts_paint', 05:33:13 INFO - 'tpaint', 05:33:13 INFO - 'sessionrestore', 05:33:13 INFO - 'sessionrestore_no_auto_restore', 05:33:13 INFO - 'tabpaint']}, 05:33:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:33:13 INFO - 'ts_paint', 05:33:13 INFO - 'tpaint', 05:33:13 INFO - 'sessionrestore', 05:33:13 INFO - 'sessionrestore_no_auto_restore', 05:33:13 INFO - 'tabpaint']}, 05:33:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:33:13 INFO - 'ts_paint', 05:33:13 INFO - 'tpaint', 05:33:13 INFO - 'sessionrestore', 05:33:13 INFO - 'sessionrestore_no_auto_restore', 05:33:13 INFO - 'tabpaint']}, 05:33:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:33:13 INFO - 'tests': ['a11yr', 05:33:13 INFO - 'ts_paint', 05:33:13 INFO - 'tpaint', 05:33:13 INFO - 'sessionrestore', 05:33:13 INFO - 'sessionrestore_no_auto_restore', 05:33:13 INFO - 'tabpaint']}, 05:33:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:33:13 INFO - 'tests': ['a11yr', 05:33:13 INFO - 'ts_paint', 05:33:13 INFO - 'tpaint', 05:33:13 INFO - 'sessionrestore', 05:33:13 INFO - 'sessionrestore_no_auto_restore', 05:33:13 INFO - 'tabpaint']}, 05:33:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:33:13 INFO - 'tests': ['tsvgx', 05:33:13 INFO - 'tsvgr_opacity', 05:33:13 INFO - 'tart', 05:33:13 INFO - 'tscrollx', 05:33:13 INFO - 'cart']}, 05:33:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:33:13 INFO - 'tsvgr_opacity', 05:33:13 INFO - 'tart', 05:33:13 INFO - 'tscrollx', 05:33:13 INFO - 'cart']}, 05:33:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:13 INFO - 'talos_options': ['--disable-e10s'], 05:33:13 INFO - 'tests': ['tp5o']}, 05:33:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:13 INFO - 'tests': ['tp5o']}, 05:33:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:13 INFO - 'talos_options': ['--disable-e10s', 05:33:13 INFO - '--xperf_path', 05:33:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:33:13 INFO - 'tests': ['tp5n']}, 05:33:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:13 INFO - 'talos_options': ['--xperf_path', 05:33:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:33:13 INFO - 'tests': ['tp5n']}}, 05:33:13 INFO - 'talos.zip': {'path': '', 05:33:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:33:13 INFO - Running post-action listener: _resource_record_post_action 05:33:13 INFO - [mozharness: 2016-08-22 12:33:13.133980Z] Finished populate-webroot step (success) 05:33:13 INFO - [mozharness: 2016-08-22 12:33:13.134113Z] Running create-virtualenv step. 05:33:13 INFO - Running pre-action listener: _resource_record_pre_action 05:33:13 INFO - Running main action method: create_virtualenv 05:33:13 INFO - Creating virtualenv /builds/slave/test/build/venv 05:33:13 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:33:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:33:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:33:13 INFO - Using real prefix '/tools/python27' 05:33:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:33:14 INFO - Installing distribute.............................................................................................................................................................................................done. 05:33:16 INFO - Installing pip.................done. 05:33:16 INFO - Return code: 0 05:33:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:33:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109762a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe79ddc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096c6d30>, '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 0x10942bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096beb20>, '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.bkQSBltUmz/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.snW51QOBTQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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:33:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:33:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bkQSBltUmz/Render', 05:33:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:16 INFO - 'HOME': '/Users/cltbld', 05:33:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:16 INFO - 'LOGNAME': 'cltbld', 05:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:16 INFO - 'MOZ_NO_REMOTE': '1', 05:33:16 INFO - 'NO_EM_RESTART': '1', 05:33:16 INFO - 'PAGER': '/bin/cat', 05:33:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:16 INFO - 'PWD': '/builds/slave/test', 05:33:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:16 INFO - 'SHELL': '/bin/bash', 05:33:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.snW51QOBTQ/Listeners', 05:33:16 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 05:33:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:16 INFO - 'USER': 'cltbld', 05:33:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:16 INFO - 'XPC_FLAGS': '0x0', 05:33:16 INFO - 'XPC_SERVICE_NAME': '0', 05:33:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:17 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:33:17 INFO - Cleaning up... 05:33:17 INFO - Return code: 0 05:33:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:33: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:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33: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:33:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33: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', '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 0x109762a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe79ddc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096c6d30>, '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 0x10942bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096beb20>, '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.bkQSBltUmz/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.snW51QOBTQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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:33: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:33: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 psutil>=3.1.1 05:33:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bkQSBltUmz/Render', 05:33:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:17 INFO - 'HOME': '/Users/cltbld', 05:33:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:17 INFO - 'LOGNAME': 'cltbld', 05:33:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:17 INFO - 'MOZ_NO_REMOTE': '1', 05:33:17 INFO - 'NO_EM_RESTART': '1', 05:33:17 INFO - 'PAGER': '/bin/cat', 05:33:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:17 INFO - 'PWD': '/builds/slave/test', 05:33:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:17 INFO - 'SHELL': '/bin/bash', 05:33:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.snW51QOBTQ/Listeners', 05:33:17 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 05:33:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:17 INFO - 'USER': 'cltbld', 05:33:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:17 INFO - 'XPC_FLAGS': '0x0', 05:33:17 INFO - 'XPC_SERVICE_NAME': '0', 05:33:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:17 INFO - Downloading/unpacking psutil>=3.1.1 05:33: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:33: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:33: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:33: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:33: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:33: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:33:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:33:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:33:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:33:20 INFO - Installing collected packages: psutil 05:33:20 INFO - Running setup.py install for psutil 05:33:20 INFO - building 'psutil._psutil_osx' extension 05:33:20 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:33:21 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:33:21 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:33:21 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:33:21 INFO - building 'psutil._psutil_posix' extension 05:33:21 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:33:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:33:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:33:21 INFO - ^ 05:33:21 INFO - 1 warning generated. 05:33:21 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:33:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:33:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:33:21 INFO - Successfully installed psutil 05:33:21 INFO - Cleaning up... 05:33:21 INFO - Return code: 0 05:33:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:21 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 0x109762a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe79ddc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096c6d30>, '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 0x10942bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096beb20>, '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.bkQSBltUmz/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.snW51QOBTQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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:33:21 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:33:21 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:33:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bkQSBltUmz/Render', 05:33:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:21 INFO - 'HOME': '/Users/cltbld', 05:33:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:21 INFO - 'LOGNAME': 'cltbld', 05:33:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:21 INFO - 'MOZ_NO_REMOTE': '1', 05:33:21 INFO - 'NO_EM_RESTART': '1', 05:33:21 INFO - 'PAGER': '/bin/cat', 05:33:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:21 INFO - 'PWD': '/builds/slave/test', 05:33:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:21 INFO - 'SHELL': '/bin/bash', 05:33:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.snW51QOBTQ/Listeners', 05:33:21 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 05:33:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:21 INFO - 'USER': 'cltbld', 05:33:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:21 INFO - 'XPC_FLAGS': '0x0', 05:33:21 INFO - 'XPC_SERVICE_NAME': '0', 05:33:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:33: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:33: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:33: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:33: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:33: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:33: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:33:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:33:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:33:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:33:24 INFO - Installing collected packages: mozsystemmonitor 05:33:24 INFO - Running setup.py install for mozsystemmonitor 05:33:24 INFO - Successfully installed mozsystemmonitor 05:33:24 INFO - Cleaning up... 05:33:24 INFO - Return code: 0 05:33:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:33:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:24 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 0x109762a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe79ddc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096c6d30>, '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 0x10942bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096beb20>, '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.bkQSBltUmz/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.snW51QOBTQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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:33:24 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:33:24 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:33:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bkQSBltUmz/Render', 05:33:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:24 INFO - 'HOME': '/Users/cltbld', 05:33:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:24 INFO - 'LOGNAME': 'cltbld', 05:33:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:24 INFO - 'MOZ_NO_REMOTE': '1', 05:33:24 INFO - 'NO_EM_RESTART': '1', 05:33:24 INFO - 'PAGER': '/bin/cat', 05:33:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:24 INFO - 'PWD': '/builds/slave/test', 05:33:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:24 INFO - 'SHELL': '/bin/bash', 05:33:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.snW51QOBTQ/Listeners', 05:33:24 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 05:33:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:24 INFO - 'USER': 'cltbld', 05:33:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:24 INFO - 'XPC_FLAGS': '0x0', 05:33:24 INFO - 'XPC_SERVICE_NAME': '0', 05:33:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:24 INFO - Downloading/unpacking jsonschema==2.5.1 05:33:24 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:33:24 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:33:24 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:33:24 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:33:24 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:33:24 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:33:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:33:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:33:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:27 INFO - Downloading functools32-3.2.3-2.tar.gz 05:33:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:33:27 INFO - warning: no files found matching '*.txt' 05:33:27 INFO - no previously-included directories found matching 'build' 05:33:27 INFO - no previously-included directories found matching 'dist' 05:33:27 INFO - no previously-included directories found matching '.git*' 05:33:27 INFO - Installing collected packages: jsonschema, functools32 05:33:27 INFO - Running setup.py install for functools32 05:33:28 INFO - warning: no files found matching '*.txt' 05:33:28 INFO - no previously-included directories found matching 'build' 05:33:28 INFO - no previously-included directories found matching 'dist' 05:33:28 INFO - no previously-included directories found matching '.git*' 05:33:28 INFO - Successfully installed jsonschema functools32 05:33:28 INFO - Cleaning up... 05:33:28 INFO - Return code: 0 05:33:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:28 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 0x109762a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe79ddc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096c6d30>, '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 0x10942bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096beb20>, '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.bkQSBltUmz/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.snW51QOBTQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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:33:28 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:33:28 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:33:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bkQSBltUmz/Render', 05:33:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:28 INFO - 'HOME': '/Users/cltbld', 05:33:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:28 INFO - 'LOGNAME': 'cltbld', 05:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:28 INFO - 'MOZ_NO_REMOTE': '1', 05:33:28 INFO - 'NO_EM_RESTART': '1', 05:33:28 INFO - 'PAGER': '/bin/cat', 05:33:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:28 INFO - 'PWD': '/builds/slave/test', 05:33:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:28 INFO - 'SHELL': '/bin/bash', 05:33:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.snW51QOBTQ/Listeners', 05:33:28 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 05:33:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:28 INFO - 'USER': 'cltbld', 05:33:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:28 INFO - 'XPC_FLAGS': '0x0', 05:33:28 INFO - 'XPC_SERVICE_NAME': '0', 05:33:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:33:28 INFO - Cleaning up... 05:33:28 INFO - Return code: 0 05:33:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:28 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 0x109762a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe79ddc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096c6d30>, '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 0x10942bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096beb20>, '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.bkQSBltUmz/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.snW51QOBTQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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:33:28 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:33:28 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:33:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bkQSBltUmz/Render', 05:33:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:28 INFO - 'HOME': '/Users/cltbld', 05:33:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:28 INFO - 'LOGNAME': 'cltbld', 05:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:28 INFO - 'MOZ_NO_REMOTE': '1', 05:33:28 INFO - 'NO_EM_RESTART': '1', 05:33:28 INFO - 'PAGER': '/bin/cat', 05:33:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:28 INFO - 'PWD': '/builds/slave/test', 05:33:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:28 INFO - 'SHELL': '/bin/bash', 05:33:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.snW51QOBTQ/Listeners', 05:33:28 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 05:33:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:28 INFO - 'USER': 'cltbld', 05:33:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:28 INFO - 'XPC_FLAGS': '0x0', 05:33:28 INFO - 'XPC_SERVICE_NAME': '0', 05:33:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:28 INFO - Downloading/unpacking blobuploader==1.2.4 05:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:31 INFO - Downloading blobuploader-1.2.4.tar.gz 05:33:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:33:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:33:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:32 INFO - Downloading docopt-0.6.1.tar.gz 05:33:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:33:32 INFO - Installing collected packages: blobuploader, requests, docopt 05:33:32 INFO - Running setup.py install for blobuploader 05:33:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:33:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:33:32 INFO - Running setup.py install for requests 05:33:33 INFO - Running setup.py install for docopt 05:33:33 INFO - Successfully installed blobuploader requests docopt 05:33:33 INFO - Cleaning up... 05:33:33 INFO - Return code: 0 05:33:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:33 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 0x109762a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe79ddc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096c6d30>, '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 0x10942bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096beb20>, '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.bkQSBltUmz/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.snW51QOBTQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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:33:33 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:33:33 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:33:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bkQSBltUmz/Render', 05:33:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:33 INFO - 'HOME': '/Users/cltbld', 05:33:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:33 INFO - 'LOGNAME': 'cltbld', 05:33:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:33 INFO - 'MOZ_NO_REMOTE': '1', 05:33:33 INFO - 'NO_EM_RESTART': '1', 05:33:33 INFO - 'PAGER': '/bin/cat', 05:33:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:33 INFO - 'PWD': '/builds/slave/test', 05:33:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:33 INFO - 'SHELL': '/bin/bash', 05:33:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.snW51QOBTQ/Listeners', 05:33:33 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 05:33:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:33 INFO - 'USER': 'cltbld', 05:33:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:33 INFO - 'XPC_FLAGS': '0x0', 05:33:33 INFO - 'XPC_SERVICE_NAME': '0', 05:33:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:33:33 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-zXjLvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:33:33 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-SHo9oK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:33:33 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-mQoyJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:33:33 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-U_etg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:33:33 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-q4brF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:33:34 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-qLChgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:33:34 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-GyKQU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:33:34 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-9b0lFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:33:34 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-8_VG3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:33:34 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-aTFJWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:33:34 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-V7hJZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:33:34 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-k8oytC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:33:34 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-iQBE15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:33:34 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-GcbrO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:34 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-bR_hXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:33:35 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-0bUMiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:33:35 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-yHRH4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:33:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:33:35 INFO - Running setup.py install for manifestparser 05:33:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:33:35 INFO - Running setup.py install for mozcrash 05:33:35 INFO - Running setup.py install for mozdebug 05:33:35 INFO - Running setup.py install for mozdevice 05:33:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:33:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:33:35 INFO - Running setup.py install for mozfile 05:33:35 INFO - Running setup.py install for mozhttpd 05:33:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:33:36 INFO - Running setup.py install for mozinfo 05:33:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:33:36 INFO - Running setup.py install for mozInstall 05:33:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:33:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:33:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:33:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:33:36 INFO - Running setup.py install for mozleak 05:33:36 INFO - Running setup.py install for mozlog 05:33:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:33:36 INFO - Running setup.py install for moznetwork 05:33:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:33:36 INFO - Running setup.py install for mozprocess 05:33:37 INFO - Running setup.py install for mozprofile 05:33:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:33:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:33:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:33:37 INFO - Running setup.py install for mozrunner 05:33:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:33:37 INFO - Running setup.py install for mozscreenshot 05:33:37 INFO - Running setup.py install for moztest 05:33:37 INFO - Running setup.py install for mozversion 05:33:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:33:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:33:37 INFO - Cleaning up... 05:33:37 INFO - Return code: 0 05:33:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:37 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:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:37 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:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:37 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 0x109762a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe79ddc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096c6d30>, '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 0x10942bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096beb20>, '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.bkQSBltUmz/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.snW51QOBTQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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:33:37 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:33:37 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:33:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bkQSBltUmz/Render', 05:33:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:37 INFO - 'HOME': '/Users/cltbld', 05:33:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:37 INFO - 'LOGNAME': 'cltbld', 05:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:37 INFO - 'MOZ_NO_REMOTE': '1', 05:33:37 INFO - 'NO_EM_RESTART': '1', 05:33:37 INFO - 'PAGER': '/bin/cat', 05:33:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:37 INFO - 'PWD': '/builds/slave/test', 05:33:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:37 INFO - 'SHELL': '/bin/bash', 05:33:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.snW51QOBTQ/Listeners', 05:33:37 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 05:33:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:37 INFO - 'USER': 'cltbld', 05:33:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:37 INFO - 'XPC_FLAGS': '0x0', 05:33:37 INFO - 'XPC_SERVICE_NAME': '0', 05:33:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:33:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-ambfc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:33:38 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:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:33:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-wApER8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:33:38 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:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:33:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-LgPSQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:33:38 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:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:33:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-yolHdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:33:38 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:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:33:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-T8_HZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:33:38 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:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:33:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-9oQmz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:33:38 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:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:33:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-J5nbPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:33:38 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:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:33:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-eRwD5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:33:38 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:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:33:38 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Ab5YqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:33:39 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:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:33:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-yoRtkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:33:39 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:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:33:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-1uqmAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:33:39 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:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:33:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-CzSdWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:33:39 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:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:33:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-fDDdQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:33:39 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:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:33:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-gv2QT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:33:39 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:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-vFpmpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:39 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:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:33:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-tIt_nD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:33:39 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:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:33:39 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-taDYtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:33:39 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:33:39 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:33:39 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:33:39 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:33:39 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:33:39 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:33:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:33:39 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:33:39 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:33:39 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:33:39 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:33:39 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:33:39 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:33:42 INFO - Downloading blessings-1.6.tar.gz 05:33:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:33:42 INFO - Installing collected packages: blessings 05:33:42 INFO - Running setup.py install for blessings 05:33:42 INFO - Successfully installed blessings 05:33:42 INFO - Cleaning up... 05:33:42 INFO - Return code: 0 05:33:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:33:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:33:42 INFO - Reading from file tmpfile_stdout 05:33:42 INFO - Current package versions: 05:33:42 INFO - blessings == 1.6 05:33:42 INFO - blobuploader == 1.2.4 05:33:42 INFO - docopt == 0.6.1 05:33:42 INFO - functools32 == 3.2.3-2 05:33:42 INFO - jsonschema == 2.5.1 05:33:42 INFO - manifestparser == 1.1 05:33:42 INFO - mozInstall == 1.12 05:33:42 INFO - mozcrash == 0.17 05:33:42 INFO - mozdebug == 0.1 05:33:42 INFO - mozdevice == 0.48 05:33:42 INFO - mozfile == 1.2 05:33:42 INFO - mozhttpd == 0.7 05:33:42 INFO - mozinfo == 0.9 05:33:42 INFO - mozleak == 0.1 05:33:42 INFO - mozlog == 3.3 05:33:42 INFO - moznetwork == 0.27 05:33:42 INFO - mozprocess == 0.23 05:33:42 INFO - mozprofile == 0.28 05:33:42 INFO - mozrunner == 6.12 05:33:42 INFO - mozscreenshot == 0.1 05:33:42 INFO - mozsystemmonitor == 0.3 05:33:42 INFO - moztest == 0.7 05:33:42 INFO - mozversion == 1.4 05:33:42 INFO - psutil == 3.1.1 05:33:42 INFO - requests == 1.2.3 05:33:42 INFO - wsgiref == 0.1.2 05:33:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:42 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:33:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:42 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:33:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:42 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 0x109762a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe79ddc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096c6d30>, '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 0x10942bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096beb20>, '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.bkQSBltUmz/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.snW51QOBTQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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:33:42 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:33:42 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:33:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bkQSBltUmz/Render', 05:33:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:42 INFO - 'HOME': '/Users/cltbld', 05:33:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:42 INFO - 'LOGNAME': 'cltbld', 05:33:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:42 INFO - 'MOZ_NO_REMOTE': '1', 05:33:42 INFO - 'NO_EM_RESTART': '1', 05:33:42 INFO - 'PAGER': '/bin/cat', 05:33:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:42 INFO - 'PWD': '/builds/slave/test', 05:33:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:42 INFO - 'SHELL': '/bin/bash', 05:33:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.snW51QOBTQ/Listeners', 05:33:42 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 05:33:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:42 INFO - 'USER': 'cltbld', 05:33:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:42 INFO - 'XPC_FLAGS': '0x0', 05:33:42 INFO - 'XPC_SERVICE_NAME': '0', 05:33:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:43 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:33:43 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:33:43 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:33:43 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:33:43 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:33:43 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:33:43 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:33:43 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:33:43 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:33:43 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:33:43 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:33:43 INFO - Cleaning up... 05:33:43 INFO - Return code: 0 05:33:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:43 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 0x109762a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097f7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe79ddc6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1096c6d30>, '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 0x10942bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096beb20>, '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.bkQSBltUmz/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.snW51QOBTQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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:33:43 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:33:43 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:33:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bkQSBltUmz/Render', 05:33:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:43 INFO - 'HOME': '/Users/cltbld', 05:33:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:43 INFO - 'LOGNAME': 'cltbld', 05:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:43 INFO - 'MOZ_NO_REMOTE': '1', 05:33:43 INFO - 'NO_EM_RESTART': '1', 05:33:43 INFO - 'PAGER': '/bin/cat', 05:33:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:43 INFO - 'PWD': '/builds/slave/test', 05:33:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:43 INFO - 'SHELL': '/bin/bash', 05:33:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.snW51QOBTQ/Listeners', 05:33:43 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 05:33:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:43 INFO - 'USER': 'cltbld', 05:33:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:43 INFO - 'XPC_FLAGS': '0x0', 05:33:43 INFO - 'XPC_SERVICE_NAME': '0', 05:33:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:33:43 INFO - Cleaning up... 05:33:43 INFO - Return code: 0 05:33:43 INFO - Running post-action listener: _resource_record_post_action 05:33:43 INFO - Running post-action listener: _start_resource_monitoring 05:33:43 INFO - Starting resource monitoring. 05:33:43 INFO - [mozharness: 2016-08-22 12:33:43.553161Z] Finished create-virtualenv step (success) 05:33:43 INFO - [mozharness: 2016-08-22 12:33:43.554133Z] Running install step. 05:33:43 INFO - Running pre-action listener: _resource_record_pre_action 05:33:43 INFO - Running main action method: install 05:33:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:33:43 INFO - Reading from file tmpfile_stdout 05:33:43 INFO - Detecting whether we're running mozinstall >=1.0... 05:33:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:33:43 INFO - Reading from file tmpfile_stdout 05:33:43 INFO - Output received: 05:33:43 INFO - Usage: mozinstall [options] installer 05:33:43 INFO - Options: 05:33:43 INFO - -h, --help show this help message and exit 05:33:43 INFO - -d DEST, --destination=DEST 05:33:43 INFO - Directory to install application into. [default: 05:33:43 INFO - "/builds/slave/test"] 05:33:43 INFO - --app=APP Application being installed. [default: firefox] 05:33:43 INFO - mkdir: /builds/slave/test/build/application 05:33:43 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:33:43 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:34:17 INFO - Reading from file tmpfile_stdout 05:34:17 INFO - Output received: 05:34:17 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:34:17 INFO - Running post-action listener: _resource_record_post_action 05:34:17 INFO - [mozharness: 2016-08-22 12:34:17.499103Z] Finished install step (success) 05:34:17 INFO - [mozharness: 2016-08-22 12:34:17.499238Z] Running run-tests step. 05:34:17 INFO - Running pre-action listener: _resource_record_pre_action 05:34:17 INFO - Running main action method: run_tests 05:34:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:34:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:34:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:34:17 INFO - 2016-08-22 05:34:17.514 screenresolution[1637:8534] starting screenresolution argv=screenresolution get 05:34:17 INFO - 2016-08-22 05:34:17.517 screenresolution[1637:8534] Display 0: 1600x1200x32@60 05:34:17 INFO - 2016-08-22 05:34:17.522 screenresolution[1638:8536] starting screenresolution argv=screenresolution list 05:34:17 INFO - Available Modes on Display 0 05:34:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:34:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:34:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:34:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:34:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:34:17 INFO - Intel Iris: 05:34:17 INFO - Chipset Model: Intel Iris 05:34:17 INFO - Type: GPU 05:34:17 INFO - Bus: Built-In 05:34:17 INFO - VRAM (Dynamic, Max): 1536 MB 05:34:17 INFO - Vendor: Intel (0x8086) 05:34:17 INFO - Device ID: 0x0a2e 05:34:17 INFO - Revision ID: 0x0009 05:34:17 INFO - Displays: 05:34:17 INFO - Display: 05:34:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:34:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:34:17 INFO - Display Serial Number: 1600x1200 60 05:34:17 INFO - Main Display: Yes 05:34:17 INFO - Mirror: Off 05:34:17 INFO - Online: Yes 05:34:17 INFO - Rotation: Supported 05:34:17 INFO - Return code: 0 05:34:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:34:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:34:17 INFO - Python 2.7.3 05:34:17 INFO - Return code: 0 05:34:17 INFO - grabbing minidump binary from tooltool 05:34: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:34:17 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 0x1096c6d30>, '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 0x10942bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1096beb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:34:17 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:34:17 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:34:17 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:34:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:34:17 INFO - Return code: 0 05:34:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:34:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:34:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:34:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:34:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:34:17 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/IHEybdxTRwGpBIczZfEdlw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0037', '--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:34:17 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/IHEybdxTRwGpBIczZfEdlw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0037 --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:34:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bkQSBltUmz/Render', 05:34:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:34:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:34:17 INFO - 'HOME': '/Users/cltbld', 05:34:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:34:17 INFO - 'LOGNAME': 'cltbld', 05:34:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:34:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:34:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:17 INFO - 'MOZ_NO_REMOTE': '1', 05:34:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:34:17 INFO - 'NO_EM_RESTART': '1', 05:34:17 INFO - 'PAGER': '/bin/cat', 05:34:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:34:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:17 INFO - 'PWD': '/builds/slave/test', 05:34:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:34:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:34:17 INFO - 'SHELL': '/bin/bash', 05:34:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.snW51QOBTQ/Listeners', 05:34:17 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 05:34:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:34:17 INFO - 'USER': 'cltbld', 05:34:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:34:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:34:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:17 INFO - 'XPC_FLAGS': '0x0', 05:34:17 INFO - 'XPC_SERVICE_NAME': '0', 05:34:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:34:17 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/IHEybdxTRwGpBIczZfEdlw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0037', '--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:34:18 INFO - mozversion application_buildid: 20160822030424 05:34:18 INFO - mozversion application_changeset: f97a056ae6235de7855fd8aaa04fb1c8d183bd06 05:34:18 INFO - mozversion application_display_name: Nightly 05:34:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:34:18 INFO - mozversion application_name: Firefox 05:34:18 INFO - mozversion application_remotingname: firefox 05:34:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:34:18 INFO - mozversion application_vendor: Mozilla 05:34:18 INFO - mozversion application_version: 51.0a1 05:34:18 INFO - mozversion platform_buildid: 20160822030424 05:34:18 INFO - mozversion platform_changeset: f97a056ae6235de7855fd8aaa04fb1c8d183bd06 05:34:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:34:18 INFO - mozversion platform_version: 51.0a1 05:34:18 INFO - using testdate: 1471869258 05:34:18 INFO - actual date: 1471869258 05:34:18 INFO - starting webserver on 'localhost:49262' 05:34:18 INFO - SUITE-START | Running 2 tests 05:34:18 INFO - TEST-START | dromaeo_css 05:34:18 INFO - operating with platform_type : mac_ 05:34:18 INFO - Initialising browser for dromaeo_css test... 05:34:18 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpAJEGYR/profile http://localhost:49262/getInfo.html) 05:34:21 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 05:34:21 INFO - PROCESS | 1648 | colorDepth:24 05:34:21 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 05:34:21 INFO - PROCESS | 1648 | __metrics 05:34:21 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3061: TypeError: this.tabs is undefined 05:34:22 INFO - TEST-INFO | 1648: exit 0 05:34:22 INFO - Browser initialized. 05:34:22 INFO - Running cycle 1/1 for dromaeo_css test... 05:34:22 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpAJEGYR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:34:33 INFO - PROCESS | 1653 | RSS: Main: 239697920 05:34:33 INFO - PROCESS | 1653 | 05:35:23 INFO - PROCESS | 1653 | 1471869323633 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:37:35 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49262/tests/dromaeo/cssquery-ext.html) 05:37:36 INFO - PROCESS | 1653 | RSS: Main: 255348736 05:37:36 INFO - PROCESS | 1653 | 05:40:39 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-ext.html (next: http://localhost:49262/tests/dromaeo/cssquery-jquery.html) 05:40:39 INFO - PROCESS | 1653 | RSS: Main: 265424896 05:40:39 INFO - PROCESS | 1653 | 05:43:41 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49262/tests/dromaeo/cssquery-mootools.html) 05:43:42 INFO - PROCESS | 1653 | RSS: Main: 271908864 05:43:42 INFO - PROCESS | 1653 | 05:46:44 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49262/tests/dromaeo/cssquery-prototype.html) 05:46:44 INFO - PROCESS | 1653 | RSS: Main: 271364096 05:46:44 INFO - PROCESS | 1653 | 05:49:47 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49262/tests/dromaeo/cssquery-yui.html) 05:49:48 INFO - PROCESS | 1653 | RSS: Main: 276541440 05:49:48 INFO - PROCESS | 1653 | 05:52:51 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-yui.html (next: http://localhost:49262/tests/dromaeo/cssquery-dojo.html) 05:52:51 INFO - PROCESS | 1653 | RSS: Main: 279318528 05:52:51 INFO - PROCESS | 1653 | 05:52:51 INFO - PROCESS | 1653 | __start_tp_report 05:52:51 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 05:52:51 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 05:52:51 INFO - PROCESS | 1653 | |i|pagename|runs| 05:52:51 INFO - PROCESS | 1653 | |0;dojo.html;3414.7438942079343;3416.897493075209;3423.5378223939774;3426.3832510148163;3434.278801451695;5337.905729325488;5775.246090041475;5806.012977793775;5877.764889404419;5898.469137777599;4821.951780482203;5063.164577844651;5795.82612521624;5800.100984347422;5811.186433899257;5218;5305.708186049766;5330.706811125387;5351.759170837322;5395.406505284415;4972.552470277675;5409.945060713162;5410.783568657269;5419.349678038641;5452.91820622691;5199.766010529535;5272.92090618641;5320.361556613192;5331.653442526223;5357.946420535804;5280.973595132038;5291.232771248147;5307.2835167252315;5313.362396512404;5351.919721204185;5244.29202057725;5246.973765131188;5249.265102885599;5282.022825777205;5303.602229832778;4322.891927701801;4567.954320456786;4934.605231581465;5733.455321744427;5805.912911306334;4827.51724827518;6180.443760061571;6252.406021427957;6283.937160628381;6292.779752708679;4997.625178111656;6249.750009999594;6281.089242059921;6302.338254483305;6311.116443697886;5772.3938986406665;5894.17481552583;5917.911231331534;5953.672548009858;5990.64056156632;6383.106365108889;6386.552941294158;6404.839879002969;6405.391487808651;6430.421262086435;6234.096056071844;6235.095911092866;6236.532260080512;6270.435660790551;6296.527760417987;6126.9387306127255;6146.139540464339;6188.597741146811;6199.814005579749;6254.6247225166635;5256.842294731164;6192.628442293477;6272.560920735505;6278.058291256348;6313.40022697843;6259.217597800275;6264.248290205204;6289.276733175652;6298.212723409574;6298.433141017239;4925.2119660854805;4974.950250497521;5002.499750025041;5068.16375298079;5073.949260507347;3771.7171212159196;4451.243288640939;4515.187266292099;4522.23122069249;4545.863624091283;5768.567357448208;5852.414758524199;5881.382454842265;5888.764449421975;5890.322612899571;5221.7128057956415;5390.299261096033;6004.42957918997;6161.876762464725;6184.567080304336;5794.594378393556;5815.592908496449;5821.359650438449;5834.883302333929;5866.73599688015;5515.200295957064;5537.667739935617;5540.833774986757;5541.861453463615;5546.667199968015;6185;6288.6855657217875;6308.653024083719;6363.649999249993;6369.33122022181;6244;6247.437730604267;6253.2496100466415;6258.43674069336;6270.686465676789;6338.334474880071;6381.361863813581;6416.871662566629;6419.711112999833;6434.356564343715;6075.605085669417;6095.817125486243;6139.539534534839;6230.221222347207;6263.655498947602;5247.947520524898;6197.5351848610635;6240.4071613196675;6253.96873015632;6271.717772700148;6181.443670069715;6183.876322473615;6208.161898143693;6211.9068213975925;6227.408396202353;5972.104184372379;6100.26796784371;6135.325114237341;6198.163247961467;6203.534734894811;4905.681130726492;5063.949360506348;6029.125776762433;6144.41628045335;6147.815565533041;4805.8077676892535;5467.58993075513;5942.989691752499;6227.564070515021;6235.282942461675;5840.007198776133;5951.791687290924;5985.670788106522;6129;6132.63204207749 05:52:51 INFO - PROCESS | 1653 | |1;ext.html;441.9393455706306;475.1589686255327;518.8495336352457;523.7459831981488;535.2506490912724;37483.81258093709;39927.001824954394;39953.60046399535;39977.60022399775;40003.799981000055;41051.79474102625;41142.765717028466;41574;41590.58409415905;41712.791436042855;9711.660091896767;9904.55429505674;9907.405555666646;9932.006799320083;9942.304038717293;9773.31586788925;9871.457069861155;9874.259430542703;9906.455144967023;9919.256055795808;9876.654317098903;9887.307888447811;9896.802063958716;9902.356346837432;9917.057879501435;9826.803463930753;9837.360571562825;9852.16256618181;9879.703608891708;9895.109440150422;9754.46350450725;9769.316147869651;9832.410055396698;9841.212702983745;9984.800303993952;39353.44202626849;39366.015849603704;39447.40828887569;39686.801565992275;39700.20599588021;2631.3421644588852;3301.3892429900543;3327.9168020799675;3509.2630547585036;3524.312759011994;29383.706162938524;29771.85114074416;30006.399872002658;30634.69365306341;30689.232769180726;3159.57345758322;3165.5093460513426;3167.9683203167906;3176.078937108236;3235.867446393767;435704;437169;439651;440388;443154.9999999968;32878.83560582182;33141.66858331434;33143;33152.50271245933;33169.67321307169;33700.83149584285;33981.98054058382;34034.14914627154;34532.482012769826;34712.652873471445;16434.589135271475;16565.751513727304;16741.581460463585;16749.58126046834;16806.15969201535;11257.324560526231;12843.678908027374;12947.158434701714;12955.287459189834;12973.740525189633;18691.439256822316;18709.625807484048;18712.625747484974;18736.15687294048;18755.718664220047;7384.298491643285;8151.369726054812;8165.673373065129;8196;8270.37972152091;846.8567433964099;893.388029199987;1021.6259131468163;1034.13132968307;1072.3351522056375;29798.957036504053;29833;29873.805047797843;30016.399672006875;30770.692293076783;1097.6103483263487;1107.4518113533852;1113.3765091548757;1128.6850818796174;1140.5779861451317;11272.436378181059;15118.168500732565;15376.924115244523;15474.845251547566;15809.683806323808;540946;710288;721441;722908;725916;50716.23925641119;55037.89924201494;58905;58928;59069.40930590639;1240.7394447166196;1377.22875189894;1387.1330418488444;1407.985920140806;1423.7935499352743;19946.800531995075;25569.744302556737;28029;28618;29832.25419364533;35811.82094089513;51896;55495.16757248564;56104;60106.39893601008;663501;664818;664914;665359;667431;26463.206103816916;40998.385024224066;42953.3556996639;43381.78309108434;43404.78297608492;38671;46480.53519464762;46798.53201467942;47432.7628361856;47582;38515.6148438512;38577.6142238574;38646.1692288464;39371;39802.40296395614;38689.32451417111;38721.89278167127;38844.41733374058;39393.60606394014;40209.1958160841;32169.35661286808;37928.81035594915;38151.80924095362;38335.04162395962;38773;27230;33669.49495757615;34020.48969265512;34540.82729586336;35236.82381588076;24785.25644230676;25226.873865630554;25397.365065873502;25490.98036078536;25854.353641159123 05:52:51 INFO - PROCESS | 1653 | |2;jquery.html;369.6063692167843;378.73488558009393;379.281262008494;382.61738261738265;398.54167707136787;19389.99999999998;20591.897040514814;21461.57076858464;21647.242346517876;21778;11947.880521194786;12156.209846360003;14985.850141498582;20041.498962525944;21302.786972130274;5448.45515448454;5487.917681234775;5702.287214098238;5722.256106706122;5722.427757224286;4769.475357710649;5452.972735136319;5604.943950560483;5615.80344687936;5620.100783874581;5364.839054828361;5570.749316280777;5585.357683866347;5595.888082238353;5621.072523033715;5448.564114870821;5562;5562.221289019541;5580.665160090387;5590.049691552445;5190.091733946582;5394.32570928634;5400.972995135038;5418.241446197536;5424.83725488232;13396.598102056954;13453.66365840852;13559.186448813103;13569.253691046988;18915.810841891544;2153.418576984221;2374.726906405768;2440.9267721968367;2862.957055644167;2995.5207166853197;9658.565364558612;9928;9967.302288839785;10244.28290019699;10438.112760415373;1780.287884846059;1838.3381982486294;1871.7192421136801;1882.2471011595335;1918.9232430702755;113719;128645;128776;131046.65346851449;132217.33891330578;9281.814363712823;9944.403335799876;10934.398608076473;10934.781304373868;11165;14380.640483987983;14514.564563062913;14521.92739036298;14572.927135364256;14575.344109515097;6862.828429289308;6986.685599148051;8544.957275213585;8648.913510864937;8680.175383338572;8471.661133554711;8482.618282177316;8485.490870547786;8519.361047921308;8604.741857744277;4490.528494508095;4518.932216016762;4529.456465224194;4533.455985281787;4597.218472859622;1907.1786443945998;1947.7565304336958;1967.79338169493;1973.5099999500285;2002.7596688397487;839.9244068033784;859.5401460218753;860.7097880948357;925.6806401791371;987.244757760314;17874.55313617144;20797.58404831895;20998.055087521097;21084.789152108282;21122.838243896425;884.73924657363;940.1867384712175;944.9338546301693;970.6214576315243;1039.5633833789827;10913.781724365468;12085.033197344192;12092.153549251469;12192.695182620328;12367.93816030914;589977;606457;614955;622939;657685.1157442109;56581;132225;134589.3270533641;139725.3013734925;149845;980.5391466010964;1014.4623349624711;1032.9618733173263;1035.1873779083382;1040.9479526023667;18333.908330458264;19162.616747665248;19208.71186932225;19216.94306813083;19355.93542355184;47828.7608561955;55068.44931550633;56998.7150064247;57224.71387643035;58540;74991.75024749266;75453;79654.203457967;79863.60068199622;85940;8119;8192;8241.381896357918;8307.293880020266;8447.8732819009;12733.236005839679;13429.865701342862;13447.193168409927;13601.863981360455;13614.319284035957;10987.011168994828;11321.207515474167;11440.885591143982;11594;11647;10841.349519028883;11264.887351126712;11265.605703800655;11525.94237028843;11727.706807329885;11541.249818761753;11866.347350895783;11904.702382440508;11907.880921191023;11976.041916646473;5912;8209.179082091743;8239.835203296021;8290.33677305802;8348.7912802178;8418.452800567944;11212.607558735404;11292.644882614139;11696.766064678488;11719.531218751154 05:52:51 INFO - PROCESS | 1653 | |3;mootools.html;1281.314496744242;1472.6907349456617;1662.085852780971;1726.6460375622999;1856.368834596237;7878.330341920943;8386.87419688705;8590.226879580836;8932.017478077414;8950.418222815513;8583.055863854986;8810.38327317088;8829.470231786081;8837.867431988509;8866.468011919289;2017.798220177985;2375.3230329356093;2406.5186962607463;2407.0251548123038;2413.6379543068506;2358.7759162879497;2370.0401337458356;2379.298107058422;2388.9641655375094;2399.3521749127726;2373.5727569037567;2377.7146742390937;2381.202297230421;2407.374082738492;2410.7468715784853;2358.917437889683;2373.964390534143;2381.142788596104;2382.404398900275;2384.833061685683;2333.988330058356;2343.261872510154;2358.7287461941924;2362.173239366225;2366;8819.691310804092;8864.113588641085;8904.421212621159;8911.643534258621;8913.064128266567;5213.426523082458;5354.625176237665;5390.434004429557;5393.406725260257;5397.055515284848;3555.8577656893694;3690.1697118148472;3714.201446688975;3756.718246131551;3769.3215221260434;1118.3848883114335;1126.2510430563666;1126.419893754717;1128.3173679923693;1144.3305666185292;11391.658250252505;11408.771824563462;11466.369349685763;11539.961403473644;11581.07351411885;4071.75569465833;4555.40779698637;4700.482946875841;4851.951480485221;4886.633502487257;8579.571021448903;9936.80126397468;10001.549930253155;10029.598816047423;10042.096211341015;4334.739915605074;4979.4771548987555;5385.299911011543;5392.622516423813;5399.78400863961;4380.102079073782;4727.267273572602;4890.755462226874;4894.608431325485;4930.556249937523;3912.980435097806;3934.291827471083;4048.2308361411237;4067.7762723049923;4094.1402305516176;1107.7507560798756;1150.3730466895563;1311.3967574915646;1328.8936885049172;1341.1684755451683;850.9829803403898;914.6067191107887;915.7756349694367;929.0941332201185;940.2853831088286;4885.267209918541;5831.591788574844;5925.34821169671;5955.106733989936;5997.490213331828;934.2946075712794;966.8114717629994;984.7931934293736;999.3104757717152;1010.6664800615927;3596.8381422836037;3971.920561588752;4011.146512719584;4014.518257809023;4106.3635136553885;10280.948595256976;10715.678529643967;10736.463176841284;10737.892621073846;10790.136789056856;10726.731831704114;10745.462726863625;10746.301490403255;10746.731331716614;10790.460476976277;8067.233612806774;8207.548584827773;8230.876536851953;8245.917540824516;8247.422680412434;5173.81891633791;5504;5677.3754886963225;5785.768569257182;5806.390329015392;9843.064908833649;9922.00779922031;9958.701238962843;9972.750681233027;10005.499725013866;9680.419174849532;10121.645742398981;10226.233032522441;10248.743781405525;10262.230332725225;6500.512461565307;6792.626405547742;6944.895826562707;7012.964935175495;7153.35619794221;8292.37807164453;8375.832483350421;8404.327653787805;8443.662253510036;8454.535000575028;7311.780646580611;7409.296116868889;7440.590767507839;7491.625418729151;7557.2820582044615;7048.718051278097;7234.638268086469;7285.271472852673;7297.525660832029;7342.045534080536;6916.20463646687;6931.653417329013;6965.965170174117;7007.649617519206;7018.789436316919;3814.275287695329;4497.752623605602;4951.207806750903;5010.9248361273885;5045.394552653705;4883.780229889592;4887.731174785421;4943.65394422387;4968.950310496849;5043.798248070036 05:52:51 INFO - PROCESS | 1653 | |4;prototype.html;237.5616986659613;301.6937808124753;307.6277703978186;320.25221108711156;321.6365506977115;4044.4337792709043;4876.074355386766;5484.204790305408;5489.725513724313;5516.696581688006;4746.3117847912035;5473.917891231625;5523;5536.726552892837;5545.306836645419;4206.495220573528;4240.321548552232;4250.596193361625;4252.851730032905;4261.744295342274;3518.9648103518894;3922.9019274518223;4159.646430053449;4239.562251705282;4244.214820258262;3489.5638045244345;3793.7723736575754;4135.813888375015;4139.586041395852;4151.58484151584;4131.834726610932;4152.8961775955695;4153.439285696422;4157.3140431828715;4169.4162817205615;3564.6988849070162;3578.4632305154173;3582.7133829293853;3584.7669901456584;3608.1881576645305;5036.320096786923;5189.974050129763;5338.733063346856;5351.812686555991;5377.623566350357;4123.237201117773;4319;4659.650526210514;4747.810087596492;4800.063987522434;4574.839880604196;5307.363116426015;5791.82624521265;5834.737436815353;5837.357890632027;3112.4864397374404;3888.5333759948985;3921.999780112135;3929.980350098231;3945.743526670757;5447.237386765856;5851.76592936282;6120.286319830455;6150.630962142286;6184.536159787989;3313.7514686398617;3980.5024371953505;3981.402789581528;3992.201559688074;4029.879103626896;3221.194701324669;4000.7599544027453;4034.596540345942;4051.3517837145914;4059.5331536873637;4185.760618069318;4507.301368287855;4737.507685079189;4742.834000809955;4749.651495695526;5166.819161329336;5581.832545023656;5789.7998760470755;5875.061229794158;5938.376470470538;1292.5928332575209;1315.2700251360395;1347.42060913808;1363.638635761524;1378.9241591712553;885.4239453772295;902.6595505674069;926.1942110364026;927.3462209142539;930.4045410937006;4398.428204333416;4682.1338052460405;5283.181106928432;5312.282841816383;5356.973215133899;5871.32479764824;5941.138534912414;5943.881122377615;5953.362825223098;5960.672163031075;4669.626429885601;5038.067957427887;5338.3593968724;5340.543350058939;5402.270693456333;3169.3819705157275;3169.730572901329;3188.7678624962155;3195.872165113416;3208.946274384396;6014.548908831855;6254.092501786908;6267.4045965633195;6280.2777680566405;6281.152044473937;5378.435264297193;5524.917126243109;5628.774849005994;5928.584999050111;6121.693915304217;6228.22147231596;6238.906416403667;6253.937460625336;6262;6282.560220784592;4851.054044461437;5613.46672066153;5857.355690874086;6030.125631783455;6043.939560604338;4582.908341833211;5409.404965453876;5738.368779434342;5928.3775203603;6008.789692360747;4781.676734669511;5165.870853228699;6060.515158787198;6065.848353791191;6169.352218017223;3914.2758589661003;3975.5030621172355;4011.5988401159652;4018.3771515415156;4026.4966879140106;5687.090065589486;5777.306723193244;6019.909701354396;6048.334683184934;6083;4895.951040489692;5680.460356266148;5836.678982655994;5876.382979787232;5912.556558258234;4353.608175264241;5906.911396328973;5960.83763666081;5964.612300200473;6087.712635177132;5000.349954505891;5388.919166212431;5726.625609853689;5824.883502330014;5829.271341082364;5115;5877.882442351043;5890.410958904075;5895.322037965689;5903.763849445974;5268.6575372600655;5274.604404669589;5778.739956702043;5784.768609255582;5811.767529298781 05:52:51 INFO - PROCESS | 1653 | |5;yui.html;687.9174499060114;708.8617719544691;757.939364850812;792.635387721648;846.0735494633376;13984.790228146574;14525.201113938729;14634.41462341505;14669.926650366746;15421.920465567415;14899.10605363679;14985;15058.849411505882;15067.849321506781;15073.62315942102;866.2766589897427;877.8376000439907;880.4937161132342;881.0000649263069;883.2713011765287;709.1667290933159;873.6723728601775;893.1648908270755;904.430208968349;911.43946472919;947.1049857884302;950.4059962523423;950.8240975419569;952.2905435450565;952.366676160356;930.3905941608258;938.197840846077;939.5490164720904;949.9857502137404;950.8478643417054;653.6795672741084;674.2145400608285;689.0043886583888;689.7103216649019;705.0869124483805;15247.61880952974;15278.618034549114;15281.312340944683;15288.159151246677;15318.310676019606;14801.185934773583;14909.925450372788;14979;15016;15031.549053528412;11990.220635658654;12138.332391718452;12278.693032674166;12363.75272494545;12592.559260425842;3208.4866421372467;3700.796456194935;4022.658074063708;4089.243489954338;4089.3865920111925;82407;102120.48939755253;112161.87838121678;114722.99999999917;114895;9519.762005949906;10812.80726710096;10896.673099807018;11096.944515277371;11103.72240693989;17752.733708994376;19700.211991520464;20033.59932801336;20698.379048628565;20883.582328353346;7832.177621349791;7870.212978702199;7963.601819908981;7966.28303452692;8135.02379714438;3985.6811455083525;4532.592066714012;4628.861134165981;4632.559906808848;4668.8132474701315;2938.8824447022307;3708.666220040155;3723.590405055442;3737.9252414951548;3745.9063523411587;683.1426559667585;700.6496751624188;705.6577559883452;707.7664370757637;711.121764620693;617.9412955769195;627.4415769964735;643.9839004024936;663.6482664187988;693.8161387232387;9221.17009469151;9306.72079837606;9496.667616633524;9712.22302215821;9785.412875227508;542.094701847907;580.6080895395592;629.0750304069562;681.2831664206172;696.7247937064831;4368.279233926367;4613.123506533748;4648.5119062498625;4671.5094915034115;4777.259524773665;112238;154207;154939.22530387275;154991;156048;128557.35721321334;129817;134891;137289;138711.6610423697;91755.54122229347;101801;104338;105921.47039264909;107144;9018.278537716837;9072.410293330913;9186.954065229631;9211;9216;59502.70248648729;61319.41528186147;62795.686021571426;65019;65097.34902650913;74821;94649;96990;98023.50988245013;98471.50764246134;11526.88473115258;11813.232139910879;11818.29090254553;12070.698232544257;12393.132480726263;12286.139970202;12472.812907806572;12675.873241267838;12691.155919345327;13503;10349.379037257788;12179.025677945567;12377.443015064164;12388.690282743004;12800.679983000127;12009.279443233434;12296.786578415971;12525.498980040697;12679.93660031694;12831;12144.514219431478;12499.312537810507;12620.684482888002;12650.430730617329;12660.107111720015;10238.590456381959;10313.329633573794;10404.531796069045;10482.37105773656;10778.29941053829;9714.3199976001;9766.804663906823;11220.382878941737;11506.884931150917;11942.790583742035 05:52:51 INFO - PROCESS | 1653 | __end_tp_report 05:52:51 INFO - PROCESS | 1653 | __start_cc_report 05:52:51 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,423 05:52:51 INFO - PROCESS | 1653 | __end_cc_report 05:52:51 INFO - PROCESS | 1653 | __startTimestamp1471870371714__endTimestamp 05:52:51 INFO - PROCESS | 1653 | 05:52:51 INFO - PROCESS | 1653 | ------- Summary: start ------- 05:52:51 INFO - PROCESS | 1653 | Number of tests: 6 05:52:51 INFO - PROCESS | 1653 | 05:52:51 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5714.29 Median:5898.47 stddev:674.98 (11.4%) stddev-sans-first:652.50 05:52:51 INFO - PROCESS | 1653 | Values: 3414.7 3416.9 3423.5 3426.4 3434.3 5337.9 5775.2 5806.0 5877.8 5898.5 4822.0 5063.2 5795.8 5800.1 5811.2 5218.0 5305.7 5330.7 5351.8 5395.4 4972.6 5409.9 5410.8 5419.3 5452.9 5199.8 5272.9 5320.4 5331.7 5357.9 5281.0 5291.2 5307.3 5313.4 5351.9 5244.3 5247.0 5249.3 5282.0 5303.6 4322.9 4568.0 4934.6 5733.5 5805.9 4827.5 6180.4 6252.4 6283.9 6292.8 4997.6 6249.8 6281.1 6302.3 6311.1 5772.4 5894.2 5917.9 5953.7 5990.6 6383.1 6386.6 6404.8 6405.4 6430.4 6234.1 6235.1 6236.5 6270.4 6296.5 6126.9 6146.1 6188.6 6199.8 6254.6 5256.8 6192.6 6272.6 6278.1 6313.4 6259.2 6264.2 6289.3 6298.2 6298.4 4925.2 4975.0 5002.5 5068.2 5073.9 3771.7 4451.2 4515.2 4522.2 4545.9 5768.6 5852.4 5881.4 5888.8 5890.3 5221.7 5390.3 6004.4 6161.9 6184.6 5794.6 5815.6 5821.4 5834.9 5866.7 5515.2 5537.7 5540.8 5541.9 5546.7 6185.0 6288.7 6308.7 6363.6 6369.3 6244.0 6247.4 6253.2 6258.4 6270.7 6338.3 6381.4 6416.9 6419.7 6434.4 6075.6 6095.8 6139.5 6230.2 6263.7 5247.9 6197.5 6240.4 6254.0 6271.7 6181.4 6183.9 6208.2 6211.9 6227.4 5972.1 6100.3 6135.3 6198.2 6203.5 4905.7 5063.9 6029.1 6144.4 6147.8 4805.8 5467.6 5943.0 6227.6 6235.3 5840.0 5951.8 5985.7 6129.0 6132.6 05:52:51 INFO - PROCESS | 1653 | 05:52:51 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:71113.25 Median:38747.45 stddev:163225.23 (421.3%) stddev-sans-first:163596.88 05:52:51 INFO - PROCESS | 1653 | Values: 441.9 475.2 518.8 523.7 535.3 37483.8 39927.0 39953.6 39977.6 40003.8 41051.8 41142.8 41574.0 41590.6 41712.8 9711.7 9904.6 9907.4 9932.0 9942.3 9773.3 9871.5 9874.3 9906.5 9919.3 9876.7 9887.3 9896.8 9902.4 9917.1 9826.8 9837.4 9852.2 9879.7 9895.1 9754.5 9769.3 9832.4 9841.2 9984.8 39353.4 39366.0 39447.4 39686.8 39700.2 2631.3 3301.4 3327.9 3509.3 3524.3 29383.7 29771.9 30006.4 30634.7 30689.2 3159.6 3165.5 3168.0 3176.1 3235.9 435704.0 437169.0 439651.0 440388.0 443155.0 32878.8 33141.7 33143.0 33152.5 33169.7 33700.8 33982.0 34034.1 34532.5 34712.7 16434.6 16565.8 16741.6 16749.6 16806.2 11257.3 12843.7 12947.2 12955.3 12973.7 18691.4 18709.6 18712.6 18736.2 18755.7 7384.3 8151.4 8165.7 8196.0 8270.4 846.9 893.4 1021.6 1034.1 1072.3 29799.0 29833.0 29873.8 30016.4 30770.7 1097.6 1107.5 1113.4 1128.7 1140.6 11272.4 15118.2 15376.9 15474.8 15809.7 540946.0 710288.0 721441.0 722908.0 725916.0 50716.2 55037.9 58905.0 58928.0 59069.4 1240.7 1377.2 1387.1 1408.0 1423.8 19946.8 25569.7 28029.0 28618.0 29832.3 35811.8 51896.0 55495.2 56104.0 60106.4 663501.0 664818.0 664914.0 665359.0 667431.0 26463.2 40998.4 42953.4 43381.8 43404.8 38671.0 46480.5 46798.5 47432.8 47582.0 38515.6 38577.6 38646.2 39371.0 39802.4 38689.3 38721.9 38844.4 39393.6 40209.2 32169.4 37928.8 38151.8 38335.0 38773.0 27230.0 33669.5 34020.5 34540.8 35236.8 24785.3 25226.9 25397.4 25491.0 25854.4 05:52:51 INFO - PROCESS | 1653 | 05:52:51 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:35366.09 Median:2651.94 stddev:103428.11 (3900.1%) stddev-sans-first:103684.88 05:52:51 INFO - PROCESS | 1653 | Values: 369.6 378.7 379.3 382.6 398.5 19390.0 20591.9 21461.6 21647.2 21778.0 11947.9 12156.2 14985.9 20041.5 21302.8 5448.5 5487.9 5702.3 5722.3 5722.4 4769.5 5453.0 5604.9 5615.8 5620.1 5364.8 5570.7 5585.4 5595.9 5621.1 5448.6 5562.0 5562.2 5580.7 5590.0 5190.1 5394.3 5401.0 5418.2 5424.8 13396.6 13453.7 13559.2 13569.3 18915.8 2153.4 2374.7 2440.9 2863.0 2995.5 9658.6 9928.0 9967.3 10244.3 10438.1 1780.3 1838.3 1871.7 1882.2 1918.9 113719.0 128645.0 128776.0 131046.7 132217.3 9281.8 9944.4 10934.4 10934.8 11165.0 14380.6 14514.6 14521.9 14572.9 14575.3 6862.8 6986.7 8545.0 8648.9 8680.2 8471.7 8482.6 8485.5 8519.4 8604.7 4490.5 4518.9 4529.5 4533.5 4597.2 1907.2 1947.8 1967.8 1973.5 2002.8 839.9 859.5 860.7 925.7 987.2 17874.6 20797.6 20998.1 21084.8 21122.8 884.7 940.2 944.9 970.6 1039.6 10913.8 12085.0 12092.2 12192.7 12367.9 589977.0 606457.0 614955.0 622939.0 657685.1 56581.0 132225.0 134589.3 139725.3 149845.0 980.5 1014.5 1033.0 1035.2 1040.9 18333.9 19162.6 19208.7 19216.9 19355.9 47828.8 55068.4 56998.7 57224.7 58540.0 74991.8 75453.0 79654.2 79863.6 85940.0 8119.0 8192.0 8241.4 8307.3 8447.9 12733.2 13429.9 13447.2 13601.9 13614.3 10987.0 11321.2 11440.9 11594.0 11647.0 10841.3 11264.9 11265.6 11525.9 11727.7 11541.2 11866.3 11904.7 11907.9 11976.0 5912.0 8209.2 8239.8 8290.3 8348.8 8418.5 11212.6 11292.6 11696.8 11719.5 05:52:51 INFO - PROCESS | 1653 | 05:52:51 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5668.63 Median:4887.18 stddev:3174.18 (64.9%) stddev-sans-first:3165.96 05:52:51 INFO - PROCESS | 1653 | Values: 1281.3 1472.7 1662.1 1726.6 1856.4 7878.3 8386.9 8590.2 8932.0 8950.4 8583.1 8810.4 8829.5 8837.9 8866.5 2017.8 2375.3 2406.5 2407.0 2413.6 2358.8 2370.0 2379.3 2389.0 2399.4 2373.6 2377.7 2381.2 2407.4 2410.7 2358.9 2374.0 2381.1 2382.4 2384.8 2334.0 2343.3 2358.7 2362.2 2366.0 8819.7 8864.1 8904.4 8911.6 8913.1 5213.4 5354.6 5390.4 5393.4 5397.1 3555.9 3690.2 3714.2 3756.7 3769.3 1118.4 1126.3 1126.4 1128.3 1144.3 11391.7 11408.8 11466.4 11540.0 11581.1 4071.8 4555.4 4700.5 4852.0 4886.6 8579.6 9936.8 10001.5 10029.6 10042.1 4334.7 4979.5 5385.3 5392.6 5399.8 4380.1 4727.3 4890.8 4894.6 4930.6 3913.0 3934.3 4048.2 4067.8 4094.1 1107.8 1150.4 1311.4 1328.9 1341.2 851.0 914.6 915.8 929.1 940.3 4885.3 5831.6 5925.3 5955.1 5997.5 934.3 966.8 984.8 999.3 1010.7 3596.8 3971.9 4011.1 4014.5 4106.4 10280.9 10715.7 10736.5 10737.9 10790.1 10726.7 10745.5 10746.3 10746.7 10790.5 8067.2 8207.5 8230.9 8245.9 8247.4 5173.8 5504.0 5677.4 5785.8 5806.4 9843.1 9922.0 9958.7 9972.8 10005.5 9680.4 10121.6 10226.2 10248.7 10262.2 6500.5 6792.6 6944.9 7013.0 7153.4 8292.4 8375.8 8404.3 8443.7 8454.5 7311.8 7409.3 7440.6 7491.6 7557.3 7048.7 7234.6 7285.3 7297.5 7342.0 6916.2 6931.7 6966.0 7007.6 7018.8 3814.3 4497.8 4951.2 5010.9 5045.4 4883.8 4887.7 4943.7 4969.0 5043.8 05:52:51 INFO - PROCESS | 1653 | 05:52:51 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4675.31 Median:5278.89 stddev:1459.39 (27.6%) stddev-sans-first:1424.97 05:52:51 INFO - PROCESS | 1653 | Values: 237.6 301.7 307.6 320.3 321.6 4044.4 4876.1 5484.2 5489.7 5516.7 4746.3 5473.9 5523.0 5536.7 5545.3 4206.5 4240.3 4250.6 4252.9 4261.7 3519.0 3922.9 4159.6 4239.6 4244.2 3489.6 3793.8 4135.8 4139.6 4151.6 4131.8 4152.9 4153.4 4157.3 4169.4 3564.7 3578.5 3582.7 3584.8 3608.2 5036.3 5190.0 5338.7 5351.8 5377.6 4123.2 4319.0 4659.7 4747.8 4800.1 4574.8 5307.4 5791.8 5834.7 5837.4 3112.5 3888.5 3922.0 3930.0 3945.7 5447.2 5851.8 6120.3 6150.6 6184.5 3313.8 3980.5 3981.4 3992.2 4029.9 3221.2 4000.8 4034.6 4051.4 4059.5 4185.8 4507.3 4737.5 4742.8 4749.7 5166.8 5581.8 5789.8 5875.1 5938.4 1292.6 1315.3 1347.4 1363.6 1378.9 885.4 902.7 926.2 927.3 930.4 4398.4 4682.1 5283.2 5312.3 5357.0 5871.3 5941.1 5943.9 5953.4 5960.7 4669.6 5038.1 5338.4 5340.5 5402.3 3169.4 3169.7 3188.8 3195.9 3208.9 6014.5 6254.1 6267.4 6280.3 6281.2 5378.4 5524.9 5628.8 5928.6 6121.7 6228.2 6238.9 6253.9 6262.0 6282.6 4851.1 5613.5 5857.4 6030.1 6043.9 4582.9 5409.4 5738.4 5928.4 6008.8 4781.7 5165.9 6060.5 6065.8 6169.4 3914.3 3975.5 4011.6 4018.4 4026.5 5687.1 5777.3 6019.9 6048.3 6083.0 4896.0 5680.5 5836.7 5876.4 5912.6 4353.6 5906.9 5960.8 5964.6 6087.7 5000.3 5388.9 5726.6 5824.9 5829.3 5115.0 5877.9 5890.4 5895.3 5903.8 5268.7 5274.6 5778.7 5784.8 5811.8 05:52:51 INFO - PROCESS | 1653 | 05:52:51 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:24412.96 Median:3741.92 stddev:39333.62 (1051.2%) stddev-sans-first:39403.62 05:52:51 INFO - PROCESS | 1653 | Values: 687.9 708.9 757.9 792.6 846.1 13984.8 14525.2 14634.4 14669.9 15421.9 14899.1 14985.0 15058.8 15067.8 15073.6 866.3 877.8 880.5 881.0 883.3 709.2 873.7 893.2 904.4 911.4 947.1 950.4 950.8 952.3 952.4 930.4 938.2 939.5 950.0 950.8 653.7 674.2 689.0 689.7 705.1 15247.6 15278.6 15281.3 15288.2 15318.3 14801.2 14909.9 14979.0 15016.0 15031.5 11990.2 12138.3 12278.7 12363.8 12592.6 3208.5 3700.8 4022.7 4089.2 4089.4 82407.0 102120.5 112161.9 114723.0 114895.0 9519.8 10812.8 10896.7 11096.9 11103.7 17752.7 19700.2 20033.6 20698.4 20883.6 7832.2 7870.2 7963.6 7966.3 8135.0 3985.7 4532.6 4628.9 4632.6 4668.8 2938.9 3708.7 3723.6 3737.9 3745.9 683.1 700.6 705.7 707.8 711.1 617.9 627.4 644.0 663.6 693.8 9221.2 9306.7 9496.7 9712.2 9785.4 542.1 580.6 629.1 681.3 696.7 4368.3 4613.1 4648.5 4671.5 4777.3 112238.0 154207.0 154939.2 154991.0 156048.0 128557.4 129817.0 134891.0 137289.0 138711.7 91755.5 101801.0 104338.0 105921.5 107144.0 9018.3 9072.4 9187.0 9211.0 9216.0 59502.7 61319.4 62795.7 65019.0 65097.3 74821.0 94649.0 96990.0 98023.5 98471.5 11526.9 11813.2 11818.3 12070.7 12393.1 12286.1 12472.8 12675.9 12691.2 13503.0 10349.4 12179.0 12377.4 12388.7 12800.7 12009.3 12296.8 12525.5 12679.9 12831.0 12144.5 12499.3 12620.7 12650.4 12660.1 10238.6 10313.3 10404.5 10482.4 10778.3 9714.3 9766.8 11220.4 11506.9 11942.8 05:52:51 INFO - PROCESS | 1653 | -------- Summary: end -------- 05:52:51 INFO - PROCESS | 1653 | 05:52:52 INFO - TEST-INFO | 1653: exit 0 05:52:52 INFO - TEST-OK | dromaeo_css | took 1114189ms 05:52:52 INFO - TEST-START | kraken 05:52:52 INFO - operating with platform_type : mac_ 05:52:52 INFO - Initialising browser for kraken test... 05:52:52 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpB6S4Il/profile http://localhost:49262/getInfo.html) 05:52:54 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 05:52:54 INFO - PROCESS | 1663 | colorDepth:24 05:52:54 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 05:52:54 INFO - PROCESS | 1663 | __metrics 05:52:55 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3061: TypeError: this.tabs is undefined 05:52:55 INFO - TEST-INFO | 1663: exit 0 05:52:55 INFO - Browser initialized. 05:52:55 INFO - Running cycle 1/1 for kraken test... 05:52:55 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpB6S4Il/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:53:07 INFO - PROCESS | 1666 | RSS: Main: 239820800 05:53:07 INFO - PROCESS | 1666 | 05:53:10 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection) 05:53:11 INFO - PROCESS | 1666 | RSS: Main: 252661760 05:53:11 INFO - PROCESS | 1666 | 05:53:14 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-dft) 05:53:14 INFO - PROCESS | 1666 | RSS: Main: 261181440 05:53:14 INFO - PROCESS | 1666 | 05:53:18 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-fft) 05:53:19 INFO - PROCESS | 1666 | RSS: Main: 263888896 05:53:19 INFO - PROCESS | 1666 | 05:53:21 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator) 05:53:21 INFO - PROCESS | 1666 | RSS: Main: 265740288 05:53:21 INFO - PROCESS | 1666 | 05:53:24 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:53:24 INFO - PROCESS | 1666 | RSS: Main: 266809344 05:53:24 INFO - PROCESS | 1666 | 05:53:27 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom) 05:53:28 INFO - PROCESS | 1666 | RSS: Main: 266969088 05:53:28 INFO - PROCESS | 1666 | 05:53:31 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate) 05:53:31 INFO - PROCESS | 1666 | RSS: Main: 267288576 05:53:31 INFO - PROCESS | 1666 | 05:53:34 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial) 05:53:35 INFO - PROCESS | 1666 | RSS: Main: 267501568 05:53:35 INFO - PROCESS | 1666 | 05:53:37 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:53:37 INFO - PROCESS | 1666 | RSS: Main: 267014144 05:53:37 INFO - PROCESS | 1666 | 05:53:39 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:53:40 INFO - PROCESS | 1666 | RSS: Main: 267079680 05:53:40 INFO - PROCESS | 1666 | 05:53:42 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:53:43 INFO - PROCESS | 1666 | RSS: Main: 267407360 05:53:43 INFO - PROCESS | 1666 | 05:53:46 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:53:46 INFO - PROCESS | 1666 | RSS: Main: 267792384 05:53:46 INFO - PROCESS | 1666 | 05:53:49 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:53:50 INFO - PROCESS | 1666 | RSS: Main: 267640832 05:53:50 INFO - PROCESS | 1666 | 05:53:52 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49262/tests/kraken/driver.html?testName=ai-astar) 05:53:52 INFO - PROCESS | 1666 | RSS: Main: 269729792 05:53:52 INFO - PROCESS | 1666 | 05:53:52 INFO - PROCESS | 1666 | __start_tp_report 05:53:52 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 05:53:52 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 05:53:52 INFO - PROCESS | 1666 | |i|pagename|runs| 05:53:52 INFO - PROCESS | 1666 | |0;ai-astar;107;117;111;118;115;116;121;116;116;115 05:53:52 INFO - PROCESS | 1666 | |1;audio-beat-detection;146;106;165;148;132;124;155;96;151;131 05:53:52 INFO - PROCESS | 1666 | |2;audio-dft;200;201;233;230;236;278;213;223;278;201 05:53:52 INFO - PROCESS | 1666 | |3;audio-fft;70;79;77;156;58;63;74;85;144;79 05:53:52 INFO - PROCESS | 1666 | |4;audio-oscillator;85;96;159;76;60;108;144;100;104;113 05:53:52 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;90;76;136;131;89;92;103;75;110;131 05:53:52 INFO - PROCESS | 1666 | |6;imaging-darkroom;114;148;118;95;94;93;95;94;95;96 05:53:52 INFO - PROCESS | 1666 | |7;imaging-desaturate;92;81;144;147;91;94;92;90;93;91 05:53:52 INFO - PROCESS | 1666 | |8;json-parse-financial;56;57;58;58;55;58;57;57;54;55 05:53:52 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;67;67;68;68;76;75;76;70;68;81 05:53:52 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;92;85;86;89;86;90;78;97;110;109 05:53:52 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;140;168;160;157;177;147;156;158;177;155 05:53:52 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;167;175;154;173;151;155;208;238;210;239 05:53:52 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;68;68;68;70;71;68;67;70;68;68 05:53:52 INFO - PROCESS | 1666 | __end_tp_report 05:53:52 INFO - PROCESS | 1666 | __start_cc_report 05:53:52 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1063 05:53:52 INFO - PROCESS | 1666 | __end_cc_report 05:53:52 INFO - PROCESS | 1666 | __startTimestamp1471870432462__endTimestamp 05:53:52 INFO - PROCESS | 1666 | 05:53:52 INFO - PROCESS | 1666 | ------- Summary: start ------- 05:53:52 INFO - PROCESS | 1666 | Number of tests: 14 05:53:52 INFO - PROCESS | 1666 | 05:53:52 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:115.20 Median:116.00 stddev:3.82 (3.3%) stddev-sans-first:2.67 05:53:52 INFO - PROCESS | 1666 | Values: 107.0 117.0 111.0 118.0 115.0 116.0 121.0 116.0 116.0 115.0 05:53:52 INFO - PROCESS | 1666 | 05:53:52 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:135.40 Median:149.50 stddev:21.99 (14.7%) stddev-sans-first:22.99 05:53:52 INFO - PROCESS | 1666 | Values: 146.0 106.0 165.0 148.0 132.0 124.0 155.0 96.0 151.0 131.0 05:53:52 INFO - PROCESS | 1666 | 05:53:52 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:229.30 Median:231.50 stddev:29.00 (12.5%) stddev-sans-first:28.75 05:53:52 INFO - PROCESS | 1666 | Values: 200.0 201.0 233.0 230.0 236.0 278.0 213.0 223.0 278.0 201.0 05:53:52 INFO - PROCESS | 1666 | 05:53:52 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:88.50 Median:75.50 stddev:33.49 (44.4%) stddev-sans-first:34.85 05:53:52 INFO - PROCESS | 1666 | Values: 70.0 79.0 77.0 156.0 58.0 63.0 74.0 85.0 144.0 79.0 05:53:52 INFO - PROCESS | 1666 | 05:53:52 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:104.50 Median:109.50 stddev:29.59 (27.0%) stddev-sans-first:30.53 05:53:52 INFO - PROCESS | 1666 | Values: 85.0 96.0 159.0 76.0 60.0 108.0 144.0 100.0 104.0 113.0 05:53:52 INFO - PROCESS | 1666 | 05:53:52 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:103.30 Median:75.50 stddev:22.86 (30.3%) stddev-sans-first:23.74 05:53:52 INFO - PROCESS | 1666 | Values: 90.0 76.0 136.0 131.0 89.0 92.0 103.0 75.0 110.0 131.0 05:53:52 INFO - PROCESS | 1666 | 05:53:52 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:104.20 Median:94.50 stddev:17.83 (18.9%) stddev-sans-first:18.55 05:53:52 INFO - PROCESS | 1666 | Values: 114.0 148.0 118.0 95.0 94.0 93.0 95.0 94.0 95.0 96.0 05:53:52 INFO - PROCESS | 1666 | 05:53:52 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:101.50 Median:91.50 stddev:23.47 (25.7%) stddev-sans-first:24.64 05:53:52 INFO - PROCESS | 1666 | Values: 92.0 81.0 144.0 147.0 91.0 94.0 92.0 90.0 93.0 91.0 05:53:52 INFO - PROCESS | 1666 | 05:53:52 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:57.00 stddev:1.43 (2.5%) stddev-sans-first:1.51 05:53:52 INFO - PROCESS | 1666 | Values: 56.0 57.0 58.0 58.0 55.0 58.0 57.0 57.0 54.0 55.0 05:53:52 INFO - PROCESS | 1666 | 05:53:52 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:72.50 stddev:4.97 (6.9%) stddev-sans-first:4.99 05:53:52 INFO - PROCESS | 1666 | Values: 67.0 67.0 68.0 68.0 76.0 75.0 76.0 70.0 68.0 81.0 05:53:52 INFO - PROCESS | 1666 | 05:53:52 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:92.20 Median:87.50 stddev:10.37 (11.9%) stddev-sans-first:11.00 05:53:52 INFO - PROCESS | 1666 | Values: 92.0 85.0 86.0 89.0 86.0 90.0 78.0 97.0 110.0 109.0 05:53:52 INFO - PROCESS | 1666 | 05:53:52 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:159.50 Median:159.00 stddev:11.84 (7.4%) stddev-sans-first:10.25 05:53:52 INFO - PROCESS | 1666 | Values: 140.0 168.0 160.0 157.0 177.0 147.0 156.0 158.0 177.0 155.0 05:53:52 INFO - PROCESS | 1666 | 05:53:52 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.00 Median:191.50 stddev:34.03 (17.8%) stddev-sans-first:35.32 05:53:52 INFO - PROCESS | 1666 | Values: 167.0 175.0 154.0 173.0 151.0 155.0 208.0 238.0 210.0 239.0 05:53:52 INFO - PROCESS | 1666 | 05:53:52 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.00 stddev:1.26 (1.9%) stddev-sans-first:1.32 05:53:52 INFO - PROCESS | 1666 | Values: 68.0 68.0 68.0 70.0 71.0 68.0 67.0 70.0 68.0 68.0 05:53:52 INFO - PROCESS | 1666 | -------- Summary: end -------- 05:53:52 INFO - PROCESS | 1666 | 05:53:53 INFO - TEST-INFO | 1666: exit 0 05:53:53 INFO - TEST-OK | kraken | took 60974ms 05:53:53 INFO - SUITE-END | took 1175s 05:53:53 INFO - Completed test suite (00:19:35) 05:53:53 INFO - javascript benchmark 05:53:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7328.75494655677, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3414.7438942079343, 3416.897493075209, 3423.5378223939774, 3426.3832510148163, 3434.278801451695, 5337.905729325488, 5775.246090041475, 5806.012977793775, 5877.764889404419, 5898.469137777599, 4821.951780482203, 5063.164577844651, 5795.82612521624, 5800.100984347422, 5811.186433899257, 5218.0, 5305.708186049766, 5330.706811125387, 5351.759170837322, 5395.406505284415, 4972.552470277675, 5409.945060713162, 5410.783568657269, 5419.349678038641, 5452.91820622691, 5199.766010529535, 5272.92090618641, 5320.361556613192, 5331.653442526223, 5357.946420535804, 5280.973595132038, 5291.232771248147, 5307.2835167252315, 5313.362396512404, 5351.919721204185, 5244.29202057725, 5246.973765131188, 5249.265102885599, 5282.022825777205, 5303.602229832778, 4322.891927701801, 4567.954320456786, 4934.605231581465, 5733.455321744427, 5805.912911306334, 4827.51724827518, 6180.443760061571, 6252.406021427957, 6283.937160628381, 6292.779752708679, 4997.625178111656, 6249.750009999594, 6281.089242059921, 6302.338254483305, 6311.116443697886, 5772.3938986406665, 5894.17481552583, 5917.911231331534, 5953.672548009858, 5990.64056156632, 6383.106365108889, 6386.552941294158, 6404.839879002969, 6405.391487808651, 6430.421262086435, 6234.096056071844, 6235.095911092866, 6236.532260080512, 6270.435660790551, 6296.527760417987, 6126.9387306127255, 6146.139540464339, 6188.597741146811, 6199.814005579749, 6254.6247225166635, 5256.842294731164, 6192.628442293477, 6272.560920735505, 6278.058291256348, 6313.40022697843, 6259.217597800275, 6264.248290205204, 6289.276733175652, 6298.212723409574, 6298.433141017239, 4925.2119660854805, 4974.950250497521, 5002.499750025041, 5068.16375298079, 5073.949260507347, 3771.7171212159196, 4451.243288640939, 4515.187266292099, 4522.23122069249, 4545.863624091283, 5768.567357448208, 5852.414758524199, 5881.382454842265, 5888.764449421975, 5890.322612899571, 5221.7128057956415, 5390.299261096033, 6004.42957918997, 6161.876762464725, 6184.567080304336, 5794.594378393556, 5815.592908496449, 5821.359650438449, 5834.883302333929, 5866.73599688015, 5515.200295957064, 5537.667739935617, 5540.833774986757, 5541.861453463615, 5546.667199968015, 6185.0, 6288.6855657217875, 6308.653024083719, 6363.649999249993, 6369.33122022181, 6244.0, 6247.437730604267, 6253.2496100466415, 6258.43674069336, 6270.686465676789, 6338.334474880071, 6381.361863813581, 6416.871662566629, 6419.711112999833, 6434.356564343715, 6075.605085669417, 6095.817125486243, 6139.539534534839, 6230.221222347207, 6263.655498947602, 5247.947520524898, 6197.5351848610635, 6240.4071613196675, 6253.96873015632, 6271.717772700148, 6181.443670069715, 6183.876322473615, 6208.161898143693, 6211.9068213975925, 6227.408396202353, 5972.104184372379, 6100.26796784371, 6135.325114237341, 6198.163247961467, 6203.534734894811, 4905.681130726492, 5063.949360506348, 6029.125776762433, 6144.41628045335, 6147.815565533041, 4805.8077676892535, 5467.58993075513, 5942.989691752499, 6227.564070515021, 6235.282942461675, 5840.007198776133, 5951.791687290924, 5985.670788106522, 6129.0, 6132.63204207749], "value": 5675.178225666452, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [441.9393455706306, 475.1589686255327, 518.8495336352457, 523.7459831981488, 535.2506490912724, 37483.81258093709, 39927.001824954394, 39953.60046399535, 39977.60022399775, 40003.799981000055, 41051.79474102625, 41142.765717028466, 41574.0, 41590.58409415905, 41712.791436042855, 9711.660091896767, 9904.55429505674, 9907.405555666646, 9932.006799320083, 9942.304038717293, 9773.31586788925, 9871.457069861155, 9874.259430542703, 9906.455144967023, 9919.256055795808, 9876.654317098903, 9887.307888447811, 9896.802063958716, 9902.356346837432, 9917.057879501435, 9826.803463930753, 9837.360571562825, 9852.16256618181, 9879.703608891708, 9895.109440150422, 9754.46350450725, 9769.316147869651, 9832.410055396698, 9841.212702983745, 9984.800303993952, 39353.44202626849, 39366.015849603704, 39447.40828887569, 39686.801565992275, 39700.20599588021, 2631.3421644588852, 3301.3892429900543, 3327.9168020799675, 3509.2630547585036, 3524.312759011994, 29383.706162938524, 29771.85114074416, 30006.399872002658, 30634.69365306341, 30689.232769180726, 3159.57345758322, 3165.5093460513426, 3167.9683203167906, 3176.078937108236, 3235.867446393767, 435704.0, 437169.0, 439651.0, 440388.0, 443154.9999999968, 32878.83560582182, 33141.66858331434, 33143.0, 33152.50271245933, 33169.67321307169, 33700.83149584285, 33981.98054058382, 34034.14914627154, 34532.482012769826, 34712.652873471445, 16434.589135271475, 16565.751513727304, 16741.581460463585, 16749.58126046834, 16806.15969201535, 11257.324560526231, 12843.678908027374, 12947.158434701714, 12955.287459189834, 12973.740525189633, 18691.439256822316, 18709.625807484048, 18712.625747484974, 18736.15687294048, 18755.718664220047, 7384.298491643285, 8151.369726054812, 8165.673373065129, 8196.0, 8270.37972152091, 846.8567433964099, 893.388029199987, 1021.6259131468163, 1034.13132968307, 1072.3351522056375, 29798.957036504053, 29833.0, 29873.805047797843, 30016.399672006875, 30770.692293076783, 1097.6103483263487, 1107.4518113533852, 1113.3765091548757, 1128.6850818796174, 1140.5779861451317, 11272.436378181059, 15118.168500732565, 15376.924115244523, 15474.845251547566, 15809.683806323808, 540946.0, 710288.0, 721441.0, 722908.0, 725916.0, 50716.23925641119, 55037.89924201494, 58905.0, 58928.0, 59069.40930590639, 1240.7394447166196, 1377.22875189894, 1387.1330418488444, 1407.985920140806, 1423.7935499352743, 19946.800531995075, 25569.744302556737, 28029.0, 28618.0, 29832.25419364533, 35811.82094089513, 51896.0, 55495.16757248564, 56104.0, 60106.39893601008, 663501.0, 664818.0, 664914.0, 665359.0, 667431.0, 26463.206103816916, 40998.385024224066, 42953.3556996639, 43381.78309108434, 43404.78297608492, 38671.0, 46480.53519464762, 46798.53201467942, 47432.7628361856, 47582.0, 38515.6148438512, 38577.6142238574, 38646.1692288464, 39371.0, 39802.40296395614, 38689.32451417111, 38721.89278167127, 38844.41733374058, 39393.60606394014, 40209.1958160841, 32169.35661286808, 37928.81035594915, 38151.80924095362, 38335.04162395962, 38773.0, 27230.0, 33669.49495757615, 34020.48969265512, 34540.82729586336, 35236.82381588076, 24785.25644230676, 25226.873865630554, 25397.365065873502, 25490.98036078536, 25854.353641159123], "value": 19524.51881867401, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.6063692167843, 378.73488558009393, 379.281262008494, 382.61738261738265, 398.54167707136787, 19389.99999999998, 20591.897040514814, 21461.57076858464, 21647.242346517876, 21778.0, 11947.880521194786, 12156.209846360003, 14985.850141498582, 20041.498962525944, 21302.786972130274, 5448.45515448454, 5487.917681234775, 5702.287214098238, 5722.256106706122, 5722.427757224286, 4769.475357710649, 5452.972735136319, 5604.943950560483, 5615.80344687936, 5620.100783874581, 5364.839054828361, 5570.749316280777, 5585.357683866347, 5595.888082238353, 5621.072523033715, 5448.564114870821, 5562.0, 5562.221289019541, 5580.665160090387, 5590.049691552445, 5190.091733946582, 5394.32570928634, 5400.972995135038, 5418.241446197536, 5424.83725488232, 13396.598102056954, 13453.66365840852, 13559.186448813103, 13569.253691046988, 18915.810841891544, 2153.418576984221, 2374.726906405768, 2440.9267721968367, 2862.957055644167, 2995.5207166853197, 9658.565364558612, 9928.0, 9967.302288839785, 10244.28290019699, 10438.112760415373, 1780.287884846059, 1838.3381982486294, 1871.7192421136801, 1882.2471011595335, 1918.9232430702755, 113719.0, 128645.0, 128776.0, 131046.65346851449, 132217.33891330578, 9281.814363712823, 9944.403335799876, 10934.398608076473, 10934.781304373868, 11165.0, 14380.640483987983, 14514.564563062913, 14521.92739036298, 14572.927135364256, 14575.344109515097, 6862.828429289308, 6986.685599148051, 8544.957275213585, 8648.913510864937, 8680.175383338572, 8471.661133554711, 8482.618282177316, 8485.490870547786, 8519.361047921308, 8604.741857744277, 4490.528494508095, 4518.932216016762, 4529.456465224194, 4533.455985281787, 4597.218472859622, 1907.1786443945998, 1947.7565304336958, 1967.79338169493, 1973.5099999500285, 2002.7596688397487, 839.9244068033784, 859.5401460218753, 860.7097880948357, 925.6806401791371, 987.244757760314, 17874.55313617144, 20797.58404831895, 20998.055087521097, 21084.789152108282, 21122.838243896425, 884.73924657363, 940.1867384712175, 944.9338546301693, 970.6214576315243, 1039.5633833789827, 10913.781724365468, 12085.033197344192, 12092.153549251469, 12192.695182620328, 12367.93816030914, 589977.0, 606457.0, 614955.0, 622939.0, 657685.1157442109, 56581.0, 132225.0, 134589.3270533641, 139725.3013734925, 149845.0, 980.5391466010964, 1014.4623349624711, 1032.9618733173263, 1035.1873779083382, 1040.9479526023667, 18333.908330458264, 19162.616747665248, 19208.71186932225, 19216.94306813083, 19355.93542355184, 47828.7608561955, 55068.44931550633, 56998.7150064247, 57224.71387643035, 58540.0, 74991.75024749266, 75453.0, 79654.203457967, 79863.60068199622, 85940.0, 8119.0, 8192.0, 8241.381896357918, 8307.293880020266, 8447.8732819009, 12733.236005839679, 13429.865701342862, 13447.193168409927, 13601.863981360455, 13614.319284035957, 10987.011168994828, 11321.207515474167, 11440.885591143982, 11594.0, 11647.0, 10841.349519028883, 11264.887351126712, 11265.605703800655, 11525.94237028843, 11727.706807329885, 11541.249818761753, 11866.347350895783, 11904.702382440508, 11907.880921191023, 11976.041916646473, 5912.0, 8209.179082091743, 8239.835203296021, 8290.33677305802, 8348.7912802178, 8418.452800567944, 11212.607558735404, 11292.644882614139, 11696.766064678488, 11719.531218751154], "value": 9382.048094955406, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1281.314496744242, 1472.6907349456617, 1662.085852780971, 1726.6460375622999, 1856.368834596237, 7878.330341920943, 8386.87419688705, 8590.226879580836, 8932.017478077414, 8950.418222815513, 8583.055863854986, 8810.38327317088, 8829.470231786081, 8837.867431988509, 8866.468011919289, 2017.798220177985, 2375.3230329356093, 2406.5186962607463, 2407.0251548123038, 2413.6379543068506, 2358.7759162879497, 2370.0401337458356, 2379.298107058422, 2388.9641655375094, 2399.3521749127726, 2373.5727569037567, 2377.7146742390937, 2381.202297230421, 2407.374082738492, 2410.7468715784853, 2358.917437889683, 2373.964390534143, 2381.142788596104, 2382.404398900275, 2384.833061685683, 2333.988330058356, 2343.261872510154, 2358.7287461941924, 2362.173239366225, 2366.0, 8819.691310804092, 8864.113588641085, 8904.421212621159, 8911.643534258621, 8913.064128266567, 5213.426523082458, 5354.625176237665, 5390.434004429557, 5393.406725260257, 5397.055515284848, 3555.8577656893694, 3690.1697118148472, 3714.201446688975, 3756.718246131551, 3769.3215221260434, 1118.3848883114335, 1126.2510430563666, 1126.419893754717, 1128.3173679923693, 1144.3305666185292, 11391.658250252505, 11408.771824563462, 11466.369349685763, 11539.961403473644, 11581.07351411885, 4071.75569465833, 4555.40779698637, 4700.482946875841, 4851.951480485221, 4886.633502487257, 8579.571021448903, 9936.80126397468, 10001.549930253155, 10029.598816047423, 10042.096211341015, 4334.739915605074, 4979.4771548987555, 5385.299911011543, 5392.622516423813, 5399.78400863961, 4380.102079073782, 4727.267273572602, 4890.755462226874, 4894.608431325485, 4930.556249937523, 3912.980435097806, 3934.291827471083, 4048.2308361411237, 4067.7762723049923, 4094.1402305516176, 1107.7507560798756, 1150.3730466895563, 1311.3967574915646, 1328.8936885049172, 1341.1684755451683, 850.9829803403898, 914.6067191107887, 915.7756349694367, 929.0941332201185, 940.2853831088286, 4885.267209918541, 5831.591788574844, 5925.34821169671, 5955.106733989936, 5997.490213331828, 934.2946075712794, 966.8114717629994, 984.7931934293736, 999.3104757717152, 1010.6664800615927, 3596.8381422836037, 3971.920561588752, 4011.146512719584, 4014.518257809023, 4106.3635136553885, 10280.948595256976, 10715.678529643967, 10736.463176841284, 10737.892621073846, 10790.136789056856, 10726.731831704114, 10745.462726863625, 10746.301490403255, 10746.731331716614, 10790.460476976277, 8067.233612806774, 8207.548584827773, 8230.876536851953, 8245.917540824516, 8247.422680412434, 5173.81891633791, 5504.0, 5677.3754886963225, 5785.768569257182, 5806.390329015392, 9843.064908833649, 9922.00779922031, 9958.701238962843, 9972.750681233027, 10005.499725013866, 9680.419174849532, 10121.645742398981, 10226.233032522441, 10248.743781405525, 10262.230332725225, 6500.512461565307, 6792.626405547742, 6944.895826562707, 7012.964935175495, 7153.35619794221, 8292.37807164453, 8375.832483350421, 8404.327653787805, 8443.662253510036, 8454.535000575028, 7311.780646580611, 7409.296116868889, 7440.590767507839, 7491.625418729151, 7557.2820582044615, 7048.718051278097, 7234.638268086469, 7285.271472852673, 7297.525660832029, 7342.045534080536, 6916.20463646687, 6931.653417329013, 6965.965170174117, 7007.649617519206, 7018.789436316919, 3814.275287695329, 4497.752623605602, 4951.207806750903, 5010.9248361273885, 5045.394552653705, 4883.780229889592, 4887.731174785421, 4943.65394422387, 4968.950310496849, 5043.798248070036], "value": 4573.037564346955, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [237.5616986659613, 301.6937808124753, 307.6277703978186, 320.25221108711156, 321.6365506977115, 4044.4337792709043, 4876.074355386766, 5484.204790305408, 5489.725513724313, 5516.696581688006, 4746.3117847912035, 5473.917891231625, 5523.0, 5536.726552892837, 5545.306836645419, 4206.495220573528, 4240.321548552232, 4250.596193361625, 4252.851730032905, 4261.744295342274, 3518.9648103518894, 3922.9019274518223, 4159.646430053449, 4239.562251705282, 4244.214820258262, 3489.5638045244345, 3793.7723736575754, 4135.813888375015, 4139.586041395852, 4151.58484151584, 4131.834726610932, 4152.8961775955695, 4153.439285696422, 4157.3140431828715, 4169.4162817205615, 3564.6988849070162, 3578.4632305154173, 3582.7133829293853, 3584.7669901456584, 3608.1881576645305, 5036.320096786923, 5189.974050129763, 5338.733063346856, 5351.812686555991, 5377.623566350357, 4123.237201117773, 4319.0, 4659.650526210514, 4747.810087596492, 4800.063987522434, 4574.839880604196, 5307.363116426015, 5791.82624521265, 5834.737436815353, 5837.357890632027, 3112.4864397374404, 3888.5333759948985, 3921.999780112135, 3929.980350098231, 3945.743526670757, 5447.237386765856, 5851.76592936282, 6120.286319830455, 6150.630962142286, 6184.536159787989, 3313.7514686398617, 3980.5024371953505, 3981.402789581528, 3992.201559688074, 4029.879103626896, 3221.194701324669, 4000.7599544027453, 4034.596540345942, 4051.3517837145914, 4059.5331536873637, 4185.760618069318, 4507.301368287855, 4737.507685079189, 4742.834000809955, 4749.651495695526, 5166.819161329336, 5581.832545023656, 5789.7998760470755, 5875.061229794158, 5938.376470470538, 1292.5928332575209, 1315.2700251360395, 1347.42060913808, 1363.638635761524, 1378.9241591712553, 885.4239453772295, 902.6595505674069, 926.1942110364026, 927.3462209142539, 930.4045410937006, 4398.428204333416, 4682.1338052460405, 5283.181106928432, 5312.282841816383, 5356.973215133899, 5871.32479764824, 5941.138534912414, 5943.881122377615, 5953.362825223098, 5960.672163031075, 4669.626429885601, 5038.067957427887, 5338.3593968724, 5340.543350058939, 5402.270693456333, 3169.3819705157275, 3169.730572901329, 3188.7678624962155, 3195.872165113416, 3208.946274384396, 6014.548908831855, 6254.092501786908, 6267.4045965633195, 6280.2777680566405, 6281.152044473937, 5378.435264297193, 5524.917126243109, 5628.774849005994, 5928.584999050111, 6121.693915304217, 6228.22147231596, 6238.906416403667, 6253.937460625336, 6262.0, 6282.560220784592, 4851.054044461437, 5613.46672066153, 5857.355690874086, 6030.125631783455, 6043.939560604338, 4582.908341833211, 5409.404965453876, 5738.368779434342, 5928.3775203603, 6008.789692360747, 4781.676734669511, 5165.870853228699, 6060.515158787198, 6065.848353791191, 6169.352218017223, 3914.2758589661003, 3975.5030621172355, 4011.5988401159652, 4018.3771515415156, 4026.4966879140106, 5687.090065589486, 5777.306723193244, 6019.909701354396, 6048.334683184934, 6083.0, 4895.951040489692, 5680.460356266148, 5836.678982655994, 5876.382979787232, 5912.556558258234, 4353.608175264241, 5906.911396328973, 5960.83763666081, 5964.612300200473, 6087.712635177132, 5000.349954505891, 5388.919166212431, 5726.625609853689, 5824.883502330014, 5829.271341082364, 5115.0, 5877.882442351043, 5890.410958904075, 5895.322037965689, 5903.763849445974, 5268.6575372600655, 5274.604404669589, 5778.739956702043, 5784.768609255582, 5811.767529298781], "value": 4207.6606429175745, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.9174499060114, 708.8617719544691, 757.939364850812, 792.635387721648, 846.0735494633376, 13984.790228146574, 14525.201113938729, 14634.41462341505, 14669.926650366746, 15421.920465567415, 14899.10605363679, 14985.0, 15058.849411505882, 15067.849321506781, 15073.62315942102, 866.2766589897427, 877.8376000439907, 880.4937161132342, 881.0000649263069, 883.2713011765287, 709.1667290933159, 873.6723728601775, 893.1648908270755, 904.430208968349, 911.43946472919, 947.1049857884302, 950.4059962523423, 950.8240975419569, 952.2905435450565, 952.366676160356, 930.3905941608258, 938.197840846077, 939.5490164720904, 949.9857502137404, 950.8478643417054, 653.6795672741084, 674.2145400608285, 689.0043886583888, 689.7103216649019, 705.0869124483805, 15247.61880952974, 15278.618034549114, 15281.312340944683, 15288.159151246677, 15318.310676019606, 14801.185934773583, 14909.925450372788, 14979.0, 15016.0, 15031.549053528412, 11990.220635658654, 12138.332391718452, 12278.693032674166, 12363.75272494545, 12592.559260425842, 3208.4866421372467, 3700.796456194935, 4022.658074063708, 4089.243489954338, 4089.3865920111925, 82407.0, 102120.48939755253, 112161.87838121678, 114722.99999999917, 114895.0, 9519.762005949906, 10812.80726710096, 10896.673099807018, 11096.944515277371, 11103.72240693989, 17752.733708994376, 19700.211991520464, 20033.59932801336, 20698.379048628565, 20883.582328353346, 7832.177621349791, 7870.212978702199, 7963.601819908981, 7966.28303452692, 8135.02379714438, 3985.6811455083525, 4532.592066714012, 4628.861134165981, 4632.559906808848, 4668.8132474701315, 2938.8824447022307, 3708.666220040155, 3723.590405055442, 3737.9252414951548, 3745.9063523411587, 683.1426559667585, 700.6496751624188, 705.6577559883452, 707.7664370757637, 711.121764620693, 617.9412955769195, 627.4415769964735, 643.9839004024936, 663.6482664187988, 693.8161387232387, 9221.17009469151, 9306.72079837606, 9496.667616633524, 9712.22302215821, 9785.412875227508, 542.094701847907, 580.6080895395592, 629.0750304069562, 681.2831664206172, 696.7247937064831, 4368.279233926367, 4613.123506533748, 4648.5119062498625, 4671.5094915034115, 4777.259524773665, 112238.0, 154207.0, 154939.22530387275, 154991.0, 156048.0, 128557.35721321334, 129817.0, 134891.0, 137289.0, 138711.6610423697, 91755.54122229347, 101801.0, 104338.0, 105921.47039264909, 107144.0, 9018.278537716837, 9072.410293330913, 9186.954065229631, 9211.0, 9216.0, 59502.70248648729, 61319.41528186147, 62795.686021571426, 65019.0, 65097.34902650913, 74821.0, 94649.0, 96990.0, 98023.50988245013, 98471.50764246134, 11526.88473115258, 11813.232139910879, 11818.29090254553, 12070.698232544257, 12393.132480726263, 12286.139970202, 12472.812907806572, 12675.873241267838, 12691.155919345327, 13503.0, 10349.379037257788, 12179.025677945567, 12377.443015064164, 12388.690282743004, 12800.679983000127, 12009.279443233434, 12296.786578415971, 12525.498980040697, 12679.93660031694, 12831.0, 12144.514219431478, 12499.312537810507, 12620.684482888002, 12650.430730617329, 12660.107111720015, 10238.590456381959, 10313.329633573794, 10404.531796069045, 10482.37105773656, 10778.29941053829, 9714.3199976001, 9766.804663906823, 11220.382878941737, 11506.884931150917, 11942.790583742035], "value": 7745.232850027247, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1617.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 117.0, 111.0, 118.0, 115.0, 116.0, 121.0, 116.0, 116.0, 115.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 106.0, 165.0, 148.0, 132.0, 124.0, 155.0, 96.0, 151.0, 131.0], "value": 135.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 201.0, 233.0, 230.0, 236.0, 278.0, 213.0, 223.0, 278.0, 201.0], "value": 229.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 79.0, 77.0, 156.0, 58.0, 63.0, 74.0, 85.0, 144.0, 79.0], "value": 88.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 96.0, 159.0, 76.0, 60.0, 108.0, 144.0, 100.0, 104.0, 113.0], "value": 104.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 76.0, 136.0, 131.0, 89.0, 92.0, 103.0, 75.0, 110.0, 131.0], "value": 103.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 148.0, 118.0, 95.0, 94.0, 93.0, 95.0, 94.0, 95.0, 96.0], "value": 104.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 81.0, 144.0, 147.0, 91.0, 94.0, 92.0, 90.0, 93.0, 91.0], "value": 101.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 58.0, 58.0, 55.0, 58.0, 57.0, 57.0, 54.0, 55.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 68.0, 76.0, 75.0, 76.0, 70.0, 68.0, 81.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 85.0, 86.0, 89.0, 86.0, 90.0, 78.0, 97.0, 110.0, 109.0], "value": 92.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 168.0, 160.0, 157.0, 177.0, 147.0, 156.0, 158.0, 177.0, 155.0], "value": 159.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 175.0, 154.0, 173.0, 151.0, 155.0, 208.0, 238.0, 210.0, 239.0], "value": 187.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 70.0, 71.0, 68.0, 67.0, 70.0, 68.0, 68.0], "value": 68.6, "unit": "score"}]}]} 05:53:53 INFO - Return code: 0 05:53:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:53:53 ERROR - # TBPL SUCCESS # 05:53:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:53:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:53:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:53:53 INFO - 2016-08-22 05:53:53.791 screenresolution[1671:11509] starting screenresolution argv=screenresolution get 05:53:53 INFO - 2016-08-22 05:53:53.794 screenresolution[1671:11509] Display 0: 1600x1200x32@60 05:53:53 INFO - 2016-08-22 05:53:53.800 screenresolution[1672:11512] starting screenresolution argv=screenresolution list 05:53:53 INFO - Available Modes on Display 0 05:53:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:53:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:53:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:53:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:53:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:53:54 INFO - Intel Iris: 05:53:54 INFO - Chipset Model: Intel Iris 05:53:54 INFO - Type: GPU 05:53:54 INFO - Bus: Built-In 05:53:54 INFO - VRAM (Dynamic, Max): 1536 MB 05:53:54 INFO - Vendor: Intel (0x8086) 05:53:54 INFO - Device ID: 0x0a2e 05:53:54 INFO - Revision ID: 0x0009 05:53:54 INFO - Displays: 05:53:54 INFO - Display: 05:53:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:53:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:53:54 INFO - Display Serial Number: 1600x1200 60 05:53:54 INFO - Main Display: Yes 05:53:54 INFO - Mirror: Off 05:53:54 INFO - Online: Yes 05:53:54 INFO - Rotation: Supported 05:53:54 INFO - Return code: 0 05:53:54 INFO - Running post-action listener: _resource_record_post_action 05:53:54 INFO - [mozharness: 2016-08-22 12:53:54.036352Z] Finished run-tests step (success) 05:53:54 INFO - Running post-run listener: _resource_record_post_run 05:53:54 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 34204672; Write bytes: 710365696; Read time: 326; Write time: 1991 05:53:54 INFO - TinderboxPrint: CPU usage
54.6% 05:53:54 INFO - TinderboxPrint: I/O read bytes / time
34,204,672 / 326 05:53:54 INFO - TinderboxPrint: I/O write bytes / time
710,365,696 / 1,991 05:53:54 INFO - TinderboxPrint: CPU idle
2,200.1 (45.4%) 05:53:54 INFO - TinderboxPrint: CPU system
984.1 (20.3%) 05:53:54 INFO - TinderboxPrint: CPU user
1,657.5 (34.2%) 05:53:54 INFO - TinderboxPrint: Swap in / out
436,805,632 / 0 05:53:54 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 384930304; Write bytes: 380069888; Read time: 28219; Write time: 736 05:53:54 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 33258496; Write bytes: 300571136; Read time: 310; Write time: 1196 05:53:54 INFO - Running post-run listener: _upload_blobber_files 05:53:54 INFO - Blob upload gear active. 05:53:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:53:54 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:53:54 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:53:54 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:53:54 INFO - (blobuploader) - INFO - Open directory for files ... 05:53:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:53:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:53:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:55 INFO - (blobuploader) - INFO - Done attempting. 05:53:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:53:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:53:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:56 INFO - (blobuploader) - INFO - Done attempting. 05:53:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:53:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:53:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:59 INFO - (blobuploader) - INFO - Done attempting. 05:53:59 INFO - (blobuploader) - INFO - Iteration through files over. 05:53:59 INFO - Return code: 0 05:53:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:53:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:53:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c877dba40a59a32ec29b99a8da898d5486d9a050ce9546656baaa767c32c3473796f98d72d02a2bdbc3f7ae8f07695f5173fe71201d109d65c5a313d801d942c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ebffdb7649fc415de76bfa9b25d1e89771ffe7e1e2d22ae095b299e2617bf5bc3d1de3f105d2caf69e6e07441f026200fb9351af67428beb7515ab031da3e38", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4dd70a4338fe180613567ad82a52151f2481e81e0d72b7866763a0ec719667e21a18559599dd3cdf0c5ca269acdd983c9725f04cc2b2e60644d28f4704a49b9a"} 05:53:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:53:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:53:59 INFO - Contents: 05:53:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c877dba40a59a32ec29b99a8da898d5486d9a050ce9546656baaa767c32c3473796f98d72d02a2bdbc3f7ae8f07695f5173fe71201d109d65c5a313d801d942c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ebffdb7649fc415de76bfa9b25d1e89771ffe7e1e2d22ae095b299e2617bf5bc3d1de3f105d2caf69e6e07441f026200fb9351af67428beb7515ab031da3e38", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4dd70a4338fe180613567ad82a52151f2481e81e0d72b7866763a0ec719667e21a18559599dd3cdf0c5ca269acdd983c9725f04cc2b2e60644d28f4704a49b9a"} 05:53:59 INFO - Running post-run listener: copy_logs_to_upload_dir 05:53:59 INFO - Copying logs to upload dir... 05:53:59 INFO - mkdir: /builds/slave/test/build/upload/logs 05:53:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.293244 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-08-22 05:53:59.447458) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 05:53:59.453047) ========= 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.bkQSBltUmz/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.snW51QOBTQ/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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/c877dba40a59a32ec29b99a8da898d5486d9a050ce9546656baaa767c32c3473796f98d72d02a2bdbc3f7ae8f07695f5173fe71201d109d65c5a313d801d942c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ebffdb7649fc415de76bfa9b25d1e89771ffe7e1e2d22ae095b299e2617bf5bc3d1de3f105d2caf69e6e07441f026200fb9351af67428beb7515ab031da3e38", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4dd70a4338fe180613567ad82a52151f2481e81e0d72b7866763a0ec719667e21a18559599dd3cdf0c5ca269acdd983c9725f04cc2b2e60644d28f4704a49b9a"} build_url:https://queue.taskcluster.net/v1/task/IHEybdxTRwGpBIczZfEdlw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/IHEybdxTRwGpBIczZfEdlw/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/c877dba40a59a32ec29b99a8da898d5486d9a050ce9546656baaa767c32c3473796f98d72d02a2bdbc3f7ae8f07695f5173fe71201d109d65c5a313d801d942c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ebffdb7649fc415de76bfa9b25d1e89771ffe7e1e2d22ae095b299e2617bf5bc3d1de3f105d2caf69e6e07441f026200fb9351af67428beb7515ab031da3e38", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4dd70a4338fe180613567ad82a52151f2481e81e0d72b7866763a0ec719667e21a18559599dd3cdf0c5ca269acdd983c9725f04cc2b2e60644d28f4704a49b9a"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 05:53:59.491210) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 05:53:59.491901) ========= 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.bkQSBltUmz/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.snW51QOBTQ/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.005252 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 05:53:59.541477) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 05:53:59.541825) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 05:53:59.542147) ========= ========= Total master_lag: 0.26 =========