builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0160 starttime: 1488977168.18 results: success (0) buildid: 20170308030207 builduid: 863c07f17b854228a4ae277e8f0d2acb revision: 58753259bfeb3b818eac7870871b0aae1f8de64a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-08 04:46:08.175929) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-08 04:46:08.176405) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-08 04:46:08.176677) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-08 04:46:08.202291) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 04:46:08.202704) ========= 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.4OhouXzNem/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.zW8MAmtDJL/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 --2017-03-08 04:46:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.58M=0.001s 2017-03-08 04:46:08 (9.58 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123332 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 04:46:08.349649) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 04:46:08.350011) ========= 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.4OhouXzNem/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.zW8MAmtDJL/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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.019933 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 04:46:08.398896) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 04:46:08.399259) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 58753259bfeb3b818eac7870871b0aae1f8de64a --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 58753259bfeb3b818eac7870871b0aae1f8de64a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4OhouXzNem/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.zW8MAmtDJL/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 2017-03-08 04:46:08,473 truncating revision to first 12 chars 2017-03-08 04:46:08,474 Setting DEBUG logging. 2017-03-08 04:46:08,474 attempt 1/10 2017-03-08 04:46:08,474 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/58753259bfeb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-08 04:46:09,118 unpacking tar archive at: mozilla-central-58753259bfeb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.893640 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 04:46:09.316337) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-08 04:46:09.316657) ========= script_repo_revision: 58753259bfeb3b818eac7870871b0aae1f8de64a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-08 04:46:09.317134) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-08 04:46:09.317405) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-08 04:46:09.337649) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-08 04:46:09.338110) ========= /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.4OhouXzNem/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.zW8MAmtDJL/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 04:46:09 INFO - MultiFileLogger online at 20170308 04:46:09 in /builds/slave/test 04:46:09 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 04:46:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:46:09 INFO - {'append_to_log': False, 04:46:09 INFO - 'base_work_dir': '/builds/slave/test', 04:46:09 INFO - 'blob_upload_branch': 'Firefox', 04:46:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:46:09 INFO - 'branch': 'Firefox', 04:46:09 INFO - 'buildbot_json_path': 'buildprops.json', 04:46:09 INFO - 'config_files': ('talos/mac_config.py',), 04:46:09 INFO - 'default_actions': ('clobber', 04:46:09 INFO - 'read-buildbot-config', 04:46:09 INFO - 'download-and-extract', 04:46:09 INFO - 'populate-webroot', 04:46:09 INFO - 'create-virtualenv', 04:46:09 INFO - 'install', 04:46:09 INFO - 'run-tests'), 04:46:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:46:09 INFO - 'download_minidump_stackwalk': True, 04:46:09 INFO - 'download_symbols': 'ondemand', 04:46:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:46:09 INFO - 'tooltool.py': '/tools/tooltool.py', 04:46:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:46:09 INFO - '/tools/misc-python/virtualenv.py')}, 04:46:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:46:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:46:09 INFO - 'gecko_profile': False, 04:46:09 INFO - 'gecko_profile_interval': 0, 04:46:09 INFO - 'installer_path': 'installer.exe', 04:46:09 INFO - 'log_level': 'info', 04:46:09 INFO - 'log_name': 'talos', 04:46:09 INFO - 'log_to_console': True, 04:46:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:46:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:46:09 INFO - 'opt_config_files': (), 04:46:09 INFO - 'pip_index': False, 04:46:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:46:09 INFO - 'cmd': ('bash', 04:46:09 INFO - '-c', 04:46:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:46:09 INFO - 'enabled': True, 04:46:09 INFO - 'halt_on_failure': False, 04:46:09 INFO - 'name': 'check_screen_resolution'},), 04:46:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:46:09 INFO - 'cmd': ('bash', 04:46:09 INFO - '-c', 04:46:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:46:09 INFO - 'enabled': True, 04:46:09 INFO - 'halt_on_failure': False, 04:46:09 INFO - 'name': 'check_screen_resolution'},), 04:46:09 INFO - 'run_cmd_checks_enabled': True, 04:46:09 INFO - 'suite': 'dromaeojs-e10s', 04:46:09 INFO - 'system_bits': '32', 04:46:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:46:09 INFO - 'title': 't-yosemite-r7-0160', 04:46:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:46:09 INFO - 'use_talos_json': True, 04:46:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:46:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:46:09 INFO - 'work_dir': 'build'} 04:46:09 INFO - [mozharness: 2017-03-08 12:46:09.543751Z] Running clobber step. 04:46:09 INFO - Running pre-action listener: _resource_record_pre_action 04:46:09 INFO - Running main action method: clobber 04:46:09 INFO - rmtree: /builds/slave/test/build 04:46:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:46:09 INFO - Running post-action listener: _resource_record_post_action 04:46:09 INFO - [mozharness: 2017-03-08 12:46:09.713818Z] Finished clobber step (success) 04:46:09 INFO - [mozharness: 2017-03-08 12:46:09.713950Z] Running read-buildbot-config step. 04:46:09 INFO - Running pre-action listener: _resource_record_pre_action 04:46:09 INFO - Running main action method: read_buildbot_config 04:46:09 INFO - Using buildbot properties: 04:46:09 INFO - { 04:46:09 INFO - "project": "", 04:46:09 INFO - "product": "firefox", 04:46:09 INFO - "script_repo_revision": "production", 04:46:09 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:46:09 INFO - "repository": "", 04:46:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:46:09 INFO - "buildid": "20170308030207", 04:46:09 INFO - "stage_platform": "macosx64", 04:46:09 INFO - "basedir": "/builds/slave/test", 04:46:09 INFO - "nightly_build": "True", 04:46:09 INFO - "buildnumber": 13, 04:46:09 INFO - "slavename": "t-yosemite-r7-0160", 04:46:09 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 04:46:09 INFO - "platform": "yosemite_r7", 04:46:09 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:46:09 INFO - "branch": "mozilla-central", 04:46:09 INFO - "repo_path": "mozilla-central", 04:46:09 INFO - "revision": "58753259bfeb3b818eac7870871b0aae1f8de64a", 04:46:09 INFO - "pgo_build": "False", 04:46:09 INFO - "builduid": "863c07f17b854228a4ae277e8f0d2acb", 04:46:09 INFO - "slavebuilddir": "test" 04:46:09 INFO - } 04:46:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:46:09 INFO - Running post-action listener: _resource_record_post_action 04:46:09 INFO - [mozharness: 2017-03-08 12:46:09.717527Z] Finished read-buildbot-config step (success) 04:46:09 INFO - [mozharness: 2017-03-08 12:46:09.717672Z] Running download-and-extract step. 04:46:09 INFO - Running pre-action listener: _resource_record_pre_action 04:46:09 INFO - Running main action method: download_and_extract 04:46:09 INFO - mkdir: /builds/slave/test/build/tests 04:46:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:09 INFO - trying https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:46:09 INFO - Downloading https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:46:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:46:11 INFO - Downloaded 1199 bytes. 04:46:11 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:46:11 INFO - Using the following test package requirements: 04:46:11 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:46:11 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:46:11 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:46:11 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:46:11 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:46:11 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:46:11 INFO - u'jsshell-mac.zip'], 04:46:11 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:46:11 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:46:11 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:46:11 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:46:11 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:46:11 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:46:11 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:46:11 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:46:11 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:46:11 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:46:11 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:46:11 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:46:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:46:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:46:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:46:12 INFO - Expected file size: 51789031 04:46:12 INFO - Obtained file size: 51789031 04:46:28 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:46:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:46:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:46:28 INFO - Fetch https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:46:31 INFO - Expected file size: 51789031 04:46:31 INFO - Obtained file size: 51789031 04:46:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:46:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:46:46 INFO - Fetch https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:46:47 INFO - Expected file size: 14404424 04:46:47 INFO - Obtained file size: 14404424 04:46:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:47 INFO - trying https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:46:47 INFO - Downloading https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:46:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:46:49 INFO - Downloaded 74991506 bytes. 04:46:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:46:49 INFO - mkdir: /builds/slave/test/properties 04:46:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:46:49 INFO - Writing to file /builds/slave/test/properties/build_url 04:46:49 INFO - Contents: 04:46:49 INFO - build_url:https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:46:50 INFO - Running post-action listener: _resource_record_post_action 04:46:50 INFO - Running post-action listener: set_extra_try_arguments 04:46:50 INFO - [mozharness: 2017-03-08 12:46:50.418960Z] Finished download-and-extract step (success) 04:46:50 INFO - [mozharness: 2017-03-08 12:46:50.419095Z] Running populate-webroot step. 04:46:50 INFO - Running pre-action listener: _resource_record_pre_action 04:46:50 INFO - Running main action method: populate_webroot 04:46:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:46:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:46:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:46:50 INFO - '--tppagecycles', 04:46:50 INFO - '7'], 04:46:50 INFO - 'tests': ['tsvgm']}}, 04:46:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:46:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:46:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:46:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:46:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:46:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:46:50 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:46:50 INFO - 'talos_options': ['--disable-e10s'], 04:46:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:46:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:46:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:46:50 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:46:50 INFO - 'talos_options': ['--disable-e10s'], 04:46:50 INFO - 'tests': ['damp', 'tps']}, 04:46:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:46:50 INFO - 'tests': ['damp', 'tps']}, 04:46:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:46:50 INFO - 'tests': ['dromaeo_dom']}, 04:46:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:46:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:46:50 INFO - 'tests': ['basic_compositor_video']}, 04:46:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:46:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:46:50 INFO - 'tests': ['a11yr', 04:46:50 INFO - 'ts_paint', 04:46:50 INFO - 'tpaint', 04:46:50 INFO - 'sessionrestore', 04:46:50 INFO - 'sessionrestore_no_auto_restore', 04:46:50 INFO - 'tabpaint']}, 04:46:50 INFO - 'other-e10s': {'tests': ['a11yr', 04:46:50 INFO - 'ts_paint', 04:46:50 INFO - 'tpaint', 04:46:50 INFO - 'sessionrestore', 04:46:50 INFO - 'sessionrestore_no_auto_restore', 04:46:50 INFO - 'tabpaint']}, 04:46:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:46:50 INFO - 'ts_paint', 04:46:50 INFO - 'tpaint', 04:46:50 INFO - 'sessionrestore', 04:46:50 INFO - 'sessionrestore_no_auto_restore', 04:46:50 INFO - 'tabpaint']}, 04:46:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:46:50 INFO - 'ts_paint', 04:46:50 INFO - 'tpaint', 04:46:50 INFO - 'sessionrestore', 04:46:50 INFO - 'sessionrestore_no_auto_restore', 04:46:50 INFO - 'tabpaint']}, 04:46:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:46:50 INFO - 'tests': ['a11yr', 04:46:50 INFO - 'ts_paint', 04:46:50 INFO - 'tpaint', 04:46:50 INFO - 'sessionrestore', 04:46:50 INFO - 'sessionrestore_no_auto_restore', 04:46:50 INFO - 'tabpaint']}, 04:46:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:46:50 INFO - 'tests': ['a11yr', 04:46:50 INFO - 'ts_paint', 04:46:50 INFO - 'tpaint', 04:46:50 INFO - 'sessionrestore', 04:46:50 INFO - 'sessionrestore_no_auto_restore', 04:46:50 INFO - 'tabpaint']}, 04:46:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:46:50 INFO - 'tests': ['tsvgx', 04:46:50 INFO - 'tsvgr_opacity', 04:46:50 INFO - 'tart', 04:46:50 INFO - 'tscrollx', 04:46:50 INFO - 'cart', 04:46:50 INFO - 'tsvg_static']}, 04:46:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:46:50 INFO - 'tsvgr_opacity', 04:46:50 INFO - 'tart', 04:46:50 INFO - 'tscrollx', 04:46:50 INFO - 'cart', 04:46:50 INFO - 'tsvg_static']}, 04:46:50 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:46:50 INFO - 'talos_options': ['--disable-e10s'], 04:46:50 INFO - 'tests': ['tp5o']}, 04:46:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:46:50 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:46:50 INFO - 'talos_options': ['--disable-e10s', 04:46:50 INFO - '--xperf_path', 04:46:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:46:50 INFO - 'tests': ['tp5n']}, 04:46:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:46:50 INFO - 'talos_options': ['--xperf_path', 04:46:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:46:50 INFO - 'tests': ['tp5n']}}, 04:46:50 INFO - 'talos.zip': {'path': '', 04:46:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:46:50 INFO - Running post-action listener: _resource_record_post_action 04:46:50 INFO - [mozharness: 2017-03-08 12:46:50.437539Z] Finished populate-webroot step (success) 04:46:50 INFO - [mozharness: 2017-03-08 12:46:50.437675Z] Running create-virtualenv step. 04:46:50 INFO - Running pre-action listener: _resource_record_pre_action 04:46:50 INFO - Running main action method: create_virtualenv 04:46:50 INFO - Creating virtualenv /builds/slave/test/build/venv 04:46:50 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 04:46:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:46:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:46:50 INFO - Using real prefix '/tools/python27' 04:46:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:46:51 INFO - Installing distribute.............................................................................................................................................................................................done. 04:46:54 INFO - Installing pip.................done. 04:46:54 INFO - Return code: 0 04:46:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:46:54 INFO - Reading from file tmpfile_stdout 04:46:54 INFO - Output received: 04:46:54 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) 04:46:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:46:54 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')]} 04:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:54 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')]} 04:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:54 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 0x10bdd1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64149bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbafd30>, '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 0x10bad6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bba4be8>, '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.4OhouXzNem/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.zW8MAmtDJL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 04:46:54 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 04:46:54 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 04:46:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4OhouXzNem/Render', 04:46:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:54 INFO - 'HOME': '/Users/cltbld', 04:46:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:54 INFO - 'LOGNAME': 'cltbld', 04:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:54 INFO - 'MOZ_NO_REMOTE': '1', 04:46:54 INFO - 'NO_EM_RESTART': '1', 04:46:54 INFO - 'PAGER': '/bin/cat', 04:46:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:54 INFO - 'PWD': '/builds/slave/test', 04:46:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:54 INFO - 'SHELL': '/bin/bash', 04:46:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zW8MAmtDJL/Listeners', 04:46:54 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 04:46:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:54 INFO - 'USER': 'cltbld', 04:46:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:54 INFO - 'XPC_FLAGS': '0x0', 04:46:54 INFO - 'XPC_SERVICE_NAME': '0', 04:46:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:54 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 04:46:54 INFO - Cleaning up... 04:46:54 INFO - Return code: 0 04:46:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:46:54 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')]} 04:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:54 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')]} 04:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:54 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 0x10bdd1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64149bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbafd30>, '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 0x10bad6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bba4be8>, '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.4OhouXzNem/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.zW8MAmtDJL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 04:46:54 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 04:46:54 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 04:46:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4OhouXzNem/Render', 04:46:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:54 INFO - 'HOME': '/Users/cltbld', 04:46:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:54 INFO - 'LOGNAME': 'cltbld', 04:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:54 INFO - 'MOZ_NO_REMOTE': '1', 04:46:54 INFO - 'NO_EM_RESTART': '1', 04:46:54 INFO - 'PAGER': '/bin/cat', 04:46:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:54 INFO - 'PWD': '/builds/slave/test', 04:46:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:54 INFO - 'SHELL': '/bin/bash', 04:46:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zW8MAmtDJL/Listeners', 04:46:54 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 04:46:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:54 INFO - 'USER': 'cltbld', 04:46:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:54 INFO - 'XPC_FLAGS': '0x0', 04:46:54 INFO - 'XPC_SERVICE_NAME': '0', 04:46:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:54 INFO - Downloading/unpacking psutil>=3.1.1 04:46:54 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 04:46:54 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 04:46:54 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 04:46:54 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 04:46:54 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 04:46:54 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 04:46:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:46:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:46:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:46:58 INFO - Installing collected packages: psutil 04:46:58 INFO - Running setup.py install for psutil 04:46:58 INFO - building 'psutil._psutil_osx' extension 04:46:58 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 04:46:58 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 04:46:58 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 04:46:59 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 04:46:59 INFO - building 'psutil._psutil_posix' extension 04:46:59 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 04:46:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:46:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:46:59 INFO - ^ 04:46:59 INFO - 1 warning generated. 04:46:59 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 04:46:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:46:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:46:59 INFO - Successfully installed psutil 04:46:59 INFO - Cleaning up... 04:46:59 INFO - Return code: 0 04:46:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:59 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 0x10bdd1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64149bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbafd30>, '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 0x10bad6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bba4be8>, '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.4OhouXzNem/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.zW8MAmtDJL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 04:46:59 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 04:46:59 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 04:46:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4OhouXzNem/Render', 04:46:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:46:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:46:59 INFO - 'HOME': '/Users/cltbld', 04:46:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:46:59 INFO - 'LOGNAME': 'cltbld', 04:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:59 INFO - 'MOZ_NO_REMOTE': '1', 04:46:59 INFO - 'NO_EM_RESTART': '1', 04:46:59 INFO - 'PAGER': '/bin/cat', 04:46:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:59 INFO - 'PWD': '/builds/slave/test', 04:46:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:46:59 INFO - 'SHELL': '/bin/bash', 04:46:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zW8MAmtDJL/Listeners', 04:46:59 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 04:46:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:46:59 INFO - 'USER': 'cltbld', 04:46:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:46:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:59 INFO - 'XPC_FLAGS': '0x0', 04:46:59 INFO - 'XPC_SERVICE_NAME': '0', 04:46:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:46:59 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 04:46:59 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 04:46:59 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 04:46:59 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 04:46:59 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 04:46:59 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 04:47:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:47:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:47:02 INFO - Installing collected packages: mozsystemmonitor 04:47:02 INFO - Running setup.py install for mozsystemmonitor 04:47:02 INFO - Successfully installed mozsystemmonitor 04:47:02 INFO - Cleaning up... 04:47:02 INFO - Return code: 0 04:47:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:02 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 0x10bdd1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64149bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbafd30>, '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 0x10bad6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bba4be8>, '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.4OhouXzNem/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.zW8MAmtDJL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 04:47:02 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 04:47:02 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 04:47:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4OhouXzNem/Render', 04:47:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:02 INFO - 'HOME': '/Users/cltbld', 04:47:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:02 INFO - 'LOGNAME': 'cltbld', 04:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:02 INFO - 'MOZ_NO_REMOTE': '1', 04:47:02 INFO - 'NO_EM_RESTART': '1', 04:47:02 INFO - 'PAGER': '/bin/cat', 04:47:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:02 INFO - 'PWD': '/builds/slave/test', 04:47:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:02 INFO - 'SHELL': '/bin/bash', 04:47:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zW8MAmtDJL/Listeners', 04:47:02 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 04:47:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:02 INFO - 'USER': 'cltbld', 04:47:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:02 INFO - 'XPC_FLAGS': '0x0', 04:47:02 INFO - 'XPC_SERVICE_NAME': '0', 04:47:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:02 INFO - Downloading/unpacking jsonschema==2.5.1 04:47:02 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 04:47:02 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 04:47:02 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 04:47:02 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 04:47:02 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 04:47:02 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 04:47:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:47:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:05 INFO - Downloading functools32-3.2.3-2.tar.gz 04:47:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:47:06 INFO - warning: no files found matching '*.txt' 04:47:06 INFO - no previously-included directories found matching 'build' 04:47:06 INFO - no previously-included directories found matching 'dist' 04:47:06 INFO - no previously-included directories found matching '.git*' 04:47:06 INFO - Installing collected packages: jsonschema, functools32 04:47:06 INFO - Running setup.py install for functools32 04:47:06 INFO - warning: no files found matching '*.txt' 04:47:06 INFO - no previously-included directories found matching 'build' 04:47:06 INFO - no previously-included directories found matching 'dist' 04:47:06 INFO - no previously-included directories found matching '.git*' 04:47:06 INFO - Successfully installed jsonschema functools32 04:47:06 INFO - Cleaning up... 04:47:06 INFO - Return code: 0 04:47:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:07 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 0x10bdd1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64149bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbafd30>, '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 0x10bad6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bba4be8>, '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.4OhouXzNem/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.zW8MAmtDJL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 04:47:07 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 04:47:07 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 04:47:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4OhouXzNem/Render', 04:47:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:07 INFO - 'HOME': '/Users/cltbld', 04:47:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:07 INFO - 'LOGNAME': 'cltbld', 04:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:07 INFO - 'MOZ_NO_REMOTE': '1', 04:47:07 INFO - 'NO_EM_RESTART': '1', 04:47:07 INFO - 'PAGER': '/bin/cat', 04:47:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:07 INFO - 'PWD': '/builds/slave/test', 04:47:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:07 INFO - 'SHELL': '/bin/bash', 04:47:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zW8MAmtDJL/Listeners', 04:47:07 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 04:47:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:07 INFO - 'USER': 'cltbld', 04:47:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:07 INFO - 'XPC_FLAGS': '0x0', 04:47:07 INFO - 'XPC_SERVICE_NAME': '0', 04:47:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:47:07 INFO - Cleaning up... 04:47:07 INFO - Return code: 0 04:47:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:07 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 0x10bdd1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64149bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbafd30>, '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 0x10bad6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bba4be8>, '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.4OhouXzNem/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.zW8MAmtDJL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 04:47:07 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 04:47:07 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 04:47:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4OhouXzNem/Render', 04:47:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:07 INFO - 'HOME': '/Users/cltbld', 04:47:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:07 INFO - 'LOGNAME': 'cltbld', 04:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:07 INFO - 'MOZ_NO_REMOTE': '1', 04:47:07 INFO - 'NO_EM_RESTART': '1', 04:47:07 INFO - 'PAGER': '/bin/cat', 04:47:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:07 INFO - 'PWD': '/builds/slave/test', 04:47:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:07 INFO - 'SHELL': '/bin/bash', 04:47:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zW8MAmtDJL/Listeners', 04:47:07 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 04:47:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:07 INFO - 'USER': 'cltbld', 04:47:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:07 INFO - 'XPC_FLAGS': '0x0', 04:47:07 INFO - 'XPC_SERVICE_NAME': '0', 04:47:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:08 INFO - Downloading/unpacking blobuploader==1.2.4 04:47:08 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 04:47:08 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 04:47:08 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 04:47:08 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 04:47:08 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 04:47:08 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 04:47:10 INFO - Downloading blobuploader-1.2.4.tar.gz 04:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:47:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:47:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:47:11 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 04:47:11 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 04:47:11 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 04:47:11 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 04:47:11 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 04:47:11 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 04:47:11 INFO - Downloading docopt-0.6.1.tar.gz 04:47:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:47:12 INFO - Installing collected packages: blobuploader, requests, docopt 04:47:12 INFO - Running setup.py install for blobuploader 04:47:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:47:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:47:12 INFO - Running setup.py install for requests 04:47:12 INFO - Running setup.py install for docopt 04:47:12 INFO - Successfully installed blobuploader requests docopt 04:47:12 INFO - Cleaning up... 04:47:12 INFO - Return code: 0 04:47:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:12 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 0x10bdd1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64149bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbafd30>, '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 0x10bad6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bba4be8>, '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.4OhouXzNem/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.zW8MAmtDJL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 04:47:12 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 04:47:12 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 04:47:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4OhouXzNem/Render', 04:47:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:12 INFO - 'HOME': '/Users/cltbld', 04:47:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:12 INFO - 'LOGNAME': 'cltbld', 04:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:12 INFO - 'MOZ_NO_REMOTE': '1', 04:47:12 INFO - 'NO_EM_RESTART': '1', 04:47:12 INFO - 'PAGER': '/bin/cat', 04:47:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:12 INFO - 'PWD': '/builds/slave/test', 04:47:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:12 INFO - 'SHELL': '/bin/bash', 04:47:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zW8MAmtDJL/Listeners', 04:47:12 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 04:47:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:12 INFO - 'USER': 'cltbld', 04:47:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:12 INFO - 'XPC_FLAGS': '0x0', 04:47:12 INFO - 'XPC_SERVICE_NAME': '0', 04:47:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:47:13 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-PSKlHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:47:13 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-InJaM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:47:13 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-FIRnMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:47:13 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-sFUvxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:47:13 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-RGeOec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:47:13 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-Ghs0rq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:47:13 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-ioBT0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:47:13 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-bDMqGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:47:14 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-1v9DXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:47:14 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-AoeOKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:47:14 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-QA5l4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:47:14 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-wRtXxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:47:14 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-mRk7P8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:47:14 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-cmWzac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:14 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-o0OxUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:47:14 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-tNY6Sm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:47:14 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-Rhum4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:47:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:47:15 INFO - Running setup.py install for manifestparser 04:47:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:47:15 INFO - Running setup.py install for mozcrash 04:47:15 INFO - Running setup.py install for mozdebug 04:47:15 INFO - Running setup.py install for mozdevice 04:47:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:47:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:47:15 INFO - Running setup.py install for mozfile 04:47:15 INFO - Running setup.py install for mozhttpd 04:47:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:47:15 INFO - Running setup.py install for mozinfo 04:47:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:47:16 INFO - Running setup.py install for mozInstall 04:47:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:47:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:47:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:47:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:47:16 INFO - Running setup.py install for mozleak 04:47:16 INFO - Running setup.py install for mozlog 04:47:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:47:16 INFO - Running setup.py install for moznetwork 04:47:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:47:16 INFO - Running setup.py install for mozprocess 04:47:16 INFO - Running setup.py install for mozprofile 04:47:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:47:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:47:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:47:16 INFO - Running setup.py install for mozrunner 04:47:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:47:17 INFO - Running setup.py install for mozscreenshot 04:47:17 INFO - Running setup.py install for moztest 04:47:17 INFO - Running setup.py install for mozversion 04:47:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:47:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:47:17 INFO - Cleaning up... 04:47:17 INFO - Return code: 0 04:47:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47: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')]} 04:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47: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')]} 04:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:17 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 0x10bdd1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64149bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbafd30>, '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 0x10bad6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bba4be8>, '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.4OhouXzNem/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.zW8MAmtDJL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 04:47:17 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 04:47:17 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 04:47:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4OhouXzNem/Render', 04:47:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:17 INFO - 'HOME': '/Users/cltbld', 04:47:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:17 INFO - 'LOGNAME': 'cltbld', 04:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:17 INFO - 'MOZ_NO_REMOTE': '1', 04:47:17 INFO - 'NO_EM_RESTART': '1', 04:47:17 INFO - 'PAGER': '/bin/cat', 04:47:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:17 INFO - 'PWD': '/builds/slave/test', 04:47:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:17 INFO - 'SHELL': '/bin/bash', 04:47:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zW8MAmtDJL/Listeners', 04:47:17 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 04:47:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:17 INFO - 'USER': 'cltbld', 04:47:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:17 INFO - 'XPC_FLAGS': '0x0', 04:47:17 INFO - 'XPC_SERVICE_NAME': '0', 04:47:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:47:17 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-fE69su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:47:18 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)) 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:47:18 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-Atb1Cd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:47:18 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)) 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:47:18 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-XfaPiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:47:18 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)) 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:47:18 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-AbijRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:47:18 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)) 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:47:18 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-y0cnKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:47:18 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)) 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:47:18 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-3NchwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:47:18 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)) 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:47:18 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-aiZ8UT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:47:18 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)) 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:47:18 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-90EYvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:47:18 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)) 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:47:18 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-yKIqQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:47:18 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)) 04:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:47:18 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-LRQlZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:47:19 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)) 04:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:47:19 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-gKgg0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:47:19 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)) 04:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:47:19 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-SFi6IQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 04:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:47:19 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-NTdHBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:47:19 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)) 04:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:47:19 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-jOKiHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:47:19 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)) 04:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:19 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-HdAKiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:19 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)) 04:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:47:19 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-v8eD41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 04:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:47:19 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-kE1267-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:47:19 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)) 04:47:19 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)) 04:47:19 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)) 04:47:19 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)) 04:47:19 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)) 04:47:19 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)) 04:47:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:22 INFO - Downloading blessings-1.6.tar.gz 04:47:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:47:22 INFO - Installing collected packages: blessings 04:47:22 INFO - Running setup.py install for blessings 04:47:22 INFO - Successfully installed blessings 04:47:22 INFO - Cleaning up... 04:47:22 INFO - Return code: 0 04:47:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:47:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:47:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:47:23 INFO - Reading from file tmpfile_stdout 04:47:23 INFO - Current package versions: 04:47:23 INFO - blessings == 1.6 04:47:23 INFO - blobuploader == 1.2.4 04:47:23 INFO - docopt == 0.6.1 04:47:23 INFO - functools32 == 3.2.3-2 04:47:23 INFO - jsonschema == 2.5.1 04:47:23 INFO - manifestparser == 1.1 04:47:23 INFO - mozInstall == 1.12 04:47:23 INFO - mozcrash == 1.0 04:47:23 INFO - mozdebug == 0.1 04:47:23 INFO - mozdevice == 0.49 04:47:23 INFO - mozfile == 1.2 04:47:23 INFO - mozhttpd == 0.7 04:47:23 INFO - mozinfo == 0.9 04:47:23 INFO - mozleak == 0.1 04:47:23 INFO - mozlog == 3.4 04:47:23 INFO - moznetwork == 0.27 04:47:23 INFO - mozprocess == 0.25 04:47:23 INFO - mozprofile == 0.28 04:47:23 INFO - mozrunner == 6.13 04:47:23 INFO - mozscreenshot == 0.1 04:47:23 INFO - mozsystemmonitor == 0.3 04:47:23 INFO - moztest == 0.8 04:47:23 INFO - mozversion == 1.4 04:47:23 INFO - psutil == 3.1.1 04:47:23 INFO - requests == 1.2.3 04:47:23 INFO - wsgiref == 0.1.2 04:47:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47:23 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')]} 04:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:23 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')]} 04:47:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:23 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 0x10bdd1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64149bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbafd30>, '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 0x10bad6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bba4be8>, '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.4OhouXzNem/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.zW8MAmtDJL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 04:47:23 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 04:47:23 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 04:47:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4OhouXzNem/Render', 04:47:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:23 INFO - 'HOME': '/Users/cltbld', 04:47:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:23 INFO - 'LOGNAME': 'cltbld', 04:47:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:23 INFO - 'MOZ_NO_REMOTE': '1', 04:47:23 INFO - 'NO_EM_RESTART': '1', 04:47:23 INFO - 'PAGER': '/bin/cat', 04:47:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:23 INFO - 'PWD': '/builds/slave/test', 04:47:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:23 INFO - 'SHELL': '/bin/bash', 04:47:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zW8MAmtDJL/Listeners', 04:47:23 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 04:47:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:23 INFO - 'USER': 'cltbld', 04:47:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:23 INFO - 'XPC_FLAGS': '0x0', 04:47:23 INFO - 'XPC_SERVICE_NAME': '0', 04:47:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:23 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)) 04:47:23 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)) 04:47:23 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)) 04:47:23 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)) 04:47:23 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)) 04:47:23 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)) 04:47:23 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)) 04:47:23 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)) 04:47:23 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)) 04:47:23 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)) 04:47:23 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)) 04:47:23 INFO - Cleaning up... 04:47:23 INFO - Return code: 0 04:47:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:47:23 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')]} 04:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:23 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')]} 04:47:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:23 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 0x10bdd1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64149bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bbafd30>, '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 0x10bad6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bba4be8>, '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.4OhouXzNem/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.zW8MAmtDJL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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 04:47:23 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 04:47:23 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 04:47:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4OhouXzNem/Render', 04:47:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:23 INFO - 'HOME': '/Users/cltbld', 04:47:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:23 INFO - 'LOGNAME': 'cltbld', 04:47:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:23 INFO - 'MOZ_NO_REMOTE': '1', 04:47:23 INFO - 'NO_EM_RESTART': '1', 04:47:23 INFO - 'PAGER': '/bin/cat', 04:47:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:23 INFO - 'PWD': '/builds/slave/test', 04:47:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:23 INFO - 'SHELL': '/bin/bash', 04:47:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zW8MAmtDJL/Listeners', 04:47:23 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 04:47:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:23 INFO - 'USER': 'cltbld', 04:47:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:23 INFO - 'XPC_FLAGS': '0x0', 04:47:23 INFO - 'XPC_SERVICE_NAME': '0', 04:47:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:47:23 INFO - Cleaning up... 04:47:23 INFO - Return code: 0 04:47:23 INFO - Running post-action listener: _resource_record_post_action 04:47:23 INFO - Running post-action listener: _start_resource_monitoring 04:47:23 INFO - Starting resource monitoring. 04:47:23 INFO - [mozharness: 2017-03-08 12:47:23.741628Z] Finished create-virtualenv step (success) 04:47:23 INFO - [mozharness: 2017-03-08 12:47:23.742435Z] Running install step. 04:47:23 INFO - Running pre-action listener: _resource_record_pre_action 04:47:23 INFO - Running main action method: install 04:47:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:47:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:47:23 INFO - Reading from file tmpfile_stdout 04:47:24 INFO - Detecting whether we're running mozinstall >=1.0... 04:47:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:47:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:47:24 INFO - Reading from file tmpfile_stdout 04:47:24 INFO - Output received: 04:47:24 INFO - Usage: mozinstall [options] installer 04:47:24 INFO - Options: 04:47:24 INFO - -h, --help show this help message and exit 04:47:24 INFO - -d DEST, --destination=DEST 04:47:24 INFO - Directory to install application into. [default: 04:47:24 INFO - "/builds/slave/test"] 04:47:24 INFO - --app=APP Application being installed. [default: firefox] 04:47:24 INFO - mkdir: /builds/slave/test/build/application 04:47:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:47:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:47:44 INFO - Reading from file tmpfile_stdout 04:47:44 INFO - Output received: 04:47:44 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:47:44 INFO - Running post-action listener: _resource_record_post_action 04:47:44 INFO - [mozharness: 2017-03-08 12:47:44.590826Z] Finished install step (success) 04:47:44 INFO - [mozharness: 2017-03-08 12:47:44.591030Z] Running run-tests step. 04:47:44 INFO - Running pre-action listener: _resource_record_pre_action 04:47:44 INFO - Running main action method: run_tests 04:47:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:47:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:47:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:47:44 INFO - 2017-03-08 04:47:44.605 screenresolution[6865:122248] starting screenresolution argv=screenresolution get 04:47:44 INFO - 2017-03-08 04:47:44.608 screenresolution[6865:122248] Display 0: 1600x1200x32@60 04:47:44 INFO - 2017-03-08 04:47:44.614 screenresolution[6866:122250] starting screenresolution argv=screenresolution list 04:47:44 INFO - Available Modes on Display 0 04:47:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:47:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:47:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:47:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:47:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:47:44 INFO - Intel Iris: 04:47:44 INFO - Chipset Model: Intel Iris 04:47:44 INFO - Type: GPU 04:47:44 INFO - Bus: Built-In 04:47:44 INFO - VRAM (Dynamic, Max): 1536 MB 04:47:44 INFO - Vendor: Intel (0x8086) 04:47:44 INFO - Device ID: 0x0a2e 04:47:44 INFO - Revision ID: 0x0009 04:47:44 INFO - Displays: 04:47:44 INFO - Display: 04:47:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:47:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:47:44 INFO - Display Serial Number: 1600x1200 60 04:47:44 INFO - Main Display: Yes 04:47:44 INFO - Mirror: Off 04:47:44 INFO - Online: Yes 04:47:44 INFO - Rotation: Supported 04:47:44 INFO - Return code: 0 04:47:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:47:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:47:44 INFO - Python 2.7.3 04:47:44 INFO - Return code: 0 04:47:44 INFO - grabbing minidump binary from tooltool 04:47: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')]} 04:47:44 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 0x10bbafd30>, '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 0x10bad6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bba4be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:47:44 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 04:47:44 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 04:47:44 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 04:47:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:47:44 INFO - Return code: 0 04:47:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:47:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:47:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:47:44 INFO - ENV: RUST_BACKTRACE is now 1 04:47:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:47:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:47:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0160', '--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 04:47:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0160 --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 04:47:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4OhouXzNem/Render', 04:47:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:44 INFO - 'HOME': '/Users/cltbld', 04:47:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:44 INFO - 'LOGNAME': 'cltbld', 04:47:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:47:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:47:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:44 INFO - 'MOZ_NO_REMOTE': '1', 04:47:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:47:44 INFO - 'NO_EM_RESTART': '1', 04:47:44 INFO - 'PAGER': '/bin/cat', 04:47:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:44 INFO - 'PWD': '/builds/slave/test', 04:47:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:47:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:44 INFO - 'RUST_BACKTRACE': '1', 04:47:44 INFO - 'SHELL': '/bin/bash', 04:47:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zW8MAmtDJL/Listeners', 04:47:44 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 04:47:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:44 INFO - 'USER': 'cltbld', 04:47:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:44 INFO - 'XPC_FLAGS': '0x0', 04:47:44 INFO - 'XPC_SERVICE_NAME': '0', 04:47:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0160', '--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 04:47:45 INFO - mozversion application_buildid: 20170308030207 04:47:45 INFO - mozversion application_changeset: 58753259bfeb3b818eac7870871b0aae1f8de64a 04:47:45 INFO - mozversion application_display_name: Nightly 04:47:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:47:45 INFO - mozversion application_name: Firefox 04:47:45 INFO - mozversion application_remotingname: firefox 04:47:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:47:45 INFO - mozversion application_vendor: Mozilla 04:47:45 INFO - mozversion application_version: 55.0a1 04:47:45 INFO - mozversion platform_buildid: 20170308030207 04:47:45 INFO - mozversion platform_changeset: 58753259bfeb3b818eac7870871b0aae1f8de64a 04:47:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:47:45 INFO - mozversion platform_version: 55.0a1 04:47:45 INFO - using testdate: 1488977265 04:47:45 INFO - actual date: 1488977265 04:47:45 INFO - starting webserver on 'localhost:57432' 04:47:45 INFO - SUITE-START | Running 2 tests 04:47:45 INFO - TEST-START | dromaeo_css 04:47:45 INFO - operating with platform_type : mac_ 04:47:45 INFO - Initialising browser for dromaeo_css test... 04:47:45 INFO - TEST-INFO | started process 6876 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/tmpRPnaGm/profile http://localhost:57432/getInfo.html) 04:47:48 INFO - PROCESS | 6876 | 2017-03-08 04:47:48.182 plugin-container[6877:122404] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x903f, name = 'com.apple.tsm.portname' 04:47:48 INFO - PROCESS | 6876 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:47:48 INFO - PROCESS | 6876 | 2017-03-08 04:47:48.182 plugin-container[6877:122404] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4e1f, name = 'com.apple.CFPasteboardClient' 04:47:48 INFO - PROCESS | 6876 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:47:48 INFO - PROCESS | 6876 | 2017-03-08 04:47:48.182 plugin-container[6877:122404] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:47:48 INFO - PROCESS | 6876 | __metrics Screen width/height:1600/1200 04:47:48 INFO - PROCESS | 6876 | colorDepth:24 04:47:48 INFO - PROCESS | 6876 | Browser inner width/height: 1024/689 04:47:48 INFO - PROCESS | 6876 | __metrics 04:47:48 ERROR - PROCESS | 6876 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 04:47:49 INFO - TEST-INFO | 6876: exit 0 04:47:49 INFO - Browser initialized. 04:47:49 INFO - Running cycle 1/1 for dromaeo_css test... 04:47:49 INFO - TEST-INFO | started process 6879 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/tmpRPnaGm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:47:51 INFO - PROCESS | 6879 | 2017-03-08 04:47:51.633 plugin-container[6880:122546] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.tsm.portname' 04:47:51 INFO - PROCESS | 6879 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:47:51 INFO - PROCESS | 6879 | 2017-03-08 04:47:51.634 plugin-container[6880:122546] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x441b, name = 'com.apple.CFPasteboardClient' 04:47:51 INFO - PROCESS | 6879 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:47:51 INFO - PROCESS | 6879 | 2017-03-08 04:47:51.634 plugin-container[6880:122546] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:48:01 INFO - PROCESS | 6879 | RSS: Main: 226856960 04:48:01 INFO - PROCESS | 6879 | 04:51:05 INFO - PROCESS | 6879 | Cycle 1(1): loaded http://localhost:57432/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57432/tests/dromaeo/cssquery-ext.html) 04:51:06 INFO - PROCESS | 6879 | RSS: Main: 249798656 04:51:06 INFO - PROCESS | 6879 | 04:52:49 INFO - PROCESS | 6879 | ************************* 04:52:49 INFO - PROCESS | 6879 | A coding exception was thrown and uncaught in a Task. 04:52:49 INFO - PROCESS | 6879 | 04:52:49 ERROR - PROCESS | 6879 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:52:49 INFO - PROCESS | 6879 | Full stack: 04:52:49 INFO - PROCESS | 6879 | ************************* 04:54:09 INFO - PROCESS | 6879 | Cycle 1(1): loaded http://localhost:57432/tests/dromaeo/cssquery-ext.html (next: http://localhost:57432/tests/dromaeo/cssquery-jquery.html) 04:54:09 INFO - PROCESS | 6879 | RSS: Main: 258174976 04:54:09 INFO - PROCESS | 6879 | 04:57:12 INFO - PROCESS | 6879 | Cycle 1(1): loaded http://localhost:57432/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57432/tests/dromaeo/cssquery-mootools.html) 04:57:12 INFO - PROCESS | 6879 | RSS: Main: 269520896 04:57:12 INFO - PROCESS | 6879 | 05:00:14 INFO - PROCESS | 6879 | Cycle 1(1): loaded http://localhost:57432/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57432/tests/dromaeo/cssquery-prototype.html) 05:00:15 INFO - PROCESS | 6879 | RSS: Main: 263266304 05:00:15 INFO - PROCESS | 6879 | 05:03:18 INFO - PROCESS | 6879 | Cycle 1(1): loaded http://localhost:57432/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57432/tests/dromaeo/cssquery-yui.html) 05:03:19 INFO - PROCESS | 6879 | RSS: Main: 273436672 05:03:19 INFO - PROCESS | 6879 | 05:06:21 INFO - PROCESS | 6879 | Cycle 1(1): loaded http://localhost:57432/tests/dromaeo/cssquery-yui.html (next: http://localhost:57432/tests/dromaeo/cssquery-dojo.html) 05:06:22 INFO - PROCESS | 6879 | RSS: Main: 267407360 05:06:22 INFO - PROCESS | 6879 | 05:06:22 INFO - PROCESS | 6879 | __start_tp_report 05:06:22 INFO - PROCESS | 6879 | _x_x_mozilla_page_load 05:06:22 INFO - PROCESS | 6879 | _x_x_mozilla_page_load_details 05:06:22 INFO - PROCESS | 6879 | |i|pagename|runs| 05:06:22 INFO - PROCESS | 6879 | |0;dojo.html;3391.796492210466;3395.881144159954;3397.7621566490357;3417.248205394813;3437.879674211403;5841.474267315941;5857.970710146448;5941.257342832146;5954.672493012882;5967.075103358976;5637.295338082739;5768.625039372438;5847.093700476433;5885.970570147143;5889.882202355961;5266.157414813631;5301.6818990860675;5323.60072994525;5338.27933229013;5357.330333708286;5274.2879711238875;5374.301340825707;5416.647917885344;5441.319835020622;5444.237806707064;4368.650507959355;5248.842534723926;5402.540784033342;5406.405295417501;5434.2935418395555;5297.205419187114;5301.231321458406;5316.548093412026;5321.281626980347;5356.866078348073;5256.08018596744;5274.868128296785;5276.604254680876;5277.656952298127;5320.920186197211;4422.137683151786;5695.800646977336;5716.1711551825165;5858.916100521417;5971.761129554812;6193.411625895533;6213.378662133796;6243.968780156116;6256.937430625681;6267;5221.660592061504;5722.912646597133;5955.255593050869;6353.396427339396;6355.8411039723915;5793.102069179284;6083.6045657032155;6085.995810691231;6086.995645718451;6111.388861113942;6298.7480500780375;6352.078948552434;6380.521460890359;6395.5203359747275;6416.230052393649;6100.823402702991;6145.432914606747;6209.161763162006;6266;6280.434760871543;6109.34393638171;6222.62664240147;6251.437370636664;6269.686515674198;6325.05124231369;6266.279377871512;6274;6290.528210384239;6293.213348331458;6294.905576416358;6207.131001659771;6237.345078766755;6265.154204182468;6276.623402595859;6280.874382512324;5074.0359331727595;5074.2895994560795;5104.412992505835;5118.718470484085;5183.222516622537;4555.908881822345;4568.817247310137;4574.108048930493;4588.816447342136;4622.052479241815;6108.267007959073;6113.23584551931;6124.969375153096;6127.417895299939;6137.01807710773;5200.76596553156;6142.253225532421;6236.438720515084;6261.436470717657;6335.809925702236;5819.418058194146;6062.393760623902;6108.633481991094;6110.450059494667;6136.2636483622255;5206.557442617344;5586;5605.495505404533;5610.523105535994;5629.2681951346885;6222.315545289924;6272.968635156795;6377.170967774346;6494.188226471691;6522.119513865662;5158.277841102324;6319.368063193644;6321.52588555851;6330.968345158245;6348.777792777415;6521.02184672303;6549.312322206099;6584.736610535525;6592.637404942582;6600.372964568358;6103.974138059404;6234.719437625227;6286;6299.874002520016;6317.241930968313;6209.410106039919;6258.217722784652;6324.873502529832;6332.936670633235;6393.2967373587935;6198.2252218472695;6216.968915155395;6222.595531290452;6264.404881536247;6270.968645156745;6087.604305720114;6126;6155;6201.193844800147;6242.687865606611;5342.706151161723;5602.0196465619165;5716.199732037601;6155.630662160284;6189.84525386869;6249;6276.623402595859;6296.748130074929;6303.842403939755;6317.989121740499;6017.548683848817;6043.969780151071;6057.333693293822;6124.54065945047;6202.72087756043 05:06:22 INFO - PROCESS | 6879 | |1;ext.html;693.7433149734599;771.8919351290818;799.5642374905677;831.7005877883964;936.5317341329335;28853;38223;39595.40606890892;39679.80160099195;39747.40378894312;30885;37606.62393376065;37682.623173768254;37958.67144649938;38072.61927380726;7612.162662107164;7771.533707977511;10361.533730982086;10657.733556661107;10744.14046876248;10461.058504734572;10554.894451055507;10572.735681607945;10574.365538067703;10591.576336946513;9888.307818452711;10533.104686101653;10549.6307629233;10575.682729518127;10620.522076506537;10488.528016239288;10512.264141510097;10548.683539493828;10552.261341706084;10562.788744225072;10333.431661258628;10343.224258180666;10416.687499375032;10418.21863360251;10429.791404171874;32803.50794738081;33114.3377132456;33114.6688533114;33130.337393252;33173.50239746406;3421.4525675891737;3745.213505163919;3774.698024158061;3792.867249646249;3822.770633761955;23771.28686139401;23922.28233153008;25090;25491.23526294214;26013.21960341193;2565.3843077661227;2573.240893936293;2977.8213307201636;3169.952450713241;3181.0297859152947;354968;359815;359833;359882;360816;44056.339154912064;44073.338899916525;44157.89605259894;44223.11553768907;44257;45765.50813902353;46001.7699911505;46140.30789538159;46172;46249;13054;13076.738465230832;13158.73682526344;13158.868411315956;13172.341382930816;11213.55145794159;11216.775664486664;11219.326840389604;11225.494852731646;11237.157213209042;9863.358881672668;11707.121965852595;11755.941220294015;11826;11906.226095303777;4949;5337.866553336197;5540.030494663418;5577.888442231214;5613.242212301368;1090.7818436312768;1116.938568378747;1121.8485504456958;1126.2679258482053;1126.3973774030853;25574;25625.743742562336;25921.83351749176;26431.471370572865;26476;1090.907272881814;1135.2790977729037;1207.8007128823647;1215.975680486403;1262.8863402293837;12191.573294934813;13459.394327255297;13646.24945628;13689.31553422325;13715.862841371458;152131;152207;152233;152458;152835.23582382017;55940.88118237613;56015.719921400945;56172.719136404055;56174.7191264041;56577.585560360494;1331.3476396565613;1346.5960211936576;1368.2679766324968;1387.2439520461373;1392.1090502078678;22842.31473055811;25654.871725641253;26030.219093427226;26726.866365668047;27046.864765676044;39746.80126599464;39781.80109099436;39798.20403591854;39958;40007;456275;457123;457347;457453;460424;28461.00386486546;28597;28878.844846205917;28946.131616051553;29076;36025.45961810627;36432.27135457223;37204.44193337048;37504.87485375334;37522.62477375301;30877.0736877894;30990.69009309878;31435;31808.36383272368;31870.45036397129;29990.700092999665;30547.389052218386;30551.2362190947;31264.531032034083;31755.04734857958;22918.656220157045;30778.76884924578;31269.687303126677;31508.36983260368;31850;22525;25016;28033.43933121367;28707.85646071756;29019.419611607227;22528.549429011655;22869.313920582408;23002.309930702108;23167;23206 05:06:22 INFO - PROCESS | 6879 | |2;jquery.html;337.54431517451457;400.3634221587675;414.13032631473897;429.97420154790717;443.32835753832927;18608.534786630305;20375.592488150247;20457.386278411635;21126.683099753496;21218;21308.4672883178;21343.039563219652;21418.464538386546;22077.889610551923;22262.443438914037;6609.83475413115;6935.375816176543;6963.617001064939;6973;6979.232284448732;5271.604629652772;6068.846919085359;6758.898616520756;6772.187337519505;6857.142857142857;5966.8806623867495;6498.610083395011;6735.797926062226;6770.458363330922;6792.728290868384;5541.113421852504;6564.80305590833;6746.156730408699;6762.93237067628;6773.45812335012;4696.459907110692;6472.6763661817195;6567.704453299613;6589.406953374171;6597.63712995785;25922.481550369077;25994;26022.86988565064;26047.088351907783;26313;2948.5871977923107;3340.8997730068136;3350.949735753966;3434.7252219822353;3441.6558344165633;15952.521424357172;16108.355665773355;16245.756313655187;16598.502044938552;16958.745618815727;1998.8400927925732;2003.1386503803358;2068.162394230339;2072.1814883121083;2074.9481262968397;125022;129186;129619;130787;132312.99999999904;17535.947843129452;20789.896050519954;21698.372622053408;21943.231986880382;22157.889210553843;33019.66980330166;33627.495587566205;33844.49233261503;33875.491867622004;34018.31963360719;9495.57269922855;9614.90385096154;9780.31537792362;9874.210063194927;9937.708097947365;7733.7679869604;7739.613019349123;7744.922550774533;7904.881426778603;7921.049474063149;8960.05919378469;10185.74535636615;10195.745106372251;10330;10355;3470.930581388358;3736.9439458408146;4000.3799411091327;4169.791510424467;4203.453551038407;862.7756783236404;867.7873920889423;879.8812160358269;887.8756974023642;906.8730377747121;21640.675389869164;22063.448413789785;22656.546869062528;22851.31446056621;23081.65377519305;813.7151996801191;896.171041786345;933.9159475647224;940.3276657190141;959.5058544849409;8155.67377304913;11697.23967942081;11828.76342473163;11840.348780816965;11862.466189021514;589123.0543847339;710918;712274;718051;738270;111451;113085;122583;124592.75407245812;127981;1184.798584240681;1252.7369252457086;1278.8465384153776;1283.4481173095658;1284.9421776020101;19498.902505487382;19621.018949052777;19924.50188745293;19967.900160499106;20036.198552057755;58332.70833645805;63714.68142659443;64141.717165657356;64895;65788.67105664441;89600;89711.55144224237;89840;90083.54958225167;90201.09798901927;7398.186199517941;10110;10843.566257349617;11250.212485125963;11909.880901191224;12567.560135395217;12845.678858028625;13096.803547946598;13104.737905242033;13250.271235082164;9025.638974440948;11083.949469348196;11138.554457821596;11148;11314.264572802742;8812.867806982773;9392.013838547127;9561.139497445263;10781.676549703208;10942.17933654963;11309.547618095514;11510.251833631122;11566.07471402269;11585.420728963687;11624.011958983581;11352.262102963281;11414.771704566028;11653.242539234923;11710.00464960488;11714.355710436008;11057.668269951915;11102.500387482422;11224.989750922456;11240.718982025515;11310.60412885545 05:06:22 INFO - PROCESS | 6879 | |3;mootools.html;1441.3802065112002;1568.5686436230042;1578.155686707611;1597.6499857620306;1604.0856711674344;10364.067233948943;10507.369557826536;10813.08088812452;11021.228514004022;11054.557817687282;10833.566657333717;10989.560417583307;11002.50488728007;11036.944815275912;11038.392888391136;2347.319277409549;2383.5471260460545;2385.296337580418;2392.7726865947707;2394.0782798622567;2330.8368414211013;2334.2880421471446;2369.07606033647;2376.7504412036747;2380.95238095238;2331.603627383349;2357.917472888449;2361.480474295652;2367.857928524294;2376.512814872947;2321.7097862767155;2332.102140675835;2341.1103780563362;2345.64815277708;2347.9295621131223;2309.1340747219792;2338.1232037985756;2346.1084787780533;2358.929232123039;2363.5036642305136;10643;10852.131829453625;10853.294535855222;10892.40091794951;10900.618478353219;5707.800226992077;5809.82570522885;5877.970610146922;5880.441358070976;5892.675902825343;3490.7556471047037;3607.7835329880027;3610.9638903611153;3616.9276614467826;3620.1673615068416;1130.655150179195;1159.3855256713955;1176.1766763265748;1203.6870413692502;1208.09996552568;13460.865391346058;13695.452181912711;14626.122432654181;15006.699866002618;15156;3915.275674000319;4484.349769283435;4530.391710942634;4680;4682.695624784378;11351.035162011322;11380.829287560693;11391.943040284912;11432.657020289405;11450.996075686722;5653.660780353192;5696;5737.8565535861935;5745.1669507921115;5755.309362876482;5149.253358263031;5192.324997750268;5198.948010519846;5262.842114736564;5292.126799078109;3805.4291856221234;3846.6922646188236;3874.4769456123627;3906.316394630985;3925.293447179535;1039.1946241662772;1040.5161599856103;1044.4255659387306;1057.1912486947492;1058.8782290036745;903.5391950105362;930.5207817973749;944.3106532231509;948.3977674176947;973.9513024348896;4820.180569303227;5555.944440555623;6526.934730652728;6559.884819580683;6651.401373876374;957.7749228931195;983.6557204978201;988.4629401281077;990.6087095597343;1001.2640709078821;3402.234497238151;3616.222512159846;4103.384492326175;4132.876013719593;4196.223698615766;12327.445264963098;13060.477580896848;13407.932960335136;13438.731225375634;13454.798178027337;11201.439928003567;11624.360660163773;12930.482780688855;13336.133151345131;13383.063185577112;8574.442661227125;8613.741587752378;9403.57683904226;9971.351862128939;9999.500024998866;5017;5321.09541377959;5867.354590994902;6294.150289711014;6350.968245158745;9721.270904682036;9815.460149691835;9850.950745246228;9896.752581185528;9999.150072243941;10388.11701005423;10427;10576.41829699374;10579.10077643409;10752.333388324821;9032.593533290887;9110.36227464071;9147.359684821999;9180.17378435944;9215.262778977532;10087.193024558164;10125.341852779546;10161.288709790539;10184.675992121272;10188.184945204513;7456.32893039629;7653.272939070779;8932.240759535252;8962.596683149144;8997.100289970951;8334.249917507454;8366.121557236402;8391.58042097905;8422.326213902996;8433.030201526657;7688.038995125609;7818.804529886798;7834.647440865288;7841.372690184886;7847.332976697045;5730.341010783646;5776.422357764358;5888.116782482491;5966.731497082728;5969.850753731192;5743.712814359349;5851.356350801323;5907.881842363215;6009.609375390585;6081.452669259611 05:06:22 INFO - PROCESS | 6879 | |4;prototype.html;298.2112312932294;336.1981673708206;379.9031247032005;383.61829979170693;387.6491774943676;4356.324769660704;5268.367795864492;5271.525562699357;5298.443663415339;5299.470052994699;4669.968563674795;4737.310063037594;4790.437116142855;4963.0570191663555;5206.661566998152;4242.830286788525;4247.469066366704;4262.352383092407;4277.978610106945;4294.355846623016;3825.9234815303676;3885.8536731664085;4254.53200147985;4281.794875639049;4289.335153051282;4297.892552686192;4301.65586753059;4325.502567204764;4328.679752675433;4341.50072741634;3612.5303710517596;3831.7509361891525;3963.365861462152;4181.550221067631;4273.380359847804;3718.851245950159;3915.609958464761;3936.704747143947;3941.8423263069444;3964.5044369453817;4087.386891966199;5100.163940981281;5101.336826212606;5106.208537676666;5127.641065125443;4575.679702420832;4618.175820550897;4661;4878.8292409765845;5012.624053195988;4614.746188959606;5260.395054568736;5460.890782184374;5607.719614019283;5613.21415001896;4359.7547263159495;4435.822567097344;4437.733735975819;4442.62237709795;4448.310511870633;5727.783277303507;5808.535317174616;5870.002099643071;5895.263092113529;5977.953858074819;4226;4284.935725964113;4527.63778897694;4605.052766229615;4615.646020529487;4042.4744783178585;4605.631549476034;4618.884527886829;4681.461631912373;4686.859394218179;4388.5830846069575;4449.710768800018;4558.772061396917;4694.694844835143;4718.079974404958;5162.535371816554;5293.788248470018;5357.1785592898605;5398.379186393615;5498.890022199614;1414.9529348282197;1478.6839712655744;1527.732646786808;1560.5240401677597;1591.3236874328363;995.716220877061;1026.4508487958906;1115.4199816095586;1135.4833550734395;1146.4439746722999;4624.260118381043;4732.692374995683;4816.590589799836;5210.713410762369;5262.842114736564;5223.056592272886;5283.682979021271;5430.886668233003;5818.665094504621;5820.563457740686;4328.935065974013;4440.555944405533;4477.074857811107;4898.314236006961;5220.660657057279;2662.534056540098;2723.128598848389;2737.343037670945;2969.866356013941;3062.9540556891666;5461.563074953994;5476.507114359727;5850.531957443394;6021.157038014681;6049.852302432661;5386.892262154814;5675.829725108253;5754.913676294859;5887.411258874078;5896.526865686354;5853.7365818538265;5857.853553661193;5957.897788909066;6017.578769486182;6027.4492757967455;4988.655331993957;4995.525425084611;5128.871778205575;5190.558802501679;5795.594828146272;4750.358701575243;4910.975445122752;5289.57683385336;5629.831105066854;5681.89203105407;5416.241726158262;5864.211415518308;5959.096791601508;5983.670898100646;6006.759729610767;3724;4157.295508841361;4583.702059366264;4586.564276393738;4605.447346318329;4753.954130091374;5563;5682.4172196851;5700.377826199994;5769.365369809234;4604.562566556172;4789.44921334051;5572.545022086332;5589.916151257653;5644.435556444323;4887.315775791321;5266.762310857022;5423.772855151179;5520.199571062254;5619.353774315842;4742.336072949859;5113.49438775005;5125.897482050413;5428.864278393072;5463.69949652757;5043.823466178666;5099.107656160231;5250.842474725764;5559.192607733231;5666.46168613981;4867.440244371801;5036.974815125901;5112.437631860418;5484.808031718871;5494.862628434161 05:06:22 INFO - PROCESS | 6879 | |5;yui.html;700.7057036044861;706.427793487275;769.9307062364386;825.8018075661842;834.449263486099;14534.34595443205;15193.848061519382;15712.292946817392;15766.527004189878;15775.21123943804;15152;15346.155961422117;15347.462838800617;15356.539303820904;15454.69090618187;910.6676063236937;924.3021518753332;938.9389689670184;939.7039932421266;939.976500587484;887.4497811356968;926.3422969691527;932.5523748600676;944.1502647617165;944.7307517357555;981.9312648114635;982.341830973246;982.9262805289596;985.9893609050708;986.1223511075149;834.3408707121367;975.5414954971152;981.6318880419842;981.7594689301131;984.4191926763173;719.5143278287187;727.1456039154026;727.8871774874902;729.0303895818548;729.3690957321932;14843.480478183319;15116.54650360491;15155.62110947224;15267.618309542238;15502.767458488132;12846.715328467171;13631.318434078355;13636.318184090855;14237.78643320351;14375.856241437661;10565.207609429246;10823.357926579703;10955.4522273886;11156.497957591928;11479.598214062467;3623.40213864712;3671.247394284192;3682.907927301812;3723.590405055442;3793.089658481972;95071.52464237704;108281;108500;110377;111148.444257779;10562.894371056345;10597;10637.521311540844;11102.000819926245;11130.387828669502;22178.112875485123;22244.332670019925;22312.442188945082;22332;22358.66462003071;6434.906065968797;7421.517601355895;7429.922661214094;7563.016807814949;7574.697012119454;4015.7613172808797;4124.649404800565;4133.100173873144;4148.274052040881;4185.142045880587;3269.73842092632;3320.00399880035;3342.6824451677053;3369.6967272945553;3370.5618269624792;495.4673725744839;558.7346010644992;577.4369989260522;581.7731084876901;594.895893218685;648.6497291462557;682.4608559238146;690.526989012518;691.7233106757337;715.5241764226731;9120.407173533698;9472.715818525456;9849.310548261554;10306.278560500694;10321.380717156995;627.9058141278754;660.8149718078946;694.4479089235555;695.3012222716239;723.9348458638642;4714.693544919569;4864.829730959399;4879.853604391874;4895.510448955076;4905.484924082992;81683.50740709317;102782;103083.48458257661;104028;104109;59467.810643786885;62467.750644986845;70255;75252.87120693194;92852.53573732088;62571.687141564;62598.37401626017;63593;63924.04113938202;66360.33639663542;10705;10910;10913.83629245546;11053.392063436588;11079.83380249313;40250.50609810866;44246;49243;50193.49806501888;51990;53076.46923530715;53144;53258.20112698235;55362.72318638381;60098.7980240384;12029.398530073286;12128.908398243848;12467.438965246767;12512.186707864324;12950.222986620833;13517.86482135166;13562.321883905963;13656.385462654005;13955.06638260945;14062.156270623795;12941.870581294066;12985.436893203898;13254.13848099909;13435.529756458476;13451.596452106452;11054;13169.9877391122;13445.663858403226;13602.319884005958;14148.575542733735;12892.613221603367;12895.677608059874;12983.545575904798;13105.344732763133;13885.166889986633;8224.917750822415;10606.893931060591;10800.826685569982;10934.617288394868;11281.153913456688;8652.005019422846;9118.863217051618;10104.69685909424;10861.782764344827;11242.606508772154 05:06:22 INFO - PROCESS | 6879 | __end_tp_report 05:06:22 INFO - PROCESS | 6879 | __start_cc_report 05:06:22 INFO - PROCESS | 6879 | _x_x_mozilla_cycle_collect,428 05:06:22 INFO - PROCESS | 6879 | __end_cc_report 05:06:22 INFO - PROCESS | 6879 | __startTimestamp1488978382120__endTimestamp 05:06:22 INFO - PROCESS | 6879 | 05:06:22 INFO - PROCESS | 6879 | ------- Summary: start ------- 05:06:22 INFO - PROCESS | 6879 | Number of tests: 6 05:06:22 INFO - PROCESS | 6879 | 05:06:22 INFO - PROCESS | 6879 | [#0] dojo.html Cycles:165 Average:5826.27 Median:6109.34 stddev:655.75 (10.7%) stddev-sans-first:629.34 05:06:22 INFO - PROCESS | 6879 | Values: 3391.8 3395.9 3397.8 3417.2 3437.9 5841.5 5858.0 5941.3 5954.7 5967.1 5637.3 5768.6 5847.1 5886.0 5889.9 5266.2 5301.7 5323.6 5338.3 5357.3 5274.3 5374.3 5416.6 5441.3 5444.2 4368.7 5248.8 5402.5 5406.4 5434.3 5297.2 5301.2 5316.5 5321.3 5356.9 5256.1 5274.9 5276.6 5277.7 5320.9 4422.1 5695.8 5716.2 5858.9 5971.8 6193.4 6213.4 6244.0 6256.9 6267.0 5221.7 5722.9 5955.3 6353.4 6355.8 5793.1 6083.6 6086.0 6087.0 6111.4 6298.7 6352.1 6380.5 6395.5 6416.2 6100.8 6145.4 6209.2 6266.0 6280.4 6109.3 6222.6 6251.4 6269.7 6325.1 6266.3 6274.0 6290.5 6293.2 6294.9 6207.1 6237.3 6265.2 6276.6 6280.9 5074.0 5074.3 5104.4 5118.7 5183.2 4555.9 4568.8 4574.1 4588.8 4622.1 6108.3 6113.2 6125.0 6127.4 6137.0 5200.8 6142.3 6236.4 6261.4 6335.8 5819.4 6062.4 6108.6 6110.5 6136.3 5206.6 5586.0 5605.5 5610.5 5629.3 6222.3 6273.0 6377.2 6494.2 6522.1 5158.3 6319.4 6321.5 6331.0 6348.8 6521.0 6549.3 6584.7 6592.6 6600.4 6104.0 6234.7 6286.0 6299.9 6317.2 6209.4 6258.2 6324.9 6332.9 6393.3 6198.2 6217.0 6222.6 6264.4 6271.0 6087.6 6126.0 6155.0 6201.2 6242.7 5342.7 5602.0 5716.2 6155.6 6189.8 6249.0 6276.6 6296.7 6303.8 6318.0 6017.5 6044.0 6057.3 6124.5 6202.7 05:06:22 INFO - PROCESS | 6879 | 05:06:22 INFO - PROCESS | 6879 | [#1] ext.html Cycles:180 Average:46189.08 Median:28865.92 stddev:92591.79 (320.8%) stddev-sans-first:92788.53 05:06:22 INFO - PROCESS | 6879 | Values: 693.7 771.9 799.6 831.7 936.5 28853.0 38223.0 39595.4 39679.8 39747.4 30885.0 37606.6 37682.6 37958.7 38072.6 7612.2 7771.5 10361.5 10657.7 10744.1 10461.1 10554.9 10572.7 10574.4 10591.6 9888.3 10533.1 10549.6 10575.7 10620.5 10488.5 10512.3 10548.7 10552.3 10562.8 10333.4 10343.2 10416.7 10418.2 10429.8 32803.5 33114.3 33114.7 33130.3 33173.5 3421.5 3745.2 3774.7 3792.9 3822.8 23771.3 23922.3 25090.0 25491.2 26013.2 2565.4 2573.2 2977.8 3170.0 3181.0 354968.0 359815.0 359833.0 359882.0 360816.0 44056.3 44073.3 44157.9 44223.1 44257.0 45765.5 46001.8 46140.3 46172.0 46249.0 13054.0 13076.7 13158.7 13158.9 13172.3 11213.6 11216.8 11219.3 11225.5 11237.2 9863.4 11707.1 11755.9 11826.0 11906.2 4949.0 5337.9 5540.0 5577.9 5613.2 1090.8 1116.9 1121.8 1126.3 1126.4 25574.0 25625.7 25921.8 26431.5 26476.0 1090.9 1135.3 1207.8 1216.0 1262.9 12191.6 13459.4 13646.2 13689.3 13715.9 152131.0 152207.0 152233.0 152458.0 152835.2 55940.9 56015.7 56172.7 56174.7 56577.6 1331.3 1346.6 1368.3 1387.2 1392.1 22842.3 25654.9 26030.2 26726.9 27046.9 39746.8 39781.8 39798.2 39958.0 40007.0 456275.0 457123.0 457347.0 457453.0 460424.0 28461.0 28597.0 28878.8 28946.1 29076.0 36025.5 36432.3 37204.4 37504.9 37522.6 30877.1 30990.7 31435.0 31808.4 31870.5 29990.7 30547.4 30551.2 31264.5 31755.0 22918.7 30778.8 31269.7 31508.4 31850.0 22525.0 25016.0 28033.4 28707.9 29019.4 22528.5 22869.3 23002.3 23167.0 23206.0 05:06:22 INFO - PROCESS | 6879 | 05:06:22 INFO - PROCESS | 6879 | [#2] jquery.html Cycles:180 Average:39987.39 Median:26034.98 stddev:115261.90 (442.7%) stddev-sans-first:115546.79 05:06:22 INFO - PROCESS | 6879 | Values: 337.5 400.4 414.1 430.0 443.3 18608.5 20375.6 20457.4 21126.7 21218.0 21308.5 21343.0 21418.5 22077.9 22262.4 6609.8 6935.4 6963.6 6973.0 6979.2 5271.6 6068.8 6758.9 6772.2 6857.1 5966.9 6498.6 6735.8 6770.5 6792.7 5541.1 6564.8 6746.2 6762.9 6773.5 4696.5 6472.7 6567.7 6589.4 6597.6 25922.5 25994.0 26022.9 26047.1 26313.0 2948.6 3340.9 3350.9 3434.7 3441.7 15952.5 16108.4 16245.8 16598.5 16958.7 1998.8 2003.1 2068.2 2072.2 2074.9 125022.0 129186.0 129619.0 130787.0 132313.0 17535.9 20789.9 21698.4 21943.2 22157.9 33019.7 33627.5 33844.5 33875.5 34018.3 9495.6 9614.9 9780.3 9874.2 9937.7 7733.8 7739.6 7744.9 7904.9 7921.0 8960.1 10185.7 10195.7 10330.0 10355.0 3470.9 3736.9 4000.4 4169.8 4203.5 862.8 867.8 879.9 887.9 906.9 21640.7 22063.4 22656.5 22851.3 23081.7 813.7 896.2 933.9 940.3 959.5 8155.7 11697.2 11828.8 11840.3 11862.5 589123.1 710918.0 712274.0 718051.0 738270.0 111451.0 113085.0 122583.0 124592.8 127981.0 1184.8 1252.7 1278.8 1283.4 1284.9 19498.9 19621.0 19924.5 19967.9 20036.2 58332.7 63714.7 64141.7 64895.0 65788.7 89600.0 89711.6 89840.0 90083.5 90201.1 7398.2 10110.0 10843.6 11250.2 11909.9 12567.6 12845.7 13096.8 13104.7 13250.3 9025.6 11083.9 11138.6 11148.0 11314.3 8812.9 9392.0 9561.1 10781.7 10942.2 11309.5 11510.3 11566.1 11585.4 11624.0 11352.3 11414.8 11653.2 11710.0 11714.4 11057.7 11102.5 11225.0 11240.7 11310.6 05:06:22 INFO - PROCESS | 6879 | 05:06:22 INFO - PROCESS | 6879 | [#3] mootools.html Cycles:180 Average:6422.87 Median:3616.58 stddev:3924.55 (108.5%) stddev-sans-first:3917.71 05:06:22 INFO - PROCESS | 6879 | Values: 1441.4 1568.6 1578.2 1597.6 1604.1 10364.1 10507.4 10813.1 11021.2 11054.6 10833.6 10989.6 11002.5 11036.9 11038.4 2347.3 2383.5 2385.3 2392.8 2394.1 2330.8 2334.3 2369.1 2376.8 2381.0 2331.6 2357.9 2361.5 2367.9 2376.5 2321.7 2332.1 2341.1 2345.6 2347.9 2309.1 2338.1 2346.1 2358.9 2363.5 10643.0 10852.1 10853.3 10892.4 10900.6 5707.8 5809.8 5878.0 5880.4 5892.7 3490.8 3607.8 3611.0 3616.9 3620.2 1130.7 1159.4 1176.2 1203.7 1208.1 13460.9 13695.5 14626.1 15006.7 15156.0 3915.3 4484.3 4530.4 4680.0 4682.7 11351.0 11380.8 11391.9 11432.7 11451.0 5653.7 5696.0 5737.9 5745.2 5755.3 5149.3 5192.3 5198.9 5262.8 5292.1 3805.4 3846.7 3874.5 3906.3 3925.3 1039.2 1040.5 1044.4 1057.2 1058.9 903.5 930.5 944.3 948.4 974.0 4820.2 5555.9 6526.9 6559.9 6651.4 957.8 983.7 988.5 990.6 1001.3 3402.2 3616.2 4103.4 4132.9 4196.2 12327.4 13060.5 13407.9 13438.7 13454.8 11201.4 11624.4 12930.5 13336.1 13383.1 8574.4 8613.7 9403.6 9971.4 9999.5 5017.0 5321.1 5867.4 6294.2 6351.0 9721.3 9815.5 9851.0 9896.8 9999.2 10388.1 10427.0 10576.4 10579.1 10752.3 9032.6 9110.4 9147.4 9180.2 9215.3 10087.2 10125.3 10161.3 10184.7 10188.2 7456.3 7653.3 8932.2 8962.6 8997.1 8334.2 8366.1 8391.6 8422.3 8433.0 7688.0 7818.8 7834.6 7841.4 7847.3 5730.3 5776.4 5888.1 5966.7 5969.9 5743.7 5851.4 5907.9 6009.6 6081.5 05:06:22 INFO - PROCESS | 6879 | 05:06:22 INFO - PROCESS | 6879 | [#4] prototype.html Cycles:180 Average:4595.17 Median:4883.07 stddev:1298.74 (26.6%) stddev-sans-first:1261.70 05:06:22 INFO - PROCESS | 6879 | Values: 298.2 336.2 379.9 383.6 387.6 4356.3 5268.4 5271.5 5298.4 5299.5 4670.0 4737.3 4790.4 4963.1 5206.7 4242.8 4247.5 4262.4 4278.0 4294.4 3825.9 3885.9 4254.5 4281.8 4289.3 4297.9 4301.7 4325.5 4328.7 4341.5 3612.5 3831.8 3963.4 4181.6 4273.4 3718.9 3915.6 3936.7 3941.8 3964.5 4087.4 5100.2 5101.3 5106.2 5127.6 4575.7 4618.2 4661.0 4878.8 5012.6 4614.7 5260.4 5460.9 5607.7 5613.2 4359.8 4435.8 4437.7 4442.6 4448.3 5727.8 5808.5 5870.0 5895.3 5978.0 4226.0 4284.9 4527.6 4605.1 4615.6 4042.5 4605.6 4618.9 4681.5 4686.9 4388.6 4449.7 4558.8 4694.7 4718.1 5162.5 5293.8 5357.2 5398.4 5498.9 1415.0 1478.7 1527.7 1560.5 1591.3 995.7 1026.5 1115.4 1135.5 1146.4 4624.3 4732.7 4816.6 5210.7 5262.8 5223.1 5283.7 5430.9 5818.7 5820.6 4328.9 4440.6 4477.1 4898.3 5220.7 2662.5 2723.1 2737.3 2969.9 3063.0 5461.6 5476.5 5850.5 6021.2 6049.9 5386.9 5675.8 5754.9 5887.4 5896.5 5853.7 5857.9 5957.9 6017.6 6027.4 4988.7 4995.5 5128.9 5190.6 5795.6 4750.4 4911.0 5289.6 5629.8 5681.9 5416.2 5864.2 5959.1 5983.7 6006.8 3724.0 4157.3 4583.7 4586.6 4605.4 4754.0 5563.0 5682.4 5700.4 5769.4 4604.6 4789.4 5572.5 5589.9 5644.4 4887.3 5266.8 5423.8 5520.2 5619.4 4742.3 5113.5 5125.9 5428.9 5463.7 5043.8 5099.1 5250.8 5559.2 5666.5 4867.4 5037.0 5112.4 5484.8 5494.9 05:06:22 INFO - PROCESS | 6879 | 05:06:22 INFO - PROCESS | 6879 | [#5] yui.html Cycles:180 Average:19023.04 Median:3758.34 stddev:26955.98 (717.2%) stddev-sans-first:26996.49 05:06:22 INFO - PROCESS | 6879 | Values: 700.7 706.4 769.9 825.8 834.4 14534.3 15193.8 15712.3 15766.5 15775.2 15152.0 15346.2 15347.5 15356.5 15454.7 910.7 924.3 938.9 939.7 940.0 887.4 926.3 932.6 944.2 944.7 981.9 982.3 982.9 986.0 986.1 834.3 975.5 981.6 981.8 984.4 719.5 727.1 727.9 729.0 729.4 14843.5 15116.5 15155.6 15267.6 15502.8 12846.7 13631.3 13636.3 14237.8 14375.9 10565.2 10823.4 10955.5 11156.5 11479.6 3623.4 3671.2 3682.9 3723.6 3793.1 95071.5 108281.0 108500.0 110377.0 111148.4 10562.9 10597.0 10637.5 11102.0 11130.4 22178.1 22244.3 22312.4 22332.0 22358.7 6434.9 7421.5 7429.9 7563.0 7574.7 4015.8 4124.6 4133.1 4148.3 4185.1 3269.7 3320.0 3342.7 3369.7 3370.6 495.5 558.7 577.4 581.8 594.9 648.6 682.5 690.5 691.7 715.5 9120.4 9472.7 9849.3 10306.3 10321.4 627.9 660.8 694.4 695.3 723.9 4714.7 4864.8 4879.9 4895.5 4905.5 81683.5 102782.0 103083.5 104028.0 104109.0 59467.8 62467.8 70255.0 75252.9 92852.5 62571.7 62598.4 63593.0 63924.0 66360.3 10705.0 10910.0 10913.8 11053.4 11079.8 40250.5 44246.0 49243.0 50193.5 51990.0 53076.5 53144.0 53258.2 55362.7 60098.8 12029.4 12128.9 12467.4 12512.2 12950.2 13517.9 13562.3 13656.4 13955.1 14062.2 12941.9 12985.4 13254.1 13435.5 13451.6 11054.0 13170.0 13445.7 13602.3 14148.6 12892.6 12895.7 12983.5 13105.3 13885.2 8224.9 10606.9 10800.8 10934.6 11281.2 8652.0 9118.9 10104.7 10861.8 11242.6 05:06:22 INFO - PROCESS | 6879 | -------- Summary: end -------- 05:06:22 INFO - PROCESS | 6879 | 05:06:22 INFO - TEST-INFO | 6879: exit 0 05:06:22 INFO - TEST-OK | dromaeo_css | took 1117620ms 05:06:22 INFO - TEST-START | kraken 05:06:22 INFO - operating with platform_type : mac_ 05:06:22 INFO - Initialising browser for kraken test... 05:06:22 INFO - TEST-INFO | started process 6882 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/tmpXVPGg3/profile http://localhost:57432/getInfo.html) 05:06:25 INFO - PROCESS | 6882 | 2017-03-08 05:06:25.734 plugin-container[6884:124782] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8937, name = 'com.apple.tsm.portname' 05:06:25 INFO - PROCESS | 6882 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:06:25 INFO - PROCESS | 6882 | 2017-03-08 05:06:25.735 plugin-container[6884:124782] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x460f, name = 'com.apple.CFPasteboardClient' 05:06:25 INFO - PROCESS | 6882 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:06:25 INFO - PROCESS | 6882 | 2017-03-08 05:06:25.735 plugin-container[6884:124782] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:06:25 INFO - PROCESS | 6882 | __metrics Screen width/height:1600/1200 05:06:25 INFO - PROCESS | 6882 | colorDepth:24 05:06:25 INFO - PROCESS | 6882 | Browser inner width/height: 1024/689 05:06:25 INFO - PROCESS | 6882 | __metrics 05:06:25 ERROR - PROCESS | 6882 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 05:06:26 INFO - TEST-INFO | 6882: exit 0 05:06:26 INFO - Browser initialized. 05:06:26 INFO - Running cycle 1/1 for kraken test... 05:06:26 INFO - TEST-INFO | started process 6885 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/tmpXVPGg3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:28 INFO - PROCESS | 6885 | 2017-03-08 05:06:28.977 plugin-container[6886:124906] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3f, name = 'com.apple.tsm.portname' 05:06:28 INFO - PROCESS | 6885 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:06:28 INFO - PROCESS | 6885 | 2017-03-08 05:06:28.978 plugin-container[6886:124906] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a43, name = 'com.apple.CFPasteboardClient' 05:06:28 INFO - PROCESS | 6885 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:06:28 INFO - PROCESS | 6885 | 2017-03-08 05:06:28.978 plugin-container[6886:124906] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:06:38 INFO - PROCESS | 6885 | RSS: Main: 227098624 05:06:38 INFO - PROCESS | 6885 | 05:06:41 INFO - PROCESS | 6885 | Cycle 1(1): loaded http://localhost:57432/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57432/tests/kraken/driver.html?testName=audio-beat-detection) 05:06:42 INFO - PROCESS | 6885 | RSS: Main: 240939008 05:06:42 INFO - PROCESS | 6885 | 05:06:45 INFO - PROCESS | 6885 | Cycle 1(1): loaded http://localhost:57432/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57432/tests/kraken/driver.html?testName=audio-dft) 05:06:46 INFO - PROCESS | 6885 | RSS: Main: 249401344 05:06:46 INFO - PROCESS | 6885 | 05:06:49 INFO - PROCESS | 6885 | Cycle 1(1): loaded http://localhost:57432/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57432/tests/kraken/driver.html?testName=audio-fft) 05:06:50 INFO - PROCESS | 6885 | RSS: Main: 252071936 05:06:50 INFO - PROCESS | 6885 | 05:06:52 INFO - PROCESS | 6885 | Cycle 1(1): loaded http://localhost:57432/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57432/tests/kraken/driver.html?testName=audio-oscillator) 05:06:53 INFO - PROCESS | 6885 | RSS: Main: 253341696 05:06:53 INFO - PROCESS | 6885 | 05:06:55 INFO - PROCESS | 6885 | Cycle 1(1): loaded http://localhost:57432/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57432/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:06:55 INFO - PROCESS | 6885 | RSS: Main: 255021056 05:06:55 INFO - PROCESS | 6885 | 05:06:59 INFO - PROCESS | 6885 | Cycle 1(1): loaded http://localhost:57432/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57432/tests/kraken/driver.html?testName=imaging-darkroom) 05:06:59 INFO - PROCESS | 6885 | RSS: Main: 260849664 05:06:59 INFO - PROCESS | 6885 | 05:07:03 INFO - PROCESS | 6885 | Cycle 1(1): loaded http://localhost:57432/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57432/tests/kraken/driver.html?testName=imaging-desaturate) 05:07:03 INFO - PROCESS | 6885 | RSS: Main: 258502656 05:07:03 INFO - PROCESS | 6885 | 05:07:07 INFO - PROCESS | 6885 | Cycle 1(1): loaded http://localhost:57432/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57432/tests/kraken/driver.html?testName=json-parse-financial) 05:07:07 INFO - PROCESS | 6885 | RSS: Main: 259629056 05:07:07 INFO - PROCESS | 6885 | 05:07:09 INFO - PROCESS | 6885 | Cycle 1(1): loaded http://localhost:57432/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57432/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:07:10 INFO - PROCESS | 6885 | RSS: Main: 260046848 05:07:10 INFO - PROCESS | 6885 | 05:07:12 INFO - PROCESS | 6885 | Cycle 1(1): loaded http://localhost:57432/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57432/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:07:13 INFO - PROCESS | 6885 | RSS: Main: 260009984 05:07:13 INFO - PROCESS | 6885 | 05:07:15 INFO - PROCESS | 6885 | Cycle 1(1): loaded http://localhost:57432/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57432/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:07:16 INFO - PROCESS | 6885 | RSS: Main: 260169728 05:07:16 INFO - PROCESS | 6885 | 05:07:19 INFO - PROCESS | 6885 | Cycle 1(1): loaded http://localhost:57432/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57432/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:07:19 INFO - PROCESS | 6885 | RSS: Main: 260509696 05:07:19 INFO - PROCESS | 6885 | 05:07:23 INFO - PROCESS | 6885 | Cycle 1(1): loaded http://localhost:57432/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57432/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:07:23 INFO - PROCESS | 6885 | RSS: Main: 260435968 05:07:23 INFO - PROCESS | 6885 | 05:07:25 INFO - PROCESS | 6885 | Cycle 1(1): loaded http://localhost:57432/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57432/tests/kraken/driver.html?testName=ai-astar) 05:07:25 INFO - PROCESS | 6885 | RSS: Main: 263782400 05:07:25 INFO - PROCESS | 6885 | 05:07:25 INFO - PROCESS | 6885 | __start_tp_report 05:07:25 INFO - PROCESS | 6885 | _x_x_mozilla_page_load 05:07:25 INFO - PROCESS | 6885 | _x_x_mozilla_page_load_details 05:07:25 INFO - PROCESS | 6885 | |i|pagename|runs| 05:07:25 INFO - PROCESS | 6885 | |0;ai-astar;157;174;123;134;175;154;119;119;122;123 05:07:25 INFO - PROCESS | 6885 | |1;audio-beat-detection;147;114;115;178;117;115;111;126;135;114 05:07:25 INFO - PROCESS | 6885 | |2;audio-dft;200;212;251;246;278;289;202;198;227;281 05:07:25 INFO - PROCESS | 6885 | |3;audio-fft;86;59;62;89;62;64;63;64;78;63 05:07:25 INFO - PROCESS | 6885 | |4;audio-oscillator;91;88;86;72;72;73;87;86;73;84 05:07:25 INFO - PROCESS | 6885 | |5;imaging-gaussian-blur;92;89;109;125;128;92;129;121;91;93 05:07:25 INFO - PROCESS | 6885 | |6;imaging-darkroom;151;127;98;100;131;156;100;106;155;99 05:07:25 INFO - PROCESS | 6885 | |7;imaging-desaturate;91;92;142;144;91;97;94;92;92;92 05:07:25 INFO - PROCESS | 6885 | |8;json-parse-financial;67;67;66;78;98;101;103;105;75;68 05:07:25 INFO - PROCESS | 6885 | |9;json-stringify-tinderbox;69;81;95;105;58;70;83;86;51;71 05:07:25 INFO - PROCESS | 6885 | |10;stanford-crypto-aes;87;79;101;79;111;108;112;91;94;87 05:07:25 INFO - PROCESS | 6885 | |11;stanford-crypto-ccm;161;157;152;141;147;145;145;145;209;173 05:07:25 INFO - PROCESS | 6885 | |12;stanford-crypto-pbkdf2;161;257;238;231;176;177;177;179;181;186 05:07:25 INFO - PROCESS | 6885 | |13;stanford-crypto-sha256-iterative;68;72;86;88;93;61;83;90;71;86 05:07:25 INFO - PROCESS | 6885 | __end_tp_report 05:07:25 INFO - PROCESS | 6885 | __start_cc_report 05:07:25 INFO - PROCESS | 6885 | _x_x_mozilla_cycle_collect,992 05:07:25 INFO - PROCESS | 6885 | __end_cc_report 05:07:25 INFO - PROCESS | 6885 | __startTimestamp1488978445854__endTimestamp 05:07:25 INFO - PROCESS | 6885 | 05:07:25 INFO - PROCESS | 6885 | ------- Summary: start ------- 05:07:25 INFO - PROCESS | 6885 | Number of tests: 14 05:07:25 INFO - PROCESS | 6885 | 05:07:25 INFO - PROCESS | 6885 | [#0] ai-astar Cycles:10 Average:140.00 Median:144.00 stddev:22.82 (15.8%) stddev-sans-first:23.36 05:07:25 INFO - PROCESS | 6885 | Values: 157.0 174.0 123.0 134.0 175.0 154.0 119.0 119.0 122.0 123.0 05:07:25 INFO - PROCESS | 6885 | 05:07:25 INFO - PROCESS | 6885 | [#1] audio-beat-detection Cycles:10 Average:127.20 Median:121.50 stddev:21.21 (17.5%) stddev-sans-first:21.25 05:07:25 INFO - PROCESS | 6885 | Values: 147.0 114.0 115.0 178.0 117.0 115.0 111.0 126.0 135.0 114.0 05:07:25 INFO - PROCESS | 6885 | 05:07:25 INFO - PROCESS | 6885 | [#2] audio-dft Cycles:10 Average:238.40 Median:248.50 stddev:35.62 (14.3%) stddev-sans-first:34.96 05:07:25 INFO - PROCESS | 6885 | Values: 200.0 212.0 251.0 246.0 278.0 289.0 202.0 198.0 227.0 281.0 05:07:25 INFO - PROCESS | 6885 | 05:07:25 INFO - PROCESS | 6885 | [#3] audio-fft Cycles:10 Average:69.00 Median:64.00 stddev:11.01 (17.2%) stddev-sans-first:9.80 05:07:25 INFO - PROCESS | 6885 | Values: 86.0 59.0 62.0 89.0 62.0 64.0 63.0 64.0 78.0 63.0 05:07:25 INFO - PROCESS | 6885 | 05:07:25 INFO - PROCESS | 6885 | [#4] audio-oscillator Cycles:10 Average:81.20 Median:86.00 stddev:7.70 (9.0%) stddev-sans-first:7.30 05:07:25 INFO - PROCESS | 6885 | Values: 91.0 88.0 86.0 72.0 72.0 73.0 87.0 86.0 73.0 84.0 05:07:25 INFO - PROCESS | 6885 | 05:07:25 INFO - PROCESS | 6885 | [#5] imaging-gaussian-blur Cycles:10 Average:106.90 Median:90.00 stddev:17.24 (19.2%) stddev-sans-first:17.42 05:07:25 INFO - PROCESS | 6885 | Values: 92.0 89.0 109.0 125.0 128.0 92.0 129.0 121.0 91.0 93.0 05:07:25 INFO - PROCESS | 6885 | 05:07:25 INFO - PROCESS | 6885 | [#6] imaging-darkroom Cycles:10 Average:122.30 Median:153.00 stddev:24.77 (16.2%) stddev-sans-first:23.99 05:07:25 INFO - PROCESS | 6885 | Values: 151.0 127.0 98.0 100.0 131.0 156.0 100.0 106.0 155.0 99.0 05:07:25 INFO - PROCESS | 6885 | 05:07:25 INFO - PROCESS | 6885 | [#7] imaging-desaturate Cycles:10 Average:102.70 Median:92.00 stddev:21.32 (23.2%) stddev-sans-first:22.19 05:07:25 INFO - PROCESS | 6885 | Values: 91.0 92.0 142.0 144.0 91.0 97.0 94.0 92.0 92.0 92.0 05:07:25 INFO - PROCESS | 6885 | 05:07:25 INFO - PROCESS | 6885 | [#8] json-parse-financial Cycles:10 Average:82.80 Median:67.50 stddev:16.82 (24.9%) stddev-sans-first:16.85 05:07:25 INFO - PROCESS | 6885 | Values: 67.0 67.0 66.0 78.0 98.0 101.0 103.0 105.0 75.0 68.0 05:07:25 INFO - PROCESS | 6885 | 05:07:25 INFO - PROCESS | 6885 | [#9] json-stringify-tinderbox Cycles:10 Average:76.90 Median:76.00 stddev:16.42 (21.6%) stddev-sans-first:17.17 05:07:25 INFO - PROCESS | 6885 | Values: 69.0 81.0 95.0 105.0 58.0 70.0 83.0 86.0 51.0 71.0 05:07:25 INFO - PROCESS | 6885 | 05:07:25 INFO - PROCESS | 6885 | [#10] stanford-crypto-aes Cycles:10 Average:94.90 Median:83.00 stddev:12.50 (15.1%) stddev-sans-first:12.93 05:07:25 INFO - PROCESS | 6885 | Values: 87.0 79.0 101.0 79.0 111.0 108.0 112.0 91.0 94.0 87.0 05:07:25 INFO - PROCESS | 6885 | 05:07:25 INFO - PROCESS | 6885 | [#11] stanford-crypto-ccm Cycles:10 Average:157.50 Median:154.50 stddev:20.51 (13.3%) stddev-sans-first:21.72 05:07:25 INFO - PROCESS | 6885 | Values: 161.0 157.0 152.0 141.0 147.0 145.0 145.0 145.0 209.0 173.0 05:07:25 INFO - PROCESS | 6885 | 05:07:25 INFO - PROCESS | 6885 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.30 Median:183.50 stddev:32.78 (17.9%) stddev-sans-first:32.18 05:07:25 INFO - PROCESS | 6885 | Values: 161.0 257.0 238.0 231.0 176.0 177.0 177.0 179.0 181.0 186.0 05:07:25 INFO - PROCESS | 6885 | 05:07:25 INFO - PROCESS | 6885 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.80 Median:86.00 stddev:10.87 (12.6%) stddev-sans-first:10.66 05:07:25 INFO - PROCESS | 6885 | Values: 68.0 72.0 86.0 88.0 93.0 61.0 83.0 90.0 71.0 86.0 05:07:25 INFO - PROCESS | 6885 | -------- Summary: end -------- 05:07:25 INFO - PROCESS | 6885 | 05:07:26 INFO - TEST-INFO | 6885: exit 0 05:07:26 INFO - TEST-OK | kraken | took 63924ms 05:07:26 INFO - SUITE-END | took 1181s 05:07:27 INFO - Completed test suite (00:19:41) 05:07:27 INFO - javascript benchmark 05:07:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7465.225743759977, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3391.796492210466, 3395.881144159954, 3397.7621566490357, 3417.248205394813, 3437.879674211403, 5841.474267315941, 5857.970710146448, 5941.257342832146, 5954.672493012882, 5967.075103358976, 5637.295338082739, 5768.625039372438, 5847.093700476433, 5885.970570147143, 5889.882202355961, 5266.157414813631, 5301.6818990860675, 5323.60072994525, 5338.27933229013, 5357.330333708286, 5274.2879711238875, 5374.301340825707, 5416.647917885344, 5441.319835020622, 5444.237806707064, 4368.650507959355, 5248.842534723926, 5402.540784033342, 5406.405295417501, 5434.2935418395555, 5297.205419187114, 5301.231321458406, 5316.548093412026, 5321.281626980347, 5356.866078348073, 5256.08018596744, 5274.868128296785, 5276.604254680876, 5277.656952298127, 5320.920186197211, 4422.137683151786, 5695.800646977336, 5716.1711551825165, 5858.916100521417, 5971.761129554812, 6193.411625895533, 6213.378662133796, 6243.968780156116, 6256.937430625681, 6267.0, 5221.660592061504, 5722.912646597133, 5955.255593050869, 6353.396427339396, 6355.8411039723915, 5793.102069179284, 6083.6045657032155, 6085.995810691231, 6086.995645718451, 6111.388861113942, 6298.7480500780375, 6352.078948552434, 6380.521460890359, 6395.5203359747275, 6416.230052393649, 6100.823402702991, 6145.432914606747, 6209.161763162006, 6266.0, 6280.434760871543, 6109.34393638171, 6222.62664240147, 6251.437370636664, 6269.686515674198, 6325.05124231369, 6266.279377871512, 6274.0, 6290.528210384239, 6293.213348331458, 6294.905576416358, 6207.131001659771, 6237.345078766755, 6265.154204182468, 6276.623402595859, 6280.874382512324, 5074.0359331727595, 5074.2895994560795, 5104.412992505835, 5118.718470484085, 5183.222516622537, 4555.908881822345, 4568.817247310137, 4574.108048930493, 4588.816447342136, 4622.052479241815, 6108.267007959073, 6113.23584551931, 6124.969375153096, 6127.417895299939, 6137.01807710773, 5200.76596553156, 6142.253225532421, 6236.438720515084, 6261.436470717657, 6335.809925702236, 5819.418058194146, 6062.393760623902, 6108.633481991094, 6110.450059494667, 6136.2636483622255, 5206.557442617344, 5586.0, 5605.495505404533, 5610.523105535994, 5629.2681951346885, 6222.315545289924, 6272.968635156795, 6377.170967774346, 6494.188226471691, 6522.119513865662, 5158.277841102324, 6319.368063193644, 6321.52588555851, 6330.968345158245, 6348.777792777415, 6521.02184672303, 6549.312322206099, 6584.736610535525, 6592.637404942582, 6600.372964568358, 6103.974138059404, 6234.719437625227, 6286.0, 6299.874002520016, 6317.241930968313, 6209.410106039919, 6258.217722784652, 6324.873502529832, 6332.936670633235, 6393.2967373587935, 6198.2252218472695, 6216.968915155395, 6222.595531290452, 6264.404881536247, 6270.968645156745, 6087.604305720114, 6126.0, 6155.0, 6201.193844800147, 6242.687865606611, 5342.706151161723, 5602.0196465619165, 5716.199732037601, 6155.630662160284, 6189.84525386869, 6249.0, 6276.623402595859, 6296.748130074929, 6303.842403939755, 6317.989121740499, 6017.548683848817, 6043.969780151071, 6057.333693293822, 6124.54065945047, 6202.72087756043], "value": 5786.273405210564, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.7433149734599, 771.8919351290818, 799.5642374905677, 831.7005877883964, 936.5317341329335, 28853.0, 38223.0, 39595.40606890892, 39679.80160099195, 39747.40378894312, 30885.0, 37606.62393376065, 37682.623173768254, 37958.67144649938, 38072.61927380726, 7612.162662107164, 7771.533707977511, 10361.533730982086, 10657.733556661107, 10744.14046876248, 10461.058504734572, 10554.894451055507, 10572.735681607945, 10574.365538067703, 10591.576336946513, 9888.307818452711, 10533.104686101653, 10549.6307629233, 10575.682729518127, 10620.522076506537, 10488.528016239288, 10512.264141510097, 10548.683539493828, 10552.261341706084, 10562.788744225072, 10333.431661258628, 10343.224258180666, 10416.687499375032, 10418.21863360251, 10429.791404171874, 32803.50794738081, 33114.3377132456, 33114.6688533114, 33130.337393252, 33173.50239746406, 3421.4525675891737, 3745.213505163919, 3774.698024158061, 3792.867249646249, 3822.770633761955, 23771.28686139401, 23922.28233153008, 25090.0, 25491.23526294214, 26013.21960341193, 2565.3843077661227, 2573.240893936293, 2977.8213307201636, 3169.952450713241, 3181.0297859152947, 354968.0, 359815.0, 359833.0, 359882.0, 360816.0, 44056.339154912064, 44073.338899916525, 44157.89605259894, 44223.11553768907, 44257.0, 45765.50813902353, 46001.7699911505, 46140.30789538159, 46172.0, 46249.0, 13054.0, 13076.738465230832, 13158.73682526344, 13158.868411315956, 13172.341382930816, 11213.55145794159, 11216.775664486664, 11219.326840389604, 11225.494852731646, 11237.157213209042, 9863.358881672668, 11707.121965852595, 11755.941220294015, 11826.0, 11906.226095303777, 4949.0, 5337.866553336197, 5540.030494663418, 5577.888442231214, 5613.242212301368, 1090.7818436312768, 1116.938568378747, 1121.8485504456958, 1126.2679258482053, 1126.3973774030853, 25574.0, 25625.743742562336, 25921.83351749176, 26431.471370572865, 26476.0, 1090.907272881814, 1135.2790977729037, 1207.8007128823647, 1215.975680486403, 1262.8863402293837, 12191.573294934813, 13459.394327255297, 13646.24945628, 13689.31553422325, 13715.862841371458, 152131.0, 152207.0, 152233.0, 152458.0, 152835.23582382017, 55940.88118237613, 56015.719921400945, 56172.719136404055, 56174.7191264041, 56577.585560360494, 1331.3476396565613, 1346.5960211936576, 1368.2679766324968, 1387.2439520461373, 1392.1090502078678, 22842.31473055811, 25654.871725641253, 26030.219093427226, 26726.866365668047, 27046.864765676044, 39746.80126599464, 39781.80109099436, 39798.20403591854, 39958.0, 40007.0, 456275.0, 457123.0, 457347.0, 457453.0, 460424.0, 28461.00386486546, 28597.0, 28878.844846205917, 28946.131616051553, 29076.0, 36025.45961810627, 36432.27135457223, 37204.44193337048, 37504.87485375334, 37522.62477375301, 30877.0736877894, 30990.69009309878, 31435.0, 31808.36383272368, 31870.45036397129, 29990.700092999665, 30547.389052218386, 30551.2362190947, 31264.531032034083, 31755.04734857958, 22918.656220157045, 30778.76884924578, 31269.687303126677, 31508.36983260368, 31850.0, 22525.0, 25016.0, 28033.43933121367, 28707.85646071756, 29019.419611607227, 22528.549429011655, 22869.313920582408, 23002.309930702108, 23167.0, 23206.0], "value": 17260.489534352262, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.54431517451457, 400.3634221587675, 414.13032631473897, 429.97420154790717, 443.32835753832927, 18608.534786630305, 20375.592488150247, 20457.386278411635, 21126.683099753496, 21218.0, 21308.4672883178, 21343.039563219652, 21418.464538386546, 22077.889610551923, 22262.443438914037, 6609.83475413115, 6935.375816176543, 6963.617001064939, 6973.0, 6979.232284448732, 5271.604629652772, 6068.846919085359, 6758.898616520756, 6772.187337519505, 6857.142857142857, 5966.8806623867495, 6498.610083395011, 6735.797926062226, 6770.458363330922, 6792.728290868384, 5541.113421852504, 6564.80305590833, 6746.156730408699, 6762.93237067628, 6773.45812335012, 4696.459907110692, 6472.6763661817195, 6567.704453299613, 6589.406953374171, 6597.63712995785, 25922.481550369077, 25994.0, 26022.86988565064, 26047.088351907783, 26313.0, 2948.5871977923107, 3340.8997730068136, 3350.949735753966, 3434.7252219822353, 3441.6558344165633, 15952.521424357172, 16108.355665773355, 16245.756313655187, 16598.502044938552, 16958.745618815727, 1998.8400927925732, 2003.1386503803358, 2068.162394230339, 2072.1814883121083, 2074.9481262968397, 125022.0, 129186.0, 129619.0, 130787.0, 132312.99999999904, 17535.947843129452, 20789.896050519954, 21698.372622053408, 21943.231986880382, 22157.889210553843, 33019.66980330166, 33627.495587566205, 33844.49233261503, 33875.491867622004, 34018.31963360719, 9495.57269922855, 9614.90385096154, 9780.31537792362, 9874.210063194927, 9937.708097947365, 7733.7679869604, 7739.613019349123, 7744.922550774533, 7904.881426778603, 7921.049474063149, 8960.05919378469, 10185.74535636615, 10195.745106372251, 10330.0, 10355.0, 3470.930581388358, 3736.9439458408146, 4000.3799411091327, 4169.791510424467, 4203.453551038407, 862.7756783236404, 867.7873920889423, 879.8812160358269, 887.8756974023642, 906.8730377747121, 21640.675389869164, 22063.448413789785, 22656.546869062528, 22851.31446056621, 23081.65377519305, 813.7151996801191, 896.171041786345, 933.9159475647224, 940.3276657190141, 959.5058544849409, 8155.67377304913, 11697.23967942081, 11828.76342473163, 11840.348780816965, 11862.466189021514, 589123.0543847339, 710918.0, 712274.0, 718051.0, 738270.0, 111451.0, 113085.0, 122583.0, 124592.75407245812, 127981.0, 1184.798584240681, 1252.7369252457086, 1278.8465384153776, 1283.4481173095658, 1284.9421776020101, 19498.902505487382, 19621.018949052777, 19924.50188745293, 19967.900160499106, 20036.198552057755, 58332.70833645805, 63714.68142659443, 64141.717165657356, 64895.0, 65788.67105664441, 89600.0, 89711.55144224237, 89840.0, 90083.54958225167, 90201.09798901927, 7398.186199517941, 10110.0, 10843.566257349617, 11250.212485125963, 11909.880901191224, 12567.560135395217, 12845.678858028625, 13096.803547946598, 13104.737905242033, 13250.271235082164, 9025.638974440948, 11083.949469348196, 11138.554457821596, 11148.0, 11314.264572802742, 8812.867806982773, 9392.013838547127, 9561.139497445263, 10781.676549703208, 10942.17933654963, 11309.547618095514, 11510.251833631122, 11566.07471402269, 11585.420728963687, 11624.011958983581, 11352.262102963281, 11414.771704566028, 11653.242539234923, 11710.00464960488, 11714.355710436008, 11057.668269951915, 11102.500387482422, 11224.989750922456, 11240.718982025515, 11310.60412885545], "value": 11294.729665516497, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1441.3802065112002, 1568.5686436230042, 1578.155686707611, 1597.6499857620306, 1604.0856711674344, 10364.067233948943, 10507.369557826536, 10813.08088812452, 11021.228514004022, 11054.557817687282, 10833.566657333717, 10989.560417583307, 11002.50488728007, 11036.944815275912, 11038.392888391136, 2347.319277409549, 2383.5471260460545, 2385.296337580418, 2392.7726865947707, 2394.0782798622567, 2330.8368414211013, 2334.2880421471446, 2369.07606033647, 2376.7504412036747, 2380.95238095238, 2331.603627383349, 2357.917472888449, 2361.480474295652, 2367.857928524294, 2376.512814872947, 2321.7097862767155, 2332.102140675835, 2341.1103780563362, 2345.64815277708, 2347.9295621131223, 2309.1340747219792, 2338.1232037985756, 2346.1084787780533, 2358.929232123039, 2363.5036642305136, 10643.0, 10852.131829453625, 10853.294535855222, 10892.40091794951, 10900.618478353219, 5707.800226992077, 5809.82570522885, 5877.970610146922, 5880.441358070976, 5892.675902825343, 3490.7556471047037, 3607.7835329880027, 3610.9638903611153, 3616.9276614467826, 3620.1673615068416, 1130.655150179195, 1159.3855256713955, 1176.1766763265748, 1203.6870413692502, 1208.09996552568, 13460.865391346058, 13695.452181912711, 14626.122432654181, 15006.699866002618, 15156.0, 3915.275674000319, 4484.349769283435, 4530.391710942634, 4680.0, 4682.695624784378, 11351.035162011322, 11380.829287560693, 11391.943040284912, 11432.657020289405, 11450.996075686722, 5653.660780353192, 5696.0, 5737.8565535861935, 5745.1669507921115, 5755.309362876482, 5149.253358263031, 5192.324997750268, 5198.948010519846, 5262.842114736564, 5292.126799078109, 3805.4291856221234, 3846.6922646188236, 3874.4769456123627, 3906.316394630985, 3925.293447179535, 1039.1946241662772, 1040.5161599856103, 1044.4255659387306, 1057.1912486947492, 1058.8782290036745, 903.5391950105362, 930.5207817973749, 944.3106532231509, 948.3977674176947, 973.9513024348896, 4820.180569303227, 5555.944440555623, 6526.934730652728, 6559.884819580683, 6651.401373876374, 957.7749228931195, 983.6557204978201, 988.4629401281077, 990.6087095597343, 1001.2640709078821, 3402.234497238151, 3616.222512159846, 4103.384492326175, 4132.876013719593, 4196.223698615766, 12327.445264963098, 13060.477580896848, 13407.932960335136, 13438.731225375634, 13454.798178027337, 11201.439928003567, 11624.360660163773, 12930.482780688855, 13336.133151345131, 13383.063185577112, 8574.442661227125, 8613.741587752378, 9403.57683904226, 9971.351862128939, 9999.500024998866, 5017.0, 5321.09541377959, 5867.354590994902, 6294.150289711014, 6350.968245158745, 9721.270904682036, 9815.460149691835, 9850.950745246228, 9896.752581185528, 9999.150072243941, 10388.11701005423, 10427.0, 10576.41829699374, 10579.10077643409, 10752.333388324821, 9032.593533290887, 9110.36227464071, 9147.359684821999, 9180.17378435944, 9215.262778977532, 10087.193024558164, 10125.341852779546, 10161.288709790539, 10184.675992121272, 10188.184945204513, 7456.32893039629, 7653.272939070779, 8932.240759535252, 8962.596683149144, 8997.100289970951, 8334.249917507454, 8366.121557236402, 8391.58042097905, 8422.326213902996, 8433.030201526657, 7688.038995125609, 7818.804529886798, 7834.647440865288, 7841.372690184886, 7847.332976697045, 5730.341010783646, 5776.422357764358, 5888.116782482491, 5966.731497082728, 5969.850753731192, 5743.712814359349, 5851.356350801323, 5907.881842363215, 6009.609375390585, 6081.452669259611], "value": 4962.871711519193, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.2112312932294, 336.1981673708206, 379.9031247032005, 383.61829979170693, 387.6491774943676, 4356.324769660704, 5268.367795864492, 5271.525562699357, 5298.443663415339, 5299.470052994699, 4669.968563674795, 4737.310063037594, 4790.437116142855, 4963.0570191663555, 5206.661566998152, 4242.830286788525, 4247.469066366704, 4262.352383092407, 4277.978610106945, 4294.355846623016, 3825.9234815303676, 3885.8536731664085, 4254.53200147985, 4281.794875639049, 4289.335153051282, 4297.892552686192, 4301.65586753059, 4325.502567204764, 4328.679752675433, 4341.50072741634, 3612.5303710517596, 3831.7509361891525, 3963.365861462152, 4181.550221067631, 4273.380359847804, 3718.851245950159, 3915.609958464761, 3936.704747143947, 3941.8423263069444, 3964.5044369453817, 4087.386891966199, 5100.163940981281, 5101.336826212606, 5106.208537676666, 5127.641065125443, 4575.679702420832, 4618.175820550897, 4661.0, 4878.8292409765845, 5012.624053195988, 4614.746188959606, 5260.395054568736, 5460.890782184374, 5607.719614019283, 5613.21415001896, 4359.7547263159495, 4435.822567097344, 4437.733735975819, 4442.62237709795, 4448.310511870633, 5727.783277303507, 5808.535317174616, 5870.002099643071, 5895.263092113529, 5977.953858074819, 4226.0, 4284.935725964113, 4527.63778897694, 4605.052766229615, 4615.646020529487, 4042.4744783178585, 4605.631549476034, 4618.884527886829, 4681.461631912373, 4686.859394218179, 4388.5830846069575, 4449.710768800018, 4558.772061396917, 4694.694844835143, 4718.079974404958, 5162.535371816554, 5293.788248470018, 5357.1785592898605, 5398.379186393615, 5498.890022199614, 1414.9529348282197, 1478.6839712655744, 1527.732646786808, 1560.5240401677597, 1591.3236874328363, 995.716220877061, 1026.4508487958906, 1115.4199816095586, 1135.4833550734395, 1146.4439746722999, 4624.260118381043, 4732.692374995683, 4816.590589799836, 5210.713410762369, 5262.842114736564, 5223.056592272886, 5283.682979021271, 5430.886668233003, 5818.665094504621, 5820.563457740686, 4328.935065974013, 4440.555944405533, 4477.074857811107, 4898.314236006961, 5220.660657057279, 2662.534056540098, 2723.128598848389, 2737.343037670945, 2969.866356013941, 3062.9540556891666, 5461.563074953994, 5476.507114359727, 5850.531957443394, 6021.157038014681, 6049.852302432661, 5386.892262154814, 5675.829725108253, 5754.913676294859, 5887.411258874078, 5896.526865686354, 5853.7365818538265, 5857.853553661193, 5957.897788909066, 6017.578769486182, 6027.4492757967455, 4988.655331993957, 4995.525425084611, 5128.871778205575, 5190.558802501679, 5795.594828146272, 4750.358701575243, 4910.975445122752, 5289.57683385336, 5629.831105066854, 5681.89203105407, 5416.241726158262, 5864.211415518308, 5959.096791601508, 5983.670898100646, 6006.759729610767, 3724.0, 4157.295508841361, 4583.702059366264, 4586.564276393738, 4605.447346318329, 4753.954130091374, 5563.0, 5682.4172196851, 5700.377826199994, 5769.365369809234, 4604.562566556172, 4789.44921334051, 5572.545022086332, 5589.916151257653, 5644.435556444323, 4887.315775791321, 5266.762310857022, 5423.772855151179, 5520.199571062254, 5619.353774315842, 4742.336072949859, 5113.49438775005, 5125.897482050413, 5428.864278393072, 5463.69949652757, 5043.823466178666, 5099.107656160231, 5250.842474725764, 5559.192607733231, 5666.46168613981, 4867.440244371801, 5036.974815125901, 5112.437631860418, 5484.808031718871, 5494.862628434161], "value": 4207.14736857583, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.7057036044861, 706.427793487275, 769.9307062364386, 825.8018075661842, 834.449263486099, 14534.34595443205, 15193.848061519382, 15712.292946817392, 15766.527004189878, 15775.21123943804, 15152.0, 15346.155961422117, 15347.462838800617, 15356.539303820904, 15454.69090618187, 910.6676063236937, 924.3021518753332, 938.9389689670184, 939.7039932421266, 939.976500587484, 887.4497811356968, 926.3422969691527, 932.5523748600676, 944.1502647617165, 944.7307517357555, 981.9312648114635, 982.341830973246, 982.9262805289596, 985.9893609050708, 986.1223511075149, 834.3408707121367, 975.5414954971152, 981.6318880419842, 981.7594689301131, 984.4191926763173, 719.5143278287187, 727.1456039154026, 727.8871774874902, 729.0303895818548, 729.3690957321932, 14843.480478183319, 15116.54650360491, 15155.62110947224, 15267.618309542238, 15502.767458488132, 12846.715328467171, 13631.318434078355, 13636.318184090855, 14237.78643320351, 14375.856241437661, 10565.207609429246, 10823.357926579703, 10955.4522273886, 11156.497957591928, 11479.598214062467, 3623.40213864712, 3671.247394284192, 3682.907927301812, 3723.590405055442, 3793.089658481972, 95071.52464237704, 108281.0, 108500.0, 110377.0, 111148.444257779, 10562.894371056345, 10597.0, 10637.521311540844, 11102.000819926245, 11130.387828669502, 22178.112875485123, 22244.332670019925, 22312.442188945082, 22332.0, 22358.66462003071, 6434.906065968797, 7421.517601355895, 7429.922661214094, 7563.016807814949, 7574.697012119454, 4015.7613172808797, 4124.649404800565, 4133.100173873144, 4148.274052040881, 4185.142045880587, 3269.73842092632, 3320.00399880035, 3342.6824451677053, 3369.6967272945553, 3370.5618269624792, 495.4673725744839, 558.7346010644992, 577.4369989260522, 581.7731084876901, 594.895893218685, 648.6497291462557, 682.4608559238146, 690.526989012518, 691.7233106757337, 715.5241764226731, 9120.407173533698, 9472.715818525456, 9849.310548261554, 10306.278560500694, 10321.380717156995, 627.9058141278754, 660.8149718078946, 694.4479089235555, 695.3012222716239, 723.9348458638642, 4714.693544919569, 4864.829730959399, 4879.853604391874, 4895.510448955076, 4905.484924082992, 81683.50740709317, 102782.0, 103083.48458257661, 104028.0, 104109.0, 59467.810643786885, 62467.750644986845, 70255.0, 75252.87120693194, 92852.53573732088, 62571.687141564, 62598.37401626017, 63593.0, 63924.04113938202, 66360.33639663542, 10705.0, 10910.0, 10913.83629245546, 11053.392063436588, 11079.83380249313, 40250.50609810866, 44246.0, 49243.0, 50193.49806501888, 51990.0, 53076.46923530715, 53144.0, 53258.20112698235, 55362.72318638381, 60098.7980240384, 12029.398530073286, 12128.908398243848, 12467.438965246767, 12512.186707864324, 12950.222986620833, 13517.86482135166, 13562.321883905963, 13656.385462654005, 13955.06638260945, 14062.156270623795, 12941.870581294066, 12985.436893203898, 13254.13848099909, 13435.529756458476, 13451.596452106452, 11054.0, 13169.9877391122, 13445.663858403226, 13602.319884005958, 14148.575542733735, 12892.613221603367, 12895.677608059874, 12983.545575904798, 13105.344732763133, 13885.166889986633, 8224.917750822415, 10606.893931060591, 10800.826685569982, 10934.617288394868, 11281.153913456688, 8652.005019422846, 9118.863217051618, 10104.69685909424, 10861.782764344827, 11242.606508772154], "value": 7348.006852826549, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1675.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 174.0, 123.0, 134.0, 175.0, 154.0, 119.0, 119.0, 122.0, 123.0], "value": 140.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 114.0, 115.0, 178.0, 117.0, 115.0, 111.0, 126.0, 135.0, 114.0], "value": 127.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 212.0, 251.0, 246.0, 278.0, 289.0, 202.0, 198.0, 227.0, 281.0], "value": 238.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 59.0, 62.0, 89.0, 62.0, 64.0, 63.0, 64.0, 78.0, 63.0], "value": 69.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 86.0, 72.0, 72.0, 73.0, 87.0, 86.0, 73.0, 84.0], "value": 81.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 89.0, 109.0, 125.0, 128.0, 92.0, 129.0, 121.0, 91.0, 93.0], "value": 106.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 127.0, 98.0, 100.0, 131.0, 156.0, 100.0, 106.0, 155.0, 99.0], "value": 122.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 142.0, 144.0, 91.0, 97.0, 94.0, 92.0, 92.0, 92.0], "value": 102.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 78.0, 98.0, 101.0, 103.0, 105.0, 75.0, 68.0], "value": 82.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 81.0, 95.0, 105.0, 58.0, 70.0, 83.0, 86.0, 51.0, 71.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 79.0, 101.0, 79.0, 111.0, 108.0, 112.0, 91.0, 94.0, 87.0], "value": 94.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 157.0, 152.0, 141.0, 147.0, 145.0, 145.0, 145.0, 209.0, 173.0], "value": 157.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 257.0, 238.0, 231.0, 176.0, 177.0, 177.0, 179.0, 181.0, 186.0], "value": 196.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 86.0, 88.0, 93.0, 61.0, 83.0, 90.0, 71.0, 86.0], "value": 79.8, "unit": "score"}]}]} 05:07:27 INFO - Return code: 0 05:07:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:07:27 ERROR - # TBPL SUCCESS # 05:07:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:07:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:07:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:07:27 INFO - 2017-03-08 05:07:27.193 screenresolution[6890:125282] starting screenresolution argv=screenresolution get 05:07:27 INFO - 2017-03-08 05:07:27.195 screenresolution[6890:125282] Display 0: 1600x1200x32@60 05:07:27 INFO - 2017-03-08 05:07:27.201 screenresolution[6891:125285] starting screenresolution argv=screenresolution list 05:07:27 INFO - Available Modes on Display 0 05:07:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:07:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:07:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:07:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:07:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:07:27 INFO - Intel Iris: 05:07:27 INFO - Chipset Model: Intel Iris 05:07:27 INFO - Type: GPU 05:07:27 INFO - Bus: Built-In 05:07:27 INFO - VRAM (Dynamic, Max): 1536 MB 05:07:27 INFO - Vendor: Intel (0x8086) 05:07:27 INFO - Device ID: 0x0a2e 05:07:27 INFO - Revision ID: 0x0009 05:07:27 INFO - Displays: 05:07:27 INFO - Display: 05:07:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:07:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:07:27 INFO - Display Serial Number: 1600x1200 60 05:07:27 INFO - Main Display: Yes 05:07:27 INFO - Mirror: Off 05:07:27 INFO - Online: Yes 05:07:27 INFO - Rotation: Supported 05:07:27 INFO - Return code: 0 05:07:27 INFO - Running post-action listener: _resource_record_post_action 05:07:27 INFO - [mozharness: 2017-03-08 13:07:27.441755Z] Finished run-tests step (success) 05:07:27 INFO - Running post-run listener: _resource_record_post_run 05:07:27 INFO - Total resource usage - Wall time: 1203s; CPU: 55.0%; Read bytes: 1417728; Write bytes: 513295360; Read time: 15; Write time: 1679 05:07:27 INFO - TinderboxPrint: CPU usage
54.9% 05:07:27 INFO - TinderboxPrint: I/O read bytes / time
1,417,728 / 15 05:07:27 INFO - TinderboxPrint: I/O write bytes / time
513,295,360 / 1,679 05:07:27 INFO - TinderboxPrint: CPU idle
2,172.2 (45.1%) 05:07:27 INFO - TinderboxPrint: CPU system
978.4 (20.3%) 05:07:27 INFO - TinderboxPrint: CPU user
1,663.2 (34.6%) 05:07:27 INFO - TinderboxPrint: Swap in / out
211,140,608 / 0 05:07:27 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201566720; Write bytes: 202942464; Read time: 15693; Write time: 441 05:07:27 INFO - run-tests - Wall time: 1183s; CPU: 55.0%; Read bytes: 1417216; Write bytes: 300448768; Read time: 13; Write time: 1153 05:07:27 INFO - Running post-run listener: _upload_blobber_files 05:07:27 INFO - Blob upload gear active. 05:07:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:07:27 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:07:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:07:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:07:28 INFO - (blobuploader) - INFO - Open directory for files ... 05:07:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:07:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:07:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:29 INFO - (blobuploader) - INFO - Done attempting. 05:07:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:07:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:07:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:30 INFO - (blobuploader) - INFO - Done attempting. 05:07:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:07:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:07:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:31 INFO - (blobuploader) - INFO - Done attempting. 05:07:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:07:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:07:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:33 INFO - (blobuploader) - INFO - Done attempting. 05:07:33 INFO - (blobuploader) - INFO - Iteration through files over. 05:07:33 INFO - Return code: 0 05:07:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:07:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:07:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c2bd5d9619d319e80f5208482adf8b0da8cf27c60b33f715bb18e946805f5b7afa6c9f30241e6f0aba5f669f04d4c8f663e5f5a6729caadfa8b6c89f46bd0e5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecf6ff7d36cd6491c1ff2d384c10d7e964be1c7e38df77796f672524690066a65fe1a465726daeb8f578d3dbe6aadbca59afc6696b3215230120b6419104c175", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7cd4b04c400d7fdebd622251745c76e0612fe850e63197864ea95bc426b8e0fe1b296bae35be989d2f2a62cccebc432db36d132cc32f31b6de095aada67efd01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac345d7c5b49656033e41e81a4efeacf2ca34d7f326bc4d67566a320aefee718f0fcbab8a88ea18802fb349db3b9af7a99ef397cd16b67e2260390e9d81841da"} 05:07:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:07:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:07:33 INFO - Contents: 05:07:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c2bd5d9619d319e80f5208482adf8b0da8cf27c60b33f715bb18e946805f5b7afa6c9f30241e6f0aba5f669f04d4c8f663e5f5a6729caadfa8b6c89f46bd0e5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecf6ff7d36cd6491c1ff2d384c10d7e964be1c7e38df77796f672524690066a65fe1a465726daeb8f578d3dbe6aadbca59afc6696b3215230120b6419104c175", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7cd4b04c400d7fdebd622251745c76e0612fe850e63197864ea95bc426b8e0fe1b296bae35be989d2f2a62cccebc432db36d132cc32f31b6de095aada67efd01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac345d7c5b49656033e41e81a4efeacf2ca34d7f326bc4d67566a320aefee718f0fcbab8a88ea18802fb349db3b9af7a99ef397cd16b67e2260390e9d81841da"} 05:07:33 INFO - Running post-run listener: copy_logs_to_upload_dir 05:07:33 INFO - Copying logs to upload dir... 05:07:33 INFO - mkdir: /builds/slave/test/build/upload/logs 05:07:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.415541 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-08 05:07:33.793098) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-08 05:07:33.796378) ========= 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.4OhouXzNem/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.zW8MAmtDJL/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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/7c2bd5d9619d319e80f5208482adf8b0da8cf27c60b33f715bb18e946805f5b7afa6c9f30241e6f0aba5f669f04d4c8f663e5f5a6729caadfa8b6c89f46bd0e5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecf6ff7d36cd6491c1ff2d384c10d7e964be1c7e38df77796f672524690066a65fe1a465726daeb8f578d3dbe6aadbca59afc6696b3215230120b6419104c175", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7cd4b04c400d7fdebd622251745c76e0612fe850e63197864ea95bc426b8e0fe1b296bae35be989d2f2a62cccebc432db36d132cc32f31b6de095aada67efd01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac345d7c5b49656033e41e81a4efeacf2ca34d7f326bc4d67566a320aefee718f0fcbab8a88ea18802fb349db3b9af7a99ef397cd16b67e2260390e9d81841da"} build_url:https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011040 build_url: 'https://queue.taskcluster.net/v1/task/Q0qQnSiETcqi9iCJYZ4BEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c2bd5d9619d319e80f5208482adf8b0da8cf27c60b33f715bb18e946805f5b7afa6c9f30241e6f0aba5f669f04d4c8f663e5f5a6729caadfa8b6c89f46bd0e5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecf6ff7d36cd6491c1ff2d384c10d7e964be1c7e38df77796f672524690066a65fe1a465726daeb8f578d3dbe6aadbca59afc6696b3215230120b6419104c175", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7cd4b04c400d7fdebd622251745c76e0612fe850e63197864ea95bc426b8e0fe1b296bae35be989d2f2a62cccebc432db36d132cc32f31b6de095aada67efd01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac345d7c5b49656033e41e81a4efeacf2ca34d7f326bc4d67566a320aefee718f0fcbab8a88ea18802fb349db3b9af7a99ef397cd16b67e2260390e9d81841da"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-08 05:07:33.830546) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 05:07:33.830891) ========= 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.4OhouXzNem/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.zW8MAmtDJL/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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.005400 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 05:07:33.879811) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-08 05:07:33.880152) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-08 05:07:33.880466) ========= ========= Total master_lag: 0.18 =========