builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0029 starttime: 1481110607.79 results: success (0) buildid: 20161207023039 builduid: bbcab8a5c4d84b2ca9b49adab56e8941 revision: b44c57f045c25e3af4e868e9a5ba76aa6060d275 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-07 03:36:47.794678) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-07 03:36:47.795105) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-07 03:36:47.795397) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-07 03:36:47.873924) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 03:36:47.874278) ========= 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.6I2PWRzW4A/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.hHPuowyAuT/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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-12-07 03:36:47-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.24M=0.001s 2016-12-07 03:36:48 (8.24 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128320 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 03:36:48.029307) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 03:36:48.029622) ========= 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.6I2PWRzW4A/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.hHPuowyAuT/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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.019416 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 03:36:48.078600) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-07 03:36:48.079283) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b44c57f045c25e3af4e868e9a5ba76aa6060d275 --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 b44c57f045c25e3af4e868e9a5ba76aa6060d275 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6I2PWRzW4A/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.hHPuowyAuT/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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-12-07 03:36:48,154 truncating revision to first 12 chars 2016-12-07 03:36:48,154 Setting DEBUG logging. 2016-12-07 03:36:48,154 attempt 1/10 2016-12-07 03:36:48,155 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b44c57f045c2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-07 03:36:49,119 unpacking tar archive at: mozilla-central-b44c57f045c2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.206902 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-07 03:36:49.315755) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-07 03:36:49.316102) ========= script_repo_revision: b44c57f045c25e3af4e868e9a5ba76aa6060d275 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-07 03:36:49.316518) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-07 03:36:49.316788) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-07 03:36:49.336562) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-12-07 03:36:49.336838) ========= /tools/buildbot/bin/python -u 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', '-u', '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.6I2PWRzW4A/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.hHPuowyAuT/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 03:36:49 INFO - MultiFileLogger online at 20161207 03:36:49 in /builds/slave/test 03:36:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:36:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:36:49 INFO - {'append_to_log': False, 03:36:49 INFO - 'base_work_dir': '/builds/slave/test', 03:36:49 INFO - 'blob_upload_branch': 'Firefox', 03:36:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:36:49 INFO - 'branch': 'Firefox', 03:36:49 INFO - 'buildbot_json_path': 'buildprops.json', 03:36:49 INFO - 'config_files': ('talos/mac_config.py',), 03:36:49 INFO - 'default_actions': ('clobber', 03:36:49 INFO - 'read-buildbot-config', 03:36:49 INFO - 'download-and-extract', 03:36:49 INFO - 'populate-webroot', 03:36:49 INFO - 'create-virtualenv', 03:36:49 INFO - 'install', 03:36:49 INFO - 'run-tests'), 03:36:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:36:49 INFO - 'download_minidump_stackwalk': True, 03:36:49 INFO - 'download_symbols': 'ondemand', 03:36:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:36:49 INFO - 'tooltool.py': '/tools/tooltool.py', 03:36:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:36:49 INFO - '/tools/misc-python/virtualenv.py')}, 03:36:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:36:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:36:49 INFO - 'installer_path': 'installer.exe', 03:36:49 INFO - 'log_level': 'info', 03:36:49 INFO - 'log_name': 'talos', 03:36:49 INFO - 'log_to_console': True, 03:36:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:36:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:36:49 INFO - 'opt_config_files': (), 03:36:49 INFO - 'pip_index': False, 03:36:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:36:49 INFO - 'cmd': ('bash', 03:36:49 INFO - '-c', 03:36:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:36:49 INFO - 'enabled': True, 03:36:49 INFO - 'halt_on_failure': False, 03:36:49 INFO - 'name': 'check_screen_resolution'},), 03:36:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:36:49 INFO - 'cmd': ('bash', 03:36:49 INFO - '-c', 03:36:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:36:49 INFO - 'enabled': True, 03:36:49 INFO - 'halt_on_failure': False, 03:36:49 INFO - 'name': 'check_screen_resolution'},), 03:36:49 INFO - 'run_cmd_checks_enabled': True, 03:36:49 INFO - 'sps_profile': False, 03:36:49 INFO - 'sps_profile_interval': 0, 03:36:49 INFO - 'suite': 'dromaeojs-e10s', 03:36:49 INFO - 'system_bits': '32', 03:36:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:36:49 INFO - 'title': 't-yosemite-r7-0029', 03:36:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:36:49 INFO - 'use_talos_json': True, 03:36:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:36:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:36:49 INFO - 'work_dir': 'build'} 03:36:49 INFO - [mozharness: 2016-12-07 11:36:49.535896Z] Running clobber step. 03:36:49 INFO - Running pre-action listener: _resource_record_pre_action 03:36:49 INFO - Running main action method: clobber 03:36:49 INFO - rmtree: /builds/slave/test/build 03:36:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:36:51 INFO - Running post-action listener: _resource_record_post_action 03:36:51 INFO - [mozharness: 2016-12-07 11:36:51.126550Z] Finished clobber step (success) 03:36:51 INFO - [mozharness: 2016-12-07 11:36:51.126700Z] Running read-buildbot-config step. 03:36:51 INFO - Running pre-action listener: _resource_record_pre_action 03:36:51 INFO - Running main action method: read_buildbot_config 03:36:51 INFO - Using buildbot properties: 03:36:51 INFO - { 03:36:51 INFO - "project": "", 03:36:51 INFO - "product": "firefox", 03:36:51 INFO - "script_repo_revision": "production", 03:36:51 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 03:36:51 INFO - "repository": "", 03:36:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 03:36:51 INFO - "buildid": "20161207023039", 03:36:51 INFO - "pgo_build": "False", 03:36:51 INFO - "basedir": "/builds/slave/test", 03:36:51 INFO - "buildnumber": 10, 03:36:51 INFO - "slavename": "t-yosemite-r7-0029", 03:36:51 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 03:36:51 INFO - "platform": "yosemite_r7", 03:36:51 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:36:51 INFO - "branch": "mozilla-central", 03:36:51 INFO - "repo_path": "mozilla-central", 03:36:51 INFO - "revision": "b44c57f045c25e3af4e868e9a5ba76aa6060d275", 03:36:51 INFO - "stage_platform": "macosx64", 03:36:51 INFO - "builduid": "bbcab8a5c4d84b2ca9b49adab56e8941", 03:36:51 INFO - "slavebuilddir": "test" 03:36:51 INFO - } 03:36:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/WSflS5v-R3Gk-T79XXcPAw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 03:36:51 INFO - Running post-action listener: _resource_record_post_action 03:36:51 INFO - [mozharness: 2016-12-07 11:36:51.130015Z] Finished read-buildbot-config step (success) 03:36:51 INFO - [mozharness: 2016-12-07 11:36:51.130124Z] Running download-and-extract step. 03:36:51 INFO - Running pre-action listener: _resource_record_pre_action 03:36:51 INFO - Running main action method: download_and_extract 03:36:51 INFO - mkdir: /builds/slave/test/build/tests 03:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:51 INFO - trying https://queue.taskcluster.net/v1/task/WSflS5v-R3Gk-T79XXcPAw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 03:36:51 INFO - Downloading https://queue.taskcluster.net/v1/task/WSflS5v-R3Gk-T79XXcPAw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 03:36:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WSflS5v-R3Gk-T79XXcPAw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 03:36:52 INFO - Downloaded 1199 bytes. 03:36:52 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 03:36:52 INFO - Using the following test package requirements: 03:36:52 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 03:36:52 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:36:52 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 03:36:52 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:36:52 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 03:36:52 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:36:52 INFO - u'jsshell-mac.zip'], 03:36:52 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:36:52 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 03:36:52 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 03:36:52 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:36:52 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 03:36:52 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:36:52 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 03:36:52 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:36:52 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 03:36:52 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:36:52 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 03:36:52 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:36:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WSflS5v-R3Gk-T79XXcPAw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 03:36:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WSflS5v-R3Gk-T79XXcPAw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:36:52 INFO - Fetch https://queue.taskcluster.net/v1/task/WSflS5v-R3Gk-T79XXcPAw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 03:36:52 INFO - Expected file size: 16284253 03:36:52 INFO - Obtained file size: 16284253 03:36:59 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:36:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WSflS5v-R3Gk-T79XXcPAw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 03:36:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WSflS5v-R3Gk-T79XXcPAw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:36:59 INFO - Fetch https://queue.taskcluster.net/v1/task/WSflS5v-R3Gk-T79XXcPAw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 03:37:00 INFO - Expected file size: 16284253 03:37:00 INFO - Obtained file size: 16284253 03:37:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WSflS5v-R3Gk-T79XXcPAw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 03:37:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WSflS5v-R3Gk-T79XXcPAw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:37:06 INFO - Fetch https://queue.taskcluster.net/v1/task/WSflS5v-R3Gk-T79XXcPAw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 03:37:07 INFO - Expected file size: 14409734 03:37:07 INFO - Obtained file size: 14409734 03:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:08 INFO - trying https://queue.taskcluster.net/v1/task/WSflS5v-R3Gk-T79XXcPAw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 03:37:08 INFO - Downloading https://queue.taskcluster.net/v1/task/WSflS5v-R3Gk-T79XXcPAw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 03:37:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WSflS5v-R3Gk-T79XXcPAw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 03:37:12 INFO - Downloaded 107588934 bytes. 03:37:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WSflS5v-R3Gk-T79XXcPAw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 03:37:12 INFO - mkdir: /builds/slave/test/properties 03:37:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:37:12 INFO - Writing to file /builds/slave/test/properties/build_url 03:37:12 INFO - Contents: 03:37:12 INFO - build_url:https://queue.taskcluster.net/v1/task/WSflS5v-R3Gk-T79XXcPAw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 03:37:13 INFO - Running post-action listener: _resource_record_post_action 03:37:13 INFO - Running post-action listener: set_extra_try_arguments 03:37:13 INFO - [mozharness: 2016-12-07 11:37:13.531031Z] Finished download-and-extract step (success) 03:37:13 INFO - [mozharness: 2016-12-07 11:37:13.531156Z] Running populate-webroot step. 03:37:13 INFO - Running pre-action listener: _resource_record_pre_action 03:37:13 INFO - Running main action method: populate_webroot 03:37:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:37:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:37:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:37:13 INFO - '--tppagecycles', 03:37:13 INFO - '7'], 03:37:13 INFO - 'tests': ['tsvgm']}}, 03:37:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:37:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:37:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:37:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:37:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:37:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:37:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:37:13 INFO - 'talos_options': ['--disable-e10s'], 03:37:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:37:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:37:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:37:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:37:13 INFO - 'talos_options': ['--disable-e10s'], 03:37:13 INFO - 'tests': ['damp', 'tps']}, 03:37:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:37:13 INFO - 'tests': ['damp', 'tps']}, 03:37:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:37:13 INFO - 'tests': ['dromaeo_dom']}, 03:37:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:37:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:37:13 INFO - 'tests': ['basic_compositor_video']}, 03:37:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:37:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:37:13 INFO - 'tests': ['a11yr', 03:37:13 INFO - 'ts_paint', 03:37:13 INFO - 'tpaint', 03:37:13 INFO - 'sessionrestore', 03:37:13 INFO - 'sessionrestore_no_auto_restore', 03:37:13 INFO - 'tabpaint']}, 03:37:13 INFO - 'other-e10s': {'tests': ['a11yr', 03:37:13 INFO - 'ts_paint', 03:37:13 INFO - 'tpaint', 03:37:13 INFO - 'sessionrestore', 03:37:13 INFO - 'sessionrestore_no_auto_restore', 03:37:13 INFO - 'tabpaint']}, 03:37:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:37:13 INFO - 'ts_paint', 03:37:13 INFO - 'tpaint', 03:37:13 INFO - 'sessionrestore', 03:37:13 INFO - 'sessionrestore_no_auto_restore', 03:37:13 INFO - 'tabpaint']}, 03:37:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:37:13 INFO - 'ts_paint', 03:37:13 INFO - 'tpaint', 03:37:13 INFO - 'sessionrestore', 03:37:13 INFO - 'sessionrestore_no_auto_restore', 03:37:13 INFO - 'tabpaint']}, 03:37:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:37:13 INFO - 'tests': ['a11yr', 03:37:13 INFO - 'ts_paint', 03:37:13 INFO - 'tpaint', 03:37:13 INFO - 'sessionrestore', 03:37:13 INFO - 'sessionrestore_no_auto_restore', 03:37:13 INFO - 'tabpaint']}, 03:37:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:37:13 INFO - 'tests': ['a11yr', 03:37:13 INFO - 'ts_paint', 03:37:13 INFO - 'tpaint', 03:37:13 INFO - 'sessionrestore', 03:37:13 INFO - 'sessionrestore_no_auto_restore', 03:37:13 INFO - 'tabpaint']}, 03:37:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:37:13 INFO - 'tests': ['tsvgx', 03:37:13 INFO - 'tsvgr_opacity', 03:37:13 INFO - 'tart', 03:37:13 INFO - 'tscrollx', 03:37:13 INFO - 'cart', 03:37:13 INFO - 'tsvg_static']}, 03:37:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:37:13 INFO - 'tsvgr_opacity', 03:37:13 INFO - 'tart', 03:37:13 INFO - 'tscrollx', 03:37:13 INFO - 'cart', 03:37:13 INFO - 'tsvg_static']}, 03:37:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:37:13 INFO - 'talos_options': ['--disable-e10s'], 03:37:13 INFO - 'tests': ['tp5o']}, 03:37:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:37:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:37:13 INFO - 'talos_options': ['--disable-e10s', 03:37:13 INFO - '--xperf_path', 03:37:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:37:13 INFO - 'tests': ['tp5n']}, 03:37:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:37:13 INFO - 'talos_options': ['--xperf_path', 03:37:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:37:13 INFO - 'tests': ['tp5n']}}, 03:37:13 INFO - 'talos.zip': {'path': '', 03:37:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:37:13 INFO - Running post-action listener: _resource_record_post_action 03:37:13 INFO - [mozharness: 2016-12-07 11:37:13.549749Z] Finished populate-webroot step (success) 03:37:13 INFO - [mozharness: 2016-12-07 11:37:13.549876Z] Running create-virtualenv step. 03:37:13 INFO - Running pre-action listener: _resource_record_pre_action 03:37:13 INFO - Running main action method: create_virtualenv 03:37:13 INFO - Creating virtualenv /builds/slave/test/build/venv 03:37: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 03:37:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:37:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:37:13 INFO - Using real prefix '/tools/python27' 03:37:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:37:14 INFO - Installing distribute.............................................................................................................................................................................................done. 03:37:17 INFO - Installing pip.................done. 03:37:17 INFO - Return code: 0 03:37:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:37:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:37:17 INFO - Reading from file tmpfile_stdout 03:37:17 INFO - Output received: 03:37:17 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:37:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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')]} 03:37:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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 0x106df73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d6d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce884a3b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c0cd30>, '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 0x106a73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c04b20>, '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.6I2PWRzW4A/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.hHPuowyAuT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 03:37: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 03:37: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 03:37:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6I2PWRzW4A/Render', 03:37:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:17 INFO - 'HOME': '/Users/cltbld', 03:37:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:17 INFO - 'LOGNAME': 'cltbld', 03:37:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:17 INFO - 'MOZ_NO_REMOTE': '1', 03:37:17 INFO - 'NO_EM_RESTART': '1', 03:37:17 INFO - 'PAGER': '/bin/cat', 03:37:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:17 INFO - 'PWD': '/builds/slave/test', 03:37:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:17 INFO - 'SHELL': '/bin/bash', 03:37:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hHPuowyAuT/Listeners', 03:37:17 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 03:37:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:17 INFO - 'USER': 'cltbld', 03:37:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:17 INFO - 'XPC_FLAGS': '0x0', 03:37:17 INFO - 'XPC_SERVICE_NAME': '0', 03:37:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37: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 03:37:17 INFO - Cleaning up... 03:37:17 INFO - Return code: 0 03:37:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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')]} 03:37:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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 0x106df73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d6d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce884a3b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c0cd30>, '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 0x106a73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c04b20>, '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.6I2PWRzW4A/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.hHPuowyAuT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 03:37: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 03:37: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 03:37:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6I2PWRzW4A/Render', 03:37:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:17 INFO - 'HOME': '/Users/cltbld', 03:37:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:17 INFO - 'LOGNAME': 'cltbld', 03:37:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:17 INFO - 'MOZ_NO_REMOTE': '1', 03:37:17 INFO - 'NO_EM_RESTART': '1', 03:37:17 INFO - 'PAGER': '/bin/cat', 03:37:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:17 INFO - 'PWD': '/builds/slave/test', 03:37:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:17 INFO - 'SHELL': '/bin/bash', 03:37:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hHPuowyAuT/Listeners', 03:37:17 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 03:37:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:17 INFO - 'USER': 'cltbld', 03:37:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:17 INFO - 'XPC_FLAGS': '0x0', 03:37:17 INFO - 'XPC_SERVICE_NAME': '0', 03:37:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:17 INFO - Downloading/unpacking psutil>=3.1.1 03:37: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 03:37: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 03:37: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 03:37:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:37:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:37:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:37:21 INFO - Installing collected packages: psutil 03:37:21 INFO - Running setup.py install for psutil 03:37:21 INFO - building 'psutil._psutil_osx' extension 03:37: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 03:37: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 03:37: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 03:37: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 03:37:22 INFO - building 'psutil._psutil_posix' extension 03:37: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 03:37:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:37:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:37:22 INFO - ^ 03:37:22 INFO - 1 warning generated. 03:37: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 03:37:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:37:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:37:22 INFO - Successfully installed psutil 03:37:22 INFO - Cleaning up... 03:37:22 INFO - Return code: 0 03:37:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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')]} 03:37:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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 0x106df73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d6d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce884a3b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c0cd30>, '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 0x106a73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c04b20>, '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.6I2PWRzW4A/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.hHPuowyAuT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 03:37: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 03:37: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 03:37:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6I2PWRzW4A/Render', 03:37:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:22 INFO - 'HOME': '/Users/cltbld', 03:37:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:22 INFO - 'LOGNAME': 'cltbld', 03:37:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:22 INFO - 'MOZ_NO_REMOTE': '1', 03:37:22 INFO - 'NO_EM_RESTART': '1', 03:37:22 INFO - 'PAGER': '/bin/cat', 03:37:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:22 INFO - 'PWD': '/builds/slave/test', 03:37:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:22 INFO - 'SHELL': '/bin/bash', 03:37:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hHPuowyAuT/Listeners', 03:37:22 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 03:37:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:22 INFO - 'USER': 'cltbld', 03:37:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:22 INFO - 'XPC_FLAGS': '0x0', 03:37:22 INFO - 'XPC_SERVICE_NAME': '0', 03:37:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:37:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:37:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:37:25 INFO - Installing collected packages: mozsystemmonitor 03:37:25 INFO - Running setup.py install for mozsystemmonitor 03:37:25 INFO - Successfully installed mozsystemmonitor 03:37:25 INFO - Cleaning up... 03:37:25 INFO - Return code: 0 03:37:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:37:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:25 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 0x106df73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d6d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce884a3b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c0cd30>, '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 0x106a73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c04b20>, '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.6I2PWRzW4A/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.hHPuowyAuT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 03:37:25 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 03:37:25 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 03:37:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6I2PWRzW4A/Render', 03:37:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:25 INFO - 'HOME': '/Users/cltbld', 03:37:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:25 INFO - 'LOGNAME': 'cltbld', 03:37:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:25 INFO - 'MOZ_NO_REMOTE': '1', 03:37:25 INFO - 'NO_EM_RESTART': '1', 03:37:25 INFO - 'PAGER': '/bin/cat', 03:37:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:25 INFO - 'PWD': '/builds/slave/test', 03:37:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:25 INFO - 'SHELL': '/bin/bash', 03:37:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hHPuowyAuT/Listeners', 03:37:25 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 03:37:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:25 INFO - 'USER': 'cltbld', 03:37:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:25 INFO - 'XPC_FLAGS': '0x0', 03:37:25 INFO - 'XPC_SERVICE_NAME': '0', 03:37:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:26 INFO - Downloading/unpacking jsonschema==2.5.1 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:37:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:29 INFO - Downloading functools32-3.2.3-2.tar.gz 03:37:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:37:29 INFO - warning: no files found matching '*.txt' 03:37:29 INFO - no previously-included directories found matching 'build' 03:37:29 INFO - no previously-included directories found matching 'dist' 03:37:29 INFO - no previously-included directories found matching '.git*' 03:37:29 INFO - Installing collected packages: jsonschema, functools32 03:37:29 INFO - Running setup.py install for functools32 03:37:29 INFO - warning: no files found matching '*.txt' 03:37:29 INFO - no previously-included directories found matching 'build' 03:37:29 INFO - no previously-included directories found matching 'dist' 03:37:29 INFO - no previously-included directories found matching '.git*' 03:37:29 INFO - Successfully installed jsonschema functools32 03:37:29 INFO - Cleaning up... 03:37:29 INFO - Return code: 0 03:37:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:37:29 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')]} 03:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:29 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')]} 03:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:29 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 0x106df73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d6d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce884a3b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c0cd30>, '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 0x106a73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c04b20>, '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.6I2PWRzW4A/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.hHPuowyAuT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 03:37:29 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 03:37:29 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 03:37:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6I2PWRzW4A/Render', 03:37:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:29 INFO - 'HOME': '/Users/cltbld', 03:37:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:29 INFO - 'LOGNAME': 'cltbld', 03:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:29 INFO - 'MOZ_NO_REMOTE': '1', 03:37:29 INFO - 'NO_EM_RESTART': '1', 03:37:29 INFO - 'PAGER': '/bin/cat', 03:37:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:29 INFO - 'PWD': '/builds/slave/test', 03:37:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:29 INFO - 'SHELL': '/bin/bash', 03:37:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hHPuowyAuT/Listeners', 03:37:29 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 03:37:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:29 INFO - 'USER': 'cltbld', 03:37:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:29 INFO - 'XPC_FLAGS': '0x0', 03:37:29 INFO - 'XPC_SERVICE_NAME': '0', 03:37:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:37:29 INFO - Cleaning up... 03:37:29 INFO - Return code: 0 03:37:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:37:29 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')]} 03:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:29 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')]} 03:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:29 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 0x106df73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d6d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce884a3b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c0cd30>, '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 0x106a73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c04b20>, '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.6I2PWRzW4A/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.hHPuowyAuT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 03:37:29 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 03:37:29 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 03:37:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6I2PWRzW4A/Render', 03:37:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:29 INFO - 'HOME': '/Users/cltbld', 03:37:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:29 INFO - 'LOGNAME': 'cltbld', 03:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:29 INFO - 'MOZ_NO_REMOTE': '1', 03:37:29 INFO - 'NO_EM_RESTART': '1', 03:37:29 INFO - 'PAGER': '/bin/cat', 03:37:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:29 INFO - 'PWD': '/builds/slave/test', 03:37:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:29 INFO - 'SHELL': '/bin/bash', 03:37:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hHPuowyAuT/Listeners', 03:37:29 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 03:37:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:29 INFO - 'USER': 'cltbld', 03:37:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:29 INFO - 'XPC_FLAGS': '0x0', 03:37:29 INFO - 'XPC_SERVICE_NAME': '0', 03:37:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:30 INFO - Downloading/unpacking blobuploader==1.2.4 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37:32 INFO - Downloading blobuploader-1.2.4.tar.gz 03:37:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:37:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:37:32 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 03:37:32 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 03:37:32 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 03:37:32 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 03:37:32 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 03:37:32 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 03:37:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:37:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37:33 INFO - Downloading docopt-0.6.1.tar.gz 03:37:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:37:34 INFO - Installing collected packages: blobuploader, requests, docopt 03:37:34 INFO - Running setup.py install for blobuploader 03:37:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:37:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:37:34 INFO - Running setup.py install for requests 03:37:34 INFO - Running setup.py install for docopt 03:37:34 INFO - Successfully installed blobuploader requests docopt 03:37:34 INFO - Cleaning up... 03:37:34 INFO - Return code: 0 03:37:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:34 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 0x106df73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d6d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce884a3b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c0cd30>, '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 0x106a73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c04b20>, '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.6I2PWRzW4A/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.hHPuowyAuT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 03:37:34 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 03:37:34 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 03:37:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6I2PWRzW4A/Render', 03:37:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:34 INFO - 'HOME': '/Users/cltbld', 03:37:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:34 INFO - 'LOGNAME': 'cltbld', 03:37:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:34 INFO - 'MOZ_NO_REMOTE': '1', 03:37:34 INFO - 'NO_EM_RESTART': '1', 03:37:34 INFO - 'PAGER': '/bin/cat', 03:37:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:34 INFO - 'PWD': '/builds/slave/test', 03:37:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:34 INFO - 'SHELL': '/bin/bash', 03:37:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hHPuowyAuT/Listeners', 03:37:34 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 03:37:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:34 INFO - 'USER': 'cltbld', 03:37:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:34 INFO - 'XPC_FLAGS': '0x0', 03:37:34 INFO - 'XPC_SERVICE_NAME': '0', 03:37:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:37:35 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-JUkmB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:37:35 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-rDICIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:37:35 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-D_pRdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:37:35 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-DOEh9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:37:35 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-nddP0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:37:35 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-oVZDwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:37:35 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-kF4sSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:37:35 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-NjTzKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:37:35 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-XTc6xh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:37:36 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-XOQ_Vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:37:36 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-GogGk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:37:36 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-sG8Kmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:37:36 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-XKd4vF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:37:36 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-3VGfIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:36 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-XBnMJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:37:36 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-VbOG3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:37:36 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-WsZbPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:37:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:37:36 INFO - Running setup.py install for manifestparser 03:37:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:37:37 INFO - Running setup.py install for mozcrash 03:37:37 INFO - Running setup.py install for mozdebug 03:37:37 INFO - Running setup.py install for mozdevice 03:37:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:37:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:37:37 INFO - Running setup.py install for mozfile 03:37:37 INFO - Running setup.py install for mozhttpd 03:37:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:37:37 INFO - Running setup.py install for mozinfo 03:37:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:37:37 INFO - Running setup.py install for mozInstall 03:37:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:37:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:37:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:37:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:37:38 INFO - Running setup.py install for mozleak 03:37:38 INFO - Running setup.py install for mozlog 03:37:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:37:38 INFO - Running setup.py install for moznetwork 03:37:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:37:38 INFO - Running setup.py install for mozprocess 03:37:38 INFO - Running setup.py install for mozprofile 03:37:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:37:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:37:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:37:38 INFO - Running setup.py install for mozrunner 03:37:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:37:39 INFO - Running setup.py install for mozscreenshot 03:37:39 INFO - Running setup.py install for moztest 03:37:39 INFO - Running setup.py install for mozversion 03:37:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:37:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:37:39 INFO - Cleaning up... 03:37:39 INFO - Return code: 0 03:37:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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')]} 03:37:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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 0x106df73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d6d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce884a3b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c0cd30>, '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 0x106a73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c04b20>, '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.6I2PWRzW4A/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.hHPuowyAuT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 03:37: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 03:37: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 03:37:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6I2PWRzW4A/Render', 03:37:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:39 INFO - 'HOME': '/Users/cltbld', 03:37:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:39 INFO - 'LOGNAME': 'cltbld', 03:37:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:39 INFO - 'MOZ_NO_REMOTE': '1', 03:37:39 INFO - 'NO_EM_RESTART': '1', 03:37:39 INFO - 'PAGER': '/bin/cat', 03:37:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:39 INFO - 'PWD': '/builds/slave/test', 03:37:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:39 INFO - 'SHELL': '/bin/bash', 03:37:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hHPuowyAuT/Listeners', 03:37:39 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 03:37:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:39 INFO - 'USER': 'cltbld', 03:37:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:39 INFO - 'XPC_FLAGS': '0x0', 03:37:39 INFO - 'XPC_SERVICE_NAME': '0', 03:37:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:37:39 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-rP9f73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:37:39 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)) 03:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:37:39 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Ng8Keh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:37:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 03:37:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:37:39 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-r3Sjpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:37: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)) 03:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:37:40 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-ThYhhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 03:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:37:40 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-_0SD2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:37: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)) 03:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:37:40 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-5youHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:37: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)) 03:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:37:40 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-BRv5b0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:37: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)) 03:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:37:40 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-ldOjbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:37:40 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)) 03:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:37:40 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-2lC03m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:37:40 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)) 03:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:37:40 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-NqcxHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 03:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:37:40 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-lZaObF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:37:40 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)) 03:37:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:37:40 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-pnlUJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:37: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)) 03:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:37:41 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-dc58k3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:37: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)) 03:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:37:41 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-oPDvEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 03:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:41 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-x9wDvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:37: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)) 03:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:37:41 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-i2gPfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:37: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)) 03:37:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:37:41 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-XHtjpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:37:41 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)) 03:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:37:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:37:41 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)) 03:37:41 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:37:41 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:37:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:37:41 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 03:37:41 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 03:37:41 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 03:37:41 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 03:37:41 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 03:37:41 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 03:37:44 INFO - Downloading blessings-1.6.tar.gz 03:37:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:37:44 INFO - Installing collected packages: blessings 03:37:44 INFO - Running setup.py install for blessings 03:37:44 INFO - Successfully installed blessings 03:37:44 INFO - Cleaning up... 03:37:44 INFO - Return code: 0 03:37:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:37:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:37:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:37:44 INFO - Reading from file tmpfile_stdout 03:37:44 INFO - Current package versions: 03:37:44 INFO - blessings == 1.6 03:37:44 INFO - blobuploader == 1.2.4 03:37:44 INFO - docopt == 0.6.1 03:37:44 INFO - functools32 == 3.2.3-2 03:37:44 INFO - jsonschema == 2.5.1 03:37:44 INFO - manifestparser == 1.1 03:37:44 INFO - mozInstall == 1.12 03:37:44 INFO - mozcrash == 1.0 03:37:44 INFO - mozdebug == 0.1 03:37:44 INFO - mozdevice == 0.49 03:37:44 INFO - mozfile == 1.2 03:37:44 INFO - mozhttpd == 0.7 03:37:44 INFO - mozinfo == 0.9 03:37:44 INFO - mozleak == 0.1 03:37:44 INFO - mozlog == 3.4 03:37:44 INFO - moznetwork == 0.27 03:37:44 INFO - mozprocess == 0.23 03:37:44 INFO - mozprofile == 0.28 03:37:44 INFO - mozrunner == 6.13 03:37:44 INFO - mozscreenshot == 0.1 03:37:44 INFO - mozsystemmonitor == 0.3 03:37:44 INFO - moztest == 0.7 03:37:44 INFO - mozversion == 1.4 03:37:44 INFO - psutil == 3.1.1 03:37:44 INFO - requests == 1.2.3 03:37:44 INFO - wsgiref == 0.1.2 03:37:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:44 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 0x106df73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d6d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce884a3b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c0cd30>, '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 0x106a73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c04b20>, '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.6I2PWRzW4A/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.hHPuowyAuT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 03:37:44 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 03:37:44 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 03:37:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6I2PWRzW4A/Render', 03:37:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:44 INFO - 'HOME': '/Users/cltbld', 03:37:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:44 INFO - 'LOGNAME': 'cltbld', 03:37:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:44 INFO - 'MOZ_NO_REMOTE': '1', 03:37:44 INFO - 'NO_EM_RESTART': '1', 03:37:44 INFO - 'PAGER': '/bin/cat', 03:37:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:44 INFO - 'PWD': '/builds/slave/test', 03:37:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:44 INFO - 'SHELL': '/bin/bash', 03:37:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hHPuowyAuT/Listeners', 03:37:44 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 03:37:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:44 INFO - 'USER': 'cltbld', 03:37:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:44 INFO - 'XPC_FLAGS': '0x0', 03:37:44 INFO - 'XPC_SERVICE_NAME': '0', 03:37:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37: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)) 03:37: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)) 03:37: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)) 03:37: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)) 03:37: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)) 03:37: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)) 03:37: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)) 03:37: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)) 03:37: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)) 03:37: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)) 03:37: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)) 03:37:45 INFO - Cleaning up... 03:37:45 INFO - Return code: 0 03:37:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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')]} 03:37:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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 0x106df73f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d6d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce884a3b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c0cd30>, '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 0x106a73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c04b20>, '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.6I2PWRzW4A/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.hHPuowyAuT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 03:37: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 03:37: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 03:37:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6I2PWRzW4A/Render', 03:37:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:45 INFO - 'HOME': '/Users/cltbld', 03:37:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:45 INFO - 'LOGNAME': 'cltbld', 03:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:45 INFO - 'MOZ_NO_REMOTE': '1', 03:37:45 INFO - 'NO_EM_RESTART': '1', 03:37:45 INFO - 'PAGER': '/bin/cat', 03:37:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:45 INFO - 'PWD': '/builds/slave/test', 03:37:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:45 INFO - 'SHELL': '/bin/bash', 03:37:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hHPuowyAuT/Listeners', 03:37:45 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 03:37:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:45 INFO - 'USER': 'cltbld', 03:37:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:45 INFO - 'XPC_FLAGS': '0x0', 03:37:45 INFO - 'XPC_SERVICE_NAME': '0', 03:37:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:37:45 INFO - Cleaning up... 03:37:45 INFO - Return code: 0 03:37:45 INFO - Running post-action listener: _resource_record_post_action 03:37:45 INFO - Running post-action listener: _start_resource_monitoring 03:37:45 INFO - Starting resource monitoring. 03:37:45 INFO - [mozharness: 2016-12-07 11:37:45.361044Z] Finished create-virtualenv step (success) 03:37:45 INFO - [mozharness: 2016-12-07 11:37:45.362049Z] Running install step. 03:37:45 INFO - Running pre-action listener: _resource_record_pre_action 03:37:45 INFO - Running main action method: install 03:37:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:37:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:37:45 INFO - Reading from file tmpfile_stdout 03:37:45 INFO - Detecting whether we're running mozinstall >=1.0... 03:37:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:37:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:37:45 INFO - Reading from file tmpfile_stdout 03:37:45 INFO - Output received: 03:37:45 INFO - Usage: mozinstall [options] installer 03:37:45 INFO - Options: 03:37:45 INFO - -h, --help show this help message and exit 03:37:45 INFO - -d DEST, --destination=DEST 03:37:45 INFO - Directory to install application into. [default: 03:37:45 INFO - "/builds/slave/test"] 03:37:45 INFO - --app=APP Application being installed. [default: firefox] 03:37:45 INFO - mkdir: /builds/slave/test/build/application 03:37:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:37:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:38:18 INFO - Reading from file tmpfile_stdout 03:38:18 INFO - Output received: 03:38:18 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:38:18 INFO - Running post-action listener: _resource_record_post_action 03:38:18 INFO - [mozharness: 2016-12-07 11:38:18.463559Z] Finished install step (success) 03:38:18 INFO - [mozharness: 2016-12-07 11:38:18.463723Z] Running run-tests step. 03:38:18 INFO - Running pre-action listener: _resource_record_pre_action 03:38:18 INFO - Running main action method: run_tests 03:38:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:38:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:38:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:38:18 INFO - 2016-12-07 03:38:18.478 screenresolution[1925:14176] starting screenresolution argv=screenresolution get 03:38:18 INFO - 2016-12-07 03:38:18.481 screenresolution[1925:14176] Display 0: 1600x1200x32@60 03:38:18 INFO - 2016-12-07 03:38:18.487 screenresolution[1926:14178] starting screenresolution argv=screenresolution list 03:38:18 INFO - Available Modes on Display 0 03:38:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:38:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:38:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:38:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:38:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:38:18 INFO - Intel Iris: 03:38:18 INFO - Chipset Model: Intel Iris 03:38:18 INFO - Type: GPU 03:38:18 INFO - Bus: Built-In 03:38:18 INFO - VRAM (Dynamic, Max): 1536 MB 03:38:18 INFO - Vendor: Intel (0x8086) 03:38:18 INFO - Device ID: 0x0a2e 03:38:18 INFO - Revision ID: 0x0009 03:38:18 INFO - Displays: 03:38:18 INFO - Display: 03:38:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:38:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:38:18 INFO - Display Serial Number: 1600x1200 60 03:38:18 INFO - Main Display: Yes 03:38:18 INFO - Mirror: Off 03:38:18 INFO - Online: Yes 03:38:18 INFO - Rotation: Supported 03:38:18 INFO - Return code: 0 03:38:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:38:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:38:18 INFO - Python 2.7.3 03:38:18 INFO - Return code: 0 03:38:18 INFO - grabbing minidump binary from tooltool 03:38:18 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')]} 03:38:18 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 0x106c0cd30>, '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 0x106a73db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c04b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:38:18 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 03:38:18 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 03:38:18 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 03:38:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:38:18 INFO - Return code: 0 03:38:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:38:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:38:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:38:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:38:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:38:18 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/WSflS5v-R3Gk-T79XXcPAw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0029', '--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 03:38:18 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/WSflS5v-R3Gk-T79XXcPAw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0029 --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 03:38:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6I2PWRzW4A/Render', 03:38:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:38:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:38:18 INFO - 'HOME': '/Users/cltbld', 03:38:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:38:18 INFO - 'LOGNAME': 'cltbld', 03:38:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:38:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:38:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:18 INFO - 'MOZ_NO_REMOTE': '1', 03:38:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:38:18 INFO - 'NO_EM_RESTART': '1', 03:38:18 INFO - 'PAGER': '/bin/cat', 03:38:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:38:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:18 INFO - 'PWD': '/builds/slave/test', 03:38:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:38:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:38:18 INFO - 'SHELL': '/bin/bash', 03:38:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hHPuowyAuT/Listeners', 03:38:18 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 03:38:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:38:18 INFO - 'USER': 'cltbld', 03:38:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:38:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:38:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:18 INFO - 'XPC_FLAGS': '0x0', 03:38:18 INFO - 'XPC_SERVICE_NAME': '0', 03:38:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:38:18 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/WSflS5v-R3Gk-T79XXcPAw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0029', '--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 03:38:19 INFO - mozversion application_buildid: 20161207023039 03:38:19 INFO - mozversion application_changeset: b44c57f045c25e3af4e868e9a5ba76aa6060d275 03:38:19 INFO - mozversion application_display_name: Nightly 03:38:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:38:19 INFO - mozversion application_name: Firefox 03:38:19 INFO - mozversion application_remotingname: firefox 03:38:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:38:19 INFO - mozversion application_vendor: Mozilla 03:38:19 INFO - mozversion application_version: 53.0a1 03:38:19 INFO - mozversion platform_buildid: 20161207023039 03:38:19 INFO - mozversion platform_changeset: b44c57f045c25e3af4e868e9a5ba76aa6060d275 03:38:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:38:19 INFO - mozversion platform_version: 53.0a1 03:38:19 INFO - using testdate: 1481110699 03:38:19 INFO - actual date: 1481110699 03:38:19 INFO - starting webserver on 'localhost:51555' 03:38:19 INFO - SUITE-START | Running 2 tests 03:38:19 INFO - TEST-START | dromaeo_css 03:38:19 INFO - operating with platform_type : mac_ 03:38:19 INFO - Initialising browser for dromaeo_css test... 03:38:19 INFO - TEST-INFO | started process 1936 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpWCmW1Z/profile http://localhost:51555/getInfo.html) 03:38:21 INFO - PROCESS | 1936 | 2016-12-07 03:38:21.993 plugin-container[1938:14337] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c3f, name = 'com.apple.tsm.portname' 03:38:21 INFO - PROCESS | 1936 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:38:21 INFO - PROCESS | 1936 | 2016-12-07 03:38:21.995 plugin-container[1938:14337] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9117, name = 'com.apple.CFPasteboardClient' 03:38:21 INFO - PROCESS | 1936 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:38:21 INFO - PROCESS | 1936 | 2016-12-07 03:38:21.995 plugin-container[1938:14337] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:38:22 INFO - PROCESS | 1936 | __metrics Screen width/height:1600/1200 03:38:22 INFO - PROCESS | 1936 | colorDepth:24 03:38:22 INFO - PROCESS | 1936 | Browser inner width/height: 1024/689 03:38:22 INFO - PROCESS | 1936 | __metrics 03:38:22 ERROR - PROCESS | 1936 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 03:38:22 INFO - PROCESS | 1936 | 03:38:22 INFO - PROCESS | 1936 | ###!!! [Parent][MessageChannel] Error: (msgtype=0xEE0015,name=PVRManager::Msg_NotifyVSync) Channel error: cannot send/recv 03:38:22 INFO - PROCESS | 1936 | 03:38:22 INFO - TEST-INFO | 1936: exit 0 03:38:22 INFO - Browser initialized. 03:38:22 INFO - Running cycle 1/1 for dromaeo_css test... 03:38:22 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpWCmW1Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:38:25 INFO - PROCESS | 1939 | 2016-12-07 03:38:25.839 plugin-container[1940:14460] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x433b, name = 'com.apple.tsm.portname' 03:38:25 INFO - PROCESS | 1939 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:38:25 INFO - PROCESS | 1939 | 2016-12-07 03:38:25.840 plugin-container[1940:14460] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x471b, name = 'com.apple.CFPasteboardClient' 03:38:25 INFO - PROCESS | 1939 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:38:25 INFO - PROCESS | 1939 | 2016-12-07 03:38:25.840 plugin-container[1940:14460] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:38:35 INFO - PROCESS | 1939 | RSS: Main: 241610752 03:38:35 INFO - PROCESS | 1939 | 03:39:25 INFO - PROCESS | 1939 | 1481110765010 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] 03:41:38 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:51555/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51555/tests/dromaeo/cssquery-ext.html) 03:41:40 INFO - PROCESS | 1939 | RSS: Main: 249962496 03:41:40 INFO - PROCESS | 1939 | 03:44:43 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:51555/tests/dromaeo/cssquery-ext.html (next: http://localhost:51555/tests/dromaeo/cssquery-jquery.html) 03:44:43 INFO - PROCESS | 1939 | RSS: Main: 261345280 03:44:43 INFO - PROCESS | 1939 | 03:47:45 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:51555/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51555/tests/dromaeo/cssquery-mootools.html) 03:47:46 INFO - PROCESS | 1939 | RSS: Main: 266596352 03:47:46 INFO - PROCESS | 1939 | 03:50:48 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:51555/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51555/tests/dromaeo/cssquery-prototype.html) 03:50:48 INFO - PROCESS | 1939 | RSS: Main: 266289152 03:50:48 INFO - PROCESS | 1939 | 03:53:51 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:51555/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51555/tests/dromaeo/cssquery-yui.html) 03:53:52 INFO - PROCESS | 1939 | RSS: Main: 271384576 03:53:52 INFO - PROCESS | 1939 | 03:56:55 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:51555/tests/dromaeo/cssquery-yui.html (next: http://localhost:51555/tests/dromaeo/cssquery-dojo.html) 03:56:55 INFO - PROCESS | 1939 | RSS: Main: 274255872 03:56:55 INFO - PROCESS | 1939 | 03:56:55 INFO - PROCESS | 1939 | __start_tp_report 03:56:55 INFO - PROCESS | 1939 | _x_x_mozilla_page_load 03:56:55 INFO - PROCESS | 1939 | _x_x_mozilla_page_load_details 03:56:55 INFO - PROCESS | 1939 | |i|pagename|runs| 03:56:55 INFO - PROCESS | 1939 | |0;dojo.html;2816.746492815646;3325.451300535412;3334.949975750364;3379.138319728469;3381.1040074380285;5594.58040646951;5605.131204663274;5674.035413979623;5681.2614360133175;5690.715464226792;5551.805686800963;5682.659040457575;5740;5764.020116580181;5781.971090144554;5131.846044618658;5157.432682404932;5190.792368305263;5195.740212989354;5249;4433.246348120827;5217.087009773293;5241.633085684004;5246.003259380725;5249.921251181236;5047.798088076473;5239.738013099349;5244.868878278055;5248.0553500369915;5253.317068781053;4471.642268618502;5239.423663397023;5249.9212511811975;5260.368755749297;5279.392869819982;5058.544730974193;5145.090560546673;5246.658967167122;5251.501107394792;5254.947450525484;5329.893402131975;5850.97074514629;5865.120231965239;5871.148683440877;5877.970610146922;5310.893782124336;6053.122297266872;6178.227721534809;6215.720292586844;6216.098665693495;6063.18147050147;6064.938635738772;6109.450149486567;6117.938820611781;6184.81445556634;4841.491643377465;5878.823635290948;5914.9112763308585;5944.10838374243;5981.9401805981815;6234.438900498886;6241.656708881055;6245.96877015612;6264.279607845065;6270.372962703785;4915.778789954461;5944.494717949023;5981;6177.351378105324;6179.876402471926;5992.940070599238;6113.932424433873;6140.048292514667;6145.095020543646;6183.505319574423;5118.820841270538;5171.5261150571905;6136.325004249529;6203;6204.627722336674;6089.269287685506;6136.7852125175405;6159.29168145669;6215.9378406216265;6235.812925612239;4820.060088282821;4868.878278043077;4888.486708895586;4893.877653058702;4896.5837903777865;4393.912121757547;4436.933445998313;4472.888177795581;4480.865574032784;4524.5701658342405;5623.775048997994;5891.734871930774;5952.940470595326;5958.177029292001;5976.432238937294;6107.310189946649;6141.699273337082;6174.969125154345;6218.098375735493;6234.594751341148;5834.533237341003;5853;5895.380984996514;5917.112433135064;5926.348101708809;5265.868353291198;5329.467053294639;5338.733063346895;5365.543928766098;5414.07960646691;6201.627902325875;6234.625922444668;6251.218597675291;6256.687165641791;6301.369863013662;5406.216098665593;6096.298925623432;6186.690665466798;6199.938000620116;6222.688865556795;6150.477209437248;6177.104319873683;6185.628862268099;6224.315325314303;6297.433231009231;6153.169322141633;6195.070739389128;6209.658468784261;6226.657533835682;6231.844203894939;5206.947930520646;5908.497777688945;6167.753289868355;6188.690565471798;6193.4425901669065;5928.762849486145;5994.910076348771;6035.39646035393;6126.5711400203345;6151.415615516519;5744.339400968942;6000.69996500182;6068.059450785136;6117.204763380732;6119.41115851624;5647.943520564741;5792.681402522901;6008.8798224036145;6018.969905150446;6024.457798798129;6078.392160784063;6117.449429551361;6119.541034422347;6137.478314343152;6162.476189523762;5496.763228273607;5823.126531020212;5848.970755146197;5856.648601083949;5942.910856337245 03:56:55 INFO - PROCESS | 1939 | |1;ext.html;501.23315313519817;517.9404368497622;524.4388504300398;524.9868753281168;526.51823581423;30976;38830.922753110906;39073.218535629305;41383.379249311285;41403;40005.19989600214;40466.39300410496;40490.39264411036;40500;40538;8329.50022998619;8568.957155214246;9222.907770922306;9360.438373697565;9402.294827887901;9203.585838637244;11243.662690119269;11256.38089905055;11294.152938529602;11391.316521008725;11207.327560346364;11272.605458808943;11281.435928203598;11290.943545282304;11307.378094204816;11183.664490065312;11231.21381503295;11231.66305010847;11233.269837460539;11286.548538058469;11057.889421105767;11070.667879963614;11102.722431939186;11139.33164010162;11162.944185279102;38437.80781096077;38472.80763596192;38799.8060009701;38801.611983880364;38802.417963730564;3249.8537565809597;3389.389909816232;3416.692497675196;3455.8963231103107;3908.4528166056775;28893.855530722423;29278.121656350344;29450.558241626393;30242.546361804372;30284.54573181404;3107.5804766356478;3146.197719581492;3147.5436061770915;3152.7793054486197;3250.073728987251;470204;474827;475811;477728;479463;58455.70772146112;58672;59088;59123.704381477815;59929.703866287775;61721.382786172464;62227;62302.68848655728;62364;62377;15379.00036497624;15866.92066539683;16002.039877607382;16011;16023.519294421187;9471.621135154655;9631.951840240754;10006.44964526958;12033.217840840318;12257.693557660952;14894.957352985404;18308.26766929308;18484.70607057493;18490.428313593227;18903.960282184336;6022.5483088768515;7744;7863.410244231705;7891.092524359772;7914.089879663912;841.4993079117914;925.22281283722;954.2461455450256;974.3861367338532;978.8400745116917;26068.217953461426;28523.857380712965;29053.709462905525;29601.111966641034;29758.1072567819;1015.939043657383;1057.5716834681966;1111.4498323329842;1126.3692332293942;1184.1237484261756;14986.775198372034;15076.849231507764;15146.545603631908;15240;15336.923315383352;191898;191964;192050;192401;192944;55065.72467137639;55327.89344213093;55531;55640;55698.72150639221;1320.1287150480637;1351.6418149190472;1357.6198664373992;1369.7671395862728;1372.5813626843708;25404.872975635004;27845.02542411006;28557.143285701462;29074.56388154137;29138.417231655672;46173.76913115547;46499.76750116228;46605.3009204869;46655.766721166176;46776.7661161692;458370;461149;461227;462674;463054;25539.489210216063;26001.21996340037;26094.478110437307;26359.868200658875;27264.318392040357;43610.34584481299;44186.337204942596;44536.886577835816;44774.3283850736;45345.31982020338;28763.137105886857;36576.81711591425;36789.632103679694;37463.6253637471;37707.62292377151;36924.630753692116;37111.628883710815;37405.361162267545;37437.43843842399;37899.621003790715;36580.81709591435;36655.45016824803;36819;36896.81551592225;37150.628493714714;31716.682833171373;33739;33790;33855.66144338525;33991.320173595894;23668.52662946766;24401.755982439947;24719.752802472463;24875.880585374063;25514.744852551237 03:56:55 INFO - PROCESS | 1939 | |2;jquery.html;356.5186997553303;360.1680118925283;362.5884620955216;370.9369407200776;387.18883938149565;18178.27286908524;18561.071946402677;19324.51688707783;19766.308179213713;19923.800761992377;19532.31636892709;20055.29806456774;20125.59748805023;20259;20391.796082039175;5544.0575102232515;5837.824865254028;5837.970810145944;5841.678707671076;5842.094475356326;5576.525995290385;5871.588988770788;5952.255968003999;5988.940110598904;5996.550258730591;5910.0543912973935;5932.317783454915;5940.970295148518;5971.10433434986;5987.161797348353;5724.5992780505385;5936.673482958436;5953.553483488756;5954.55340849438;5955.910661340084;4848.854534363974;5551.2228288039705;5713.285839270091;5749.683767392792;5791.247137872092;12291.201071930385;12414.441350139265;12415.689607759788;12498.812517812241;12514.561990330294;2102.6334964088674;2184.683220932956;2247.1685476373846;2367.443650742074;2799.5240809062507;9690.806183876353;9787.706368808947;9808.558614862348;10253.84619230712;10277.434741089237;1482.9332680029424;1656.9312793248407;1777.1380880273057;1821.7813862336604;1915.6647586672277;87635;105791;109018.45490772574;109333.90666093316;109822.45088774584;11113.721687054134;11299.943500282447;11396.259243149168;11526.769464610661;11548.249363791327;14200.64498387528;14272.500462483764;14337.35481903317;14361.210133442552;14402;6784;8254.380921430917;8262.091169971298;8405.70580029696;8525.914740852511;8042.316403105685;8082.232187942136;8134.715284964997;8216.630251638691;8281.54451505161;4315.395844581761;4504.189245935763;4522.4346956630425;4554.840580579664;4601.217792975202;1719.8710096742793;1855.4433669898976;1877.9248830046918;1926.6435709393807;1930.7296978423033;859.8495263328892;862.4480332587149;892.1836519584507;903.6400217672361;906.4561263242134;19024.809751902303;19400.738951968076;20704.689429658567;20894.74942235675;20984.160633574793;684.3498676257575;776.4719990406578;924.4545718026262;934.9439033658002;996.5963784667222;10469.633562825264;10922.235443519035;10926.125909927347;10928.726781830359;10942.617008404668;508065.6531064185;508756;512745;534330.3283483635;540019;123044.76955230512;123845;124568.1314780279;124642;126104;910.8178364327161;929.2380248196549;949.0225068179648;951.5242378810594;954.3605784124653;14469.27653617336;17266;18276.903385796893;18417.907910460362;18544.443666690022;36742.63257367499;42542.36186457144;47025.529744702115;49137.754311228215;49377;67241.99137012851;68418.9737153953;71768.64115679388;72834.27165728487;76032;7413.147488038729;7669.003029606116;7887.250711182429;7904.644291007034;8069.515829050276;8721.56392180401;10234.385936843813;11035.172362072715;11757.941210293893;12138.939305303416;9678.903210967801;9933.701988940344;10263.922288159934;10557.9472102639;10678.83981740259;10132.645357412455;10420.478976051016;10477.738056548647;10571.788564228518;10645;8909.821803564022;9832;10106.292559520763;10153.086222240034;10359.585616575252;7529.435292352986;7625.504342217738;7674.501157424749;7846.215378462108;7951.165127661744;8814.51520166397;10207.540660670436;10228.539715712663;10446.738831528968;10665.36007839532 03:56:55 INFO - PROCESS | 1939 | |3;mootools.html;1451.2163431746858;1461.7076584683064;1641.6716656668668;1729.7924249090104;1749.247823435922;6318.715657795398;7559.69761209551;7759.92240077599;8169.8153767703725;8171.387145964061;7680.846383072335;7959.960200198991;7983.880241796363;7999.280064794168;8131.349492040637;2201.57069371473;2223.977760222393;2240.4622890506243;2257.582347265753;2267.319804058784;2248.2468373094953;2279.806216471602;2282.1556024271044;2285.69143165673;2286.2683941138844;1991.9840881150574;2064.463239557718;2227.8106360959337;2249.921252756154;2251.065807689815;2215.6898034275214;2227.3652009177385;2239.395363251921;2246.7640897705833;2254.6843441918145;2240.6975058367075;2255;2259.378670865509;2264.501809601885;2270.080617349976;7997.480163789393;8029.996250468691;8067.394945379061;8077.273045425881;8087.919120808834;4893.143699852511;5013.824516141954;5032.094223039851;5043.672161309503;5053.1157047516535;2861.313284811651;2993.925151871199;3121.1884909923356;3253.6209491721334;3308.2721801203697;994.6071301835807;1024.7899180667946;1036.7926414717012;1043.1602559939247;1045.947702614866;8416.705415310496;8847.867281990839;10311.43287119208;10441.42572158531;10459.68620941373;3787.7348585598743;3894.7078969076865;4462.598366147063;4469.4189755332245;4485.170243504962;9093.81812363749;9121.635134594542;9148.954255228682;9161.358704890727;9174.954125229331;5042.546170844568;5048.570871475966;5066.518680725325;5079.415867175248;5088.0587091388215;4379.167958087953;4453.777311134495;4617.2612382018715;4637.095766325601;4677.6959497633225;3552.8223588820456;3598.9280214395567;3633.454981752758;3642.6903713184147;3650.379435495972;1159.8492196014465;1178.5462596900254;1186.3890096600257;1188.5542921404474;1194.3550482739397;860.9139086091466;866.4627930683017;867.1545243387773;908.5411867007119;928.9535523223811;4588.564086411786;5481.123020316731;5608.747606357723;5755.8561035974435;5818.301803783573;878.8374150782125;893.3478560650761;893.9106089391009;927.5733162745078;968.6125549780145;3564.6613571710645;3751.6248375162813;3773.6226377362045;3777.20678657485;3827.004978705557;8959.955200224087;9710.75723106914;9730.562124704406;9761.853572196424;9777.853332200022;9648.71053868385;9707.417554946725;9742.756431089138;9755.268354873271;9774.071463210983;7417.480776345712;7439.363340065177;7493.138289096823;7633.274838890296;7674.539527628472;5228.738563071907;5349.224362467498;5375;5387.407385187705;5448.101063324666;9032.683856065007;9061.957874844476;9063.546822658973;9092.954535227282;9122.680706175252;8286.83426331482;9017.098290171192;9109.590068446803;9155;9339.53302334867;6155.169052178077;6389;6544.83637909037;6555.639439830855;6622.735090596322;6472.546921715435;7609.619519024137;7614.923850761422;7689.346790440082;7715.382769378324;6838;6911.239763626098;6913.170419549485;6925.3074692530345;6970.337817907291;6743.426808721118;6820.590764554143;6824.590524568542;6864.279250678607;6871.244163142151;6349.4920406366455;6505.674716264262;6509.707063182073;6509.967450162909;6519.315471875385;4590.403247577793;4752.714837109785;4753.691010084333;4769.689970152068;4783.019481006455;4610.930836037529;4733.124371991193;4776.761161941959;4797.976010119927;4805.6155507558615 03:56:55 INFO - PROCESS | 1939 | |4;prototype.html;286.5815908773191;289.247955316178;295.2088403079745;297.2346208513079;297.35622377552585;4578.565036321553;4805.27920811878;5487.533559647435;5524.806631767889;5587.1339942308905;5253.60597955153;5319.175527793189;5424.620276580641;5444.292242008543;5464.617476776627;3273.5417041614132;4051.4327994080854;4107.794610269475;4160;4174.749515029108;3207.5188721691698;3358.865645374182;4029.033032072311;4198.160367926412;4238.279492486269;4068.6745060395247;4135.813888375031;4169.435796984848;4175.31107367284;4176.763008668276;3400.574928133983;4109.547949725527;4132.8140233689255;4173.624373806372;4183.79081045948;3584.731145164123;3618.5476815398074;3629.764065335771;3630.2195028068827;3653.0319465341704;4706.435227772655;5055.595552355802;5345.167061457434;5351.170568561879;5380.24676545284;4770.427548694144;4785.49752276013;4787.234042553175;4815.277708343777;4846.442659094214;4645;5054.014467178901;5428.75570599324;5605.394605394606;5809.593328467009;3769.660730534265;3940.6847452203756;3955.960440395588;3981.3430783920617;3982.3429134192825;4998.375203099613;5969.850753731148;6004.5796794224425;6016.082200132932;6061.302835206194;4030.214108248922;4036.5780531680757;4036.777977211223;4037.253108174997;4049.6760259179196;3934.855503750463;4052.4326594276827;4074.388841673713;4102.589741025873;4135.255653982252;4281.314989601711;4494.662900282427;4653.860384188412;4695.98072828687;4730.337752714623;4867.568364303158;5492.423295553909;5767.509761670305;5789.742000619762;5818.389069147678;1155.4061132756847;1259.482323799819;1292.4959265886312;1307.1046333261745;1334.9399277032558;812.9918900563259;839.8152406470567;855.3029281135854;874.9912500875037;914.0128661046055;5115.71863547501;5123.410807757155;5127.410347809975;5196.428392876781;5221.1464929949325;5219.060569097599;5541.833744987657;5569;5605.271314729059;5659.717014149276;4326.567343265711;4998.951478415417;5000.424951130666;5054.82308119214;5096.566791822663;2635.614768634389;2811.6223050705007;3030.9090727278217;3055.2514633914834;3080.753539716862;4783.182390691515;5039.807683657621;5454.318210223722;5535.723213839373;5634.5203016530495;5720.599558030898;5850.912236316459;5903.085021821625;5969.940300597025;6303.329617651326;5215.5045270698465;5481.808136715196;5978.671173085522;6078.422549857756;6350.396712312323;5145.137844736838;5389.487998640123;5658.660480371191;5837.970810145922;6062.818115456544;5017.62367822422;5776.884462310814;6060.636351822881;6085.896192941543;6134.754609815557;6046.848828779316;6323;6340.512718005171;6350.968245158745;6363.809085727436;3161.826099564546;3285.371702637832;3420.9315813684084;3816.637419445148;3889.922201555896;4784.976075119602;5943.4948029416255;5968.926003108316;5979.730912108878;5988.520918326436;5554.666719996813;5685.857853553694;5738.454846789548;5825.475707186373;5849;5129.897402052013;5823.79616713413;5903.970480147572;5913.231279933753;5931.436513531207;4933.9013219736125;5586.357568879468;5677.126548238989;5749.223854779719;5819.447152520504;5794.681292528951;5813.244887561199;5817.7963771267805;5818.534517238695;5932.703364831655;5071.446765791453;5269.367675878919;5471.781128754806;5771.769129234784;5837.824865254049 03:56:55 INFO - PROCESS | 1939 | |5;yui.html;705.0622671846445;707.1867352544573;759.0284435922022;776.7320274505294;777.8366543025962;14952.476663316786;15642.29609667565;15721.685566288681;16761.748573771372;17660.116994150274;16312.347506099743;16471.670566588662;16493.257803398847;16547.503574892773;16548.83451165488;652.0610321137547;828.2835347424465;853.0658928473312;854.0647990450447;855.8459477294084;681.9283975182584;770.1297533786841;835.4319063037133;849.9235068843802;852.3309202276214;833.4624167412015;886.5345693510926;888.3559419420933;888.5468411110348;892.9821403571957;765.3456294867891;883.4655033704613;884.0496466298722;884.3058199313508;886.3839631456141;646.2406672160193;650.2294780684904;650.408128602969;650.7234425369246;651.1795138125948;14105.012649114566;14832.887533435036;15107.32017059235;15183.240837958057;15522.922385388114;13765.242911639856;13859.722805543934;13891;14085.084469509551;14372.281385930766;11555.306681599131;11759.118066144987;11979.82030269538;11994.520219191309;12118;3574.3566158091535;3740.4576336431337;3761.6426439488205;3799.7530160539754;3811.275857587077;106030.46984765027;111388.32917506243;111919;112195;112480;9821.80356392868;10263.948680256552;10649.467526623637;10715.892841071645;10863;21080.156793728387;21118.260860869796;21126.260580879596;21148.47128821761;21176;7570.05374328209;7614.048243969504;7638.312551870358;7718.189590093071;7807.960960195162;4113.814878330482;4190.622843944059;4190.748555086643;4191.7484950903045;4215.915681686349;3341;3445.3626079175433;3446.9655303446643;3564.0733409313766;3720.144366795598;632.4434497642045;637.764027309889;640.8173670503884;646.1890327638783;658.4501940879419;573.4638113363935;652.7486917536783;663.0816319397572;673.6968364236016;675.5102550650739;7993.600319983978;8903.73288801337;9005.729828105168;9286.837756585162;9540.189083927806;583.821934310031;601.9699015049317;648.1444493268934;661.5931202310641;668.4552090046597;4323.805428755651;4385.429894113809;4550.6587005974025;4632.374629425052;4659.534046595381;93513;93991;95928;106496;118610;100975;103575;103810;104392;107419.925800741;84234;85310.57344713237;86561.47823739384;86734;90148;8613.870791938001;8621;8625.956870215608;8639.654413823628;8645.610947507503;55743.72128139334;56561.71719141378;58307;58900.70549647224;59529.51176220629;58916;82511;84159.15840841513;85577.57211213904;86899.56550217209;11261.7747645045;11430.428478575872;11649.184557080924;11691.356975366096;11953.282803031845;12558.120931534704;12621;12919.547815826776;12928.482860685843;13258.337083145998;12072.698182545506;12085.637430877088;12325.075619328407;12369;12471.251724896536;11891.227070240408;12000.918768849784;12038.582270433588;12090;12405.75188496207;11811.822822657496;11835;11867.406629668309;11893.881061189624;11901.642950711492;7730;9624.470654114091;9677.22582193437;10220.846687299547;10441;9966.053224943618;10283.537240824331;10330.121939635215;10331.638392656221;10335.17318614524 03:56:55 INFO - PROCESS | 1939 | __end_tp_report 03:56:55 INFO - PROCESS | 1939 | __start_cc_report 03:56:55 INFO - PROCESS | 1939 | _x_x_mozilla_cycle_collect,347 03:56:55 INFO - PROCESS | 1939 | __end_cc_report 03:56:55 INFO - PROCESS | 1939 | __startTimestamp1481111815609__endTimestamp 03:56:55 INFO - PROCESS | 1939 | 03:56:55 INFO - PROCESS | 1939 | ------- Summary: start ------- 03:56:55 INFO - PROCESS | 1939 | Number of tests: 6 03:56:55 INFO - PROCESS | 1939 | 03:56:55 INFO - PROCESS | 1939 | [#0] dojo.html Cycles:165 Average:5672.21 Median:5917.11 stddev:653.26 (11.0%) stddev-sans-first:615.67 03:56:55 INFO - PROCESS | 1939 | Values: 2816.7 3325.5 3334.9 3379.1 3381.1 5594.6 5605.1 5674.0 5681.3 5690.7 5551.8 5682.7 5740.0 5764.0 5782.0 5131.8 5157.4 5190.8 5195.7 5249.0 4433.2 5217.1 5241.6 5246.0 5249.9 5047.8 5239.7 5244.9 5248.1 5253.3 4471.6 5239.4 5249.9 5260.4 5279.4 5058.5 5145.1 5246.7 5251.5 5254.9 5329.9 5851.0 5865.1 5871.1 5878.0 5310.9 6053.1 6178.2 6215.7 6216.1 6063.2 6064.9 6109.5 6117.9 6184.8 4841.5 5878.8 5914.9 5944.1 5981.9 6234.4 6241.7 6246.0 6264.3 6270.4 4915.8 5944.5 5981.0 6177.4 6179.9 5992.9 6113.9 6140.0 6145.1 6183.5 5118.8 5171.5 6136.3 6203.0 6204.6 6089.3 6136.8 6159.3 6215.9 6235.8 4820.1 4868.9 4888.5 4893.9 4896.6 4393.9 4436.9 4472.9 4480.9 4524.6 5623.8 5891.7 5952.9 5958.2 5976.4 6107.3 6141.7 6175.0 6218.1 6234.6 5834.5 5853.0 5895.4 5917.1 5926.3 5265.9 5329.5 5338.7 5365.5 5414.1 6201.6 6234.6 6251.2 6256.7 6301.4 5406.2 6096.3 6186.7 6199.9 6222.7 6150.5 6177.1 6185.6 6224.3 6297.4 6153.2 6195.1 6209.7 6226.7 6231.8 5206.9 5908.5 6167.8 6188.7 6193.4 5928.8 5994.9 6035.4 6126.6 6151.4 5744.3 6000.7 6068.1 6117.2 6119.4 5647.9 5792.7 6008.9 6019.0 6024.5 6078.4 6117.4 6119.5 6137.5 6162.5 5496.8 5823.1 5849.0 5856.6 5942.9 03:56:55 INFO - PROCESS | 1939 | 03:56:55 INFO - PROCESS | 1939 | [#1] ext.html Cycles:180 Average:53485.59 Median:18704.01 stddev:106054.87 (567.0%) stddev-sans-first:106277.77 03:56:55 INFO - PROCESS | 1939 | Values: 501.2 517.9 524.4 525.0 526.5 30976.0 38830.9 39073.2 41383.4 41403.0 40005.2 40466.4 40490.4 40500.0 40538.0 8329.5 8569.0 9222.9 9360.4 9402.3 9203.6 11243.7 11256.4 11294.2 11391.3 11207.3 11272.6 11281.4 11290.9 11307.4 11183.7 11231.2 11231.7 11233.3 11286.5 11057.9 11070.7 11102.7 11139.3 11162.9 38437.8 38472.8 38799.8 38801.6 38802.4 3249.9 3389.4 3416.7 3455.9 3908.5 28893.9 29278.1 29450.6 30242.5 30284.5 3107.6 3146.2 3147.5 3152.8 3250.1 470204.0 474827.0 475811.0 477728.0 479463.0 58455.7 58672.0 59088.0 59123.7 59929.7 61721.4 62227.0 62302.7 62364.0 62377.0 15379.0 15866.9 16002.0 16011.0 16023.5 9471.6 9632.0 10006.4 12033.2 12257.7 14895.0 18308.3 18484.7 18490.4 18904.0 6022.5 7744.0 7863.4 7891.1 7914.1 841.5 925.2 954.2 974.4 978.8 26068.2 28523.9 29053.7 29601.1 29758.1 1015.9 1057.6 1111.4 1126.4 1184.1 14986.8 15076.8 15146.5 15240.0 15336.9 191898.0 191964.0 192050.0 192401.0 192944.0 55065.7 55327.9 55531.0 55640.0 55698.7 1320.1 1351.6 1357.6 1369.8 1372.6 25404.9 27845.0 28557.1 29074.6 29138.4 46173.8 46499.8 46605.3 46655.8 46776.8 458370.0 461149.0 461227.0 462674.0 463054.0 25539.5 26001.2 26094.5 26359.9 27264.3 43610.3 44186.3 44536.9 44774.3 45345.3 28763.1 36576.8 36789.6 37463.6 37707.6 36924.6 37111.6 37405.4 37437.4 37899.6 36580.8 36655.5 36819.0 36896.8 37150.6 31716.7 33739.0 33790.0 33855.7 33991.3 23668.5 24401.8 24719.8 24875.9 25514.7 03:56:55 INFO - PROCESS | 1939 | 03:56:55 INFO - PROCESS | 1939 | [#2] jquery.html Cycles:180 Average:31309.59 Median:21464.78 stddev:87302.78 (406.7%) stddev-sans-first:87516.75 03:56:55 INFO - PROCESS | 1939 | Values: 356.5 360.2 362.6 370.9 387.2 18178.3 18561.1 19324.5 19766.3 19923.8 19532.3 20055.3 20125.6 20259.0 20391.8 5544.1 5837.8 5838.0 5841.7 5842.1 5576.5 5871.6 5952.3 5988.9 5996.6 5910.1 5932.3 5941.0 5971.1 5987.2 5724.6 5936.7 5953.6 5954.6 5955.9 4848.9 5551.2 5713.3 5749.7 5791.2 12291.2 12414.4 12415.7 12498.8 12514.6 2102.6 2184.7 2247.2 2367.4 2799.5 9690.8 9787.7 9808.6 10253.8 10277.4 1482.9 1656.9 1777.1 1821.8 1915.7 87635.0 105791.0 109018.5 109333.9 109822.5 11113.7 11299.9 11396.3 11526.8 11548.2 14200.6 14272.5 14337.4 14361.2 14402.0 6784.0 8254.4 8262.1 8405.7 8525.9 8042.3 8082.2 8134.7 8216.6 8281.5 4315.4 4504.2 4522.4 4554.8 4601.2 1719.9 1855.4 1877.9 1926.6 1930.7 859.8 862.4 892.2 903.6 906.5 19024.8 19400.7 20704.7 20894.7 20984.2 684.3 776.5 924.5 934.9 996.6 10469.6 10922.2 10926.1 10928.7 10942.6 508065.7 508756.0 512745.0 534330.3 540019.0 123044.8 123845.0 124568.1 124642.0 126104.0 910.8 929.2 949.0 951.5 954.4 14469.3 17266.0 18276.9 18417.9 18544.4 36742.6 42542.4 47025.5 49137.8 49377.0 67242.0 68419.0 71768.6 72834.3 76032.0 7413.1 7669.0 7887.3 7904.6 8069.5 8721.6 10234.4 11035.2 11757.9 12138.9 9678.9 9933.7 10263.9 10557.9 10678.8 10132.6 10420.5 10477.7 10571.8 10645.0 8909.8 9832.0 10106.3 10153.1 10359.6 7529.4 7625.5 7674.5 7846.2 7951.2 8814.5 10207.5 10228.5 10446.7 10665.4 03:56:55 INFO - PROCESS | 1939 | 03:56:55 INFO - PROCESS | 1939 | [#3] mootools.html Cycles:180 Average:5216.62 Median:5381.20 stddev:2826.27 (52.5%) stddev-sans-first:2820.03 03:56:55 INFO - PROCESS | 1939 | Values: 1451.2 1461.7 1641.7 1729.8 1749.2 6318.7 7559.7 7759.9 8169.8 8171.4 7680.8 7960.0 7983.9 7999.3 8131.3 2201.6 2224.0 2240.5 2257.6 2267.3 2248.2 2279.8 2282.2 2285.7 2286.3 1992.0 2064.5 2227.8 2249.9 2251.1 2215.7 2227.4 2239.4 2246.8 2254.7 2240.7 2255.0 2259.4 2264.5 2270.1 7997.5 8030.0 8067.4 8077.3 8087.9 4893.1 5013.8 5032.1 5043.7 5053.1 2861.3 2993.9 3121.2 3253.6 3308.3 994.6 1024.8 1036.8 1043.2 1045.9 8416.7 8847.9 10311.4 10441.4 10459.7 3787.7 3894.7 4462.6 4469.4 4485.2 9093.8 9121.6 9149.0 9161.4 9175.0 5042.5 5048.6 5066.5 5079.4 5088.1 4379.2 4453.8 4617.3 4637.1 4677.7 3552.8 3598.9 3633.5 3642.7 3650.4 1159.8 1178.5 1186.4 1188.6 1194.4 860.9 866.5 867.2 908.5 929.0 4588.6 5481.1 5608.7 5755.9 5818.3 878.8 893.3 893.9 927.6 968.6 3564.7 3751.6 3773.6 3777.2 3827.0 8960.0 9710.8 9730.6 9761.9 9777.9 9648.7 9707.4 9742.8 9755.3 9774.1 7417.5 7439.4 7493.1 7633.3 7674.5 5228.7 5349.2 5375.0 5387.4 5448.1 9032.7 9062.0 9063.5 9093.0 9122.7 8286.8 9017.1 9109.6 9155.0 9339.5 6155.2 6389.0 6544.8 6555.6 6622.7 6472.5 7609.6 7614.9 7689.3 7715.4 6838.0 6911.2 6913.2 6925.3 6970.3 6743.4 6820.6 6824.6 6864.3 6871.2 6349.5 6505.7 6509.7 6510.0 6519.3 4590.4 4752.7 4753.7 4769.7 4783.0 4610.9 4733.1 4776.8 4798.0 4805.6 03:56:55 INFO - PROCESS | 1939 | 03:56:55 INFO - PROCESS | 1939 | [#4] prototype.html Cycles:180 Average:4628.44 Median:5125.41 stddev:1451.14 (28.3%) stddev-sans-first:1418.15 03:56:55 INFO - PROCESS | 1939 | Values: 286.6 289.2 295.2 297.2 297.4 4578.6 4805.3 5487.5 5524.8 5587.1 5253.6 5319.2 5424.6 5444.3 5464.6 3273.5 4051.4 4107.8 4160.0 4174.7 3207.5 3358.9 4029.0 4198.2 4238.3 4068.7 4135.8 4169.4 4175.3 4176.8 3400.6 4109.5 4132.8 4173.6 4183.8 3584.7 3618.5 3629.8 3630.2 3653.0 4706.4 5055.6 5345.2 5351.2 5380.2 4770.4 4785.5 4787.2 4815.3 4846.4 4645.0 5054.0 5428.8 5605.4 5809.6 3769.7 3940.7 3956.0 3981.3 3982.3 4998.4 5969.9 6004.6 6016.1 6061.3 4030.2 4036.6 4036.8 4037.3 4049.7 3934.9 4052.4 4074.4 4102.6 4135.3 4281.3 4494.7 4653.9 4696.0 4730.3 4867.6 5492.4 5767.5 5789.7 5818.4 1155.4 1259.5 1292.5 1307.1 1334.9 813.0 839.8 855.3 875.0 914.0 5115.7 5123.4 5127.4 5196.4 5221.1 5219.1 5541.8 5569.0 5605.3 5659.7 4326.6 4999.0 5000.4 5054.8 5096.6 2635.6 2811.6 3030.9 3055.3 3080.8 4783.2 5039.8 5454.3 5535.7 5634.5 5720.6 5850.9 5903.1 5969.9 6303.3 5215.5 5481.8 5978.7 6078.4 6350.4 5145.1 5389.5 5658.7 5838.0 6062.8 5017.6 5776.9 6060.6 6085.9 6134.8 6046.8 6323.0 6340.5 6351.0 6363.8 3161.8 3285.4 3420.9 3816.6 3889.9 4785.0 5943.5 5968.9 5979.7 5988.5 5554.7 5685.9 5738.5 5825.5 5849.0 5129.9 5823.8 5904.0 5913.2 5931.4 4933.9 5586.4 5677.1 5749.2 5819.4 5794.7 5813.2 5817.8 5818.5 5932.7 5071.4 5269.4 5471.8 5771.8 5837.8 03:56:55 INFO - PROCESS | 1939 | 03:56:55 INFO - PROCESS | 1939 | [#5] yui.html Cycles:180 Average:21497.21 Median:4203.83 stddev:32180.17 (765.5%) stddev-sans-first:32232.58 03:56:55 INFO - PROCESS | 1939 | Values: 705.1 707.2 759.0 776.7 777.8 14952.5 15642.3 15721.7 16761.7 17660.1 16312.3 16471.7 16493.3 16547.5 16548.8 652.1 828.3 853.1 854.1 855.8 681.9 770.1 835.4 849.9 852.3 833.5 886.5 888.4 888.5 893.0 765.3 883.5 884.0 884.3 886.4 646.2 650.2 650.4 650.7 651.2 14105.0 14832.9 15107.3 15183.2 15522.9 13765.2 13859.7 13891.0 14085.1 14372.3 11555.3 11759.1 11979.8 11994.5 12118.0 3574.4 3740.5 3761.6 3799.8 3811.3 106030.5 111388.3 111919.0 112195.0 112480.0 9821.8 10263.9 10649.5 10715.9 10863.0 21080.2 21118.3 21126.3 21148.5 21176.0 7570.1 7614.0 7638.3 7718.2 7808.0 4113.8 4190.6 4190.7 4191.7 4215.9 3341.0 3445.4 3447.0 3564.1 3720.1 632.4 637.8 640.8 646.2 658.5 573.5 652.7 663.1 673.7 675.5 7993.6 8903.7 9005.7 9286.8 9540.2 583.8 602.0 648.1 661.6 668.5 4323.8 4385.4 4550.7 4632.4 4659.5 93513.0 93991.0 95928.0 106496.0 118610.0 100975.0 103575.0 103810.0 104392.0 107419.9 84234.0 85310.6 86561.5 86734.0 90148.0 8613.9 8621.0 8626.0 8639.7 8645.6 55743.7 56561.7 58307.0 58900.7 59529.5 58916.0 82511.0 84159.2 85577.6 86899.6 11261.8 11430.4 11649.2 11691.4 11953.3 12558.1 12621.0 12919.5 12928.5 13258.3 12072.7 12085.6 12325.1 12369.0 12471.3 11891.2 12000.9 12038.6 12090.0 12405.8 11811.8 11835.0 11867.4 11893.9 11901.6 7730.0 9624.5 9677.2 10220.8 10441.0 9966.1 10283.5 10330.1 10331.6 10335.2 03:56:55 INFO - PROCESS | 1939 | -------- Summary: end -------- 03:56:55 INFO - PROCESS | 1939 | 03:56:56 INFO - TEST-INFO | 1939: exit 0 03:56:56 INFO - TEST-OK | dromaeo_css | took 1117198ms 03:56:56 INFO - TEST-START | kraken 03:56:56 INFO - operating with platform_type : mac_ 03:56:56 INFO - Initialising browser for kraken test... 03:56:56 INFO - TEST-INFO | started process 1948 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpHFn64y/profile http://localhost:51555/getInfo.html) 03:56:59 INFO - PROCESS | 1948 | 2016-12-07 03:56:59.080 plugin-container[1949:16619] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 03:56:59 INFO - PROCESS | 1948 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:56:59 INFO - PROCESS | 1948 | 2016-12-07 03:56:59.082 plugin-container[1949:16619] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x471b, name = 'com.apple.CFPasteboardClient' 03:56:59 INFO - PROCESS | 1948 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:56:59 INFO - PROCESS | 1948 | 2016-12-07 03:56:59.082 plugin-container[1949:16619] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:56:59 INFO - PROCESS | 1948 | __metrics Screen width/height:1600/1200 03:56:59 INFO - PROCESS | 1948 | colorDepth:24 03:56:59 INFO - PROCESS | 1948 | Browser inner width/height: 1024/689 03:56:59 INFO - PROCESS | 1948 | __metrics 03:56:59 ERROR - PROCESS | 1948 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 03:57:00 INFO - TEST-INFO | 1948: exit 0 03:57:00 INFO - Browser initialized. 03:57:00 INFO - Running cycle 1/1 for kraken test... 03:57:00 INFO - TEST-INFO | started process 1950 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpHFn64y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:57:02 INFO - PROCESS | 1950 | 2016-12-07 03:57:02.817 plugin-container[1951:16734] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x872b, name = 'com.apple.tsm.portname' 03:57:02 INFO - PROCESS | 1950 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:57:02 INFO - PROCESS | 1950 | 2016-12-07 03:57:02.817 plugin-container[1951:16734] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 03:57:02 INFO - PROCESS | 1950 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:57:02 INFO - PROCESS | 1950 | 2016-12-07 03:57:02.817 plugin-container[1951:16734] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:57:12 INFO - PROCESS | 1950 | RSS: Main: 241819648 03:57:12 INFO - PROCESS | 1950 | 03:57:15 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51555/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51555/tests/kraken/driver.html?testName=audio-beat-detection) 03:57:16 INFO - PROCESS | 1950 | RSS: Main: 253947904 03:57:16 INFO - PROCESS | 1950 | 03:57:19 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51555/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51555/tests/kraken/driver.html?testName=audio-dft) 03:57:19 INFO - PROCESS | 1950 | RSS: Main: 261599232 03:57:19 INFO - PROCESS | 1950 | 03:57:23 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51555/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51555/tests/kraken/driver.html?testName=audio-fft) 03:57:23 INFO - PROCESS | 1950 | RSS: Main: 264167424 03:57:23 INFO - PROCESS | 1950 | 03:57:25 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51555/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51555/tests/kraken/driver.html?testName=audio-oscillator) 03:57:26 INFO - PROCESS | 1950 | RSS: Main: 266461184 03:57:26 INFO - PROCESS | 1950 | 03:57:28 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51555/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51555/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:57:29 INFO - PROCESS | 1950 | RSS: Main: 267087872 03:57:29 INFO - PROCESS | 1950 | 03:57:31 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51555/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51555/tests/kraken/driver.html?testName=imaging-darkroom) 03:57:32 INFO - PROCESS | 1950 | RSS: Main: 272752640 03:57:32 INFO - PROCESS | 1950 | 03:57:35 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51555/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51555/tests/kraken/driver.html?testName=imaging-desaturate) 03:57:36 INFO - PROCESS | 1950 | RSS: Main: 272048128 03:57:36 INFO - PROCESS | 1950 | 03:57:39 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51555/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51555/tests/kraken/driver.html?testName=json-parse-financial) 03:57:39 INFO - PROCESS | 1950 | RSS: Main: 272502784 03:57:39 INFO - PROCESS | 1950 | 03:57:41 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51555/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51555/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:57:42 INFO - PROCESS | 1950 | RSS: Main: 271491072 03:57:42 INFO - PROCESS | 1950 | 03:57:43 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51555/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51555/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:57:44 INFO - PROCESS | 1950 | RSS: Main: 271532032 03:57:44 INFO - PROCESS | 1950 | 03:57:46 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51555/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51555/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:57:47 INFO - PROCESS | 1950 | RSS: Main: 271540224 03:57:47 INFO - PROCESS | 1950 | 03:57:50 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51555/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51555/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:57:51 INFO - PROCESS | 1950 | RSS: Main: 272056320 03:57:51 INFO - PROCESS | 1950 | 03:57:54 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51555/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51555/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:57:55 INFO - PROCESS | 1950 | RSS: Main: 271867904 03:57:55 INFO - PROCESS | 1950 | 03:57:56 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51555/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51555/tests/kraken/driver.html?testName=ai-astar) 03:57:57 INFO - PROCESS | 1950 | RSS: Main: 272670720 03:57:57 INFO - PROCESS | 1950 | 03:57:57 INFO - PROCESS | 1950 | __start_tp_report 03:57:57 INFO - PROCESS | 1950 | _x_x_mozilla_page_load 03:57:57 INFO - PROCESS | 1950 | _x_x_mozilla_page_load_details 03:57:57 INFO - PROCESS | 1950 | |i|pagename|runs| 03:57:57 INFO - PROCESS | 1950 | |0;ai-astar;112;166;118;118;117;119;121;121;118;136 03:57:57 INFO - PROCESS | 1950 | |1;audio-beat-detection;147;117;118;187;131;118;119;120;138;117 03:57:57 INFO - PROCESS | 1950 | |2;audio-dft;195;210;229;197;239;249;198;196;197;194 03:57:57 INFO - PROCESS | 1950 | |3;audio-fft;87;53;75;93;83;86;84;61;76;62 03:57:57 INFO - PROCESS | 1950 | |4;audio-oscillator;87;72;85;72;73;67;110;100;101;110 03:57:57 INFO - PROCESS | 1950 | |5;imaging-gaussian-blur;89;87;89;88;127;131;114;89;89;86 03:57:57 INFO - PROCESS | 1950 | |6;imaging-darkroom;96;97;97;95;97;95;96;97;101;151 03:57:57 INFO - PROCESS | 1950 | |7;imaging-desaturate;92;95;121;79;137;147;128;93;93;94 03:57:57 INFO - PROCESS | 1950 | |8;json-parse-financial;57;57;58;58;60;59;57;58;59;58 03:57:57 INFO - PROCESS | 1950 | |9;json-stringify-tinderbox;69;68;74;77;79;69;72;70;71;75 03:57:57 INFO - PROCESS | 1950 | |10;stanford-crypto-aes;103;114;115;109;90;90;92;91;89;92 03:57:57 INFO - PROCESS | 1950 | |11;stanford-crypto-ccm;145;148;155;155;163;144;148;183;215;170 03:57:57 INFO - PROCESS | 1950 | |12;stanford-crypto-pbkdf2;174;173;174;198;235;228;173;172;173;176 03:57:57 INFO - PROCESS | 1950 | |13;stanford-crypto-sha256-iterative;66;69;70;67;69;70;66;69;69;67 03:57:57 INFO - PROCESS | 1950 | __end_tp_report 03:57:57 INFO - PROCESS | 1950 | __start_cc_report 03:57:57 INFO - PROCESS | 1950 | _x_x_mozilla_cycle_collect,936 03:57:57 INFO - PROCESS | 1950 | __end_cc_report 03:57:57 INFO - PROCESS | 1950 | __startTimestamp1481111877005__endTimestamp 03:57:57 INFO - PROCESS | 1950 | 03:57:57 INFO - PROCESS | 1950 | ------- Summary: start ------- 03:57:57 INFO - PROCESS | 1950 | Number of tests: 14 03:57:57 INFO - PROCESS | 1950 | 03:57:57 INFO - PROCESS | 1950 | [#0] ai-astar Cycles:10 Average:124.60 Median:120.00 stddev:15.81 (13.2%) stddev-sans-first:16.09 03:57:57 INFO - PROCESS | 1950 | Values: 112.0 166.0 118.0 118.0 117.0 119.0 121.0 121.0 118.0 136.0 03:57:57 INFO - PROCESS | 1950 | 03:57:57 INFO - PROCESS | 1950 | [#1] audio-beat-detection Cycles:10 Average:131.20 Median:125.50 stddev:22.20 (17.7%) stddev-sans-first:22.80 03:57:57 INFO - PROCESS | 1950 | Values: 147.0 117.0 118.0 187.0 131.0 118.0 119.0 120.0 138.0 117.0 03:57:57 INFO - PROCESS | 1950 | 03:57:57 INFO - PROCESS | 1950 | [#2] audio-dft Cycles:10 Average:210.40 Median:204.00 stddev:20.76 (10.2%) stddev-sans-first:21.26 03:57:57 INFO - PROCESS | 1950 | Values: 195.0 210.0 229.0 197.0 239.0 249.0 198.0 196.0 197.0 194.0 03:57:57 INFO - PROCESS | 1950 | 03:57:57 INFO - PROCESS | 1950 | [#3] audio-fft Cycles:10 Average:76.00 Median:83.50 stddev:13.22 (15.8%) stddev-sans-first:13.41 03:57:57 INFO - PROCESS | 1950 | Values: 87.0 53.0 75.0 93.0 83.0 86.0 84.0 61.0 76.0 62.0 03:57:57 INFO - PROCESS | 1950 | 03:57:57 INFO - PROCESS | 1950 | [#4] audio-oscillator Cycles:10 Average:87.70 Median:72.00 stddev:16.56 (23.0%) stddev-sans-first:17.56 03:57:57 INFO - PROCESS | 1950 | Values: 87.0 72.0 85.0 72.0 73.0 67.0 110.0 100.0 101.0 110.0 03:57:57 INFO - PROCESS | 1950 | 03:57:57 INFO - PROCESS | 1950 | [#5] imaging-gaussian-blur Cycles:10 Average:98.90 Median:88.50 stddev:17.85 (20.2%) stddev-sans-first:18.57 03:57:57 INFO - PROCESS | 1950 | Values: 89.0 87.0 89.0 88.0 127.0 131.0 114.0 89.0 89.0 86.0 03:57:57 INFO - PROCESS | 1950 | 03:57:57 INFO - PROCESS | 1950 | [#6] imaging-darkroom Cycles:10 Average:102.20 Median:96.50 stddev:17.23 (17.9%) stddev-sans-first:18.13 03:57:57 INFO - PROCESS | 1950 | Values: 96.0 97.0 97.0 95.0 97.0 95.0 96.0 97.0 101.0 151.0 03:57:57 INFO - PROCESS | 1950 | 03:57:57 INFO - PROCESS | 1950 | [#7] imaging-desaturate Cycles:10 Average:107.90 Median:92.50 stddev:23.20 (25.1%) stddev-sans-first:23.88 03:57:57 INFO - PROCESS | 1950 | Values: 92.0 95.0 121.0 79.0 137.0 147.0 128.0 93.0 93.0 94.0 03:57:57 INFO - PROCESS | 1950 | 03:57:57 INFO - PROCESS | 1950 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.00 stddev:0.99 (1.7%) stddev-sans-first:0.97 03:57:57 INFO - PROCESS | 1950 | Values: 57.0 57.0 58.0 58.0 60.0 59.0 57.0 58.0 59.0 58.0 03:57:57 INFO - PROCESS | 1950 | 03:57:57 INFO - PROCESS | 1950 | [#9] json-stringify-tinderbox Cycles:10 Average:72.40 Median:73.00 stddev:3.72 (5.1%) stddev-sans-first:3.73 03:57:57 INFO - PROCESS | 1950 | Values: 69.0 68.0 74.0 77.0 79.0 69.0 72.0 70.0 71.0 75.0 03:57:57 INFO - PROCESS | 1950 | 03:57:57 INFO - PROCESS | 1950 | [#10] stanford-crypto-aes Cycles:10 Average:98.50 Median:90.00 stddev:10.64 (11.8%) stddev-sans-first:11.16 03:57:57 INFO - PROCESS | 1950 | Values: 103.0 114.0 115.0 109.0 90.0 90.0 92.0 91.0 89.0 92.0 03:57:57 INFO - PROCESS | 1950 | 03:57:57 INFO - PROCESS | 1950 | [#11] stanford-crypto-ccm Cycles:10 Average:162.60 Median:159.00 stddev:22.15 (13.9%) stddev-sans-first:22.56 03:57:57 INFO - PROCESS | 1950 | Values: 145.0 148.0 155.0 155.0 163.0 144.0 148.0 183.0 215.0 170.0 03:57:57 INFO - PROCESS | 1950 | 03:57:57 INFO - PROCESS | 1950 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.60 Median:175.00 stddev:24.44 (14.0%) stddev-sans-first:25.42 03:57:57 INFO - PROCESS | 1950 | Values: 174.0 173.0 174.0 198.0 235.0 228.0 173.0 172.0 173.0 176.0 03:57:57 INFO - PROCESS | 1950 | 03:57:57 INFO - PROCESS | 1950 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:69.00 stddev:1.55 (2.2%) stddev-sans-first:1.42 03:57:57 INFO - PROCESS | 1950 | Values: 66.0 69.0 70.0 67.0 69.0 70.0 66.0 69.0 69.0 67.0 03:57:57 INFO - PROCESS | 1950 | -------- Summary: end -------- 03:57:57 INFO - PROCESS | 1950 | 03:57:58 INFO - TEST-INFO | 1950: exit 0 03:57:58 INFO - TEST-OK | kraken | took 61777ms 03:57:58 INFO - SUITE-END | took 1178s 03:57:58 INFO - Completed test suite (00:19:39) 03:57:58 INFO - javascript benchmark 03:57:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7061.212970704288, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2816.746492815646, 3325.451300535412, 3334.949975750364, 3379.138319728469, 3381.1040074380285, 5594.58040646951, 5605.131204663274, 5674.035413979623, 5681.2614360133175, 5690.715464226792, 5551.805686800963, 5682.659040457575, 5740.0, 5764.020116580181, 5781.971090144554, 5131.846044618658, 5157.432682404932, 5190.792368305263, 5195.740212989354, 5249.0, 4433.246348120827, 5217.087009773293, 5241.633085684004, 5246.003259380725, 5249.921251181236, 5047.798088076473, 5239.738013099349, 5244.868878278055, 5248.0553500369915, 5253.317068781053, 4471.642268618502, 5239.423663397023, 5249.9212511811975, 5260.368755749297, 5279.392869819982, 5058.544730974193, 5145.090560546673, 5246.658967167122, 5251.501107394792, 5254.947450525484, 5329.893402131975, 5850.97074514629, 5865.120231965239, 5871.148683440877, 5877.970610146922, 5310.893782124336, 6053.122297266872, 6178.227721534809, 6215.720292586844, 6216.098665693495, 6063.18147050147, 6064.938635738772, 6109.450149486567, 6117.938820611781, 6184.81445556634, 4841.491643377465, 5878.823635290948, 5914.9112763308585, 5944.10838374243, 5981.9401805981815, 6234.438900498886, 6241.656708881055, 6245.96877015612, 6264.279607845065, 6270.372962703785, 4915.778789954461, 5944.494717949023, 5981.0, 6177.351378105324, 6179.876402471926, 5992.940070599238, 6113.932424433873, 6140.048292514667, 6145.095020543646, 6183.505319574423, 5118.820841270538, 5171.5261150571905, 6136.325004249529, 6203.0, 6204.627722336674, 6089.269287685506, 6136.7852125175405, 6159.29168145669, 6215.9378406216265, 6235.812925612239, 4820.060088282821, 4868.878278043077, 4888.486708895586, 4893.877653058702, 4896.5837903777865, 4393.912121757547, 4436.933445998313, 4472.888177795581, 4480.865574032784, 4524.5701658342405, 5623.775048997994, 5891.734871930774, 5952.940470595326, 5958.177029292001, 5976.432238937294, 6107.310189946649, 6141.699273337082, 6174.969125154345, 6218.098375735493, 6234.594751341148, 5834.533237341003, 5853.0, 5895.380984996514, 5917.112433135064, 5926.348101708809, 5265.868353291198, 5329.467053294639, 5338.733063346895, 5365.543928766098, 5414.07960646691, 6201.627902325875, 6234.625922444668, 6251.218597675291, 6256.687165641791, 6301.369863013662, 5406.216098665593, 6096.298925623432, 6186.690665466798, 6199.938000620116, 6222.688865556795, 6150.477209437248, 6177.104319873683, 6185.628862268099, 6224.315325314303, 6297.433231009231, 6153.169322141633, 6195.070739389128, 6209.658468784261, 6226.657533835682, 6231.844203894939, 5206.947930520646, 5908.497777688945, 6167.753289868355, 6188.690565471798, 6193.4425901669065, 5928.762849486145, 5994.910076348771, 6035.39646035393, 6126.5711400203345, 6151.415615516519, 5744.339400968942, 6000.69996500182, 6068.059450785136, 6117.204763380732, 6119.41115851624, 5647.943520564741, 5792.681402522901, 6008.8798224036145, 6018.969905150446, 6024.457798798129, 6078.392160784063, 6117.449429551361, 6119.541034422347, 6137.478314343152, 6162.476189523762, 5496.763228273607, 5823.126531020212, 5848.970755146197, 5856.648601083949, 5942.910856337245], "value": 5631.529678570922, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.23315313519817, 517.9404368497622, 524.4388504300398, 524.9868753281168, 526.51823581423, 30976.0, 38830.922753110906, 39073.218535629305, 41383.379249311285, 41403.0, 40005.19989600214, 40466.39300410496, 40490.39264411036, 40500.0, 40538.0, 8329.50022998619, 8568.957155214246, 9222.907770922306, 9360.438373697565, 9402.294827887901, 9203.585838637244, 11243.662690119269, 11256.38089905055, 11294.152938529602, 11391.316521008725, 11207.327560346364, 11272.605458808943, 11281.435928203598, 11290.943545282304, 11307.378094204816, 11183.664490065312, 11231.21381503295, 11231.66305010847, 11233.269837460539, 11286.548538058469, 11057.889421105767, 11070.667879963614, 11102.722431939186, 11139.33164010162, 11162.944185279102, 38437.80781096077, 38472.80763596192, 38799.8060009701, 38801.611983880364, 38802.417963730564, 3249.8537565809597, 3389.389909816232, 3416.692497675196, 3455.8963231103107, 3908.4528166056775, 28893.855530722423, 29278.121656350344, 29450.558241626393, 30242.546361804372, 30284.54573181404, 3107.5804766356478, 3146.197719581492, 3147.5436061770915, 3152.7793054486197, 3250.073728987251, 470204.0, 474827.0, 475811.0, 477728.0, 479463.0, 58455.70772146112, 58672.0, 59088.0, 59123.704381477815, 59929.703866287775, 61721.382786172464, 62227.0, 62302.68848655728, 62364.0, 62377.0, 15379.00036497624, 15866.92066539683, 16002.039877607382, 16011.0, 16023.519294421187, 9471.621135154655, 9631.951840240754, 10006.44964526958, 12033.217840840318, 12257.693557660952, 14894.957352985404, 18308.26766929308, 18484.70607057493, 18490.428313593227, 18903.960282184336, 6022.5483088768515, 7744.0, 7863.410244231705, 7891.092524359772, 7914.089879663912, 841.4993079117914, 925.22281283722, 954.2461455450256, 974.3861367338532, 978.8400745116917, 26068.217953461426, 28523.857380712965, 29053.709462905525, 29601.111966641034, 29758.1072567819, 1015.939043657383, 1057.5716834681966, 1111.4498323329842, 1126.3692332293942, 1184.1237484261756, 14986.775198372034, 15076.849231507764, 15146.545603631908, 15240.0, 15336.923315383352, 191898.0, 191964.0, 192050.0, 192401.0, 192944.0, 55065.72467137639, 55327.89344213093, 55531.0, 55640.0, 55698.72150639221, 1320.1287150480637, 1351.6418149190472, 1357.6198664373992, 1369.7671395862728, 1372.5813626843708, 25404.872975635004, 27845.02542411006, 28557.143285701462, 29074.56388154137, 29138.417231655672, 46173.76913115547, 46499.76750116228, 46605.3009204869, 46655.766721166176, 46776.7661161692, 458370.0, 461149.0, 461227.0, 462674.0, 463054.0, 25539.489210216063, 26001.21996340037, 26094.478110437307, 26359.868200658875, 27264.318392040357, 43610.34584481299, 44186.337204942596, 44536.886577835816, 44774.3283850736, 45345.31982020338, 28763.137105886857, 36576.81711591425, 36789.632103679694, 37463.6253637471, 37707.62292377151, 36924.630753692116, 37111.628883710815, 37405.361162267545, 37437.43843842399, 37899.621003790715, 36580.81709591435, 36655.45016824803, 36819.0, 36896.81551592225, 37150.628493714714, 31716.682833171373, 33739.0, 33790.0, 33855.66144338525, 33991.320173595894, 23668.52662946766, 24401.755982439947, 24719.752802472463, 24875.880585374063, 25514.744852551237], "value": 18958.047191110643, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.5186997553303, 360.1680118925283, 362.5884620955216, 370.9369407200776, 387.18883938149565, 18178.27286908524, 18561.071946402677, 19324.51688707783, 19766.308179213713, 19923.800761992377, 19532.31636892709, 20055.29806456774, 20125.59748805023, 20259.0, 20391.796082039175, 5544.0575102232515, 5837.824865254028, 5837.970810145944, 5841.678707671076, 5842.094475356326, 5576.525995290385, 5871.588988770788, 5952.255968003999, 5988.940110598904, 5996.550258730591, 5910.0543912973935, 5932.317783454915, 5940.970295148518, 5971.10433434986, 5987.161797348353, 5724.5992780505385, 5936.673482958436, 5953.553483488756, 5954.55340849438, 5955.910661340084, 4848.854534363974, 5551.2228288039705, 5713.285839270091, 5749.683767392792, 5791.247137872092, 12291.201071930385, 12414.441350139265, 12415.689607759788, 12498.812517812241, 12514.561990330294, 2102.6334964088674, 2184.683220932956, 2247.1685476373846, 2367.443650742074, 2799.5240809062507, 9690.806183876353, 9787.706368808947, 9808.558614862348, 10253.84619230712, 10277.434741089237, 1482.9332680029424, 1656.9312793248407, 1777.1380880273057, 1821.7813862336604, 1915.6647586672277, 87635.0, 105791.0, 109018.45490772574, 109333.90666093316, 109822.45088774584, 11113.721687054134, 11299.943500282447, 11396.259243149168, 11526.769464610661, 11548.249363791327, 14200.64498387528, 14272.500462483764, 14337.35481903317, 14361.210133442552, 14402.0, 6784.0, 8254.380921430917, 8262.091169971298, 8405.70580029696, 8525.914740852511, 8042.316403105685, 8082.232187942136, 8134.715284964997, 8216.630251638691, 8281.54451505161, 4315.395844581761, 4504.189245935763, 4522.4346956630425, 4554.840580579664, 4601.217792975202, 1719.8710096742793, 1855.4433669898976, 1877.9248830046918, 1926.6435709393807, 1930.7296978423033, 859.8495263328892, 862.4480332587149, 892.1836519584507, 903.6400217672361, 906.4561263242134, 19024.809751902303, 19400.738951968076, 20704.689429658567, 20894.74942235675, 20984.160633574793, 684.3498676257575, 776.4719990406578, 924.4545718026262, 934.9439033658002, 996.5963784667222, 10469.633562825264, 10922.235443519035, 10926.125909927347, 10928.726781830359, 10942.617008404668, 508065.6531064185, 508756.0, 512745.0, 534330.3283483635, 540019.0, 123044.76955230512, 123845.0, 124568.1314780279, 124642.0, 126104.0, 910.8178364327161, 929.2380248196549, 949.0225068179648, 951.5242378810594, 954.3605784124653, 14469.27653617336, 17266.0, 18276.903385796893, 18417.907910460362, 18544.443666690022, 36742.63257367499, 42542.36186457144, 47025.529744702115, 49137.754311228215, 49377.0, 67241.99137012851, 68418.9737153953, 71768.64115679388, 72834.27165728487, 76032.0, 7413.147488038729, 7669.003029606116, 7887.250711182429, 7904.644291007034, 8069.515829050276, 8721.56392180401, 10234.385936843813, 11035.172362072715, 11757.941210293893, 12138.939305303416, 9678.903210967801, 9933.701988940344, 10263.922288159934, 10557.9472102639, 10678.83981740259, 10132.645357412455, 10420.478976051016, 10477.738056548647, 10571.788564228518, 10645.0, 8909.821803564022, 9832.0, 10106.292559520763, 10153.086222240034, 10359.585616575252, 7529.435292352986, 7625.504342217738, 7674.501157424749, 7846.215378462108, 7951.165127661744, 8814.51520166397, 10207.540660670436, 10228.539715712663, 10446.738831528968, 10665.36007839532], "value": 8932.39349173882, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1451.2163431746858, 1461.7076584683064, 1641.6716656668668, 1729.7924249090104, 1749.247823435922, 6318.715657795398, 7559.69761209551, 7759.92240077599, 8169.8153767703725, 8171.387145964061, 7680.846383072335, 7959.960200198991, 7983.880241796363, 7999.280064794168, 8131.349492040637, 2201.57069371473, 2223.977760222393, 2240.4622890506243, 2257.582347265753, 2267.319804058784, 2248.2468373094953, 2279.806216471602, 2282.1556024271044, 2285.69143165673, 2286.2683941138844, 1991.9840881150574, 2064.463239557718, 2227.8106360959337, 2249.921252756154, 2251.065807689815, 2215.6898034275214, 2227.3652009177385, 2239.395363251921, 2246.7640897705833, 2254.6843441918145, 2240.6975058367075, 2255.0, 2259.378670865509, 2264.501809601885, 2270.080617349976, 7997.480163789393, 8029.996250468691, 8067.394945379061, 8077.273045425881, 8087.919120808834, 4893.143699852511, 5013.824516141954, 5032.094223039851, 5043.672161309503, 5053.1157047516535, 2861.313284811651, 2993.925151871199, 3121.1884909923356, 3253.6209491721334, 3308.2721801203697, 994.6071301835807, 1024.7899180667946, 1036.7926414717012, 1043.1602559939247, 1045.947702614866, 8416.705415310496, 8847.867281990839, 10311.43287119208, 10441.42572158531, 10459.68620941373, 3787.7348585598743, 3894.7078969076865, 4462.598366147063, 4469.4189755332245, 4485.170243504962, 9093.81812363749, 9121.635134594542, 9148.954255228682, 9161.358704890727, 9174.954125229331, 5042.546170844568, 5048.570871475966, 5066.518680725325, 5079.415867175248, 5088.0587091388215, 4379.167958087953, 4453.777311134495, 4617.2612382018715, 4637.095766325601, 4677.6959497633225, 3552.8223588820456, 3598.9280214395567, 3633.454981752758, 3642.6903713184147, 3650.379435495972, 1159.8492196014465, 1178.5462596900254, 1186.3890096600257, 1188.5542921404474, 1194.3550482739397, 860.9139086091466, 866.4627930683017, 867.1545243387773, 908.5411867007119, 928.9535523223811, 4588.564086411786, 5481.123020316731, 5608.747606357723, 5755.8561035974435, 5818.301803783573, 878.8374150782125, 893.3478560650761, 893.9106089391009, 927.5733162745078, 968.6125549780145, 3564.6613571710645, 3751.6248375162813, 3773.6226377362045, 3777.20678657485, 3827.004978705557, 8959.955200224087, 9710.75723106914, 9730.562124704406, 9761.853572196424, 9777.853332200022, 9648.71053868385, 9707.417554946725, 9742.756431089138, 9755.268354873271, 9774.071463210983, 7417.480776345712, 7439.363340065177, 7493.138289096823, 7633.274838890296, 7674.539527628472, 5228.738563071907, 5349.224362467498, 5375.0, 5387.407385187705, 5448.101063324666, 9032.683856065007, 9061.957874844476, 9063.546822658973, 9092.954535227282, 9122.680706175252, 8286.83426331482, 9017.098290171192, 9109.590068446803, 9155.0, 9339.53302334867, 6155.169052178077, 6389.0, 6544.83637909037, 6555.639439830855, 6622.735090596322, 6472.546921715435, 7609.619519024137, 7614.923850761422, 7689.346790440082, 7715.382769378324, 6838.0, 6911.239763626098, 6913.170419549485, 6925.3074692530345, 6970.337817907291, 6743.426808721118, 6820.590764554143, 6824.590524568542, 6864.279250678607, 6871.244163142151, 6349.4920406366455, 6505.674716264262, 6509.707063182073, 6509.967450162909, 6519.315471875385, 4590.403247577793, 4752.714837109785, 4753.691010084333, 4769.689970152068, 4783.019481006455, 4610.930836037529, 4733.124371991193, 4776.761161941959, 4797.976010119927, 4805.6155507558615], "value": 4252.017977805075, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.5815908773191, 289.247955316178, 295.2088403079745, 297.2346208513079, 297.35622377552585, 4578.565036321553, 4805.27920811878, 5487.533559647435, 5524.806631767889, 5587.1339942308905, 5253.60597955153, 5319.175527793189, 5424.620276580641, 5444.292242008543, 5464.617476776627, 3273.5417041614132, 4051.4327994080854, 4107.794610269475, 4160.0, 4174.749515029108, 3207.5188721691698, 3358.865645374182, 4029.033032072311, 4198.160367926412, 4238.279492486269, 4068.6745060395247, 4135.813888375031, 4169.435796984848, 4175.31107367284, 4176.763008668276, 3400.574928133983, 4109.547949725527, 4132.8140233689255, 4173.624373806372, 4183.79081045948, 3584.731145164123, 3618.5476815398074, 3629.764065335771, 3630.2195028068827, 3653.0319465341704, 4706.435227772655, 5055.595552355802, 5345.167061457434, 5351.170568561879, 5380.24676545284, 4770.427548694144, 4785.49752276013, 4787.234042553175, 4815.277708343777, 4846.442659094214, 4645.0, 5054.014467178901, 5428.75570599324, 5605.394605394606, 5809.593328467009, 3769.660730534265, 3940.6847452203756, 3955.960440395588, 3981.3430783920617, 3982.3429134192825, 4998.375203099613, 5969.850753731148, 6004.5796794224425, 6016.082200132932, 6061.302835206194, 4030.214108248922, 4036.5780531680757, 4036.777977211223, 4037.253108174997, 4049.6760259179196, 3934.855503750463, 4052.4326594276827, 4074.388841673713, 4102.589741025873, 4135.255653982252, 4281.314989601711, 4494.662900282427, 4653.860384188412, 4695.98072828687, 4730.337752714623, 4867.568364303158, 5492.423295553909, 5767.509761670305, 5789.742000619762, 5818.389069147678, 1155.4061132756847, 1259.482323799819, 1292.4959265886312, 1307.1046333261745, 1334.9399277032558, 812.9918900563259, 839.8152406470567, 855.3029281135854, 874.9912500875037, 914.0128661046055, 5115.71863547501, 5123.410807757155, 5127.410347809975, 5196.428392876781, 5221.1464929949325, 5219.060569097599, 5541.833744987657, 5569.0, 5605.271314729059, 5659.717014149276, 4326.567343265711, 4998.951478415417, 5000.424951130666, 5054.82308119214, 5096.566791822663, 2635.614768634389, 2811.6223050705007, 3030.9090727278217, 3055.2514633914834, 3080.753539716862, 4783.182390691515, 5039.807683657621, 5454.318210223722, 5535.723213839373, 5634.5203016530495, 5720.599558030898, 5850.912236316459, 5903.085021821625, 5969.940300597025, 6303.329617651326, 5215.5045270698465, 5481.808136715196, 5978.671173085522, 6078.422549857756, 6350.396712312323, 5145.137844736838, 5389.487998640123, 5658.660480371191, 5837.970810145922, 6062.818115456544, 5017.62367822422, 5776.884462310814, 6060.636351822881, 6085.896192941543, 6134.754609815557, 6046.848828779316, 6323.0, 6340.512718005171, 6350.968245158745, 6363.809085727436, 3161.826099564546, 3285.371702637832, 3420.9315813684084, 3816.637419445148, 3889.922201555896, 4784.976075119602, 5943.4948029416255, 5968.926003108316, 5979.730912108878, 5988.520918326436, 5554.666719996813, 5685.857853553694, 5738.454846789548, 5825.475707186373, 5849.0, 5129.897402052013, 5823.79616713413, 5903.970480147572, 5913.231279933753, 5931.436513531207, 4933.9013219736125, 5586.357568879468, 5677.126548238989, 5749.223854779719, 5819.447152520504, 5794.681292528951, 5813.244887561199, 5817.7963771267805, 5818.534517238695, 5932.703364831655, 5071.446765791453, 5269.367675878919, 5471.781128754806, 5771.769129234784, 5837.824865254049], "value": 4153.356727821181, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.0622671846445, 707.1867352544573, 759.0284435922022, 776.7320274505294, 777.8366543025962, 14952.476663316786, 15642.29609667565, 15721.685566288681, 16761.748573771372, 17660.116994150274, 16312.347506099743, 16471.670566588662, 16493.257803398847, 16547.503574892773, 16548.83451165488, 652.0610321137547, 828.2835347424465, 853.0658928473312, 854.0647990450447, 855.8459477294084, 681.9283975182584, 770.1297533786841, 835.4319063037133, 849.9235068843802, 852.3309202276214, 833.4624167412015, 886.5345693510926, 888.3559419420933, 888.5468411110348, 892.9821403571957, 765.3456294867891, 883.4655033704613, 884.0496466298722, 884.3058199313508, 886.3839631456141, 646.2406672160193, 650.2294780684904, 650.408128602969, 650.7234425369246, 651.1795138125948, 14105.012649114566, 14832.887533435036, 15107.32017059235, 15183.240837958057, 15522.922385388114, 13765.242911639856, 13859.722805543934, 13891.0, 14085.084469509551, 14372.281385930766, 11555.306681599131, 11759.118066144987, 11979.82030269538, 11994.520219191309, 12118.0, 3574.3566158091535, 3740.4576336431337, 3761.6426439488205, 3799.7530160539754, 3811.275857587077, 106030.46984765027, 111388.32917506243, 111919.0, 112195.0, 112480.0, 9821.80356392868, 10263.948680256552, 10649.467526623637, 10715.892841071645, 10863.0, 21080.156793728387, 21118.260860869796, 21126.260580879596, 21148.47128821761, 21176.0, 7570.05374328209, 7614.048243969504, 7638.312551870358, 7718.189590093071, 7807.960960195162, 4113.814878330482, 4190.622843944059, 4190.748555086643, 4191.7484950903045, 4215.915681686349, 3341.0, 3445.3626079175433, 3446.9655303446643, 3564.0733409313766, 3720.144366795598, 632.4434497642045, 637.764027309889, 640.8173670503884, 646.1890327638783, 658.4501940879419, 573.4638113363935, 652.7486917536783, 663.0816319397572, 673.6968364236016, 675.5102550650739, 7993.600319983978, 8903.73288801337, 9005.729828105168, 9286.837756585162, 9540.189083927806, 583.821934310031, 601.9699015049317, 648.1444493268934, 661.5931202310641, 668.4552090046597, 4323.805428755651, 4385.429894113809, 4550.6587005974025, 4632.374629425052, 4659.534046595381, 93513.0, 93991.0, 95928.0, 106496.0, 118610.0, 100975.0, 103575.0, 103810.0, 104392.0, 107419.925800741, 84234.0, 85310.57344713237, 86561.47823739384, 86734.0, 90148.0, 8613.870791938001, 8621.0, 8625.956870215608, 8639.654413823628, 8645.610947507503, 55743.72128139334, 56561.71719141378, 58307.0, 58900.70549647224, 59529.51176220629, 58916.0, 82511.0, 84159.15840841513, 85577.57211213904, 86899.56550217209, 11261.7747645045, 11430.428478575872, 11649.184557080924, 11691.356975366096, 11953.282803031845, 12558.120931534704, 12621.0, 12919.547815826776, 12928.482860685843, 13258.337083145998, 12072.698182545506, 12085.637430877088, 12325.075619328407, 12369.0, 12471.251724896536, 11891.227070240408, 12000.918768849784, 12038.582270433588, 12090.0, 12405.75188496207, 11811.822822657496, 11835.0, 11867.406629668309, 11893.881061189624, 11901.642950711492, 7730.0, 9624.470654114091, 9677.22582193437, 10220.846687299547, 10441.0, 9966.053224943618, 10283.537240824331, 10330.121939635215, 10331.638392656221, 10335.17318614524], "value": 7359.50134350056, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 166.0, 118.0, 118.0, 117.0, 119.0, 121.0, 121.0, 118.0, 136.0], "value": 124.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 117.0, 118.0, 187.0, 131.0, 118.0, 119.0, 120.0, 138.0, 117.0], "value": 131.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 210.0, 229.0, 197.0, 239.0, 249.0, 198.0, 196.0, 197.0, 194.0], "value": 210.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 53.0, 75.0, 93.0, 83.0, 86.0, 84.0, 61.0, 76.0, 62.0], "value": 76.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 85.0, 72.0, 73.0, 67.0, 110.0, 100.0, 101.0, 110.0], "value": 87.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 89.0, 88.0, 127.0, 131.0, 114.0, 89.0, 89.0, 86.0], "value": 98.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 95.0, 97.0, 95.0, 96.0, 97.0, 101.0, 151.0], "value": 102.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 95.0, 121.0, 79.0, 137.0, 147.0, 128.0, 93.0, 93.0, 94.0], "value": 107.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 58.0, 60.0, 59.0, 57.0, 58.0, 59.0, 58.0], "value": 58.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 74.0, 77.0, 79.0, 69.0, 72.0, 70.0, 71.0, 75.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 115.0, 109.0, 90.0, 90.0, 92.0, 91.0, 89.0, 92.0], "value": 98.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 148.0, 155.0, 155.0, 163.0, 144.0, 148.0, 183.0, 215.0, 170.0], "value": 162.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 173.0, 174.0, 198.0, 235.0, 228.0, 173.0, 172.0, 173.0, 176.0], "value": 187.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 70.0, 67.0, 69.0, 70.0, 66.0, 69.0, 69.0, 67.0], "value": 68.2, "unit": "score"}]}]} 03:57:58 INFO - Return code: 0 03:57:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:57:58 ERROR - # TBPL SUCCESS # 03:57:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:57:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:57:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:57:58 INFO - 2016-12-07 03:57:58.311 screenresolution[1955:17113] starting screenresolution argv=screenresolution get 03:57:58 INFO - 2016-12-07 03:57:58.315 screenresolution[1955:17113] Display 0: 1600x1200x32@60 03:57:58 INFO - 2016-12-07 03:57:58.321 screenresolution[1956:17116] starting screenresolution argv=screenresolution list 03:57:58 INFO - Available Modes on Display 0 03:57:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:57:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:57:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:57:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:57:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:57:58 INFO - Intel Iris: 03:57:58 INFO - Chipset Model: Intel Iris 03:57:58 INFO - Type: GPU 03:57:58 INFO - Bus: Built-In 03:57:58 INFO - VRAM (Dynamic, Max): 1536 MB 03:57:58 INFO - Vendor: Intel (0x8086) 03:57:58 INFO - Device ID: 0x0a2e 03:57:58 INFO - Revision ID: 0x0009 03:57:58 INFO - Displays: 03:57:58 INFO - Display: 03:57:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:57:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:57:58 INFO - Display Serial Number: 1600x1200 60 03:57:58 INFO - Main Display: Yes 03:57:58 INFO - Mirror: Off 03:57:58 INFO - Online: Yes 03:57:58 INFO - Rotation: Supported 03:57:58 INFO - Return code: 0 03:57:58 INFO - Running post-action listener: _resource_record_post_action 03:57:58 INFO - [mozharness: 2016-12-07 11:57:58.564515Z] Finished run-tests step (success) 03:57:58 INFO - Running post-run listener: _resource_record_post_run 03:57:58 INFO - Total resource usage - Wall time: 1212s; CPU: 55.0%; Read bytes: 1775104; Write bytes: 690906624; Read time: 20; Write time: 1894 03:57:58 INFO - TinderboxPrint: CPU usage
54.6% 03:57:58 INFO - TinderboxPrint: I/O read bytes / time
1,775,104 / 20 03:57:58 INFO - TinderboxPrint: I/O write bytes / time
690,906,624 / 1,894 03:57:58 INFO - TinderboxPrint: CPU idle
2,202.3 (45.4%) 03:57:58 INFO - TinderboxPrint: CPU system
979.8 (20.2%) 03:57:58 INFO - TinderboxPrint: CPU user
1,667.5 (34.4%) 03:57:58 INFO - TinderboxPrint: Swap in / out
385,269,760 / 0 03:57:58 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 384590336; Write bytes: 386618880; Read time: 29097; Write time: 711 03:57:58 INFO - run-tests - Wall time: 1180s; CPU: 55.0%; Read bytes: 1701376; Write bytes: 303013888; Read time: 18; Write time: 1177 03:57:59 INFO - Running post-run listener: _upload_blobber_files 03:57:59 INFO - Blob upload gear active. 03:57:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:57:59 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 03:57:59 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'] 03:57:59 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 03:57:59 INFO - (blobuploader) - INFO - Open directory for files ... 03:57:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:57:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:58:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:58:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:58:00 INFO - (blobuploader) - INFO - Done attempting. 03:58:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:58:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:58:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:58:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:58:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:58:01 INFO - (blobuploader) - INFO - Done attempting. 03:58:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:58:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:58:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:58:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:58:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:58:04 INFO - (blobuploader) - INFO - Done attempting. 03:58:04 INFO - (blobuploader) - INFO - Iteration through files over. 03:58:04 INFO - Return code: 0 03:58:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:58:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:58:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4355e4f1db83ad01549891b221c4c4590a86aadad5135a06c1c5c08efdbe5e1b9866309f4655857b93f97cf542937a48743e0fab5969f219fcf7bb85372f5f72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdafdaafb8845e7b09664ea9964d422728d01516b00827486e8d07c7c6ad6bbd4c67c879c9ec6145c6e4f665fd5a7f15577778e0ad0c00a51dc51d2b048dc709", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a6be7fd5ac1f11be546f9a97e4cf24aa979277f8c8c3b697c58ce7e3554f6667f25537eb2c271a0a6840af30baadd5460959e6c1582485ed602c56e5bbb9afb"} 03:58:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:58:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:58:04 INFO - Contents: 03:58:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4355e4f1db83ad01549891b221c4c4590a86aadad5135a06c1c5c08efdbe5e1b9866309f4655857b93f97cf542937a48743e0fab5969f219fcf7bb85372f5f72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdafdaafb8845e7b09664ea9964d422728d01516b00827486e8d07c7c6ad6bbd4c67c879c9ec6145c6e4f665fd5a7f15577778e0ad0c00a51dc51d2b048dc709", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a6be7fd5ac1f11be546f9a97e4cf24aa979277f8c8c3b697c58ce7e3554f6667f25537eb2c271a0a6840af30baadd5460959e6c1582485ed602c56e5bbb9afb"} 03:58:04 INFO - Running post-run listener: copy_logs_to_upload_dir 03:58:04 INFO - Copying logs to upload dir... 03:58:04 INFO - mkdir: /builds/slave/test/build/upload/logs 03:58:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.911230 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-12-07 03:58:04.286477) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-07 03:58:04.289895) ========= 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.6I2PWRzW4A/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.hHPuowyAuT/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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/4355e4f1db83ad01549891b221c4c4590a86aadad5135a06c1c5c08efdbe5e1b9866309f4655857b93f97cf542937a48743e0fab5969f219fcf7bb85372f5f72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdafdaafb8845e7b09664ea9964d422728d01516b00827486e8d07c7c6ad6bbd4c67c879c9ec6145c6e4f665fd5a7f15577778e0ad0c00a51dc51d2b048dc709", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a6be7fd5ac1f11be546f9a97e4cf24aa979277f8c8c3b697c58ce7e3554f6667f25537eb2c271a0a6840af30baadd5460959e6c1582485ed602c56e5bbb9afb"} build_url:https://queue.taskcluster.net/v1/task/WSflS5v-R3Gk-T79XXcPAw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011865 build_url: 'https://queue.taskcluster.net/v1/task/WSflS5v-R3Gk-T79XXcPAw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4355e4f1db83ad01549891b221c4c4590a86aadad5135a06c1c5c08efdbe5e1b9866309f4655857b93f97cf542937a48743e0fab5969f219fcf7bb85372f5f72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdafdaafb8845e7b09664ea9964d422728d01516b00827486e8d07c7c6ad6bbd4c67c879c9ec6145c6e4f665fd5a7f15577778e0ad0c00a51dc51d2b048dc709", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a6be7fd5ac1f11be546f9a97e4cf24aa979277f8c8c3b697c58ce7e3554f6667f25537eb2c271a0a6840af30baadd5460959e6c1582485ed602c56e5bbb9afb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-07 03:58:04.325658) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 03:58:04.325994) ========= 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.6I2PWRzW4A/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.hHPuowyAuT/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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.005433 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 03:58:04.374364) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-07 03:58:04.374727) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-07 03:58:04.375162) ========= ========= Total master_lag: 0.19 =========