builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0181 starttime: 1471663661.01 results: success (0) buildid: 20160819181715 builduid: 08c5c470a89e447fb81d794f50295f7a revision: f97a056ae6235de7855fd8aaa04fb1c8d183bd06 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 20:27:41.012923) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 20:27:41.013341) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 20:27:41.013652) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 20:27:41.039881) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 20:27:41.040202) ========= 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.fIquJkjZd1/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.E5j14vST24/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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-19 20:27:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 25.1M=0s 2016-08-19 20:27:41 (25.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.345682 ========= master_lag: 0.18 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 20:27:41.568581) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 20:27:41.568914) ========= 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.fIquJkjZd1/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.E5j14vST24/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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.029998 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 20:27:41.626576) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-19 20:27:41.626903) ========= 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.fIquJkjZd1/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.E5j14vST24/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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-19 20:27:41,703 truncating revision to first 12 chars 2016-08-19 20:27:41,704 Setting DEBUG logging. 2016-08-19 20:27:41,704 attempt 1/10 2016-08-19 20:27:41,704 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-19 20:27:43,228 unpacking tar archive at: mozilla-central-f97a056ae623/testing/mozharness/ program finished with exit code 0 elapsedTime=1.801840 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-19 20:27:43.453064) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 20:27:43.453866) ========= script_repo_revision: f97a056ae6235de7855fd8aaa04fb1c8d183bd06 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 20:27:43.454465) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 20:27:43.454773) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 20:27:43.473984) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-08-19 20:27:43.474709) ========= /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.fIquJkjZd1/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.E5j14vST24/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 20:27:43 INFO - MultiFileLogger online at 20160819 20:27:43 in /builds/slave/test 20:27:43 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 20:27:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:27:43 INFO - {'append_to_log': False, 20:27:43 INFO - 'base_work_dir': '/builds/slave/test', 20:27:43 INFO - 'blob_upload_branch': 'Firefox', 20:27:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:27:43 INFO - 'branch': 'Firefox', 20:27:43 INFO - 'buildbot_json_path': 'buildprops.json', 20:27:43 INFO - 'config_files': ('talos/mac_config.py',), 20:27:43 INFO - 'default_actions': ('clobber', 20:27:43 INFO - 'read-buildbot-config', 20:27:43 INFO - 'download-and-extract', 20:27:43 INFO - 'populate-webroot', 20:27:43 INFO - 'create-virtualenv', 20:27:43 INFO - 'install', 20:27:43 INFO - 'run-tests'), 20:27:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:27:43 INFO - 'download_minidump_stackwalk': True, 20:27:43 INFO - 'download_symbols': 'ondemand', 20:27:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:27:43 INFO - 'tooltool.py': '/tools/tooltool.py', 20:27:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:27:43 INFO - '/tools/misc-python/virtualenv.py')}, 20:27:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:27:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:27:43 INFO - 'installer_path': 'installer.exe', 20:27:43 INFO - 'log_level': 'info', 20:27:43 INFO - 'log_name': 'talos', 20:27:43 INFO - 'log_to_console': True, 20:27:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:27:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:27:43 INFO - 'opt_config_files': (), 20:27:43 INFO - 'pip_index': False, 20:27:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:27:43 INFO - 'cmd': ('bash', 20:27:43 INFO - '-c', 20:27:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:27:43 INFO - 'enabled': True, 20:27:43 INFO - 'halt_on_failure': False, 20:27:43 INFO - 'name': 'check_screen_resolution'},), 20:27:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:27:43 INFO - 'cmd': ('bash', 20:27:43 INFO - '-c', 20:27:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:27:43 INFO - 'enabled': True, 20:27:43 INFO - 'halt_on_failure': False, 20:27:43 INFO - 'name': 'check_screen_resolution'},), 20:27:43 INFO - 'run_cmd_checks_enabled': True, 20:27:43 INFO - 'sps_profile': False, 20:27:43 INFO - 'sps_profile_interval': 0, 20:27:43 INFO - 'suite': 'dromaeojs-e10s', 20:27:43 INFO - 'system_bits': '32', 20:27:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:27:43 INFO - 'title': 't-yosemite-r7-0181', 20:27:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:27:43 INFO - 'use_talos_json': True, 20:27:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:27:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:27:43 INFO - 'work_dir': 'build'} 20:27:43 INFO - [mozharness: 2016-08-20 03:27:43.683851Z] Running clobber step. 20:27:43 INFO - Running pre-action listener: _resource_record_pre_action 20:27:43 INFO - Running main action method: clobber 20:27:43 INFO - rmtree: /builds/slave/test/build 20:27:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:27:45 INFO - Running post-action listener: _resource_record_post_action 20:27:45 INFO - [mozharness: 2016-08-20 03:27:45.838037Z] Finished clobber step (success) 20:27:45 INFO - [mozharness: 2016-08-20 03:27:45.838208Z] Running read-buildbot-config step. 20:27:45 INFO - Running pre-action listener: _resource_record_pre_action 20:27:45 INFO - Running main action method: read_buildbot_config 20:27:45 INFO - Using buildbot properties: 20:27:45 INFO - { 20:27:45 INFO - "project": "", 20:27:45 INFO - "product": "firefox", 20:27:45 INFO - "script_repo_revision": "production", 20:27:45 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 20:27:45 INFO - "repository": "", 20:27:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 20:27:45 INFO - "buildid": "20160819181715", 20:27:45 INFO - "pgo_build": "False", 20:27:45 INFO - "basedir": "/builds/slave/test", 20:27:45 INFO - "buildnumber": 32, 20:27:45 INFO - "slavename": "t-yosemite-r7-0181", 20:27:45 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 20:27:45 INFO - "platform": "yosemite_r7", 20:27:45 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 20:27:45 INFO - "branch": "mozilla-central", 20:27:45 INFO - "repo_path": "mozilla-central", 20:27:45 INFO - "revision": "f97a056ae6235de7855fd8aaa04fb1c8d183bd06", 20:27:45 INFO - "stage_platform": "macosx64", 20:27:45 INFO - "builduid": "08c5c470a89e447fb81d794f50295f7a", 20:27:45 INFO - "slavebuilddir": "test" 20:27:45 INFO - } 20:27:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/NiLmUKs2SpmIFerD9APJTw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 20:27:45 INFO - Running post-action listener: _resource_record_post_action 20:27:45 INFO - [mozharness: 2016-08-20 03:27:45.843726Z] Finished read-buildbot-config step (success) 20:27:45 INFO - [mozharness: 2016-08-20 03:27:45.843934Z] Running download-and-extract step. 20:27:45 INFO - Running pre-action listener: _resource_record_pre_action 20:27:45 INFO - Running main action method: download_and_extract 20:27:45 INFO - mkdir: /builds/slave/test/build/tests 20:27:45 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')]} 20:27:45 INFO - trying https://queue.taskcluster.net/v1/task/NiLmUKs2SpmIFerD9APJTw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 20:27:45 INFO - Downloading https://queue.taskcluster.net/v1/task/NiLmUKs2SpmIFerD9APJTw/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 20:27:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NiLmUKs2SpmIFerD9APJTw/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 20:27:47 INFO - Downloaded 1199 bytes. 20:27:47 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 20:27:47 INFO - Using the following test package requirements: 20:27:47 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 20:27:47 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:27:47 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 20:27:47 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:27:47 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 20:27:47 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:27:47 INFO - u'jsshell-mac.zip'], 20:27:47 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:27:47 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 20:27:47 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 20:27:47 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:27:47 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 20:27:47 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:27:47 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 20:27:47 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:27:47 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 20:27:47 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:27:47 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 20:27:47 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:27:47 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')]} 20:27:47 INFO - trying https://queue.taskcluster.net/v1/task/NiLmUKs2SpmIFerD9APJTw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 20:27:47 INFO - Downloading https://queue.taskcluster.net/v1/task/NiLmUKs2SpmIFerD9APJTw/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 20:27:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NiLmUKs2SpmIFerD9APJTw/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 20:27:48 INFO - Downloaded 16351873 bytes. 20:27:48 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 20:27:55 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 20:27:55 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')]} 20:27:55 INFO - trying https://queue.taskcluster.net/v1/task/NiLmUKs2SpmIFerD9APJTw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 20:27:55 INFO - Downloading https://queue.taskcluster.net/v1/task/NiLmUKs2SpmIFerD9APJTw/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 20:27:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NiLmUKs2SpmIFerD9APJTw/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 20:27:55 INFO - Downloaded 16351873 bytes. 20:27:55 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 20:28:02 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')]} 20:28:02 INFO - trying https://queue.taskcluster.net/v1/task/NiLmUKs2SpmIFerD9APJTw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 20:28:02 INFO - Downloading https://queue.taskcluster.net/v1/task/NiLmUKs2SpmIFerD9APJTw/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 20:28:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NiLmUKs2SpmIFerD9APJTw/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 20:28:04 INFO - Downloaded 14413981 bytes. 20:28:04 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 20:28:04 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')]} 20:28:04 INFO - trying https://queue.taskcluster.net/v1/task/NiLmUKs2SpmIFerD9APJTw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 20:28:04 INFO - Downloading https://queue.taskcluster.net/v1/task/NiLmUKs2SpmIFerD9APJTw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 20:28:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NiLmUKs2SpmIFerD9APJTw/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 20:28:12 INFO - Downloaded 111491987 bytes. 20:28:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NiLmUKs2SpmIFerD9APJTw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 20:28:12 INFO - mkdir: /builds/slave/test/properties 20:28:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:28:12 INFO - Writing to file /builds/slave/test/properties/build_url 20:28:12 INFO - Contents: 20:28:12 INFO - build_url:https://queue.taskcluster.net/v1/task/NiLmUKs2SpmIFerD9APJTw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 20:28:13 INFO - Running post-action listener: _resource_record_post_action 20:28:13 INFO - Running post-action listener: set_extra_try_arguments 20:28:13 INFO - [mozharness: 2016-08-20 03:28:13.521693Z] Finished download-and-extract step (success) 20:28:13 INFO - [mozharness: 2016-08-20 03:28:13.521820Z] Running populate-webroot step. 20:28:13 INFO - Running pre-action listener: _resource_record_pre_action 20:28:13 INFO - Running main action method: populate_webroot 20:28:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:28:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:28:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:28:13 INFO - '--tppagecycles', 20:28:13 INFO - '7'], 20:28:13 INFO - 'tests': ['tsvgm']}}, 20:28:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:28:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:28:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:28:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:28:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:28:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:28:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:13 INFO - 'talos_options': ['--disable-e10s'], 20:28:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:28:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:28:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:13 INFO - 'talos_options': ['--disable-e10s'], 20:28:13 INFO - 'tests': ['damp', 'tps']}, 20:28:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:13 INFO - 'tests': ['damp', 'tps']}, 20:28:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:28:13 INFO - 'tests': ['dromaeo_dom']}, 20:28:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:28:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:28:13 INFO - 'tests': ['basic_compositor_video']}, 20:28:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:28:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:28:13 INFO - 'tests': ['a11yr', 20:28:13 INFO - 'ts_paint', 20:28:13 INFO - 'tpaint', 20:28:13 INFO - 'sessionrestore', 20:28:13 INFO - 'sessionrestore_no_auto_restore', 20:28:13 INFO - 'tabpaint']}, 20:28:13 INFO - 'other-e10s': {'tests': ['a11yr', 20:28:13 INFO - 'ts_paint', 20:28:13 INFO - 'tpaint', 20:28:13 INFO - 'sessionrestore', 20:28:13 INFO - 'sessionrestore_no_auto_restore', 20:28:13 INFO - 'tabpaint']}, 20:28:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:28:13 INFO - 'ts_paint', 20:28:13 INFO - 'tpaint', 20:28:13 INFO - 'sessionrestore', 20:28:13 INFO - 'sessionrestore_no_auto_restore', 20:28:13 INFO - 'tabpaint']}, 20:28:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:28:13 INFO - 'ts_paint', 20:28:13 INFO - 'tpaint', 20:28:13 INFO - 'sessionrestore', 20:28:13 INFO - 'sessionrestore_no_auto_restore', 20:28:13 INFO - 'tabpaint']}, 20:28:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:28:13 INFO - 'tests': ['a11yr', 20:28:13 INFO - 'ts_paint', 20:28:13 INFO - 'tpaint', 20:28:13 INFO - 'sessionrestore', 20:28:13 INFO - 'sessionrestore_no_auto_restore', 20:28:13 INFO - 'tabpaint']}, 20:28:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:28:13 INFO - 'tests': ['a11yr', 20:28:13 INFO - 'ts_paint', 20:28:13 INFO - 'tpaint', 20:28:13 INFO - 'sessionrestore', 20:28:13 INFO - 'sessionrestore_no_auto_restore', 20:28:13 INFO - 'tabpaint']}, 20:28:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:28:13 INFO - 'tests': ['tsvgx', 20:28:13 INFO - 'tsvgr_opacity', 20:28:13 INFO - 'tart', 20:28:13 INFO - 'tscrollx', 20:28:13 INFO - 'cart']}, 20:28:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:28:13 INFO - 'tsvgr_opacity', 20:28:13 INFO - 'tart', 20:28:13 INFO - 'tscrollx', 20:28:13 INFO - 'cart']}, 20:28:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:13 INFO - 'talos_options': ['--disable-e10s'], 20:28:13 INFO - 'tests': ['tp5o']}, 20:28:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:13 INFO - 'tests': ['tp5o']}, 20:28:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:13 INFO - 'talos_options': ['--disable-e10s', 20:28:13 INFO - '--xperf_path', 20:28:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:28:13 INFO - 'tests': ['tp5n']}, 20:28:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:28:13 INFO - 'talos_options': ['--xperf_path', 20:28:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:28:13 INFO - 'tests': ['tp5n']}}, 20:28:13 INFO - 'talos.zip': {'path': '', 20:28:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:28:13 INFO - Running post-action listener: _resource_record_post_action 20:28:13 INFO - [mozharness: 2016-08-20 03:28:13.540457Z] Finished populate-webroot step (success) 20:28:13 INFO - [mozharness: 2016-08-20 03:28:13.540590Z] Running create-virtualenv step. 20:28:13 INFO - Running pre-action listener: _resource_record_pre_action 20:28:13 INFO - Running main action method: create_virtualenv 20:28:13 INFO - Creating virtualenv /builds/slave/test/build/venv 20:28: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 20:28:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:28:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:28:13 INFO - Using real prefix '/tools/python27' 20:28:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:28:14 INFO - Installing distribute.............................................................................................................................................................................................done. 20:28:17 INFO - Installing pip.................done. 20:28:17 INFO - Return code: 0 20:28:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:28: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')]} 20:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28: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')]} 20:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105457a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054ec618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f897b5a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053bbd30>, '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 0x105120db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053b3b20>, '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.fIquJkjZd1/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.E5j14vST24/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 20:28: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', 'pip>=1.5'] in /builds/slave/test/build 20:28: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 pip>=1.5 20:28:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fIquJkjZd1/Render', 20:28:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:28:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:28:17 INFO - 'HOME': '/Users/cltbld', 20:28:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:28:17 INFO - 'LOGNAME': 'cltbld', 20:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:17 INFO - 'MOZ_NO_REMOTE': '1', 20:28:17 INFO - 'NO_EM_RESTART': '1', 20:28:17 INFO - 'PAGER': '/bin/cat', 20:28:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:17 INFO - 'PWD': '/builds/slave/test', 20:28:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:28:17 INFO - 'SHELL': '/bin/bash', 20:28:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E5j14vST24/Listeners', 20:28:17 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 20:28:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:28:17 INFO - 'USER': 'cltbld', 20:28:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:28:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:17 INFO - 'XPC_FLAGS': '0x0', 20:28:17 INFO - 'XPC_SERVICE_NAME': '0', 20:28:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:28:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28: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 20:28:17 INFO - Cleaning up... 20:28:17 INFO - Return code: 0 20:28:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:28: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')]} 20:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28: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')]} 20:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28: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 0x105457a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054ec618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f897b5a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053bbd30>, '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 0x105120db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053b3b20>, '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.fIquJkjZd1/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.E5j14vST24/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 20:28: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 20:28: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 20:28:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fIquJkjZd1/Render', 20:28:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:28:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:28:17 INFO - 'HOME': '/Users/cltbld', 20:28:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:28:17 INFO - 'LOGNAME': 'cltbld', 20:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:17 INFO - 'MOZ_NO_REMOTE': '1', 20:28:17 INFO - 'NO_EM_RESTART': '1', 20:28:17 INFO - 'PAGER': '/bin/cat', 20:28:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:17 INFO - 'PWD': '/builds/slave/test', 20:28:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:28:17 INFO - 'SHELL': '/bin/bash', 20:28:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E5j14vST24/Listeners', 20:28:17 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 20:28:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:28:17 INFO - 'USER': 'cltbld', 20:28:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:28:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:17 INFO - 'XPC_FLAGS': '0x0', 20:28:17 INFO - 'XPC_SERVICE_NAME': '0', 20:28:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:28:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:17 INFO - Downloading/unpacking psutil>=3.1.1 20:28: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 20:28: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 20:28: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 20:28: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 20:28: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 20:28: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 20:28:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:28:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:28:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:28:21 INFO - Installing collected packages: psutil 20:28:21 INFO - Running setup.py install for psutil 20:28:21 INFO - building 'psutil._psutil_osx' extension 20:28: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_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 20:28:22 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 20:28:22 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 20:28:22 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 20:28:22 INFO - building 'psutil._psutil_posix' extension 20:28:22 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 20:28:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:28:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:28:22 INFO - ^ 20:28:22 INFO - 1 warning generated. 20:28:22 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 20:28:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:28:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:28:22 INFO - Successfully installed psutil 20:28:22 INFO - Cleaning up... 20:28:22 INFO - Return code: 0 20:28:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:22 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 0x105457a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054ec618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f897b5a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053bbd30>, '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 0x105120db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053b3b20>, '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.fIquJkjZd1/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.E5j14vST24/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 20:28:22 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 20:28:22 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 20:28:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fIquJkjZd1/Render', 20:28:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:28:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:28:22 INFO - 'HOME': '/Users/cltbld', 20:28:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:28:22 INFO - 'LOGNAME': 'cltbld', 20:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:22 INFO - 'MOZ_NO_REMOTE': '1', 20:28:22 INFO - 'NO_EM_RESTART': '1', 20:28:22 INFO - 'PAGER': '/bin/cat', 20:28:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:22 INFO - 'PWD': '/builds/slave/test', 20:28:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:28:22 INFO - 'SHELL': '/bin/bash', 20:28:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E5j14vST24/Listeners', 20:28:22 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 20:28:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:28:22 INFO - 'USER': 'cltbld', 20:28:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:28:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:22 INFO - 'XPC_FLAGS': '0x0', 20:28:22 INFO - 'XPC_SERVICE_NAME': '0', 20:28:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:28:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:28:23 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 20:28:23 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 20:28:23 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 20:28:23 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 20:28:23 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 20:28:23 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 20:28:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:28:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:28:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:28:26 INFO - Installing collected packages: mozsystemmonitor 20:28:26 INFO - Running setup.py install for mozsystemmonitor 20:28:26 INFO - Successfully installed mozsystemmonitor 20:28:26 INFO - Cleaning up... 20:28:26 INFO - Return code: 0 20:28:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:28:26 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')]} 20:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:26 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')]} 20:28:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:26 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 0x105457a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054ec618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f897b5a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053bbd30>, '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 0x105120db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053b3b20>, '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.fIquJkjZd1/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.E5j14vST24/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 20:28:26 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 20:28:26 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 20:28:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fIquJkjZd1/Render', 20:28:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:28:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:28:26 INFO - 'HOME': '/Users/cltbld', 20:28:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:28:26 INFO - 'LOGNAME': 'cltbld', 20:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:26 INFO - 'MOZ_NO_REMOTE': '1', 20:28:26 INFO - 'NO_EM_RESTART': '1', 20:28:26 INFO - 'PAGER': '/bin/cat', 20:28:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:26 INFO - 'PWD': '/builds/slave/test', 20:28:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:28:26 INFO - 'SHELL': '/bin/bash', 20:28:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E5j14vST24/Listeners', 20:28:26 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 20:28:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:28:26 INFO - 'USER': 'cltbld', 20:28:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:28:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:26 INFO - 'XPC_FLAGS': '0x0', 20:28:26 INFO - 'XPC_SERVICE_NAME': '0', 20:28:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:26 INFO - Downloading/unpacking jsonschema==2.5.1 20:28:26 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 20:28:26 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 20:28:26 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 20:28:26 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 20:28:26 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 20:28:26 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 20:28:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:28:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:28:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:28:29 INFO - Downloading functools32-3.2.3-2.tar.gz 20:28:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:28:29 INFO - warning: no files found matching '*.txt' 20:28:29 INFO - no previously-included directories found matching 'build' 20:28:29 INFO - no previously-included directories found matching 'dist' 20:28:29 INFO - no previously-included directories found matching '.git*' 20:28:29 INFO - Installing collected packages: jsonschema, functools32 20:28:29 INFO - Running setup.py install for functools32 20:28:30 INFO - warning: no files found matching '*.txt' 20:28:30 INFO - no previously-included directories found matching 'build' 20:28:30 INFO - no previously-included directories found matching 'dist' 20:28:30 INFO - no previously-included directories found matching '.git*' 20:28:30 INFO - Successfully installed jsonschema functools32 20:28:30 INFO - Cleaning up... 20:28:30 INFO - Return code: 0 20:28:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105457a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054ec618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f897b5a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053bbd30>, '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 0x105120db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053b3b20>, '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.fIquJkjZd1/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.E5j14vST24/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 20:28:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:28:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:28:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fIquJkjZd1/Render', 20:28:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:28:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:28:30 INFO - 'HOME': '/Users/cltbld', 20:28:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:28:30 INFO - 'LOGNAME': 'cltbld', 20:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:30 INFO - 'MOZ_NO_REMOTE': '1', 20:28:30 INFO - 'NO_EM_RESTART': '1', 20:28:30 INFO - 'PAGER': '/bin/cat', 20:28:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:30 INFO - 'PWD': '/builds/slave/test', 20:28:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:28:30 INFO - 'SHELL': '/bin/bash', 20:28:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E5j14vST24/Listeners', 20:28:30 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 20:28:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:28:30 INFO - 'USER': 'cltbld', 20:28:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:28:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:30 INFO - 'XPC_FLAGS': '0x0', 20:28:30 INFO - 'XPC_SERVICE_NAME': '0', 20:28:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:28:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:28:30 INFO - Cleaning up... 20:28:30 INFO - Return code: 0 20:28:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105457a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054ec618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f897b5a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053bbd30>, '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 0x105120db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053b3b20>, '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.fIquJkjZd1/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.E5j14vST24/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 20:28:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:28:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:28:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fIquJkjZd1/Render', 20:28:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:28:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:28:30 INFO - 'HOME': '/Users/cltbld', 20:28:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:28:30 INFO - 'LOGNAME': 'cltbld', 20:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:30 INFO - 'MOZ_NO_REMOTE': '1', 20:28:30 INFO - 'NO_EM_RESTART': '1', 20:28:30 INFO - 'PAGER': '/bin/cat', 20:28:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:30 INFO - 'PWD': '/builds/slave/test', 20:28:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:28:30 INFO - 'SHELL': '/bin/bash', 20:28:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E5j14vST24/Listeners', 20:28:30 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 20:28:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:28:30 INFO - 'USER': 'cltbld', 20:28:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:28:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:30 INFO - 'XPC_FLAGS': '0x0', 20:28:30 INFO - 'XPC_SERVICE_NAME': '0', 20:28:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:28:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:30 INFO - Downloading/unpacking blobuploader==1.2.4 20:28:30 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 20:28:30 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 20:28:30 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 20:28:30 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 20:28:30 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 20:28:30 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 20:28:33 INFO - Downloading blobuploader-1.2.4.tar.gz 20:28:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:28:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:28:33 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 20:28:33 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 20:28:33 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 20:28:33 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 20:28:33 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 20:28:33 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 20:28:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:28:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:28:33 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 20:28:33 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 20:28:33 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 20:28:33 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 20:28:33 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 20:28:33 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 20:28:34 INFO - Downloading docopt-0.6.1.tar.gz 20:28:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:28:34 INFO - Installing collected packages: blobuploader, requests, docopt 20:28:34 INFO - Running setup.py install for blobuploader 20:28:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:28:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:28:34 INFO - Running setup.py install for requests 20:28:35 INFO - Running setup.py install for docopt 20:28:35 INFO - Successfully installed blobuploader requests docopt 20:28:35 INFO - Cleaning up... 20:28:35 INFO - Return code: 0 20:28:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:28:35 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')]} 20:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:35 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')]} 20:28:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:35 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 0x105457a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054ec618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f897b5a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053bbd30>, '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 0x105120db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053b3b20>, '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.fIquJkjZd1/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.E5j14vST24/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 20:28:35 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 20:28:35 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 20:28:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fIquJkjZd1/Render', 20:28:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:28:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:28:35 INFO - 'HOME': '/Users/cltbld', 20:28:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:28:35 INFO - 'LOGNAME': 'cltbld', 20:28:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:35 INFO - 'MOZ_NO_REMOTE': '1', 20:28:35 INFO - 'NO_EM_RESTART': '1', 20:28:35 INFO - 'PAGER': '/bin/cat', 20:28:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:28:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:35 INFO - 'PWD': '/builds/slave/test', 20:28:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:28:35 INFO - 'SHELL': '/bin/bash', 20:28:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E5j14vST24/Listeners', 20:28:35 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 20:28:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:28:35 INFO - 'USER': 'cltbld', 20:28:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:28:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:28:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:35 INFO - 'XPC_FLAGS': '0x0', 20:28:35 INFO - 'XPC_SERVICE_NAME': '0', 20:28:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:28:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:28:35 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-v4iuyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:28:35 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-i9ovgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:28:35 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-LxxkYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:28:35 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-4B7_hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:28:35 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-l_1g4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:28:36 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-3r_PU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:28:36 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-imOGFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:28:36 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-IOV5jA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:28:36 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-YNHrls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:28:36 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-pOpAUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:28:36 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-UHyxrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:28:36 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-mVng4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:28:36 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-xPv5r1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:28:36 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-vsDFfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:28:37 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-zAgYyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:28:37 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-zyHObm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:28:37 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-2m0Vuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:28:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:28:37 INFO - Running setup.py install for manifestparser 20:28:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:28:37 INFO - Running setup.py install for mozcrash 20:28:37 INFO - Running setup.py install for mozdebug 20:28:37 INFO - Running setup.py install for mozdevice 20:28:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:28:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:28:37 INFO - Running setup.py install for mozfile 20:28:38 INFO - Running setup.py install for mozhttpd 20:28:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:28:38 INFO - Running setup.py install for mozinfo 20:28:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:28:38 INFO - Running setup.py install for mozInstall 20:28:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:28:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:28:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:28:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:28:38 INFO - Running setup.py install for mozleak 20:28:38 INFO - Running setup.py install for mozlog 20:28:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:28:38 INFO - Running setup.py install for moznetwork 20:28:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:28:38 INFO - Running setup.py install for mozprocess 20:28:39 INFO - Running setup.py install for mozprofile 20:28:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:28:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:28:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:28:39 INFO - Running setup.py install for mozrunner 20:28:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:28:39 INFO - Running setup.py install for mozscreenshot 20:28:39 INFO - Running setup.py install for moztest 20:28:39 INFO - Running setup.py install for mozversion 20:28:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:28:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:28:39 INFO - Cleaning up... 20:28:39 INFO - Return code: 0 20:28:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:28:39 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')]} 20:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:39 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')]} 20:28:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:39 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 0x105457a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054ec618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f897b5a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053bbd30>, '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 0x105120db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053b3b20>, '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.fIquJkjZd1/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.E5j14vST24/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 20:28:39 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 20:28:39 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 20:28:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fIquJkjZd1/Render', 20:28:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:28:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:28:39 INFO - 'HOME': '/Users/cltbld', 20:28:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:28:39 INFO - 'LOGNAME': 'cltbld', 20:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:39 INFO - 'MOZ_NO_REMOTE': '1', 20:28:39 INFO - 'NO_EM_RESTART': '1', 20:28:39 INFO - 'PAGER': '/bin/cat', 20:28:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:28:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:39 INFO - 'PWD': '/builds/slave/test', 20:28:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:28:39 INFO - 'SHELL': '/bin/bash', 20:28:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E5j14vST24/Listeners', 20:28:39 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 20:28:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:28:39 INFO - 'USER': 'cltbld', 20:28:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:28:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:39 INFO - 'XPC_FLAGS': '0x0', 20:28:39 INFO - 'XPC_SERVICE_NAME': '0', 20:28:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:28:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:28:40 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-bXbvpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:28:40 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)) 20:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:28:40 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-mpACmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:28:40 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)) 20:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:28:40 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-ae9Nho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:28:40 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)) 20:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:28:40 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-UBYhQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:28:40 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)) 20:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:28:40 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-O0pZjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:28:40 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)) 20:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:28:40 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-RNl5Js-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:28:40 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)) 20:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:28:40 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-HRZwEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:28:40 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)) 20:28:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:28:40 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-BLNtyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:28:41 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)) 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:28:41 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-bSbOhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:28:41 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)) 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:28:41 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-IX30xU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:28:41 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)) 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:28:41 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-20xyVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:28:41 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)) 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:28:41 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-arEyaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:28:41 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)) 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:28:41 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-yhErd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:28:41 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)) 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:28:41 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-Ny2MsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:28:41 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)) 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:28:41 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-TqHNWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:28:41 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)) 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:28:41 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-fWUn4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:28:41 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)) 20:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:28:41 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-ebaIxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:28:42 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)) 20:28:42 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)) 20:28:42 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)) 20:28:42 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)) 20:28:42 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)) 20:28:42 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)) 20:28:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:28:42 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 20:28:42 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 20:28:42 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 20:28:42 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 20:28:42 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 20:28:42 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 20:28:44 INFO - Downloading blessings-1.6.tar.gz 20:28:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:28:44 INFO - Installing collected packages: blessings 20:28:44 INFO - Running setup.py install for blessings 20:28:44 INFO - Successfully installed blessings 20:28:44 INFO - Cleaning up... 20:28:44 INFO - Return code: 0 20:28:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:28:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:28:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:28:45 INFO - Reading from file tmpfile_stdout 20:28:45 INFO - Current package versions: 20:28:45 INFO - blessings == 1.6 20:28:45 INFO - blobuploader == 1.2.4 20:28:45 INFO - docopt == 0.6.1 20:28:45 INFO - functools32 == 3.2.3-2 20:28:45 INFO - jsonschema == 2.5.1 20:28:45 INFO - manifestparser == 1.1 20:28:45 INFO - mozInstall == 1.12 20:28:45 INFO - mozcrash == 0.17 20:28:45 INFO - mozdebug == 0.1 20:28:45 INFO - mozdevice == 0.48 20:28:45 INFO - mozfile == 1.2 20:28:45 INFO - mozhttpd == 0.7 20:28:45 INFO - mozinfo == 0.9 20:28:45 INFO - mozleak == 0.1 20:28:45 INFO - mozlog == 3.3 20:28:45 INFO - moznetwork == 0.27 20:28:45 INFO - mozprocess == 0.23 20:28:45 INFO - mozprofile == 0.28 20:28:45 INFO - mozrunner == 6.12 20:28:45 INFO - mozscreenshot == 0.1 20:28:45 INFO - mozsystemmonitor == 0.3 20:28:45 INFO - moztest == 0.7 20:28:45 INFO - mozversion == 1.4 20:28:45 INFO - psutil == 3.1.1 20:28:45 INFO - requests == 1.2.3 20:28:45 INFO - wsgiref == 0.1.2 20:28:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:28:45 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')]} 20:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:45 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')]} 20:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:45 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 0x105457a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054ec618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f897b5a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053bbd30>, '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 0x105120db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053b3b20>, '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.fIquJkjZd1/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.E5j14vST24/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 20:28:45 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 20:28:45 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 20:28:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fIquJkjZd1/Render', 20:28:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:28:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:28:45 INFO - 'HOME': '/Users/cltbld', 20:28:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:28:45 INFO - 'LOGNAME': 'cltbld', 20:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:45 INFO - 'MOZ_NO_REMOTE': '1', 20:28:45 INFO - 'NO_EM_RESTART': '1', 20:28:45 INFO - 'PAGER': '/bin/cat', 20:28:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:45 INFO - 'PWD': '/builds/slave/test', 20:28:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:28:45 INFO - 'SHELL': '/bin/bash', 20:28:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E5j14vST24/Listeners', 20:28:45 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 20:28:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:28:45 INFO - 'USER': 'cltbld', 20:28:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:28:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:45 INFO - 'XPC_FLAGS': '0x0', 20:28:45 INFO - 'XPC_SERVICE_NAME': '0', 20:28:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:45 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)) 20:28:45 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)) 20:28:45 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)) 20:28:45 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)) 20:28:45 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)) 20:28:45 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)) 20:28:45 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)) 20:28:45 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)) 20:28:45 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)) 20:28:45 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)) 20:28:45 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)) 20:28:45 INFO - Cleaning up... 20:28:45 INFO - Return code: 0 20:28:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:28:45 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')]} 20:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:45 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')]} 20:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:45 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 0x105457a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054ec618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f897b5a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053bbd30>, '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 0x105120db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053b3b20>, '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.fIquJkjZd1/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.E5j14vST24/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 20:28:45 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 20:28:45 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 20:28:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fIquJkjZd1/Render', 20:28:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:28:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:28:45 INFO - 'HOME': '/Users/cltbld', 20:28:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:28:45 INFO - 'LOGNAME': 'cltbld', 20:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:45 INFO - 'MOZ_NO_REMOTE': '1', 20:28:45 INFO - 'NO_EM_RESTART': '1', 20:28:45 INFO - 'PAGER': '/bin/cat', 20:28:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:45 INFO - 'PWD': '/builds/slave/test', 20:28:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:28:45 INFO - 'SHELL': '/bin/bash', 20:28:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E5j14vST24/Listeners', 20:28:45 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 20:28:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:28:45 INFO - 'USER': 'cltbld', 20:28:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:28:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:45 INFO - 'XPC_FLAGS': '0x0', 20:28:45 INFO - 'XPC_SERVICE_NAME': '0', 20:28:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:28:45 INFO - Cleaning up... 20:28:45 INFO - Return code: 0 20:28:45 INFO - Running post-action listener: _resource_record_post_action 20:28:45 INFO - Running post-action listener: _start_resource_monitoring 20:28:45 INFO - Starting resource monitoring. 20:28:45 INFO - [mozharness: 2016-08-20 03:28:45.679447Z] Finished create-virtualenv step (success) 20:28:45 INFO - [mozharness: 2016-08-20 03:28:45.680418Z] Running install step. 20:28:45 INFO - Running pre-action listener: _resource_record_pre_action 20:28:45 INFO - Running main action method: install 20:28:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:28:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:28:45 INFO - Reading from file tmpfile_stdout 20:28:45 INFO - Detecting whether we're running mozinstall >=1.0... 20:28:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:28:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:28:46 INFO - Reading from file tmpfile_stdout 20:28:46 INFO - Output received: 20:28:46 INFO - Usage: mozinstall [options] installer 20:28:46 INFO - Options: 20:28:46 INFO - -h, --help show this help message and exit 20:28:46 INFO - -d DEST, --destination=DEST 20:28:46 INFO - Directory to install application into. [default: 20:28:46 INFO - "/builds/slave/test"] 20:28:46 INFO - --app=APP Application being installed. [default: firefox] 20:28:46 INFO - mkdir: /builds/slave/test/build/application 20:28:46 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'] 20:28:46 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 20:29:20 INFO - Reading from file tmpfile_stdout 20:29:20 INFO - Output received: 20:29:20 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:29:20 INFO - Running post-action listener: _resource_record_post_action 20:29:20 INFO - [mozharness: 2016-08-20 03:29:20.577326Z] Finished install step (success) 20:29:20 INFO - [mozharness: 2016-08-20 03:29:20.577430Z] Running run-tests step. 20:29:20 INFO - Running pre-action listener: _resource_record_pre_action 20:29:20 INFO - Running main action method: run_tests 20:29:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:29:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:29:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:29:20 INFO - 2016-08-19 20:29:20.592 screenresolution[1657:8497] starting screenresolution argv=screenresolution get 20:29:20 INFO - 2016-08-19 20:29:20.594 screenresolution[1657:8497] Display 0: 1600x1200x32@60 20:29:20 INFO - 2016-08-19 20:29:20.600 screenresolution[1658:8499] starting screenresolution argv=screenresolution list 20:29:20 INFO - Available Modes on Display 0 20:29:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:29:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:29:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:29:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:29:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:29:20 INFO - Intel Iris: 20:29:20 INFO - Chipset Model: Intel Iris 20:29:20 INFO - Type: GPU 20:29:20 INFO - Bus: Built-In 20:29:20 INFO - VRAM (Dynamic, Max): 1536 MB 20:29:20 INFO - Vendor: Intel (0x8086) 20:29:20 INFO - Device ID: 0x0a2e 20:29:20 INFO - Revision ID: 0x0009 20:29:20 INFO - Displays: 20:29:20 INFO - Display: 20:29:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:29:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:29:20 INFO - Display Serial Number: 1600x1200 60 20:29:20 INFO - Main Display: Yes 20:29:20 INFO - Mirror: Off 20:29:20 INFO - Online: Yes 20:29:20 INFO - Rotation: Supported 20:29:20 INFO - Return code: 0 20:29:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:29:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:29:20 INFO - Python 2.7.3 20:29:20 INFO - Return code: 0 20:29:20 INFO - grabbing minidump binary from tooltool 20:29:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:29:20 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 0x1053bbd30>, '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 0x105120db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053b3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:29:20 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 20:29:20 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 20:29:20 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 20:29:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:29:20 INFO - Return code: 0 20:29:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:29:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:29:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:29:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:29:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:29:20 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NiLmUKs2SpmIFerD9APJTw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0181', '--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 20:29:20 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NiLmUKs2SpmIFerD9APJTw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0181 --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 20:29:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fIquJkjZd1/Render', 20:29:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:29:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:29:20 INFO - 'HOME': '/Users/cltbld', 20:29:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:29:20 INFO - 'LOGNAME': 'cltbld', 20:29:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:29:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:29:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:29:20 INFO - 'MOZ_NO_REMOTE': '1', 20:29:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:29:20 INFO - 'NO_EM_RESTART': '1', 20:29:20 INFO - 'PAGER': '/bin/cat', 20:29:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:29:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:29:20 INFO - 'PWD': '/builds/slave/test', 20:29:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:29:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:29:20 INFO - 'SHELL': '/bin/bash', 20:29:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.E5j14vST24/Listeners', 20:29:20 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 20:29:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:29:20 INFO - 'USER': 'cltbld', 20:29:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:29:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:29:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:29:20 INFO - 'XPC_FLAGS': '0x0', 20:29:20 INFO - 'XPC_SERVICE_NAME': '0', 20:29:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:29:20 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NiLmUKs2SpmIFerD9APJTw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0181', '--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 20:29:21 INFO - mozversion application_buildid: 20160819181715 20:29:21 INFO - mozversion application_changeset: f97a056ae6235de7855fd8aaa04fb1c8d183bd06 20:29:21 INFO - mozversion application_display_name: Nightly 20:29:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:29:21 INFO - mozversion application_name: Firefox 20:29:21 INFO - mozversion application_remotingname: firefox 20:29:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:29:21 INFO - mozversion application_vendor: Mozilla 20:29:21 INFO - mozversion application_version: 51.0a1 20:29:21 INFO - mozversion platform_buildid: 20160819181715 20:29:21 INFO - mozversion platform_changeset: f97a056ae6235de7855fd8aaa04fb1c8d183bd06 20:29:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:29:21 INFO - mozversion platform_version: 51.0a1 20:29:21 INFO - using testdate: 1471663761 20:29:21 INFO - actual date: 1471663761 20:29:21 INFO - starting webserver on 'localhost:49268' 20:29:21 INFO - SUITE-START | Running 2 tests 20:29:21 INFO - TEST-START | dromaeo_css 20:29:21 INFO - operating with platform_type : mac_ 20:29:21 INFO - Initialising browser for dromaeo_css test... 20:29:21 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmpzR0Dny/profile http://localhost:49268/getInfo.html) 20:29:24 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 20:29:24 INFO - PROCESS | 1668 | colorDepth:24 20:29:24 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 20:29:24 INFO - PROCESS | 1668 | __metrics 20:29:24 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3061: TypeError: this.tabs is undefined 20:29:24 INFO - TEST-INFO | 1668: exit 0 20:29:24 INFO - Browser initialized. 20:29:24 INFO - Running cycle 1/1 for dromaeo_css test... 20:29:24 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmpzR0Dny/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:29:36 INFO - PROCESS | 1671 | RSS: Main: 239935488 20:29:36 INFO - PROCESS | 1671 | 20:30:26 INFO - PROCESS | 1671 | 1471663826398 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] 20:32:38 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49268/tests/dromaeo/cssquery-ext.html) 20:32:40 INFO - PROCESS | 1671 | RSS: Main: 254676992 20:32:40 INFO - PROCESS | 1671 | 20:35:42 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-ext.html (next: http://localhost:49268/tests/dromaeo/cssquery-jquery.html) 20:35:43 INFO - PROCESS | 1671 | RSS: Main: 266838016 20:35:43 INFO - PROCESS | 1671 | 20:38:44 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49268/tests/dromaeo/cssquery-mootools.html) 20:38:45 INFO - PROCESS | 1671 | RSS: Main: 271642624 20:38:45 INFO - PROCESS | 1671 | 20:41:47 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49268/tests/dromaeo/cssquery-prototype.html) 20:41:48 INFO - PROCESS | 1671 | RSS: Main: 272052224 20:41:48 INFO - PROCESS | 1671 | 20:44:50 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49268/tests/dromaeo/cssquery-yui.html) 20:44:51 INFO - PROCESS | 1671 | RSS: Main: 277303296 20:44:51 INFO - PROCESS | 1671 | 20:47:54 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-yui.html (next: http://localhost:49268/tests/dromaeo/cssquery-dojo.html) 20:47:54 INFO - PROCESS | 1671 | RSS: Main: 279908352 20:47:54 INFO - PROCESS | 1671 | 20:47:54 INFO - PROCESS | 1671 | __start_tp_report 20:47:54 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 20:47:54 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 20:47:54 INFO - PROCESS | 1671 | |i|pagename|runs| 20:47:54 INFO - PROCESS | 1671 | |0;dojo.html;2845.3029007893065;3441.62142164362;3442.2254992626663;3451.6375780543044;3466.324066806973;5554.333479982408;5668;5804.100364443508;5894.970525147368;5940.613860099091;5738.713064346776;5744.971275143629;5749.396313387097;5789.247397838275;5868.442497962697;5199.168133098705;5308.654937429054;5320.654157479771;5369.19462080689;5378.005069062236;5382.703951282678;5396.055690254209;5396.325459317585;5414.242006119146;5458.918116228259;4041.4139949707424;5030.647854650176;5158.097332966753;5196.818111366084;5311.468853114697;5191.039657663345;5243.501867322599;5262.578993680497;5281.603879709037;5296.523312901857;4374.300111982067;5267.683938963636;5269.973650131763;5303.124984377611;5344.9577332420195;5674.290713660793;5683.829485115453;5763.6541807491685;5788.6816225107605;5848.064309710426;5719.399463056361;6194.194754681907;6212.0371342441995;6232.9376706232815;6273.05904114382;4863.927041094386;5007;5376.623636345457;6276.811695649092;6281.466075383598;4905.55849973497;4980.252962055684;5693.516051135658;5894.705264736746;5928.822135335947;5404.945950540523;6277.78027769035;6336.04959256106;6348.301686814447;6360.52296077796;5274.393444753902;6180.845478863064;6208.534359923024;6283.554782400073;6298.527610429236;5528.143137813645;6193.6903154842075;6196.349383314777;6215.223097112861;6243.469305109026;6181.7527298908435;6246.469050130699;6256.43692067707;6266.905996409966;6282.560220784501;6106.572539922252;6207.503399728011;6220.657863817443;6248.28144763349;6248.593841400385;4894.339264199359;4995.300657907896;5018.548330650259;5075.7969681212335;5083.847484575469;4454.28731402974;4499.302608095751;4508.301213311942;4523.11799199153;4544.590986811203;5753.108268218349;5860.355360910296;5873.415697093265;5877.441643043904;5878.3239927408895;6166.229221347332;6188.752449901954;6194.659293738888;6241.625502469867;6284.780032698925;5856.975029369928;5861.5603829712945;5878.941210587925;5895.145203945404;5920.526357891358;5485.6434331768305;5488.725563721798;5510.724463776795;5516.806911758069;5530.778768849201;6181.660008699565;6285.811425657238;6292.465140463112;6375.6174629522375;6386.776462823872;6247.187865577446;6256.186695729526;6258;6260.092286618324;6260.373962603703;5532.78278778668;6317.241930968313;6343.429091381798;6349.174607301022;6377.202849643794;5186.507281808223;5234.319538459976;6090.878182436415;6208.2239720034995;6276.1840960676645;5867.530597552271;6167.321594624677;6210.5031597473;6231.719572619152;6256.624602523863;6150.661713605795;6178.5366097543765;6218.22272215973;6241.656708881055;6265.154204182377;5953.76184952597;5997.400259973968;6056.031035034373;6125.877482450415;6153.600015998945;5084.3644544431945;5945.137954996415;6085.817425477243;6094.847628809315;6121.540884433774;6199.039148931923;6211.937880621317;6224.470919971672;6242.344553821965;6255.40573645503;5854.2389489366105;5941.851453713692;5979.402059793986;6112.266528016488;6131.570790044654 20:47:54 INFO - PROCESS | 1671 | |1;ext.html;489.23679060665364;508.2198824803927;525.1204232909877;534.6364472158936;565.2849145830528;39481.40777888334;40226.1954760905;41974;42154.57845421545;42300.153996920046;42744.3588346175;43280.56719432805;43504.91237719059;43523;43708.56291437085;8920.420172688755;9512.714618561455;9617.567209475574;10495.632652857152;12215.633530994084;10671.82609912909;11478.540858365697;11952.7609447811;12045.578404755835;12088.637340879744;12044.879551204463;12076.275423474619;12090.274583524973;12093.697657558543;12115.878841211606;11966.042716582653;12124;12167.939160304186;12173.756524869454;12175;8940.687075952375;11858.991985681227;12126.696832579168;12157.270563766115;12234.632961011184;40394.39408408876;41015.794921025205;41015.7949210255;41244.38133427971;43196.568034319884;3466.7053300469493;3519.6128425873135;3542.929141417183;3811.3330167220624;4046.5548789633117;31889.84055079733;32530.349393012242;32544.6745532544;32654.836725816218;32692.673073269438;3249.46383846665;3388.6950174484414;3446.3107378524146;3449.9482507762405;3458.2737625098757;488063;491598;492116;492233;493097;61574;61697.69151154216;62117;62117;62169;63156;63302.36697632965;63428.68285658542;63455.365446345866;63618.36381636217;16072.67854642924;16137.677246455005;16164.838351616569;16262.75605865913;16286.185690715416;12516.561920332744;12609.243445393306;12611.306378149106;12650.30423326726;12670.429830657642;13593.864061359458;17001.40495082691;17026.489205323862;17116.972981621144;17162.39931602388;6710.295418981034;6796.898046529306;6800.625965571941;6817.284185160586;6843.520953533304;851.5571902610608;857.2156476823636;945.550863339908;1001.6944831826363;1057.349729916096;24076.638850417257;26977.86511067432;30559.20084226935;30638.846805766276;31205;1015.1827778638119;1036.549101141006;1063.2982231727024;1102.2064113838023;1162.68607475981;15817.604559886095;16034.839651603335;16068.276927538054;16256.349746010028;16319.83680163183;616018;623101.8844905746;625130;625626;626158.7765040023;60573;60697.69651151716;60738.696306519065;60740;61000;1107.883672214422;1283.5828355784408;1395.413926151019;1427.364822653909;1433.068505471431;25728.742712573385;29123.271918202216;30954.845225773726;31161.5631973683;31352.843235783675;53278;53294.93410131698;53496.465035349145;53656.73171634117;53710;500046;568907;570498;575664;576017;41931.58068419277;42301.78849105858;42349.36475952801;42558;43068;48887.755561221966;49617.751911240215;50426.991460169855;50829.745851270505;50973.49026509687;39967;40089.799551002056;40261.19477610373;40730;41278;39752.40371394489;40345.798271008454;40456;40649.79675101605;41821.79089104535;33119.337613248084;39076;39338.409923850595;39398.80300598479;39790.2041959165;34402.82798585991;35148.648513514534;36073;36090.09774755652;36127.45808812817;25434.364140896625;25946.22161335163;26090;26154.346141346618;26258.737412626393 20:47:54 INFO - PROCESS | 1671 | |2;jquery.html;364.64447164015087;370.1265014565626;381.7213434193038;385.2833729263571;402.14945390499105;16277;19584.51038724031;20464.07911643976;21722.3483295501;21953.560928781433;20871.956402179905;20905.581888362223;21043.68434473484;21600;21724.8913755431;5862.794802181914;6064.72708728106;6138.232720909887;6143.569950103494;6157;5982.162497250389;6024.638521688691;6077.665728384959;6091.451769340759;6127.877442451148;5906.232189815318;6020.247469066367;6030.939690603103;6072.2106126203535;6084.452399284063;5924.526037916978;5971.910421343661;6023.337432882379;6025.9096113558335;6042.335343112254;5208.192730126836;5237.47625237477;5258.710770907599;5262.973720124577;5266.4733526647415;26078;26787.732122678717;27009.054683085997;27216.183514494398;27555.86222068897;2385.9642105368434;2416.3355077353867;2445.08309383981;2465.8027357811334;2500.712418071909;15612.141332226724;15713.92143039289;15750.527484175493;15782.447614333443;15945.362185512566;1788.2131861980688;1801.5135913303466;1866.150901339887;1872.9906350468161;1905.6812188398742;115533;118557;118800.8119918807;119028;121747.391263044;10704.411257380918;10818.24272300947;11233;11464.25482343645;11631.59289424866;12078.637640870787;12846.614601561969;14026.22855742944;14044.71910561783;14091.929540352232;8294.958525207336;8403.831923361498;8545.957270213608;8625.870611940825;8742.08208138149;8622.353323500762;8645.135486451305;8661.870071948926;8731.56342182901;8808.603612837309;5796.913046304308;6686.531942764057;6800.557963732342;6819.522633415712;6857.897131543031;1663.4178037686954;1748.326894145763;1837.61410103877;1883.0772921268754;1919.7984211657574;870.4777133719845;896.2247655777705;952.5284983932997;989.4706332112429;1035.7255327338262;19240.4227873164;19560;21167.68248476274;22373.993170307374;22673.979670914847;924.7179610218948;946.5314669238771;987.693814917378;1033.6537260017978;1060.6977011551671;11537.961583457529;11925.165238433226;12084.335361555199;12140.514379424902;12185.87814121865;619452;620939;621514;643132.7060188202;644512;119340.40329798295;122866;127632.36183819022;128414;130030;1020.9795804084025;1025.8922813104666;1042.5464922758624;1048.7378155461136;1051.4164638625484;17249.655006900044;19483;19549.924754138658;19963.60072798565;20330.695039574715;32288.70845166261;34569.82715086408;51242;51382.201622943016;52389.69025774386;71229.6438517804;81386.18613813785;82399;83405;90989;7677.424193185645;7998;8185.79535511617;8209.671613135646;8264.049634291892;9171.54142292896;12395.62813115608;12935.935320323715;13088.952883769465;13485.190888546718;9336.439813611205;11473.254238474472;11732.70668233301;11739.47172377228;11793.056555475712;10286.2799604027;11370.147238957277;11537.423128843357;11741.354225517678;11928.76142477163;11567;11608.361540115375;11677.182597218112;11939.46272417726;11982.281063136239;5321.3880403754065;7075.929240707527;7318.1949985502615;7486.251374862688;8258.876116858371;8937.374383793072;10908.072813810915;11167.776644467227;11270.661880143609;11319.773604528027 20:47:54 INFO - PROCESS | 1671 | |3;mootools.html;1326.1711430356033;1398.6713122416236;1459.5694270190293;1516.2957659451347;1523.824760152582;7855.764327070197;8301.086880443147;8340.3744719146;8858.025617182106;8877.822443551126;8343.74968750937;8509.702160424386;8602;8622.525761083154;8634.48193108414;2320.6170981788027;2360.976390236093;2375.061850569024;2376.560336337783;2382.523495300938;2137.2626443876916;2233.687283780264;2349.447879748258;2376.4296568823443;2384.856908585482;2013.7281467001987;2089.7879230046537;2092.675635276527;2363.763623637631;2392.5812982727953;2355.623100303943;2357.104300365867;2358;2369.7748713872156;2388.8924998375114;2362.7637236276237;2364.113457453455;2368.9289321320216;2371.4190023444194;2373.2642880706862;7346.338829505316;8540.701075462392;8683.956580217122;8727.519986400745;8779.165979231962;4577.58094990554;5102.846914592568;5335.386430560497;5356.651817631841;5359.517643412073;3501.6673416025437;3538.1331573764337;3675.0628589709722;3680.8895733127783;3692.0463629096616;1081.4700796609684;1113.7549739057476;1117.1788735279563;1137.7553825927466;1140.1278022312938;11284.605038823684;11311.038561722264;11375.431228438627;11457.65627031182;11468.71328216793;4078.5513593504693;4130.471725461538;4562.931556026662;4780.808767649255;4813;8477.618507167192;8575.828483430296;8939.418937769024;9876.259280553988;9933;5323.467653234646;5335.253064570963;5339.973300133474;5349.973250133725;5358.276632654542;3868.6905047596124;4351.12977404514;4826.32431459596;4859.1010663027455;4869.9269510957365;3904.5314562252142;3966.464527288837;4012.578679238696;4058.553559108496;4061.898452538651;1190.7618476304774;1239.4794186441716;1280.8911242544302;1305.4712841299288;1326.2374134872487;776.9549955310099;799.8760192170223;841.7558907916635;846.9830603387898;894.5974311559825;5703.7148142592705;5706.42935706426;5861.20873682056;5898.587098903035;5996.940030599725;429.84310726584573;432.9848455304049;440.4604359659456;441.3622315753705;453.1955778493201;3210.2455922858576;3765.755225910307;3808.5239345081864;3915.393114067324;3977.244323578511;10092.545835437422;10403.687889363331;10492.21308401873;10508.684739457829;10518.631847885288;10450;10472.266941314036;10494.73763155912;10500.212484063726;10523.315984460985;7526.623668816537;7842.5686587237105;7975.1626079262005;8091.393145513992;8135.593220338959;4685.344051832678;5799.942000580109;5870.324912635102;6053.878922421439;6066.908996365147;9487.478188699688;9674.129328360481;9824.55789489489;9835.606575737176;9929.553170107218;8484.278836298983;8528.27509661661;9610.819293607303;9913.603455861974;9976.60093596248;6807.047013418224;7228.241034691282;7393.297636724503;7510.361619262424;7528.322450979438;8159.755207343789;8245.752627421187;8259.050209226016;8265.049519305358;8270.462419942685;7207.13514378278;7274;7341.889871651822;7407.703691852265;7433.962830185815;7143.035690181967;7163.570185788869;7169.455339854112;7208.135023796968;7231.819204519929;6778.423833974168;6785.08401365829;6869.107016088076;6877.071595334566;6887.793366199022;4243.278642630698;4860.343853579721;4902.117618828645;4942.851714448572;4986.650934434555;3914.393269043303;4817.9518204818905;4896.6327525436445;5003.274525193754;5074.67014644047 20:47:54 INFO - PROCESS | 1671 | |4;prototype.html;270.4968758109916;300.50866832728485;300.83604435582606;312.73730066743946;312.76855127205874;4897.240927656215;5135.871603209922;5238.030964271612;5429.185622156679;5495.340559132899;4587.541245875411;5516.986300000501;5550.47270509302;5605.691686957216;5610.793679358937;3524.259905419865;3525.0695474545955;4121.4848143982;4306.80619372129;4312.396264522969;3195.952060719091;3212.8032607555515;3940.586238444965;4177.707560470768;4347;3922.882313530599;4110.903439245991;4152.937705934413;4160.292750232453;4176.352665336863;3448.8620455181763;3583.9213256311277;4073.207788573018;4189.9999999999845;4228.809703563347;3603.783772973604;3604.18905746205;3606.891793246207;3611.747177697562;3650.1787097903025;4428.822847086113;5164.251183578398;5182.948170518284;5217.634765566412;5436.945630543683;3966.861159859391;4010.3984402339593;4699.929501057487;4789.760511974388;4817.289862098939;5188.549614506349;5638.519051617316;5933;5937.228160339171;5956.255468066492;3175.4442972479956;3326.417876871562;3833.3483307837732;3908.530976282836;3942.2115576884453;5087.211482220262;5146.716930568818;6086.786962456293;6221.951243890507;6232.3144454110015;3964.960350396517;3976.1848820991627;3987.501562304712;4007.278689835799;4007.779572123561;3297.86808527661;3470.514128022079;3533.4876442916147;3810.8376945032032;4013.3578627419474;4048.6963477739287;4478.715854914018;4749.928751068667;4764.380630518011;4785.952140478551;5665.320161580555;5916.3787802281;5960.4635582797755;5960.582759206901;6019.969900150471;1164.6797130788932;1283.5828355784408;1288.9419976101099;1332.7134666046848;1347.1782212850153;744.9553026818409;843.1821133500495;881.3874357321728;886.2953951608487;892.9776755581032;4312.762798046075;5345.946540534623;5387.353517577916;5440;5443.42844001382;5071.692379967106;5319.191474898553;6017.849553761191;6029.914615369188;6034.668093254913;5054.342935418372;5115.820946266863;5163.819266325736;5346.518813306743;5437.483439073281;2214.933551993443;2644.444666619993;2673.3667337672377;2679.3837417394107;2682.5305571524905;4816.566509014206;4886.996331504066;4927.728974906343;4941.678790878582;5053.239307189807;4141.81361838718;4805.471398146201;4836.661433699677;4904;5011.822221777879;4867.028853314413;5142.382914050338;5179.772697740008;5254.684718916801;5300.720690103292;4335.200891629938;4621.77739154753;4821.649938017361;4906.55840974314;5116.388337673621;4403.4055402521535;4488.394066801071;4735.100330937111;5048.409750928446;5121.462246464068;4925.45819959797;5103.571000119972;5162.793488260578;5171.3535808024;5284.920726189033;3461.5653424123884;3480.416410533252;3484.9128771780906;3496.5454490916018;3498.73759468046;4410.757408342443;4638.53614638547;4700.576948074689;4926.975365123151;5048.444671086251;4498.505164431976;4667.906641867075;4899.265110233494;4926.48271931442;5002.349694539686;4931.72875491837;4931.966840393061;4976.278439626306;4982.900341993212;5003.4246061701915;3960.4851369321805;4645;4864.391951006124;4898.755062246944;4898.779554919965;4454.910901782011;4463.660901729533;4636.698614590041;4979.228219625964;4986.202207646759;3960.4455376247925;4859.829905953275;4860.17377045896;4866;4892.217245240744 20:47:54 INFO - PROCESS | 1671 | |5;yui.html;731.228553875661;735.8859376796596;785.242241237206;821.893153889995;824.9628766705499;15601.219939003047;16306.429274975379;16332.938359006655;16335.83664163358;16380.672386552262;14648.194349310783;14773.48292809752;14796.852031479682;14805.703885922276;14827.55517334479;668.4518694670372;822.112118911574;845.1168528887312;851.1786126388034;855.3242938078942;675.5777638975641;838.9848283576849;855.4183155454289;859.9871001934945;866.1814585216972;908.5548081440113;915.5193523400202;922.1562270522464;922.9953850230739;927.1192367251105;898.6495266845935;911.129870973219;914.3553794574809;914.419343716738;914.510736755839;666.8366250268667;672.5460314287836;675.1223409567592;677.4411110833582;677.9084823548857;14819.18494482803;15016.924915375463;15020.324085416074;15036.774448383283;15044.849551504454;14731.926340368336;14745.557633270912;14757.262136893112;14784.630384240372;14945.103293802407;11907.94046029773;12108.757824843542;12307.569235076819;12348.567800126952;12568.43442045101;3872.244912242114;3875.147467557133;4043.4945631796027;4096.692748043909;4099.221147981874;124460;126535;127358.72641273562;128635.71364286331;130429;11467.369294688706;11506.539738410538;11574.537018519333;11611.477483513263;11839.704007399712;23348.649770253458;23392.64911026302;23736.881315593313;23932.88033559856;23953;7562.621868906533;8041.2360825722635;8137.796555086052;8222.712205072794;8230;4503.887402814956;4631.444226692751;4639.652026098056;4645.442546894395;4669.486356500782;2964.3330250693853;3072.2319420144963;3077.2153100959113;3093.443180227536;3099.3336432666633;688.5868478912713;724.1238101896764;729.1323325242944;729.9854002920018;740.3595889555603;585.1807469542674;606.8732618196248;612.963222206669;671.1744554198364;698.7659134190002;8316.37627177964;9443.386179898285;9636.036396360309;9769.364991275545;9771.902280977241;665.55075324156;678.718331892269;690.7685925215009;699.3216579917472;717.7344382578375;4474.217012022948;4586.954130458719;4734.834280800224;4738.64460165489;4792.784324705397;102828.48585757024;145533;157006;164348.17825911034;165370.17314913348;136762.91968030037;139375;141434;141468;145317;94220;96170.9999999986;116620.67310576527;124452.75547244593;125336;7974.322182614543;9374.812503750023;9680.886698029817;9883.308168428428;10026.197904167795;44564.77717611391;47854.5214547864;60592;63338.73322533616;63645.363546363944;72996.54006919726;87606;90416;91227.54386228026;94519.52740236255;12791.552295669608;13079.934600326937;13096.148750331198;13168.736625267633;13260.867391325963;14715.92642036783;14778.48275310359;14817.629559261104;14847.257637118317;14912.179830109015;13207.980049875312;13519.461486872422;13543.72912541724;13621.318934053455;13691.110077844909;13922.930385348009;13924.930375348464;13956.581302560939;13999.930000349934;14462.421503139756;13373.070761147635;13655.863441365856;13711.177329360271;13792.93103534476;13811.378487968266;9283.907160928575;10772.89227107719;11229.775404492028;11502.48238829238;11676.70808229801;11090.68352689733;11313;11315.886841131813;11549.711257218636;11591.24656897299 20:47:54 INFO - PROCESS | 1671 | __end_tp_report 20:47:54 INFO - PROCESS | 1671 | __start_cc_report 20:47:54 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,429 20:47:54 INFO - PROCESS | 1671 | __end_cc_report 20:47:54 INFO - PROCESS | 1671 | __startTimestamp1471664874337__endTimestamp 20:47:54 INFO - PROCESS | 1671 | 20:47:54 INFO - PROCESS | 1671 | ------- Summary: start ------- 20:47:54 INFO - PROCESS | 1671 | Number of tests: 6 20:47:54 INFO - PROCESS | 1671 | 20:47:54 INFO - PROCESS | 1671 | [#0] dojo.html Cycles:165 Average:5714.87 Median:5894.71 stddev:661.95 (11.2%) stddev-sans-first:624.53 20:47:54 INFO - PROCESS | 1671 | Values: 2845.3 3441.6 3442.2 3451.6 3466.3 5554.3 5668.0 5804.1 5895.0 5940.6 5738.7 5745.0 5749.4 5789.2 5868.4 5199.2 5308.7 5320.7 5369.2 5378.0 5382.7 5396.1 5396.3 5414.2 5458.9 4041.4 5030.6 5158.1 5196.8 5311.5 5191.0 5243.5 5262.6 5281.6 5296.5 4374.3 5267.7 5270.0 5303.1 5345.0 5674.3 5683.8 5763.7 5788.7 5848.1 5719.4 6194.2 6212.0 6232.9 6273.1 4863.9 5007.0 5376.6 6276.8 6281.5 4905.6 4980.3 5693.5 5894.7 5928.8 5404.9 6277.8 6336.0 6348.3 6360.5 5274.4 6180.8 6208.5 6283.6 6298.5 5528.1 6193.7 6196.3 6215.2 6243.5 6181.8 6246.5 6256.4 6266.9 6282.6 6106.6 6207.5 6220.7 6248.3 6248.6 4894.3 4995.3 5018.5 5075.8 5083.8 4454.3 4499.3 4508.3 4523.1 4544.6 5753.1 5860.4 5873.4 5877.4 5878.3 6166.2 6188.8 6194.7 6241.6 6284.8 5857.0 5861.6 5878.9 5895.1 5920.5 5485.6 5488.7 5510.7 5516.8 5530.8 6181.7 6285.8 6292.5 6375.6 6386.8 6247.2 6256.2 6258.0 6260.1 6260.4 5532.8 6317.2 6343.4 6349.2 6377.2 5186.5 5234.3 6090.9 6208.2 6276.2 5867.5 6167.3 6210.5 6231.7 6256.6 6150.7 6178.5 6218.2 6241.7 6265.2 5953.8 5997.4 6056.0 6125.9 6153.6 5084.4 5945.1 6085.8 6094.8 6121.5 6199.0 6211.9 6224.5 6242.3 6255.4 5854.2 5941.9 5979.4 6112.3 6131.6 20:47:54 INFO - PROCESS | 1671 | 20:47:54 INFO - PROCESS | 1671 | [#1] ext.html Cycles:180 Average:70528.51 Median:39440.11 stddev:149343.26 (378.7%) stddev-sans-first:149669.63 20:47:54 INFO - PROCESS | 1671 | Values: 489.2 508.2 525.1 534.6 565.3 39481.4 40226.2 41974.0 42154.6 42300.2 42744.4 43280.6 43504.9 43523.0 43708.6 8920.4 9512.7 9617.6 10495.6 12215.6 10671.8 11478.5 11952.8 12045.6 12088.6 12044.9 12076.3 12090.3 12093.7 12115.9 11966.0 12124.0 12167.9 12173.8 12175.0 8940.7 11859.0 12126.7 12157.3 12234.6 40394.4 41015.8 41015.8 41244.4 43196.6 3466.7 3519.6 3542.9 3811.3 4046.6 31889.8 32530.3 32544.7 32654.8 32692.7 3249.5 3388.7 3446.3 3449.9 3458.3 488063.0 491598.0 492116.0 492233.0 493097.0 61574.0 61697.7 62117.0 62117.0 62169.0 63156.0 63302.4 63428.7 63455.4 63618.4 16072.7 16137.7 16164.8 16262.8 16286.2 12516.6 12609.2 12611.3 12650.3 12670.4 13593.9 17001.4 17026.5 17117.0 17162.4 6710.3 6796.9 6800.6 6817.3 6843.5 851.6 857.2 945.6 1001.7 1057.3 24076.6 26977.9 30559.2 30638.8 31205.0 1015.2 1036.5 1063.3 1102.2 1162.7 15817.6 16034.8 16068.3 16256.3 16319.8 616018.0 623101.9 625130.0 625626.0 626158.8 60573.0 60697.7 60738.7 60740.0 61000.0 1107.9 1283.6 1395.4 1427.4 1433.1 25728.7 29123.3 30954.8 31161.6 31352.8 53278.0 53294.9 53496.5 53656.7 53710.0 500046.0 568907.0 570498.0 575664.0 576017.0 41931.6 42301.8 42349.4 42558.0 43068.0 48887.8 49617.8 50427.0 50829.7 50973.5 39967.0 40089.8 40261.2 40730.0 41278.0 39752.4 40345.8 40456.0 40649.8 41821.8 33119.3 39076.0 39338.4 39398.8 39790.2 34402.8 35148.6 36073.0 36090.1 36127.5 25434.4 25946.2 26090.0 26154.3 26258.7 20:47:54 INFO - PROCESS | 1671 | 20:47:54 INFO - PROCESS | 1671 | [#2] jquery.html Cycles:180 Average:36012.87 Median:2401.15 stddev:104798.60 (4364.5%) stddev-sans-first:105058.40 20:47:54 INFO - PROCESS | 1671 | Values: 364.6 370.1 381.7 385.3 402.1 16277.0 19584.5 20464.1 21722.3 21953.6 20872.0 20905.6 21043.7 21600.0 21724.9 5862.8 6064.7 6138.2 6143.6 6157.0 5982.2 6024.6 6077.7 6091.5 6127.9 5906.2 6020.2 6030.9 6072.2 6084.5 5924.5 5971.9 6023.3 6025.9 6042.3 5208.2 5237.5 5258.7 5263.0 5266.5 26078.0 26787.7 27009.1 27216.2 27555.9 2386.0 2416.3 2445.1 2465.8 2500.7 15612.1 15713.9 15750.5 15782.4 15945.4 1788.2 1801.5 1866.2 1873.0 1905.7 115533.0 118557.0 118800.8 119028.0 121747.4 10704.4 10818.2 11233.0 11464.3 11631.6 12078.6 12846.6 14026.2 14044.7 14091.9 8295.0 8403.8 8546.0 8625.9 8742.1 8622.4 8645.1 8661.9 8731.6 8808.6 5796.9 6686.5 6800.6 6819.5 6857.9 1663.4 1748.3 1837.6 1883.1 1919.8 870.5 896.2 952.5 989.5 1035.7 19240.4 19560.0 21167.7 22374.0 22674.0 924.7 946.5 987.7 1033.7 1060.7 11538.0 11925.2 12084.3 12140.5 12185.9 619452.0 620939.0 621514.0 643132.7 644512.0 119340.4 122866.0 127632.4 128414.0 130030.0 1021.0 1025.9 1042.5 1048.7 1051.4 17249.7 19483.0 19549.9 19963.6 20330.7 32288.7 34569.8 51242.0 51382.2 52389.7 71229.6 81386.2 82399.0 83405.0 90989.0 7677.4 7998.0 8185.8 8209.7 8264.0 9171.5 12395.6 12935.9 13089.0 13485.2 9336.4 11473.3 11732.7 11739.5 11793.1 10286.3 11370.1 11537.4 11741.4 11928.8 11567.0 11608.4 11677.2 11939.5 11982.3 5321.4 7075.9 7318.2 7486.3 8258.9 8937.4 10908.1 11167.8 11270.7 11319.8 20:47:54 INFO - PROCESS | 1671 | 20:47:54 INFO - PROCESS | 1671 | [#3] mootools.html Cycles:180 Average:5536.28 Median:4883.28 stddev:3111.94 (63.7%) stddev-sans-first:3104.58 20:47:54 INFO - PROCESS | 1671 | Values: 1326.2 1398.7 1459.6 1516.3 1523.8 7855.8 8301.1 8340.4 8858.0 8877.8 8343.7 8509.7 8602.0 8622.5 8634.5 2320.6 2361.0 2375.1 2376.6 2382.5 2137.3 2233.7 2349.4 2376.4 2384.9 2013.7 2089.8 2092.7 2363.8 2392.6 2355.6 2357.1 2358.0 2369.8 2388.9 2362.8 2364.1 2368.9 2371.4 2373.3 7346.3 8540.7 8684.0 8727.5 8779.2 4577.6 5102.8 5335.4 5356.7 5359.5 3501.7 3538.1 3675.1 3680.9 3692.0 1081.5 1113.8 1117.2 1137.8 1140.1 11284.6 11311.0 11375.4 11457.7 11468.7 4078.6 4130.5 4562.9 4780.8 4813.0 8477.6 8575.8 8939.4 9876.3 9933.0 5323.5 5335.3 5340.0 5350.0 5358.3 3868.7 4351.1 4826.3 4859.1 4869.9 3904.5 3966.5 4012.6 4058.6 4061.9 1190.8 1239.5 1280.9 1305.5 1326.2 777.0 799.9 841.8 847.0 894.6 5703.7 5706.4 5861.2 5898.6 5996.9 429.8 433.0 440.5 441.4 453.2 3210.2 3765.8 3808.5 3915.4 3977.2 10092.5 10403.7 10492.2 10508.7 10518.6 10450.0 10472.3 10494.7 10500.2 10523.3 7526.6 7842.6 7975.2 8091.4 8135.6 4685.3 5799.9 5870.3 6053.9 6066.9 9487.5 9674.1 9824.6 9835.6 9929.6 8484.3 8528.3 9610.8 9913.6 9976.6 6807.0 7228.2 7393.3 7510.4 7528.3 8159.8 8245.8 8259.1 8265.0 8270.5 7207.1 7274.0 7341.9 7407.7 7434.0 7143.0 7163.6 7169.5 7208.1 7231.8 6778.4 6785.1 6869.1 6877.1 6887.8 4243.3 4860.3 4902.1 4942.9 4986.7 3914.4 4818.0 4896.6 5003.3 5074.7 20:47:54 INFO - PROCESS | 1671 | 20:47:54 INFO - PROCESS | 1671 | [#4] prototype.html Cycles:180 Average:4314.98 Median:4816.93 stddev:1317.90 (27.4%) stddev-sans-first:1286.16 20:47:54 INFO - PROCESS | 1671 | Values: 270.5 300.5 300.8 312.7 312.8 4897.2 5135.9 5238.0 5429.2 5495.3 4587.5 5517.0 5550.5 5605.7 5610.8 3524.3 3525.1 4121.5 4306.8 4312.4 3196.0 3212.8 3940.6 4177.7 4347.0 3922.9 4110.9 4152.9 4160.3 4176.4 3448.9 3583.9 4073.2 4190.0 4228.8 3603.8 3604.2 3606.9 3611.7 3650.2 4428.8 5164.3 5182.9 5217.6 5436.9 3966.9 4010.4 4699.9 4789.8 4817.3 5188.5 5638.5 5933.0 5937.2 5956.3 3175.4 3326.4 3833.3 3908.5 3942.2 5087.2 5146.7 6086.8 6222.0 6232.3 3965.0 3976.2 3987.5 4007.3 4007.8 3297.9 3470.5 3533.5 3810.8 4013.4 4048.7 4478.7 4749.9 4764.4 4786.0 5665.3 5916.4 5960.5 5960.6 6020.0 1164.7 1283.6 1288.9 1332.7 1347.2 745.0 843.2 881.4 886.3 893.0 4312.8 5345.9 5387.4 5440.0 5443.4 5071.7 5319.2 6017.8 6029.9 6034.7 5054.3 5115.8 5163.8 5346.5 5437.5 2214.9 2644.4 2673.4 2679.4 2682.5 4816.6 4887.0 4927.7 4941.7 5053.2 4141.8 4805.5 4836.7 4904.0 5011.8 4867.0 5142.4 5179.8 5254.7 5300.7 4335.2 4621.8 4821.6 4906.6 5116.4 4403.4 4488.4 4735.1 5048.4 5121.5 4925.5 5103.6 5162.8 5171.4 5284.9 3461.6 3480.4 3484.9 3496.5 3498.7 4410.8 4638.5 4700.6 4927.0 5048.4 4498.5 4667.9 4899.3 4926.5 5002.3 4931.7 4932.0 4976.3 4982.9 5003.4 3960.5 4645.0 4864.4 4898.8 4898.8 4454.9 4463.7 4636.7 4979.2 4986.2 3960.4 4859.8 4860.2 4866.0 4892.2 20:47:54 INFO - PROCESS | 1671 | 20:47:54 INFO - PROCESS | 1671 | [#5] yui.html Cycles:180 Average:25551.70 Median:3085.33 stddev:41454.74 (1343.6%) stddev-sans-first:41529.15 20:47:54 INFO - PROCESS | 1671 | Values: 731.2 735.9 785.2 821.9 825.0 15601.2 16306.4 16332.9 16335.8 16380.7 14648.2 14773.5 14796.9 14805.7 14827.6 668.5 822.1 845.1 851.2 855.3 675.6 839.0 855.4 860.0 866.2 908.6 915.5 922.2 923.0 927.1 898.6 911.1 914.4 914.4 914.5 666.8 672.5 675.1 677.4 677.9 14819.2 15016.9 15020.3 15036.8 15044.8 14731.9 14745.6 14757.3 14784.6 14945.1 11907.9 12108.8 12307.6 12348.6 12568.4 3872.2 3875.1 4043.5 4096.7 4099.2 124460.0 126535.0 127358.7 128635.7 130429.0 11467.4 11506.5 11574.5 11611.5 11839.7 23348.6 23392.6 23736.9 23932.9 23953.0 7562.6 8041.2 8137.8 8222.7 8230.0 4503.9 4631.4 4639.7 4645.4 4669.5 2964.3 3072.2 3077.2 3093.4 3099.3 688.6 724.1 729.1 730.0 740.4 585.2 606.9 613.0 671.2 698.8 8316.4 9443.4 9636.0 9769.4 9771.9 665.6 678.7 690.8 699.3 717.7 4474.2 4587.0 4734.8 4738.6 4792.8 102828.5 145533.0 157006.0 164348.2 165370.2 136762.9 139375.0 141434.0 141468.0 145317.0 94220.0 96171.0 116620.7 124452.8 125336.0 7974.3 9374.8 9680.9 9883.3 10026.2 44564.8 47854.5 60592.0 63338.7 63645.4 72996.5 87606.0 90416.0 91227.5 94519.5 12791.6 13079.9 13096.1 13168.7 13260.9 14715.9 14778.5 14817.6 14847.3 14912.2 13208.0 13519.5 13543.7 13621.3 13691.1 13922.9 13924.9 13956.6 13999.9 14462.4 13373.1 13655.9 13711.2 13792.9 13811.4 9283.9 10772.9 11229.8 11502.5 11676.7 11090.7 11313.0 11315.9 11549.7 11591.2 20:47:54 INFO - PROCESS | 1671 | -------- Summary: end -------- 20:47:54 INFO - PROCESS | 1671 | 20:47:54 INFO - TEST-INFO | 1671: exit 0 20:47:54 INFO - TEST-OK | dromaeo_css | took 1113766ms 20:47:54 INFO - TEST-START | kraken 20:47:54 INFO - operating with platform_type : mac_ 20:47:54 INFO - Initialising browser for kraken test... 20:47:54 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmpbL7T3Y/profile http://localhost:49268/getInfo.html) 20:47:57 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 20:47:57 INFO - PROCESS | 1680 | colorDepth:24 20:47:57 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 20:47:57 INFO - PROCESS | 1680 | __metrics 20:47:57 ERROR - PROCESS | 1680 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3061: TypeError: this.tabs is undefined 20:47:58 INFO - TEST-INFO | 1680: exit 0 20:47:58 INFO - Browser initialized. 20:47:58 INFO - Running cycle 1/1 for kraken test... 20:47:58 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmpbL7T3Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:48:10 INFO - PROCESS | 1682 | RSS: Main: 239685632 20:48:10 INFO - PROCESS | 1682 | 20:48:13 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection) 20:48:14 INFO - PROCESS | 1682 | RSS: Main: 252452864 20:48:14 INFO - PROCESS | 1682 | 20:48:16 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-dft) 20:48:17 INFO - PROCESS | 1682 | RSS: Main: 261095424 20:48:17 INFO - PROCESS | 1682 | 20:48:20 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-fft) 20:48:21 INFO - PROCESS | 1682 | RSS: Main: 264187904 20:48:21 INFO - PROCESS | 1682 | 20:48:23 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator) 20:48:24 INFO - PROCESS | 1682 | RSS: Main: 266575872 20:48:24 INFO - PROCESS | 1682 | 20:48:26 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:48:26 INFO - PROCESS | 1682 | RSS: Main: 267239424 20:48:26 INFO - PROCESS | 1682 | 20:48:29 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom) 20:48:30 INFO - PROCESS | 1682 | RSS: Main: 267091968 20:48:30 INFO - PROCESS | 1682 | 20:48:33 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate) 20:48:34 INFO - PROCESS | 1682 | RSS: Main: 267333632 20:48:34 INFO - PROCESS | 1682 | 20:48:37 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial) 20:48:37 INFO - PROCESS | 1682 | RSS: Main: 267763712 20:48:37 INFO - PROCESS | 1682 | 20:48:39 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:48:40 INFO - PROCESS | 1682 | RSS: Main: 267345920 20:48:40 INFO - PROCESS | 1682 | 20:48:41 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:48:42 INFO - PROCESS | 1682 | RSS: Main: 267399168 20:48:42 INFO - PROCESS | 1682 | 20:48:45 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:48:45 INFO - PROCESS | 1682 | RSS: Main: 267702272 20:48:45 INFO - PROCESS | 1682 | 20:48:48 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:48:49 INFO - PROCESS | 1682 | RSS: Main: 267956224 20:48:49 INFO - PROCESS | 1682 | 20:48:52 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:48:52 INFO - PROCESS | 1682 | RSS: Main: 267931648 20:48:52 INFO - PROCESS | 1682 | 20:48:54 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49268/tests/kraken/driver.html?testName=ai-astar) 20:48:54 INFO - PROCESS | 1682 | RSS: Main: 269598720 20:48:54 INFO - PROCESS | 1682 | 20:48:54 INFO - PROCESS | 1682 | __start_tp_report 20:48:54 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 20:48:54 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 20:48:54 INFO - PROCESS | 1682 | |i|pagename|runs| 20:48:54 INFO - PROCESS | 1682 | |0;ai-astar;107;120;109;118;118;117;118;118;118;117 20:48:54 INFO - PROCESS | 1682 | |1;audio-beat-detection;144;150;165;160;111;129;130;113;164;125 20:48:54 INFO - PROCESS | 1682 | |2;audio-dft;199;197;205;239;197;199;197;196;204;216 20:48:54 INFO - PROCESS | 1682 | |3;audio-fft;69;76;71;142;52;68;84;94;152;59 20:48:54 INFO - PROCESS | 1682 | |4;audio-oscillator;73;74;128;99;105;120;115;70;74;114 20:48:54 INFO - PROCESS | 1682 | |5;imaging-gaussian-blur;131;87;89;107;88;132;138;90;91;87 20:48:54 INFO - PROCESS | 1682 | |6;imaging-darkroom;95;97;96;94;96;96;108;95;150;146 20:48:54 INFO - PROCESS | 1682 | |7;imaging-desaturate;97;103;127;94;131;151;104;93;92;141 20:48:54 INFO - PROCESS | 1682 | |8;json-parse-financial;56;59;57;56;57;59;54;59;61;58 20:48:54 INFO - PROCESS | 1682 | |9;json-stringify-tinderbox;65;68;68;77;71;83;106;62;60;59 20:48:54 INFO - PROCESS | 1682 | |10;stanford-crypto-aes;86;94;107;110;89;89;86;103;118;110 20:48:54 INFO - PROCESS | 1682 | |11;stanford-crypto-ccm;165;149;117;152;168;162;154;143;161;156 20:48:54 INFO - PROCESS | 1682 | |12;stanford-crypto-pbkdf2;171;171;171;171;228;240;178;171;172;169 20:48:54 INFO - PROCESS | 1682 | |13;stanford-crypto-sha256-iterative;65;65;71;70;67;60;64;59;61;64 20:48:54 INFO - PROCESS | 1682 | __end_tp_report 20:48:54 INFO - PROCESS | 1682 | __start_cc_report 20:48:54 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,1099 20:48:54 INFO - PROCESS | 1682 | __end_cc_report 20:48:54 INFO - PROCESS | 1682 | __startTimestamp1471664934879__endTimestamp 20:48:54 INFO - PROCESS | 1682 | 20:48:54 INFO - PROCESS | 1682 | ------- Summary: start ------- 20:48:54 INFO - PROCESS | 1682 | Number of tests: 14 20:48:54 INFO - PROCESS | 1682 | 20:48:54 INFO - PROCESS | 1682 | [#0] ai-astar Cycles:10 Average:116.00 Median:118.00 stddev:4.32 (3.7%) stddev-sans-first:3.12 20:48:54 INFO - PROCESS | 1682 | Values: 107.0 120.0 109.0 118.0 118.0 117.0 118.0 118.0 118.0 117.0 20:48:54 INFO - PROCESS | 1682 | 20:48:54 INFO - PROCESS | 1682 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:147.00 stddev:20.34 (13.8%) stddev-sans-first:21.50 20:48:54 INFO - PROCESS | 1682 | Values: 144.0 150.0 165.0 160.0 111.0 129.0 130.0 113.0 164.0 125.0 20:48:54 INFO - PROCESS | 1682 | 20:48:54 INFO - PROCESS | 1682 | [#2] audio-dft Cycles:10 Average:204.90 Median:201.50 stddev:13.43 (6.7%) stddev-sans-first:14.07 20:48:54 INFO - PROCESS | 1682 | Values: 199.0 197.0 205.0 239.0 197.0 199.0 197.0 196.0 204.0 216.0 20:48:54 INFO - PROCESS | 1682 | 20:48:54 INFO - PROCESS | 1682 | [#3] audio-fft Cycles:10 Average:86.70 Median:70.00 stddev:33.96 (48.5%) stddev-sans-first:35.41 20:48:54 INFO - PROCESS | 1682 | Values: 69.0 76.0 71.0 142.0 52.0 68.0 84.0 94.0 152.0 59.0 20:48:54 INFO - PROCESS | 1682 | 20:48:54 INFO - PROCESS | 1682 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:71.50 stddev:22.44 (31.4%) stddev-sans-first:22.03 20:48:54 INFO - PROCESS | 1682 | Values: 73.0 74.0 128.0 99.0 105.0 120.0 115.0 70.0 74.0 114.0 20:48:54 INFO - PROCESS | 1682 | 20:48:54 INFO - PROCESS | 1682 | [#5] imaging-gaussian-blur Cycles:10 Average:104.00 Median:87.50 stddev:21.35 (24.4%) stddev-sans-first:20.29 20:48:54 INFO - PROCESS | 1682 | Values: 131.0 87.0 89.0 107.0 88.0 132.0 138.0 90.0 91.0 87.0 20:48:54 INFO - PROCESS | 1682 | 20:48:54 INFO - PROCESS | 1682 | [#6] imaging-darkroom Cycles:10 Average:107.30 Median:95.50 stddev:21.83 (22.9%) stddev-sans-first:22.70 20:48:54 INFO - PROCESS | 1682 | Values: 95.0 97.0 96.0 94.0 96.0 96.0 108.0 95.0 150.0 146.0 20:48:54 INFO - PROCESS | 1682 | 20:48:54 INFO - PROCESS | 1682 | [#7] imaging-desaturate Cycles:10 Average:113.30 Median:121.50 stddev:22.08 (18.2%) stddev-sans-first:22.61 20:48:54 INFO - PROCESS | 1682 | Values: 97.0 103.0 127.0 94.0 131.0 151.0 104.0 93.0 92.0 141.0 20:48:54 INFO - PROCESS | 1682 | 20:48:54 INFO - PROCESS | 1682 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.50 stddev:2.01 (3.4%) stddev-sans-first:2.05 20:48:54 INFO - PROCESS | 1682 | Values: 56.0 59.0 57.0 56.0 57.0 59.0 54.0 59.0 61.0 58.0 20:48:54 INFO - PROCESS | 1682 | 20:48:54 INFO - PROCESS | 1682 | [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:68.00 stddev:14.13 (20.8%) stddev-sans-first:14.76 20:48:54 INFO - PROCESS | 1682 | Values: 65.0 68.0 68.0 77.0 71.0 83.0 106.0 62.0 60.0 59.0 20:48:54 INFO - PROCESS | 1682 | 20:48:54 INFO - PROCESS | 1682 | [#10] stanford-crypto-aes Cycles:10 Average:99.20 Median:86.00 stddev:11.76 (13.7%) stddev-sans-first:11.47 20:48:54 INFO - PROCESS | 1682 | Values: 86.0 94.0 107.0 110.0 89.0 89.0 86.0 103.0 118.0 110.0 20:48:54 INFO - PROCESS | 1682 | 20:48:54 INFO - PROCESS | 1682 | [#11] stanford-crypto-ccm Cycles:10 Average:152.70 Median:158.50 stddev:14.67 (9.3%) stddev-sans-first:14.87 20:48:54 INFO - PROCESS | 1682 | Values: 165.0 149.0 117.0 152.0 168.0 162.0 154.0 143.0 161.0 156.0 20:48:54 INFO - PROCESS | 1682 | 20:48:54 INFO - PROCESS | 1682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.20 Median:171.50 stddev:26.50 (15.5%) stddev-sans-first:27.68 20:48:54 INFO - PROCESS | 1682 | Values: 171.0 171.0 171.0 171.0 228.0 240.0 178.0 171.0 172.0 169.0 20:48:54 INFO - PROCESS | 1682 | 20:48:54 INFO - PROCESS | 1682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.00 stddev:3.98 (6.1%) stddev-sans-first:4.22 20:48:54 INFO - PROCESS | 1682 | Values: 65.0 65.0 71.0 70.0 67.0 60.0 64.0 59.0 61.0 64.0 20:48:54 INFO - PROCESS | 1682 | -------- Summary: end -------- 20:48:54 INFO - PROCESS | 1682 | 20:48:55 INFO - TEST-INFO | 1682: exit 0 20:48:55 INFO - TEST-OK | kraken | took 60742ms 20:48:55 INFO - SUITE-END | took 1174s 20:48:56 INFO - Completed test suite (00:19:34) 20:48:56 INFO - javascript benchmark 20:48:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7358.53109269744, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2845.3029007893065, 3441.62142164362, 3442.2254992626663, 3451.6375780543044, 3466.324066806973, 5554.333479982408, 5668.0, 5804.100364443508, 5894.970525147368, 5940.613860099091, 5738.713064346776, 5744.971275143629, 5749.396313387097, 5789.247397838275, 5868.442497962697, 5199.168133098705, 5308.654937429054, 5320.654157479771, 5369.19462080689, 5378.005069062236, 5382.703951282678, 5396.055690254209, 5396.325459317585, 5414.242006119146, 5458.918116228259, 4041.4139949707424, 5030.647854650176, 5158.097332966753, 5196.818111366084, 5311.468853114697, 5191.039657663345, 5243.501867322599, 5262.578993680497, 5281.603879709037, 5296.523312901857, 4374.300111982067, 5267.683938963636, 5269.973650131763, 5303.124984377611, 5344.9577332420195, 5674.290713660793, 5683.829485115453, 5763.6541807491685, 5788.6816225107605, 5848.064309710426, 5719.399463056361, 6194.194754681907, 6212.0371342441995, 6232.9376706232815, 6273.05904114382, 4863.927041094386, 5007.0, 5376.623636345457, 6276.811695649092, 6281.466075383598, 4905.55849973497, 4980.252962055684, 5693.516051135658, 5894.705264736746, 5928.822135335947, 5404.945950540523, 6277.78027769035, 6336.04959256106, 6348.301686814447, 6360.52296077796, 5274.393444753902, 6180.845478863064, 6208.534359923024, 6283.554782400073, 6298.527610429236, 5528.143137813645, 6193.6903154842075, 6196.349383314777, 6215.223097112861, 6243.469305109026, 6181.7527298908435, 6246.469050130699, 6256.43692067707, 6266.905996409966, 6282.560220784501, 6106.572539922252, 6207.503399728011, 6220.657863817443, 6248.28144763349, 6248.593841400385, 4894.339264199359, 4995.300657907896, 5018.548330650259, 5075.7969681212335, 5083.847484575469, 4454.28731402974, 4499.302608095751, 4508.301213311942, 4523.11799199153, 4544.590986811203, 5753.108268218349, 5860.355360910296, 5873.415697093265, 5877.441643043904, 5878.3239927408895, 6166.229221347332, 6188.752449901954, 6194.659293738888, 6241.625502469867, 6284.780032698925, 5856.975029369928, 5861.5603829712945, 5878.941210587925, 5895.145203945404, 5920.526357891358, 5485.6434331768305, 5488.725563721798, 5510.724463776795, 5516.806911758069, 5530.778768849201, 6181.660008699565, 6285.811425657238, 6292.465140463112, 6375.6174629522375, 6386.776462823872, 6247.187865577446, 6256.186695729526, 6258.0, 6260.092286618324, 6260.373962603703, 5532.78278778668, 6317.241930968313, 6343.429091381798, 6349.174607301022, 6377.202849643794, 5186.507281808223, 5234.319538459976, 6090.878182436415, 6208.2239720034995, 6276.1840960676645, 5867.530597552271, 6167.321594624677, 6210.5031597473, 6231.719572619152, 6256.624602523863, 6150.661713605795, 6178.5366097543765, 6218.22272215973, 6241.656708881055, 6265.154204182377, 5953.76184952597, 5997.400259973968, 6056.031035034373, 6125.877482450415, 6153.600015998945, 5084.3644544431945, 5945.137954996415, 6085.817425477243, 6094.847628809315, 6121.540884433774, 6199.039148931923, 6211.937880621317, 6224.470919971672, 6242.344553821965, 6255.40573645503, 5854.2389489366105, 5941.851453713692, 5979.402059793986, 6112.266528016488, 6131.570790044654], "value": 5675.334976084424, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.23679060665364, 508.2198824803927, 525.1204232909877, 534.6364472158936, 565.2849145830528, 39481.40777888334, 40226.1954760905, 41974.0, 42154.57845421545, 42300.153996920046, 42744.3588346175, 43280.56719432805, 43504.91237719059, 43523.0, 43708.56291437085, 8920.420172688755, 9512.714618561455, 9617.567209475574, 10495.632652857152, 12215.633530994084, 10671.82609912909, 11478.540858365697, 11952.7609447811, 12045.578404755835, 12088.637340879744, 12044.879551204463, 12076.275423474619, 12090.274583524973, 12093.697657558543, 12115.878841211606, 11966.042716582653, 12124.0, 12167.939160304186, 12173.756524869454, 12175.0, 8940.687075952375, 11858.991985681227, 12126.696832579168, 12157.270563766115, 12234.632961011184, 40394.39408408876, 41015.794921025205, 41015.7949210255, 41244.38133427971, 43196.568034319884, 3466.7053300469493, 3519.6128425873135, 3542.929141417183, 3811.3330167220624, 4046.5548789633117, 31889.84055079733, 32530.349393012242, 32544.6745532544, 32654.836725816218, 32692.673073269438, 3249.46383846665, 3388.6950174484414, 3446.3107378524146, 3449.9482507762405, 3458.2737625098757, 488063.0, 491598.0, 492116.0, 492233.0, 493097.0, 61574.0, 61697.69151154216, 62117.0, 62117.0, 62169.0, 63156.0, 63302.36697632965, 63428.68285658542, 63455.365446345866, 63618.36381636217, 16072.67854642924, 16137.677246455005, 16164.838351616569, 16262.75605865913, 16286.185690715416, 12516.561920332744, 12609.243445393306, 12611.306378149106, 12650.30423326726, 12670.429830657642, 13593.864061359458, 17001.40495082691, 17026.489205323862, 17116.972981621144, 17162.39931602388, 6710.295418981034, 6796.898046529306, 6800.625965571941, 6817.284185160586, 6843.520953533304, 851.5571902610608, 857.2156476823636, 945.550863339908, 1001.6944831826363, 1057.349729916096, 24076.638850417257, 26977.86511067432, 30559.20084226935, 30638.846805766276, 31205.0, 1015.1827778638119, 1036.549101141006, 1063.2982231727024, 1102.2064113838023, 1162.68607475981, 15817.604559886095, 16034.839651603335, 16068.276927538054, 16256.349746010028, 16319.83680163183, 616018.0, 623101.8844905746, 625130.0, 625626.0, 626158.7765040023, 60573.0, 60697.69651151716, 60738.696306519065, 60740.0, 61000.0, 1107.883672214422, 1283.5828355784408, 1395.413926151019, 1427.364822653909, 1433.068505471431, 25728.742712573385, 29123.271918202216, 30954.845225773726, 31161.5631973683, 31352.843235783675, 53278.0, 53294.93410131698, 53496.465035349145, 53656.73171634117, 53710.0, 500046.0, 568907.0, 570498.0, 575664.0, 576017.0, 41931.58068419277, 42301.78849105858, 42349.36475952801, 42558.0, 43068.0, 48887.755561221966, 49617.751911240215, 50426.991460169855, 50829.745851270505, 50973.49026509687, 39967.0, 40089.799551002056, 40261.19477610373, 40730.0, 41278.0, 39752.40371394489, 40345.798271008454, 40456.0, 40649.79675101605, 41821.79089104535, 33119.337613248084, 39076.0, 39338.409923850595, 39398.80300598479, 39790.2041959165, 34402.82798585991, 35148.648513514534, 36073.0, 36090.09774755652, 36127.45808812817, 25434.364140896625, 25946.22161335163, 26090.0, 26154.346141346618, 26258.737412626393], "value": 20932.066556879905, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.64447164015087, 370.1265014565626, 381.7213434193038, 385.2833729263571, 402.14945390499105, 16277.0, 19584.51038724031, 20464.07911643976, 21722.3483295501, 21953.560928781433, 20871.956402179905, 20905.581888362223, 21043.68434473484, 21600.0, 21724.8913755431, 5862.794802181914, 6064.72708728106, 6138.232720909887, 6143.569950103494, 6157.0, 5982.162497250389, 6024.638521688691, 6077.665728384959, 6091.451769340759, 6127.877442451148, 5906.232189815318, 6020.247469066367, 6030.939690603103, 6072.2106126203535, 6084.452399284063, 5924.526037916978, 5971.910421343661, 6023.337432882379, 6025.9096113558335, 6042.335343112254, 5208.192730126836, 5237.47625237477, 5258.710770907599, 5262.973720124577, 5266.4733526647415, 26078.0, 26787.732122678717, 27009.054683085997, 27216.183514494398, 27555.86222068897, 2385.9642105368434, 2416.3355077353867, 2445.08309383981, 2465.8027357811334, 2500.712418071909, 15612.141332226724, 15713.92143039289, 15750.527484175493, 15782.447614333443, 15945.362185512566, 1788.2131861980688, 1801.5135913303466, 1866.150901339887, 1872.9906350468161, 1905.6812188398742, 115533.0, 118557.0, 118800.8119918807, 119028.0, 121747.391263044, 10704.411257380918, 10818.24272300947, 11233.0, 11464.25482343645, 11631.59289424866, 12078.637640870787, 12846.614601561969, 14026.22855742944, 14044.71910561783, 14091.929540352232, 8294.958525207336, 8403.831923361498, 8545.957270213608, 8625.870611940825, 8742.08208138149, 8622.353323500762, 8645.135486451305, 8661.870071948926, 8731.56342182901, 8808.603612837309, 5796.913046304308, 6686.531942764057, 6800.557963732342, 6819.522633415712, 6857.897131543031, 1663.4178037686954, 1748.326894145763, 1837.61410103877, 1883.0772921268754, 1919.7984211657574, 870.4777133719845, 896.2247655777705, 952.5284983932997, 989.4706332112429, 1035.7255327338262, 19240.4227873164, 19560.0, 21167.68248476274, 22373.993170307374, 22673.979670914847, 924.7179610218948, 946.5314669238771, 987.693814917378, 1033.6537260017978, 1060.6977011551671, 11537.961583457529, 11925.165238433226, 12084.335361555199, 12140.514379424902, 12185.87814121865, 619452.0, 620939.0, 621514.0, 643132.7060188202, 644512.0, 119340.40329798295, 122866.0, 127632.36183819022, 128414.0, 130030.0, 1020.9795804084025, 1025.8922813104666, 1042.5464922758624, 1048.7378155461136, 1051.4164638625484, 17249.655006900044, 19483.0, 19549.924754138658, 19963.60072798565, 20330.695039574715, 32288.70845166261, 34569.82715086408, 51242.0, 51382.201622943016, 52389.69025774386, 71229.6438517804, 81386.18613813785, 82399.0, 83405.0, 90989.0, 7677.424193185645, 7998.0, 8185.79535511617, 8209.671613135646, 8264.049634291892, 9171.54142292896, 12395.62813115608, 12935.935320323715, 13088.952883769465, 13485.190888546718, 9336.439813611205, 11473.254238474472, 11732.70668233301, 11739.47172377228, 11793.056555475712, 10286.2799604027, 11370.147238957277, 11537.423128843357, 11741.354225517678, 11928.76142477163, 11567.0, 11608.361540115375, 11677.182597218112, 11939.46272417726, 11982.281063136239, 5321.3880403754065, 7075.929240707527, 7318.1949985502615, 7486.251374862688, 8258.876116858371, 8937.374383793072, 10908.072813810915, 11167.776644467227, 11270.661880143609, 11319.773604528027], "value": 9821.866031265487, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1326.1711430356033, 1398.6713122416236, 1459.5694270190293, 1516.2957659451347, 1523.824760152582, 7855.764327070197, 8301.086880443147, 8340.3744719146, 8858.025617182106, 8877.822443551126, 8343.74968750937, 8509.702160424386, 8602.0, 8622.525761083154, 8634.48193108414, 2320.6170981788027, 2360.976390236093, 2375.061850569024, 2376.560336337783, 2382.523495300938, 2137.2626443876916, 2233.687283780264, 2349.447879748258, 2376.4296568823443, 2384.856908585482, 2013.7281467001987, 2089.7879230046537, 2092.675635276527, 2363.763623637631, 2392.5812982727953, 2355.623100303943, 2357.104300365867, 2358.0, 2369.7748713872156, 2388.8924998375114, 2362.7637236276237, 2364.113457453455, 2368.9289321320216, 2371.4190023444194, 2373.2642880706862, 7346.338829505316, 8540.701075462392, 8683.956580217122, 8727.519986400745, 8779.165979231962, 4577.58094990554, 5102.846914592568, 5335.386430560497, 5356.651817631841, 5359.517643412073, 3501.6673416025437, 3538.1331573764337, 3675.0628589709722, 3680.8895733127783, 3692.0463629096616, 1081.4700796609684, 1113.7549739057476, 1117.1788735279563, 1137.7553825927466, 1140.1278022312938, 11284.605038823684, 11311.038561722264, 11375.431228438627, 11457.65627031182, 11468.71328216793, 4078.5513593504693, 4130.471725461538, 4562.931556026662, 4780.808767649255, 4813.0, 8477.618507167192, 8575.828483430296, 8939.418937769024, 9876.259280553988, 9933.0, 5323.467653234646, 5335.253064570963, 5339.973300133474, 5349.973250133725, 5358.276632654542, 3868.6905047596124, 4351.12977404514, 4826.32431459596, 4859.1010663027455, 4869.9269510957365, 3904.5314562252142, 3966.464527288837, 4012.578679238696, 4058.553559108496, 4061.898452538651, 1190.7618476304774, 1239.4794186441716, 1280.8911242544302, 1305.4712841299288, 1326.2374134872487, 776.9549955310099, 799.8760192170223, 841.7558907916635, 846.9830603387898, 894.5974311559825, 5703.7148142592705, 5706.42935706426, 5861.20873682056, 5898.587098903035, 5996.940030599725, 429.84310726584573, 432.9848455304049, 440.4604359659456, 441.3622315753705, 453.1955778493201, 3210.2455922858576, 3765.755225910307, 3808.5239345081864, 3915.393114067324, 3977.244323578511, 10092.545835437422, 10403.687889363331, 10492.21308401873, 10508.684739457829, 10518.631847885288, 10450.0, 10472.266941314036, 10494.73763155912, 10500.212484063726, 10523.315984460985, 7526.623668816537, 7842.5686587237105, 7975.1626079262005, 8091.393145513992, 8135.593220338959, 4685.344051832678, 5799.942000580109, 5870.324912635102, 6053.878922421439, 6066.908996365147, 9487.478188699688, 9674.129328360481, 9824.55789489489, 9835.606575737176, 9929.553170107218, 8484.278836298983, 8528.27509661661, 9610.819293607303, 9913.603455861974, 9976.60093596248, 6807.047013418224, 7228.241034691282, 7393.297636724503, 7510.361619262424, 7528.322450979438, 8159.755207343789, 8245.752627421187, 8259.050209226016, 8265.049519305358, 8270.462419942685, 7207.13514378278, 7274.0, 7341.889871651822, 7407.703691852265, 7433.962830185815, 7143.035690181967, 7163.570185788869, 7169.455339854112, 7208.135023796968, 7231.819204519929, 6778.423833974168, 6785.08401365829, 6869.107016088076, 6877.071595334566, 6887.793366199022, 4243.278642630698, 4860.343853579721, 4902.117618828645, 4942.851714448572, 4986.650934434555, 3914.393269043303, 4817.9518204818905, 4896.6327525436445, 5003.274525193754, 5074.67014644047], "value": 4378.94435858125, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [270.4968758109916, 300.50866832728485, 300.83604435582606, 312.73730066743946, 312.76855127205874, 4897.240927656215, 5135.871603209922, 5238.030964271612, 5429.185622156679, 5495.340559132899, 4587.541245875411, 5516.986300000501, 5550.47270509302, 5605.691686957216, 5610.793679358937, 3524.259905419865, 3525.0695474545955, 4121.4848143982, 4306.80619372129, 4312.396264522969, 3195.952060719091, 3212.8032607555515, 3940.586238444965, 4177.707560470768, 4347.0, 3922.882313530599, 4110.903439245991, 4152.937705934413, 4160.292750232453, 4176.352665336863, 3448.8620455181763, 3583.9213256311277, 4073.207788573018, 4189.9999999999845, 4228.809703563347, 3603.783772973604, 3604.18905746205, 3606.891793246207, 3611.747177697562, 3650.1787097903025, 4428.822847086113, 5164.251183578398, 5182.948170518284, 5217.634765566412, 5436.945630543683, 3966.861159859391, 4010.3984402339593, 4699.929501057487, 4789.760511974388, 4817.289862098939, 5188.549614506349, 5638.519051617316, 5933.0, 5937.228160339171, 5956.255468066492, 3175.4442972479956, 3326.417876871562, 3833.3483307837732, 3908.530976282836, 3942.2115576884453, 5087.211482220262, 5146.716930568818, 6086.786962456293, 6221.951243890507, 6232.3144454110015, 3964.960350396517, 3976.1848820991627, 3987.501562304712, 4007.278689835799, 4007.779572123561, 3297.86808527661, 3470.514128022079, 3533.4876442916147, 3810.8376945032032, 4013.3578627419474, 4048.6963477739287, 4478.715854914018, 4749.928751068667, 4764.380630518011, 4785.952140478551, 5665.320161580555, 5916.3787802281, 5960.4635582797755, 5960.582759206901, 6019.969900150471, 1164.6797130788932, 1283.5828355784408, 1288.9419976101099, 1332.7134666046848, 1347.1782212850153, 744.9553026818409, 843.1821133500495, 881.3874357321728, 886.2953951608487, 892.9776755581032, 4312.762798046075, 5345.946540534623, 5387.353517577916, 5440.0, 5443.42844001382, 5071.692379967106, 5319.191474898553, 6017.849553761191, 6029.914615369188, 6034.668093254913, 5054.342935418372, 5115.820946266863, 5163.819266325736, 5346.518813306743, 5437.483439073281, 2214.933551993443, 2644.444666619993, 2673.3667337672377, 2679.3837417394107, 2682.5305571524905, 4816.566509014206, 4886.996331504066, 4927.728974906343, 4941.678790878582, 5053.239307189807, 4141.81361838718, 4805.471398146201, 4836.661433699677, 4904.0, 5011.822221777879, 4867.028853314413, 5142.382914050338, 5179.772697740008, 5254.684718916801, 5300.720690103292, 4335.200891629938, 4621.77739154753, 4821.649938017361, 4906.55840974314, 5116.388337673621, 4403.4055402521535, 4488.394066801071, 4735.100330937111, 5048.409750928446, 5121.462246464068, 4925.45819959797, 5103.571000119972, 5162.793488260578, 5171.3535808024, 5284.920726189033, 3461.5653424123884, 3480.416410533252, 3484.9128771780906, 3496.5454490916018, 3498.73759468046, 4410.757408342443, 4638.53614638547, 4700.576948074689, 4926.975365123151, 5048.444671086251, 4498.505164431976, 4667.906641867075, 4899.265110233494, 4926.48271931442, 5002.349694539686, 4931.72875491837, 4931.966840393061, 4976.278439626306, 4982.900341993212, 5003.4246061701915, 3960.4851369321805, 4645.0, 4864.391951006124, 4898.755062246944, 4898.779554919965, 4454.910901782011, 4463.660901729533, 4636.698614590041, 4979.228219625964, 4986.202207646759, 3960.4455376247925, 4859.829905953275, 4860.17377045896, 4866.0, 4892.217245240744], "value": 3900.2541737581314, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.228553875661, 735.8859376796596, 785.242241237206, 821.893153889995, 824.9628766705499, 15601.219939003047, 16306.429274975379, 16332.938359006655, 16335.83664163358, 16380.672386552262, 14648.194349310783, 14773.48292809752, 14796.852031479682, 14805.703885922276, 14827.55517334479, 668.4518694670372, 822.112118911574, 845.1168528887312, 851.1786126388034, 855.3242938078942, 675.5777638975641, 838.9848283576849, 855.4183155454289, 859.9871001934945, 866.1814585216972, 908.5548081440113, 915.5193523400202, 922.1562270522464, 922.9953850230739, 927.1192367251105, 898.6495266845935, 911.129870973219, 914.3553794574809, 914.419343716738, 914.510736755839, 666.8366250268667, 672.5460314287836, 675.1223409567592, 677.4411110833582, 677.9084823548857, 14819.18494482803, 15016.924915375463, 15020.324085416074, 15036.774448383283, 15044.849551504454, 14731.926340368336, 14745.557633270912, 14757.262136893112, 14784.630384240372, 14945.103293802407, 11907.94046029773, 12108.757824843542, 12307.569235076819, 12348.567800126952, 12568.43442045101, 3872.244912242114, 3875.147467557133, 4043.4945631796027, 4096.692748043909, 4099.221147981874, 124460.0, 126535.0, 127358.72641273562, 128635.71364286331, 130429.0, 11467.369294688706, 11506.539738410538, 11574.537018519333, 11611.477483513263, 11839.704007399712, 23348.649770253458, 23392.64911026302, 23736.881315593313, 23932.88033559856, 23953.0, 7562.621868906533, 8041.2360825722635, 8137.796555086052, 8222.712205072794, 8230.0, 4503.887402814956, 4631.444226692751, 4639.652026098056, 4645.442546894395, 4669.486356500782, 2964.3330250693853, 3072.2319420144963, 3077.2153100959113, 3093.443180227536, 3099.3336432666633, 688.5868478912713, 724.1238101896764, 729.1323325242944, 729.9854002920018, 740.3595889555603, 585.1807469542674, 606.8732618196248, 612.963222206669, 671.1744554198364, 698.7659134190002, 8316.37627177964, 9443.386179898285, 9636.036396360309, 9769.364991275545, 9771.902280977241, 665.55075324156, 678.718331892269, 690.7685925215009, 699.3216579917472, 717.7344382578375, 4474.217012022948, 4586.954130458719, 4734.834280800224, 4738.64460165489, 4792.784324705397, 102828.48585757024, 145533.0, 157006.0, 164348.17825911034, 165370.17314913348, 136762.91968030037, 139375.0, 141434.0, 141468.0, 145317.0, 94220.0, 96170.9999999986, 116620.67310576527, 124452.75547244593, 125336.0, 7974.322182614543, 9374.812503750023, 9680.886698029817, 9883.308168428428, 10026.197904167795, 44564.77717611391, 47854.5214547864, 60592.0, 63338.73322533616, 63645.363546363944, 72996.54006919726, 87606.0, 90416.0, 91227.54386228026, 94519.52740236255, 12791.552295669608, 13079.934600326937, 13096.148750331198, 13168.736625267633, 13260.867391325963, 14715.92642036783, 14778.48275310359, 14817.629559261104, 14847.257637118317, 14912.179830109015, 13207.980049875312, 13519.461486872422, 13543.72912541724, 13621.318934053455, 13691.110077844909, 13922.930385348009, 13924.930375348464, 13956.581302560939, 13999.930000349934, 14462.421503139756, 13373.070761147635, 13655.863441365856, 13711.177329360271, 13792.93103534476, 13811.378487968266, 9283.907160928575, 10772.89227107719, 11229.775404492028, 11502.48238829238, 11676.70808229801, 11090.68352689733, 11313.0, 11315.886841131813, 11549.711257218636, 11591.24656897299], "value": 7965.8920997008245, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1598.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 120.0, 109.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0], "value": 116.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 150.0, 165.0, 160.0, 111.0, 129.0, 130.0, 113.0, 164.0, 125.0], "value": 139.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 197.0, 205.0, 239.0, 197.0, 199.0, 197.0, 196.0, 204.0, 216.0], "value": 204.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 76.0, 71.0, 142.0, 52.0, 68.0, 84.0, 94.0, 152.0, 59.0], "value": 86.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 128.0, 99.0, 105.0, 120.0, 115.0, 70.0, 74.0, 114.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 87.0, 89.0, 107.0, 88.0, 132.0, 138.0, 90.0, 91.0, 87.0], "value": 104.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 94.0, 96.0, 96.0, 108.0, 95.0, 150.0, 146.0], "value": 107.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 103.0, 127.0, 94.0, 131.0, 151.0, 104.0, 93.0, 92.0, 141.0], "value": 113.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 59.0, 57.0, 56.0, 57.0, 59.0, 54.0, 59.0, 61.0, 58.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 68.0, 77.0, 71.0, 83.0, 106.0, 62.0, 60.0, 59.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 94.0, 107.0, 110.0, 89.0, 89.0, 86.0, 103.0, 118.0, 110.0], "value": 99.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 149.0, 117.0, 152.0, 168.0, 162.0, 154.0, 143.0, 161.0, 156.0], "value": 152.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 171.0, 171.0, 228.0, 240.0, 178.0, 171.0, 172.0, 169.0], "value": 184.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 71.0, 70.0, 67.0, 60.0, 64.0, 59.0, 61.0, 64.0], "value": 64.6, "unit": "score"}]}]} 20:48:56 INFO - Return code: 0 20:48:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:48:56 ERROR - # TBPL SUCCESS # 20:48:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:48:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:48:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:48:56 INFO - 2016-08-19 20:48:56.196 screenresolution[1687:11377] starting screenresolution argv=screenresolution get 20:48:56 INFO - 2016-08-19 20:48:56.199 screenresolution[1687:11377] Display 0: 1600x1200x32@60 20:48:56 INFO - 2016-08-19 20:48:56.205 screenresolution[1688:11380] starting screenresolution argv=screenresolution list 20:48:56 INFO - Available Modes on Display 0 20:48:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:48:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:48:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:48:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:48:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:48:56 INFO - Intel Iris: 20:48:56 INFO - Chipset Model: Intel Iris 20:48:56 INFO - Type: GPU 20:48:56 INFO - Bus: Built-In 20:48:56 INFO - VRAM (Dynamic, Max): 1536 MB 20:48:56 INFO - Vendor: Intel (0x8086) 20:48:56 INFO - Device ID: 0x0a2e 20:48:56 INFO - Revision ID: 0x0009 20:48:56 INFO - Displays: 20:48:56 INFO - Display: 20:48:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:48:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:48:56 INFO - Display Serial Number: 1600x1200 60 20:48:56 INFO - Main Display: Yes 20:48:56 INFO - Mirror: Off 20:48:56 INFO - Online: Yes 20:48:56 INFO - Rotation: Supported 20:48:56 INFO - Return code: 0 20:48:56 INFO - Running post-action listener: _resource_record_post_action 20:48:56 INFO - [mozharness: 2016-08-20 03:48:56.441070Z] Finished run-tests step (success) 20:48:56 INFO - Running post-run listener: _resource_record_post_run 20:48:56 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 32771072; Write bytes: 709146624; Read time: 316; Write time: 1966 20:48:56 INFO - TinderboxPrint: CPU usage
54.6% 20:48:56 INFO - TinderboxPrint: I/O read bytes / time
32,771,072 / 316 20:48:56 INFO - TinderboxPrint: I/O write bytes / time
709,146,624 / 1,966 20:48:56 INFO - TinderboxPrint: CPU idle
2,198.1 (45.4%) 20:48:56 INFO - TinderboxPrint: CPU system
978.9 (20.2%) 20:48:56 INFO - TinderboxPrint: CPU user
1,664.6 (34.4%) 20:48:56 INFO - TinderboxPrint: Swap in / out
435,466,240 / 0 20:48:56 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 386990592; Write bytes: 381868032; Read time: 29429; Write time: 711 20:48:56 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 31837184; Write bytes: 299651072; Read time: 303; Write time: 1199 20:48:56 INFO - Running post-run listener: _upload_blobber_files 20:48:56 INFO - Blob upload gear active. 20:48:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:48:56 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 20:48:56 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'] 20:48:56 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 20:48:57 INFO - (blobuploader) - INFO - Open directory for files ... 20:48:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:48:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:48:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:48:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:48:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:48:58 INFO - (blobuploader) - INFO - Done attempting. 20:48:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:48:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:48:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:48:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:48:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:48:59 INFO - (blobuploader) - INFO - Done attempting. 20:48:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:48:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:48:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:49:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:49:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:49:02 INFO - (blobuploader) - INFO - Done attempting. 20:49:02 INFO - (blobuploader) - INFO - Iteration through files over. 20:49:02 INFO - Return code: 0 20:49:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:49:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:49:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/499969f93f7b960d7f2ade52ddedf31ef2857ebace1df4d9844c7567bca84458fa98bb25a42e4a673d45a083359018600777fc6770f58e6339436c8ecb81bb6d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/331276a2c9975c5d9f884044a57519602fd316008a167d85b229ce60b29300a71ff511bfbf4ef3a81e05a74ee1db9dcf35857c9a9ad6efbe05198229c24723e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5dd32ebfb6ee9b4bf0fcb98c3e595f03b1a82328a45b2c02e9190bcaabf36f2b3c303af3c8446b8757786ff1e73bb41c725c9a7fba910a12e6eef5f8834ecfa4"} 20:49:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:49:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:49:02 INFO - Contents: 20:49:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/499969f93f7b960d7f2ade52ddedf31ef2857ebace1df4d9844c7567bca84458fa98bb25a42e4a673d45a083359018600777fc6770f58e6339436c8ecb81bb6d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/331276a2c9975c5d9f884044a57519602fd316008a167d85b229ce60b29300a71ff511bfbf4ef3a81e05a74ee1db9dcf35857c9a9ad6efbe05198229c24723e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5dd32ebfb6ee9b4bf0fcb98c3e595f03b1a82328a45b2c02e9190bcaabf36f2b3c303af3c8446b8757786ff1e73bb41c725c9a7fba910a12e6eef5f8834ecfa4"} 20:49:02 INFO - Running post-run listener: copy_logs_to_upload_dir 20:49:02 INFO - Copying logs to upload dir... 20:49:02 INFO - mkdir: /builds/slave/test/build/upload/logs 20:49:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.569894 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-08-19 20:49:02.084841) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 20:49:02.087976) ========= 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.fIquJkjZd1/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.E5j14vST24/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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/499969f93f7b960d7f2ade52ddedf31ef2857ebace1df4d9844c7567bca84458fa98bb25a42e4a673d45a083359018600777fc6770f58e6339436c8ecb81bb6d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/331276a2c9975c5d9f884044a57519602fd316008a167d85b229ce60b29300a71ff511bfbf4ef3a81e05a74ee1db9dcf35857c9a9ad6efbe05198229c24723e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5dd32ebfb6ee9b4bf0fcb98c3e595f03b1a82328a45b2c02e9190bcaabf36f2b3c303af3c8446b8757786ff1e73bb41c725c9a7fba910a12e6eef5f8834ecfa4"} build_url:https://queue.taskcluster.net/v1/task/NiLmUKs2SpmIFerD9APJTw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010969 build_url: 'https://queue.taskcluster.net/v1/task/NiLmUKs2SpmIFerD9APJTw/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/499969f93f7b960d7f2ade52ddedf31ef2857ebace1df4d9844c7567bca84458fa98bb25a42e4a673d45a083359018600777fc6770f58e6339436c8ecb81bb6d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/331276a2c9975c5d9f884044a57519602fd316008a167d85b229ce60b29300a71ff511bfbf4ef3a81e05a74ee1db9dcf35857c9a9ad6efbe05198229c24723e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5dd32ebfb6ee9b4bf0fcb98c3e595f03b1a82328a45b2c02e9190bcaabf36f2b3c303af3c8446b8757786ff1e73bb41c725c9a7fba910a12e6eef5f8834ecfa4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 20:49:02.120157) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 20:49:02.120466) ========= 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.fIquJkjZd1/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.E5j14vST24/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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.005245 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 20:49:02.169535) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 20:49:02.169852) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 20:49:02.170180) ========= ========= Total master_lag: 0.34 =========