builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0388 starttime: 1463683587.42 results: success (0) buildid: 20160519093943 builduid: d44bf7d8a2264dda955d4021a07fe9d2 revision: f9c0368a28b144d9b0a7b87f100ea9f471b619c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 11:46:27.419015) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 11:46:27.419499) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 11:46:27.419817) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 11:46:27.442521) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 11:46:27.442964) ========= 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.0BST0xYy5U/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.I88PAs22zr/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-19 11:46:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.3M=0.001s 2016-05-19 11:46:27 (19.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096598 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 11:46:27.559515) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 11:46:27.559910) ========= 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.0BST0xYy5U/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.I88PAs22zr/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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.025477 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 11:46:27.608129) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-19 11:46:27.608530) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f9c0368a28b144d9b0a7b87f100ea9f471b619c0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f9c0368a28b144d9b0a7b87f100ea9f471b619c0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0BST0xYy5U/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.I88PAs22zr/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-19 11:46:27,694 truncating revision to first 12 chars 2016-05-19 11:46:27,694 Setting DEBUG logging. 2016-05-19 11:46:27,694 attempt 1/10 2016-05-19 11:46:27,694 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f9c0368a28b1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-19 11:46:28,438 unpacking tar archive at: mozilla-beta-f9c0368a28b1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.002952 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-19 11:46:28.630653) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 11:46:28.631039) ========= script_repo_revision: f9c0368a28b144d9b0a7b87f100ea9f471b619c0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 11:46:28.631480) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 11:46:28.631745) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 11:46:28.647691) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-05-19 11:46:28.648155) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0BST0xYy5U/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.I88PAs22zr/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 11:46:28 INFO - MultiFileLogger online at 20160519 11:46:28 in /builds/slave/test 11:46:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:46:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:46:28 INFO - {'append_to_log': False, 11:46:28 INFO - 'base_work_dir': '/builds/slave/test', 11:46:28 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:46:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:46:28 INFO - 'branch': 'Mozilla-Beta', 11:46:28 INFO - 'buildbot_json_path': 'buildprops.json', 11:46:28 INFO - 'config_files': ('talos/mac_config.py',), 11:46:28 INFO - 'default_actions': ('clobber', 11:46:28 INFO - 'read-buildbot-config', 11:46:28 INFO - 'download-and-extract', 11:46:28 INFO - 'populate-webroot', 11:46:28 INFO - 'create-virtualenv', 11:46:28 INFO - 'install', 11:46:28 INFO - 'run-tests'), 11:46:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:46:28 INFO - 'download_minidump_stackwalk': True, 11:46:28 INFO - 'download_symbols': 'ondemand', 11:46:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:46:28 INFO - 'tooltool.py': '/tools/tooltool.py', 11:46:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:46:28 INFO - '/tools/misc-python/virtualenv.py')}, 11:46:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:46:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:46:28 INFO - 'installer_path': 'installer.exe', 11:46:28 INFO - 'log_level': 'info', 11:46:28 INFO - 'log_name': 'talos', 11:46:28 INFO - 'log_to_console': True, 11:46:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:46:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:46:28 INFO - 'opt_config_files': (), 11:46:28 INFO - 'pip_index': False, 11:46:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:46:28 INFO - 'cmd': ('bash', 11:46:28 INFO - '-c', 11:46:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:46:28 INFO - 'enabled': True, 11:46:28 INFO - 'halt_on_failure': False, 11:46:28 INFO - 'name': 'check_screen_resolution'},), 11:46:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:46:28 INFO - 'cmd': ('bash', 11:46:28 INFO - '-c', 11:46:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:46:28 INFO - 'enabled': True, 11:46:28 INFO - 'halt_on_failure': False, 11:46:28 INFO - 'name': 'check_screen_resolution'},), 11:46:28 INFO - 'run_cmd_checks_enabled': True, 11:46:28 INFO - 'sps_profile': False, 11:46:28 INFO - 'sps_profile_interval': 0, 11:46:28 INFO - 'suite': 'dromaeojs-e10s', 11:46:28 INFO - 'system_bits': '32', 11:46:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:46:28 INFO - 'title': 't-yosemite-r7-0388', 11:46:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:46:28 INFO - 'use_talos_json': True, 11:46:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:46:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:46:28 INFO - 'work_dir': 'build'} 11:46:28 INFO - ##### 11:46:28 INFO - ##### Running clobber step. 11:46:28 INFO - ##### 11:46:28 INFO - Running pre-action listener: _resource_record_pre_action 11:46:28 INFO - Running main action method: clobber 11:46:28 INFO - rmtree: /builds/slave/test/build 11:46:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:46:30 INFO - Running post-action listener: _resource_record_post_action 11:46:30 INFO - ##### 11:46:30 INFO - ##### Running read-buildbot-config step. 11:46:30 INFO - ##### 11:46:30 INFO - Running pre-action listener: _resource_record_pre_action 11:46:30 INFO - Running main action method: read_buildbot_config 11:46:30 INFO - Using buildbot properties: 11:46:30 INFO - { 11:46:30 INFO - "project": "", 11:46:30 INFO - "product": "firefox", 11:46:30 INFO - "script_repo_revision": "production", 11:46:30 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 11:46:30 INFO - "repository": "", 11:46:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 11:46:30 INFO - "buildid": "20160519093943", 11:46:30 INFO - "pgo_build": "False", 11:46:30 INFO - "basedir": "/builds/slave/test", 11:46:30 INFO - "buildnumber": 7, 11:46:30 INFO - "slavename": "t-yosemite-r7-0388", 11:46:30 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 11:46:30 INFO - "platform": "yosemite_r7", 11:46:30 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:46:30 INFO - "branch": "mozilla-beta", 11:46:30 INFO - "repo_path": "releases/mozilla-beta", 11:46:30 INFO - "revision": "f9c0368a28b144d9b0a7b87f100ea9f471b619c0", 11:46:30 INFO - "stage_platform": "macosx64", 11:46:30 INFO - "builduid": "d44bf7d8a2264dda955d4021a07fe9d2", 11:46:30 INFO - "slavebuilddir": "test" 11:46:30 INFO - } 11:46:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 11:46:30 INFO - Running post-action listener: _resource_record_post_action 11:46:30 INFO - ##### 11:46:30 INFO - ##### Running download-and-extract step. 11:46:30 INFO - ##### 11:46:30 INFO - Running pre-action listener: _resource_record_pre_action 11:46:30 INFO - Running main action method: download_and_extract 11:46:30 INFO - mkdir: /builds/slave/test/build/tests 11:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:30 INFO - https://queue.taskcluster.net/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:46:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 11:46:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 11:46:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 11:46:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 11:46:32 INFO - Downloaded 1241 bytes. 11:46:32 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 11:46:32 INFO - Using the following test package requirements: 11:46:32 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 11:46:32 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 11:46:32 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 11:46:32 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 11:46:32 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 11:46:32 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:46:32 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 11:46:32 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 11:46:32 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 11:46:32 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 11:46:32 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 11:46:32 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 11:46:32 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 11:46:32 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 11:46:32 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 11:46:32 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 11:46:32 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 11:46:32 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 11:46:32 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 11:46:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:32 INFO - https://queue.taskcluster.net/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:46:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 11:46:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 11:46:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 11:46:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 11:46:43 INFO - Downloaded 17747765 bytes. 11:46:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:46:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:46:46 INFO - Return code: 0 11:46:46 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 11:46:46 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:46 INFO - https://queue.taskcluster.net/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:46:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 11:46:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 11:46:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 11:46:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 11:46:47 INFO - Downloaded 17747765 bytes. 11:46:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:46:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:46:51 INFO - Return code: 0 11:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:51 INFO - https://queue.taskcluster.net/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:46:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 11:46:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 11:46:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 11:46:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 11:46:58 INFO - Downloaded 10845194 bytes. 11:46:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:46:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 11:46:58 INFO - Return code: 0 11:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:58 INFO - https://queue.taskcluster.net/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 11:46:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 11:46:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 11:46:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 11:46:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 11:47:00 INFO - Downloaded 88421489 bytes. 11:47:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 11:47:00 INFO - mkdir: /builds/slave/test/properties 11:47:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:47:00 INFO - Writing to file /builds/slave/test/properties/build_url 11:47:00 INFO - Contents: 11:47:00 INFO - build_url:https://queue.taskcluster.net/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 11:47:02 INFO - Running post-action listener: _resource_record_post_action 11:47:02 INFO - Running post-action listener: set_extra_try_arguments 11:47:02 INFO - ##### 11:47:02 INFO - ##### Running populate-webroot step. 11:47:02 INFO - ##### 11:47:02 INFO - Running pre-action listener: _resource_record_pre_action 11:47:02 INFO - Running main action method: populate_webroot 11:47:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:47:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:47:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:47:02 INFO - '--tppagecycles', 11:47:02 INFO - '7'], 11:47:02 INFO - 'tests': ['tsvgm']}}, 11:47:02 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:47:02 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:47:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:47:02 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:47:02 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:47:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:47:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:47:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:02 INFO - 'talos_options': ['--e10s'], 11:47:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:47:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:02 INFO - 'tests': ['damp', 'tps']}, 11:47:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:02 INFO - 'talos_options': ['--e10s'], 11:47:02 INFO - 'tests': ['damp', 'tps']}, 11:47:02 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:47:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:47:02 INFO - 'other': {'tests': ['a11yr', 11:47:02 INFO - 'ts_paint', 11:47:02 INFO - 'tpaint', 11:47:02 INFO - 'sessionrestore', 11:47:02 INFO - 'sessionrestore_no_auto_restore', 11:47:02 INFO - 'tabpaint']}, 11:47:02 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:47:02 INFO - 'tests': ['a11yr', 11:47:02 INFO - 'ts_paint', 11:47:02 INFO - 'tpaint', 11:47:02 INFO - 'sessionrestore', 11:47:02 INFO - 'sessionrestore_no_auto_restore', 11:47:02 INFO - 'tabpaint']}, 11:47:02 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:47:02 INFO - 'tests': ['a11yr', 11:47:02 INFO - 'ts_paint', 11:47:02 INFO - 'tpaint', 11:47:02 INFO - 'sessionrestore', 11:47:02 INFO - 'sessionrestore_no_auto_restore', 11:47:02 INFO - 'tabpaint']}, 11:47:02 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:47:02 INFO - 'tests': ['a11yr', 11:47:02 INFO - 'ts_paint', 11:47:02 INFO - 'tpaint', 11:47:02 INFO - 'sessionrestore', 11:47:02 INFO - 'sessionrestore_no_auto_restore', 11:47:02 INFO - 'tabpaint']}, 11:47:02 INFO - 'other_l64': {'tests': ['a11yr', 11:47:02 INFO - 'ts_paint', 11:47:02 INFO - 'tpaint', 11:47:02 INFO - 'sessionrestore', 11:47:02 INFO - 'sessionrestore_no_auto_restore', 11:47:02 INFO - 'tabpaint']}, 11:47:02 INFO - 'other_nol64': {'tests': ['a11yr', 11:47:02 INFO - 'ts_paint', 11:47:02 INFO - 'tpaint', 11:47:02 INFO - 'sessionrestore', 11:47:02 INFO - 'sessionrestore_no_auto_restore', 11:47:02 INFO - 'tabpaint']}, 11:47:02 INFO - 'svgr': {'tests': ['tsvgx', 11:47:02 INFO - 'tsvgr_opacity', 11:47:02 INFO - 'tart', 11:47:02 INFO - 'tscrollx', 11:47:02 INFO - 'cart']}, 11:47:02 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:47:02 INFO - 'tests': ['tsvgx', 11:47:02 INFO - 'tsvgr_opacity', 11:47:02 INFO - 'tart', 11:47:02 INFO - 'tscrollx', 11:47:02 INFO - 'cart']}, 11:47:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:02 INFO - 'tests': ['tp5o']}, 11:47:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:02 INFO - 'talos_options': ['--e10s'], 11:47:02 INFO - 'tests': ['tp5o']}, 11:47:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:02 INFO - 'talos_options': ['--xperf_path', 11:47:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:47:02 INFO - 'tests': ['tp5n']}, 11:47:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:47:02 INFO - 'talos_options': ['--e10s', 11:47:02 INFO - '--xperf_path', 11:47:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:47:02 INFO - 'tests': ['tp5n']}}, 11:47:02 INFO - 'talos.zip': {'path': '', 11:47:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:47:02 INFO - Running post-action listener: _resource_record_post_action 11:47:02 INFO - ##### 11:47:02 INFO - ##### Running create-virtualenv step. 11:47:02 INFO - ##### 11:47:02 INFO - Running pre-action listener: _resource_record_pre_action 11:47:02 INFO - Running main action method: create_virtualenv 11:47:02 INFO - Creating virtualenv /builds/slave/test/build/venv 11:47:02 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 11:47:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:47:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:47:02 INFO - Using real prefix '/tools/python27' 11:47:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:47:03 INFO - Installing distribute.............................................................................................................................................................................................done. 11:47:06 INFO - Installing pip.................done. 11:47:06 INFO - Return code: 0 11:47:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:06 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 0x105831a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058384c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99a1d9d1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056d5d30>, '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 0x105539db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056ccb20>, '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.0BST0xYy5U/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.I88PAs22zr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 11:47:06 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 11:47:06 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 11:47:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0BST0xYy5U/Render', 11:47:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:06 INFO - 'HOME': '/Users/cltbld', 11:47:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:06 INFO - 'LOGNAME': 'cltbld', 11:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:06 INFO - 'MOZ_NO_REMOTE': '1', 11:47:06 INFO - 'NO_EM_RESTART': '1', 11:47:06 INFO - 'PAGER': '/bin/cat', 11:47:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:06 INFO - 'PWD': '/builds/slave/test', 11:47:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:06 INFO - 'SHELL': '/bin/bash', 11:47:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I88PAs22zr/Listeners', 11:47:06 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 11:47:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:06 INFO - 'USER': 'cltbld', 11:47:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:06 INFO - 'XPC_FLAGS': '0x0', 11:47:06 INFO - 'XPC_SERVICE_NAME': '0', 11:47:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:06 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 11:47:06 INFO - Cleaning up... 11:47:06 INFO - Return code: 0 11:47:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:06 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105831a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058384c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99a1d9d1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056d5d30>, '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 0x105539db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056ccb20>, '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.0BST0xYy5U/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.I88PAs22zr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 11:47:06 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>=0.7.1'] in /builds/slave/test/build 11:47:06 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>=0.7.1 11:47:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0BST0xYy5U/Render', 11:47:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:06 INFO - 'HOME': '/Users/cltbld', 11:47:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:06 INFO - 'LOGNAME': 'cltbld', 11:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:06 INFO - 'MOZ_NO_REMOTE': '1', 11:47:06 INFO - 'NO_EM_RESTART': '1', 11:47:06 INFO - 'PAGER': '/bin/cat', 11:47:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:06 INFO - 'PWD': '/builds/slave/test', 11:47:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:06 INFO - 'SHELL': '/bin/bash', 11:47:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I88PAs22zr/Listeners', 11:47:06 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 11:47:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:06 INFO - 'USER': 'cltbld', 11:47:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:06 INFO - 'XPC_FLAGS': '0x0', 11:47:06 INFO - 'XPC_SERVICE_NAME': '0', 11:47:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:07 INFO - Downloading/unpacking psutil>=0.7.1 11:47:07 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 11:47:07 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 11:47:07 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 11:47:07 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 11:47:07 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 11:47:07 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 11:47:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:47:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:47:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:47:10 INFO - Installing collected packages: psutil 11:47:10 INFO - Running setup.py install for psutil 11:47:10 INFO - building 'psutil._psutil_osx' extension 11:47:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 11:47:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 11:47:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 11:47:10 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 11:47:10 INFO - building 'psutil._psutil_posix' extension 11:47:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 11:47:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:47:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:47:11 INFO - ^ 11:47:11 INFO - 1 warning generated. 11:47:11 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 11:47:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:47:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:47:11 INFO - Successfully installed psutil 11:47:11 INFO - Cleaning up... 11:47:11 INFO - Return code: 0 11:47:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:47:11 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:11 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:11 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105831a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058384c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99a1d9d1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056d5d30>, '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 0x105539db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056ccb20>, '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.0BST0xYy5U/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.I88PAs22zr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 11:47:11 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.0.0'] in /builds/slave/test/build 11:47:11 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.0.0 11:47:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0BST0xYy5U/Render', 11:47:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:11 INFO - 'HOME': '/Users/cltbld', 11:47:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:11 INFO - 'LOGNAME': 'cltbld', 11:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:11 INFO - 'MOZ_NO_REMOTE': '1', 11:47:11 INFO - 'NO_EM_RESTART': '1', 11:47:11 INFO - 'PAGER': '/bin/cat', 11:47:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:11 INFO - 'PWD': '/builds/slave/test', 11:47:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:11 INFO - 'SHELL': '/bin/bash', 11:47:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I88PAs22zr/Listeners', 11:47:11 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 11:47:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:11 INFO - 'USER': 'cltbld', 11:47:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:11 INFO - 'XPC_FLAGS': '0x0', 11:47:11 INFO - 'XPC_SERVICE_NAME': '0', 11:47:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11: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 11: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 11: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 11: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 11: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 11: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 11:47:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:47:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:47:14 INFO - Installing collected packages: mozsystemmonitor 11:47:14 INFO - Running setup.py install for mozsystemmonitor 11:47:14 INFO - Successfully installed mozsystemmonitor 11:47:14 INFO - Cleaning up... 11:47:14 INFO - Return code: 0 11:47:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:47:14 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:14 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:14 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 0x105831a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058384c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99a1d9d1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056d5d30>, '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 0x105539db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056ccb20>, '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.0BST0xYy5U/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.I88PAs22zr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 11:47:14 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 11:47:14 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 11:47:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0BST0xYy5U/Render', 11:47:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:14 INFO - 'HOME': '/Users/cltbld', 11:47:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:14 INFO - 'LOGNAME': 'cltbld', 11:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:14 INFO - 'MOZ_NO_REMOTE': '1', 11:47:14 INFO - 'NO_EM_RESTART': '1', 11:47:14 INFO - 'PAGER': '/bin/cat', 11:47:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:14 INFO - 'PWD': '/builds/slave/test', 11:47:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:14 INFO - 'SHELL': '/bin/bash', 11:47:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I88PAs22zr/Listeners', 11:47:14 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 11:47:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:14 INFO - 'USER': 'cltbld', 11:47:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:14 INFO - 'XPC_FLAGS': '0x0', 11:47:14 INFO - 'XPC_SERVICE_NAME': '0', 11:47:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:14 INFO - Downloading/unpacking blobuploader==1.2.4 11:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:16 INFO - Downloading blobuploader-1.2.4.tar.gz 11:47:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:47:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:47:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:18 INFO - Downloading docopt-0.6.1.tar.gz 11:47:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:47:18 INFO - Installing collected packages: blobuploader, requests, docopt 11:47:18 INFO - Running setup.py install for blobuploader 11:47:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:47:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:47:18 INFO - Running setup.py install for requests 11:47:18 INFO - Running setup.py install for docopt 11:47:18 INFO - Successfully installed blobuploader requests docopt 11:47:18 INFO - Cleaning up... 11:47:19 INFO - Return code: 0 11:47:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:47:19 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:19 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:19 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 0x105831a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058384c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99a1d9d1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056d5d30>, '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 0x105539db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056ccb20>, '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.0BST0xYy5U/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.I88PAs22zr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 11:47:19 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 11:47:19 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 11:47:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0BST0xYy5U/Render', 11:47:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:19 INFO - 'HOME': '/Users/cltbld', 11:47:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:19 INFO - 'LOGNAME': 'cltbld', 11:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:19 INFO - 'MOZ_NO_REMOTE': '1', 11:47:19 INFO - 'NO_EM_RESTART': '1', 11:47:19 INFO - 'PAGER': '/bin/cat', 11:47:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:19 INFO - 'PWD': '/builds/slave/test', 11:47:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:19 INFO - 'SHELL': '/bin/bash', 11:47:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I88PAs22zr/Listeners', 11:47:19 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 11:47:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:19 INFO - 'USER': 'cltbld', 11:47:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:19 INFO - 'XPC_FLAGS': '0x0', 11:47:19 INFO - 'XPC_SERVICE_NAME': '0', 11:47:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:47:19 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-SJS_mx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:47:19 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-Mnq143-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:47:19 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-3fq99k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:47:19 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-MzsQAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:47:19 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-PaKbZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:47:19 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-O3Sb3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:47:19 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-iBwkKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:47:20 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-lPJ6RS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:47:20 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-yvkwZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:47:20 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-3k_28q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:47:20 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-v60Tb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:47:20 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-cC4oay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:47:20 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-XfVHKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:47:20 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-v7BbKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:20 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-Z4fHYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:47:20 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-G9xfOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:47:20 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-uBgkyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:47:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:47:21 INFO - Running setup.py install for manifestparser 11:47:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:47:21 INFO - Running setup.py install for mozcrash 11:47:21 INFO - Running setup.py install for mozdebug 11:47:21 INFO - Running setup.py install for mozdevice 11:47:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:47:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:47:21 INFO - Running setup.py install for mozfile 11:47:21 INFO - Running setup.py install for mozhttpd 11:47:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:47:21 INFO - Running setup.py install for mozinfo 11:47:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:47:22 INFO - Running setup.py install for mozInstall 11:47:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:47:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:47:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:47:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:47:22 INFO - Running setup.py install for mozleak 11:47:22 INFO - Running setup.py install for mozlog 11:47:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:47:22 INFO - Running setup.py install for moznetwork 11:47:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:47:22 INFO - Running setup.py install for mozprocess 11:47:22 INFO - Running setup.py install for mozprofile 11:47:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:47:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:47:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:47:22 INFO - Running setup.py install for mozrunner 11:47:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:47:23 INFO - Running setup.py install for mozscreenshot 11:47:23 INFO - Running setup.py install for moztest 11:47:23 INFO - Running setup.py install for mozversion 11:47:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:47:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:47:23 INFO - Cleaning up... 11:47:23 INFO - Return code: 0 11:47:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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/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 0x105831a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058384c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99a1d9d1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056d5d30>, '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 0x105539db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056ccb20>, '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.0BST0xYy5U/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.I88PAs22zr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 11:47:23 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 11:47:23 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 11:47:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0BST0xYy5U/Render', 11:47:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:23 INFO - 'HOME': '/Users/cltbld', 11:47:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:23 INFO - 'LOGNAME': 'cltbld', 11:47:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:23 INFO - 'MOZ_NO_REMOTE': '1', 11:47:23 INFO - 'NO_EM_RESTART': '1', 11:47:23 INFO - 'PAGER': '/bin/cat', 11:47:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:23 INFO - 'PWD': '/builds/slave/test', 11:47:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:23 INFO - 'SHELL': '/bin/bash', 11:47:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I88PAs22zr/Listeners', 11:47:23 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 11:47:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:23 INFO - 'USER': 'cltbld', 11:47:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:23 INFO - 'XPC_FLAGS': '0x0', 11:47:23 INFO - 'XPC_SERVICE_NAME': '0', 11:47:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:47:23 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-U51nlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:47:23 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)) 11:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:47:23 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-7ZfjcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:47:24 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-TP0v7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:47:24 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)) 11:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:47:24 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-trPzjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:47:24 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-TVpUUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:47:24 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)) 11:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:47:24 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-8ldnGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:47:24 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)) 11:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:47:24 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-DJIij0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:47:24 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)) 11:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:47:24 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-JS0_m5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:47:24 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)) 11:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:47:24 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-vNjIaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:47:24 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)) 11:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:47:24 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-6nbFOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 11:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:47:24 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-NTD1rc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:47:25 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)) 11:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:47:25 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-FHgRYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 11:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:47:25 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-Daps7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:47:25 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)) 11:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:47:25 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-onKkVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 11:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:25 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-SIXmch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:25 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)) 11:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:47:25 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-6K1Scp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:47:25 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-15GKez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:47:25 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)) 11:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:47:25 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)) 11:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:47:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:47:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:47:25 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 11:47:25 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 11:47:25 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 11:47:25 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 11:47:25 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 11:47:25 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 11:47:28 INFO - Downloading blessings-1.6.tar.gz 11:47:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:47:28 INFO - Installing collected packages: blessings 11:47:28 INFO - Running setup.py install for blessings 11:47:28 INFO - Successfully installed blessings 11:47:28 INFO - Cleaning up... 11:47:28 INFO - Return code: 0 11:47:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:47:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:47:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:47:29 INFO - Reading from file tmpfile_stdout 11:47:29 INFO - Current package versions: 11:47:29 INFO - blessings == 1.6 11:47:29 INFO - blobuploader == 1.2.4 11:47:29 INFO - docopt == 0.6.1 11:47:29 INFO - manifestparser == 1.1 11:47:29 INFO - mozInstall == 1.12 11:47:29 INFO - mozcrash == 0.17 11:47:29 INFO - mozdebug == 0.1 11:47:29 INFO - mozdevice == 0.48 11:47:29 INFO - mozfile == 1.2 11:47:29 INFO - mozhttpd == 0.7 11:47:29 INFO - mozinfo == 0.9 11:47:29 INFO - mozleak == 0.1 11:47:29 INFO - mozlog == 3.1 11:47:29 INFO - moznetwork == 0.27 11:47:29 INFO - mozprocess == 0.22 11:47:29 INFO - mozprofile == 0.28 11:47:29 INFO - mozrunner == 6.11 11:47:29 INFO - mozscreenshot == 0.1 11:47:29 INFO - mozsystemmonitor == 0.0 11:47:29 INFO - moztest == 0.7 11:47:29 INFO - mozversion == 1.4 11:47:29 INFO - psutil == 3.1.1 11:47:29 INFO - requests == 1.2.3 11:47:29 INFO - wsgiref == 0.1.2 11:47:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:47:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:29 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 0x105831a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058384c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99a1d9d1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056d5d30>, '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 0x105539db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056ccb20>, '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.0BST0xYy5U/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.I88PAs22zr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 11:47:29 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 11:47:29 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 11:47:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0BST0xYy5U/Render', 11:47:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:29 INFO - 'HOME': '/Users/cltbld', 11:47:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:29 INFO - 'LOGNAME': 'cltbld', 11:47:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:29 INFO - 'MOZ_NO_REMOTE': '1', 11:47:29 INFO - 'NO_EM_RESTART': '1', 11:47:29 INFO - 'PAGER': '/bin/cat', 11:47:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:29 INFO - 'PWD': '/builds/slave/test', 11:47:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:29 INFO - 'SHELL': '/bin/bash', 11:47:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I88PAs22zr/Listeners', 11:47:29 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 11:47:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:29 INFO - 'USER': 'cltbld', 11:47:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:29 INFO - 'XPC_FLAGS': '0x0', 11:47:29 INFO - 'XPC_SERVICE_NAME': '0', 11:47:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:29 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)) 11:47:29 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)) 11:47:29 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)) 11:47:29 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)) 11:47:29 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)) 11:47:29 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)) 11:47:29 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)) 11:47:29 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)) 11:47:29 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)) 11:47:29 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)) 11:47:29 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)) 11:47:29 INFO - Cleaning up... 11:47:29 INFO - Return code: 0 11:47:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:47:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105831a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058384c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99a1d9d1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056d5d30>, '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 0x105539db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056ccb20>, '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.0BST0xYy5U/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.I88PAs22zr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 11:47:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:47:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:47:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0BST0xYy5U/Render', 11:47:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:29 INFO - 'HOME': '/Users/cltbld', 11:47:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:29 INFO - 'LOGNAME': 'cltbld', 11:47:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:29 INFO - 'MOZ_NO_REMOTE': '1', 11:47:29 INFO - 'NO_EM_RESTART': '1', 11:47:29 INFO - 'PAGER': '/bin/cat', 11:47:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:29 INFO - 'PWD': '/builds/slave/test', 11:47:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:29 INFO - 'SHELL': '/bin/bash', 11:47:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I88PAs22zr/Listeners', 11:47:29 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 11:47:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:29 INFO - 'USER': 'cltbld', 11:47:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:29 INFO - 'XPC_FLAGS': '0x0', 11:47:29 INFO - 'XPC_SERVICE_NAME': '0', 11:47:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:29 INFO - Downloading/unpacking jsonschema 11:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:47:32 INFO - Downloading/unpacking functools32 (from jsonschema) 11:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:33 INFO - Downloading functools32-3.2.3-2.tar.gz 11:47:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:47:33 INFO - warning: no files found matching '*.txt' 11:47:33 INFO - no previously-included directories found matching 'build' 11:47:33 INFO - no previously-included directories found matching 'dist' 11:47:33 INFO - no previously-included directories found matching '.git*' 11:47:33 INFO - Installing collected packages: jsonschema, functools32 11:47:33 INFO - Running setup.py install for functools32 11:47:33 INFO - warning: no files found matching '*.txt' 11:47:33 INFO - no previously-included directories found matching 'build' 11:47:33 INFO - no previously-included directories found matching 'dist' 11:47:33 INFO - no previously-included directories found matching '.git*' 11:47:33 INFO - Successfully installed jsonschema functools32 11:47:33 INFO - Cleaning up... 11:47:33 INFO - Return code: 0 11:47:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:47:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:33 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105831a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058384c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99a1d9d1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056d5d30>, '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 0x105539db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056ccb20>, '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.0BST0xYy5U/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.I88PAs22zr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 11:47:33 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', 'flake8'] in /builds/slave/test/build 11:47:33 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 flake8 11:47:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0BST0xYy5U/Render', 11:47:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:47:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:47:33 INFO - 'HOME': '/Users/cltbld', 11:47:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:47:33 INFO - 'LOGNAME': 'cltbld', 11:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:33 INFO - 'MOZ_NO_REMOTE': '1', 11:47:33 INFO - 'NO_EM_RESTART': '1', 11:47:33 INFO - 'PAGER': '/bin/cat', 11:47:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:33 INFO - 'PWD': '/builds/slave/test', 11:47:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:47:33 INFO - 'SHELL': '/bin/bash', 11:47:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I88PAs22zr/Listeners', 11:47:33 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 11:47:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:47:33 INFO - 'USER': 'cltbld', 11:47:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:47:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:33 INFO - 'XPC_FLAGS': '0x0', 11:47:33 INFO - 'XPC_SERVICE_NAME': '0', 11:47:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:47:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:33 INFO - Downloading/unpacking flake8 11:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:47:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:47:36 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 11:47:36 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 11:47:36 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 11:47:36 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 11:47:36 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 11:47:36 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 11:47:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:47:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:47:36 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 11:47:36 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 11:47:36 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 11:47:36 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 11:47:36 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 11:47:36 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 11:47:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:47:36 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 11:47:36 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 11:47:36 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 11:47:36 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 11:47:36 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 11:47:36 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 11:47:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:47:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:47:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:47:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:47:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:47:37 INFO - no previously-included directories found matching 'docs/_build' 11:47:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:47:37 INFO - Running setup.py install for pep8 11:47:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:47:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:47:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:47:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:47:37 INFO - no previously-included directories found matching 'docs/_build' 11:47:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:47:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:47:37 INFO - Cleaning up... 11:47:37 INFO - Return code: 0 11:47:37 INFO - Running post-action listener: _resource_record_post_action 11:47:37 INFO - Running post-action listener: _start_resource_monitoring 11:47:37 INFO - Starting resource monitoring. 11:47:37 INFO - ##### 11:47:37 INFO - ##### Running install step. 11:47:37 INFO - ##### 11:47:37 INFO - Running pre-action listener: _resource_record_pre_action 11:47:37 INFO - Running main action method: install 11:47:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:47:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:47:38 INFO - Reading from file tmpfile_stdout 11:47:38 INFO - Detecting whether we're running mozinstall >=1.0... 11:47:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:47:38 INFO - Reading from file tmpfile_stdout 11:47:38 INFO - Output received: 11:47:38 INFO - Usage: mozinstall [options] installer 11:47:38 INFO - Options: 11:47:38 INFO - -h, --help show this help message and exit 11:47:38 INFO - -d DEST, --destination=DEST 11:47:38 INFO - Directory to install application into. [default: 11:47:38 INFO - "/builds/slave/test"] 11:47:38 INFO - --app=APP Application being installed. [default: firefox] 11:47:38 INFO - mkdir: /builds/slave/test/build/application 11:47:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 11:48:00 INFO - Reading from file tmpfile_stdout 11:48:00 INFO - Output received: 11:48:00 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:48:00 INFO - Running post-action listener: _resource_record_post_action 11:48:00 INFO - ##### 11:48:00 INFO - ##### Running run-tests step. 11:48:00 INFO - ##### 11:48:00 INFO - Running pre-action listener: _resource_record_pre_action 11:48:00 INFO - Running main action method: run_tests 11:48:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:48:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:48:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:48:00 INFO - 2016-05-19 11:48:00.949 screenresolution[1641:7423] starting screenresolution argv=screenresolution get 11:48:00 INFO - 2016-05-19 11:48:00.952 screenresolution[1641:7423] Display 0: 1600x1200x32@60 11:48:00 INFO - 2016-05-19 11:48:00.958 screenresolution[1642:7426] starting screenresolution argv=screenresolution list 11:48:00 INFO - Available Modes on Display 0 11:48:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:48:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:48:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:48:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:48:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:48:01 INFO - Intel Iris: 11:48:01 INFO - Chipset Model: Intel Iris 11:48:01 INFO - Type: GPU 11:48:01 INFO - Bus: Built-In 11:48:01 INFO - VRAM (Dynamic, Max): 1536 MB 11:48:01 INFO - Vendor: Intel (0x8086) 11:48:01 INFO - Device ID: 0x0a2e 11:48:01 INFO - Revision ID: 0x0009 11:48:01 INFO - Displays: 11:48:01 INFO - Display: 11:48:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:48:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:48:01 INFO - Display Serial Number: 1600x1200 60 11:48:01 INFO - Main Display: Yes 11:48:01 INFO - Mirror: Off 11:48:01 INFO - Online: Yes 11:48:01 INFO - Rotation: Supported 11:48:01 INFO - Return code: 0 11:48:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:48:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:48:01 INFO - Python 2.7.3 11:48:01 INFO - Return code: 0 11:48:01 INFO - grabbing minidump binary from tooltool 11:48:01 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:01 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056d5d30>, '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 0x105539db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1056ccb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:48:01 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 11:48:01 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 11:48:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:48:01 INFO - Return code: 0 11:48:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:48:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:48:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:48:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:48:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:48:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:48:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:48:02 INFO - Return code: 0 11:48:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0388', '--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 11:48:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0388 --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 11:48:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0BST0xYy5U/Render', 11:48:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:02 INFO - 'HOME': '/Users/cltbld', 11:48:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:02 INFO - 'LOGNAME': 'cltbld', 11:48:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:48:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:02 INFO - 'MOZ_NO_REMOTE': '1', 11:48:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:48:02 INFO - 'NO_EM_RESTART': '1', 11:48:02 INFO - 'PAGER': '/bin/cat', 11:48:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:02 INFO - 'PWD': '/builds/slave/test', 11:48:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:48:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:02 INFO - 'SHELL': '/bin/bash', 11:48:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I88PAs22zr/Listeners', 11:48:02 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 11:48:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:02 INFO - 'USER': 'cltbld', 11:48:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:02 INFO - 'XPC_FLAGS': '0x0', 11:48:02 INFO - 'XPC_SERVICE_NAME': '0', 11:48:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:48:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0388', '--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 11:48:02 INFO - mozversion application_buildid: 20160519093943 11:48:02 INFO - mozversion application_changeset: f9c0368a28b144d9b0a7b87f100ea9f471b619c0 11:48:02 INFO - mozversion application_display_name: Firefox 11:48:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:48:02 INFO - mozversion application_name: Firefox 11:48:02 INFO - mozversion application_remotingname: firefox 11:48:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:48:02 INFO - mozversion application_vendor: Mozilla 11:48:02 INFO - mozversion application_version: 47.0 11:48:02 INFO - mozversion platform_buildid: 20160519093943 11:48:02 INFO - mozversion platform_changeset: f9c0368a28b144d9b0a7b87f100ea9f471b619c0 11:48:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:48:02 INFO - mozversion platform_version: 47.0 11:48:02 INFO - using testdate: 1463683682 11:48:02 INFO - actual date: 1463683682 11:48:02 INFO - starting webserver on 'localhost:49274' 11:48:02 INFO - SUITE-START | Running 2 tests 11:48:02 INFO - TEST-START | dromaeo_css 11:48:02 INFO - operating with platform_type : mac_ 11:48:02 INFO - Initialising browser for dromaeo_css test... 11:48:02 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/tmpGbghRD/profile http://localhost:49274/getInfo.html) 11:48:05 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 11:48:05 INFO - PROCESS | 1660 | colorDepth:24 11:48:05 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 11:48:05 INFO - PROCESS | 1660 | __metrics 11:48:05 ERROR - PROCESS | 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 11:48:06 INFO - TEST-INFO | 1660: exit 0 11:48:06 INFO - Browser initialized. 11:48:06 INFO - Running cycle 1/1 for dromaeo_css test... 11:48:06 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/tmpGbghRD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:48:17 INFO - PROCESS | 1664 | RSS: Main: 168042496 11:48:17 INFO - PROCESS | 1664 | 11:49:07 INFO - PROCESS | 1664 | 1463683747608 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:51:17 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 11:51:18 INFO - PROCESS | 1664 | RSS: Main: 179953664 11:51:18 INFO - PROCESS | 1664 | 11:54:20 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 11:54:21 INFO - PROCESS | 1664 | RSS: Main: 190119936 11:54:21 INFO - PROCESS | 1664 | 11:57:23 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 11:57:23 INFO - PROCESS | 1664 | RSS: Main: 192102400 11:57:23 INFO - PROCESS | 1664 | 12:00:25 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 12:00:25 INFO - PROCESS | 1664 | RSS: Main: 195219456 12:00:25 INFO - PROCESS | 1664 | 12:03:28 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 12:03:29 INFO - PROCESS | 1664 | RSS: Main: 194506752 12:03:29 INFO - PROCESS | 1664 | 12:06:31 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 12:06:31 INFO - PROCESS | 1664 | RSS: Main: 199692288 12:06:31 INFO - PROCESS | 1664 | 12:06:31 INFO - PROCESS | 1664 | __start_tp_report 12:06:31 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 12:06:31 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 12:06:31 INFO - PROCESS | 1664 | |i|pagename|runs| 12:06:31 INFO - PROCESS | 1664 | |0;dojo.html;3118.345147519021;3705.851765929363;3711.294853977745;3736.1406876418405;3743.9812800936006;5986.401359864017;5992.7902523411685;5993.550483713728;5994.760209591622;6008.369121242261;5960.6423614583155;6028.668423236721;6035.366286539916;6046.727897244624;6056.757729690807;5355.544778693806;5385.488378604046;5408.756605952722;5459.617826752129;5503.862403439906;4354.390385346054;5409.756560954766;5416.51251387375;5424.159255315432;5432.967736130143;5417.64785288957;5474.72626368682;5479.397266300703;5484;5509.421510741375;5343.278657381243;5363.517283444469;5367.946320536803;5383.300170977767;5396.811111611075;4328.610425061728;5213.2701421800975;5233.476652334774;5290;5345.679259244458;5294.285271488338;5681.204631351614;5689.374168841424;5777.335606405275;5780.913286300667;5284.4187139414635;6251.249850018027;6261.311255761862;6272.5922815016875;6322.9051564226575;6208.844778880519;6256.15541901842;6340.968295158495;6354.586951848115;6364.936350636481;4997.85006449807;6005.399460054004;6020.819375418744;6087.4521293083835;6107.816765497042;5442.863928401822;6507.869842603216;6526.804195874131;6535.183102112236;6563.803085907431;5846.123081537803;5875.706214689249;6224.533160013018;6225.28409232944;6269.843253918597;6319.210098737658;6353.491720662336;6354.205724284465;6358.650274234961;6361.554691171574;5348.8662783429945;6247.812565623039;6277.560570760094;6292.276388215322;6307.590006649553;6191.535634827406;6227.595206311576;6230.190075290183;6272.372762723691;6273.780417685359;4975.776090075883;5030.924536131961;5034.219695947134;5040.84877453677;5046.167382381939;4545.045540436546;4554.749488778149;4562.954370456319;4564.087182563434;4570.657200709894;5868.295804503487;5934.287885453773;6067.787627433018;6078.027515597483;6141.907871381933;6343.5876668016435;6359.586626869239;6365.2361716594305;6370.968145159337;6376.872462550723;6113.20528331323;6137.570370074052;6164.660943648142;6173.536984726164;6177.1969643945995;5428.104362780097;5512.80705175317;5516.338039435213;5552.444755524415;5584.832455026356;6561.573497722633;6573.3098024706715;6605.9009114864275;6617.669116544153;6622.304658010936;6236.937630623817;6381.93618063832;6393.328700486382;6399.04014397844;6406.071119687526;6454.709538070704;6549.639769812516;6551.934480655323;6553.967230163818;6591.736330546724;6295.653739044396;6313.2424109107205;6316.905246421215;6328.145700330397;6332.620042797447;6196.1015652731;6249.593776404519;6310.148130002574;6327.778527751507;6329;6212.099245609452;6282.717277722422;6287.748490060347;6322.272938612118;6334.778282760081;6257.655828929453;6258.186435763321;6297.4017468340435;6308.747650093945;6322.178116844781;5250.89498210026;5698.857528561653;6100.267967843887;6132.600268413531;6178.196834411498;4866.367372241586;5017.924731129109;5321.855801002803;6042.2749270086115;6308.558400911892;5373.516383525502;6194.752209911553;6207.96896015517;6214.40963108504;6234.625922444668 12:06:31 INFO - PROCESS | 1664 | |1;ext.html;542.5659472422061;597.5249676507174;600.8918394688956;622.3962756126562;678.1556961582828;38644.420333695016;39157;39461.80269098651;39462.40806387906;39678.60321396785;41412.58587414125;41670.791646041806;41955.79022104893;42010.369844452354;42059.57940420602;8321.16788321169;9578.521073946293;9714;9830.803383932318;9857.852132217986;9653.951730241339;9767.120959113678;9892;9897.208223342115;9934.105930466256;9867.60529578816;9909.95045024774;9940.502974851264;9942.950285248564;9958.004199580057;9805.705828825146;9840.852387214198;9872.259580531489;9924.404535727806;9928.851067233998;9766.316357854954;9797.216222702167;9888.851667224997;9911.950440247825;9973.750656233653;39933.80033099845;40092.398614020814;40236;40429.59570404288;40510.392344114865;3307;3431.0907609483506;3484.790912545255;3502.6497350265026;3546.4503002034726;28995.85502072476;29863.701362986525;29932;30228.546571801442;30407.783688652427;2799.1602519244148;2808.8455134967567;2828.1232817826335;2834.702356252584;2842.6873043965147;426116;452559;511917;512993;517024;48907.26639100417;73331.63334183295;73341.6332918332;73469;73627;50176.99646007059;50430.49569504258;50540.49459505431;50676.74661626742;50862.491375086516;17948.461546153638;18010.90994545019;18204.36284730028;18410.895346279267;18430.98629575386;14264.500742473963;14348.139111653334;14394.784078238834;14694.779578306334;14772.704545909022;12761.170523915916;15338.233088345538;15649.530514084596;15657.29542170605;15730.449434269745;6481.805545833632;6692.59844409337;6694.330566943267;6698.8995165072565;6704.530682852251;965.792354643755;1057.3188630078212;1065.3181963543338;1066.5573786878513;1142.5772464188303;30640.92756753503;30944.07167784925;31014.379712405625;31254.843725781226;31495;1107.8781334053247;1234.456838990841;1240.0079936051122;1280.5838102616688;1297.688554746854;15118.546443606709;15728.898977071723;15822;15843.683126337408;16008;462718;466299;467228;467783;469484;62989.68505157445;63259;63693.36306636967;63879.041814372824;63895;1515.9621009474631;1528.0907859823387;1556.4241230744697;1556.5019193858084;1568.4980806141925;29904.551431728105;30471.536916574558;30698.846505767327;30806.2154206002;30906.53640195444;49044.509554905424;49895.75052124716;50115;50196.745081371795;50346;422789;424992;429127;429830;430378;29568.852155739944;35933.92198234057;50053.49946500634;51114.48885511246;52215.47784522106;48295.75852120717;48484.54546363615;49452.50547494479;49926;50522.989540208255;39234.607653924235;39545.406818897165;39581.40627890641;40028.799856000536;40049.59950400459;38404.039899002746;38650.8404747858;39062.21875562416;39452.80273598729;39888;31002.68997309998;35025.64974350224;40672.98317542085;41627;42234.36648450337;27897;31842.6815731849;32066.839665801523;33023.50464742983;33123.33753324968;26143.346416339744;26415.471690566465;26795;26857.731422686305;26940.86529567418 12:06:31 INFO - PROCESS | 1664 | |2;jquery.html;349.74964501905686;364.81029864470474;371.74906937816985;378.75570257184114;388.4639197906888;14743.48397806077;19910.610726712795;20400;20591.176352945902;20623.76257424554;17160.656786864256;21244.8937755311;21615.783842161574;21826.345209643736;22300.442488937784;5957.225560677106;6172.351903050182;6205.720742566573;6205.782797602084;6211.285702144243;4660.6504512161555;6120.571559990803;6888.035675005503;6899.62052087135;6912.205096413926;6813.080234168398;6814.182298124208;6815.148106486689;6832.863342733142;6840.931590684104;5711.286089238845;5866.20806191163;5909.4090590941;6000.339962604132;6028.819135425944;5533.391326954032;5662.348829884575;5675.9432405675825;5717.371089180187;5720.141978703186;12088.637340879788;14207.78688319676;14416.855831441657;22949.426264343358;26237.606435903286;2183.2358674463812;2269.614165591853;2313.3291345509783;2325;2672.4655068986085;10116.443595602239;10297.485125743682;10491.213159013028;10599.788004239948;11850;1751.9386821461187;1785.1520527749215;1808.7558179645712;1821.9362322318789;1859.9070046497757;103634;108987;110436.4478177612;111267.88732112656;113978;11452.942735286437;11476.254043487146;11839.763204735857;11844.230125041844;11911.10666700001;14507.564773056825;14617.122972621677;14628;14638.780418293734;14654.780178297335;9144.039875813078;9219.585118669676;9261.675841345655;9281.48951807657;9358.344915855962;9506.301733913391;9536.28477864163;9567.90432095684;9663;9727.416355018722;3860.7104467165077;4561.407017087758;4667.8599642010795;4678.578927896506;4686.461056978423;1927.11352777721;1942.2519732240814;1965.7837637859825;1991.5519008223323;2006.5184355754513;952.8761261036021;988.5897352598735;990.9454979976026;1026.2303272545591;1103.3545375954996;21254.36236912895;21760.238391656218;21962.670559941613;22224.666630000564;22241.030798490356;1021.5658345203259;1033.1992705653029;1041.3023274406166;1052.5737076484036;1077.0468135699805;11634.94182529082;11817.940910295394;11831.585894493823;11839.348835814113;11856.992155666692;620389;620478;638388.8080559567;656817;661800;111296;121084;127581;130023;130652;1015.3653966271081;1022.4070039377143;1030.927835051538;1044.4882007816116;1047.2669131607904;18347.082645867387;18816.341428049953;18995.525111872314;19007.23971041198;19237.03814809226;39667.801660991514;45616.54383456123;47939.8839075459;51728.22407663813;52993;62202;64843;72320.63839680768;74304.62847685727;75946;6498.74005039812;6560.967195163994;8177.304929081095;8294.212049855254;8350.791230219293;10431.634892778717;13337.799933001206;13508.729825403634;13526.18842869431;13674.93162534181;11214.327140371604;11484.138689598147;11484.827727583926;11537.596184133516;11797.29216247028;10349;10829.620963266249;11553.711157221136;11620.6513804586;11886.583969561023;11412.714682133013;11420.94289528547;11588.478518466858;11635.301881887113;11877.287362758263;8232.300254478436;8386.790330241793;8398.580070996304;8478.3641226907;8565.95717021411;9330.206932410549;9955.601775928882;10968.890311097106;11106.666799996014;11389.145814064144 12:06:31 INFO - PROCESS | 1664 | |3;mootools.html;1475.3582191746589;1632;1963.312840505823;2093.905774240159;2111.4826867417487;8394.874076888836;9028.322875784326;9135.08649135087;9342.626294948193;9365;9092;9097.454152750823;9131.77170570736;9193.40242884212;9229.35394522382;2552.1960582416573;2564.7050589182204;2575.304667739709;2580.9096681616147;2585.61215817627;2529.7090834553987;2593.870306484668;2595.8578225580777;2600.9089681861137;2610.843349399033;2568.2808813532242;2584.8836802343844;2586.237060067285;2598.012755153039;2611.830231034977;2565.589505679092;2566.2686134451683;2569.820112592119;2581.7676409123173;2598.636190933271;2552.974470255292;2557.6163575463643;2587.5083734090463;2599.350162459385;2602.856842873641;9238.630454781867;9282.675106371313;9319.76700582484;9333.06669333068;9351.812963740687;5770.336411312711;5825.592208545403;5888.558358123115;5944.762209511614;5964.194833697482;3674.0998455378335;3758.849646014156;3782.3569993101237;3820.102275965146;3826.751261168043;1071.7642118733866;1081.5241293830688;1088.0588291128197;1115.219346457483;1135.483355073448;12253.264804111692;12588.05589580785;12617.053720970964;12672.112952093357;12687.365631718469;4938.333325001079;5107.259447380184;5127.282180494733;5148.382194136652;5160.251763494272;10477.47612619366;10532.526036328383;10537.57849686004;10595.417252051056;10692.251542392114;5608.579356548275;5610.4670056344585;5696.060150075274;5737.110747834093;5835.941640583625;3935.114599215211;4466.307722303049;4726.172919739032;5091.66904151229;5218.582513398919;4119.958800411958;4147.95638970476;4153.460050193456;4173.937390939138;4195.664346852244;1356.3828458051562;1383.4604504243352;1389.9151273090365;1390.332640332646;1390.9374078166506;1210.2375503432957;1220;1414.9292535373397;1434.791955166495;1445.0173881760504;8647.264982476434;8697.391182617155;8873.467591944374;8876;8899.377043607015;1270.4156088199531;1277.7508385864667;1289.6195622291445;1303.2636560343376;1318.4726109556063;6416.101745755598;6480.092787009822;6535.607863528204;6584.5061620378665;6682.599044057372;9000.819983600291;10829.566817327377;11179.273347232403;11211.887881121247;11351.60269390584;10798.352098874093;11084.445777711082;11174.553017879356;11271.09831213501;11383.14626403023;8748.168923952342;8780.912190878009;8782.648694052294;8828.51443170619;8928.866067009;8232.300254478436;8246.628901699318;8334.958325208578;8393.580320983805;8402.621882015446;9747.025297470196;10033.949830250802;10064.194864410976;10083.697489075339;10095.798084038131;10239.283250172715;10369.429681367597;10471.685849424224;10531;10602.416867072385;6787.694553744995;6914.481413893877;7222.09723784527;7309.634518273959;7533.209013053551;7997.480163789335;8635.568221589021;8702;8706.695265665672;8734.257588104829;7548.396128309612;7723.691052357843;7763.301302882542;7780.455368124177;7834.921650783419;7587.013688220496;7640.121386040676;7645.5794931279315;7676.961615191888;7740.14858365568;8026;8070.0719417267765;8180.386471014579;8219.465734727224;8225.95887020561;7328.890066649111;7386.224446433047;7481.4014878808475;7485.925140748523;7500.36246919018;7525.096988361432;7545.396368290633;7590.20302868213;7619;7629.7329593463965 12:06:31 INFO - PROCESS | 1664 | |4;prototype.html;340.58788865472775;342.31536926147703;345.97924124552543;347.57075012359746;350.2661923270747;6904.8273793155195;6910.89633655495;6916.58500489971;6930.272321406249;6944.305569443053;6860.622665753382;6871.38157565819;6905.3094690530925;6917.13535808024;6921.723131074751;4844;4974.403071631409;5054.747262636872;5077.263796749469;5152.43323234443;5059.4181669107975;5079;5093.414257360396;5094.566961808251;5100.974495127519;5038.546530812227;5063.696178229299;5116.948830511703;5119.744012799364;5141.5886729061585;5115.10485665009;5144.871378215537;5145.176771716526;5147.124988751883;5148.974255128738;4367.847125350598;4378.430803995492;4389.582989615981;4399.142167277382;4415.094905544388;6460.870782584369;6653.500987425962;6673.799786006428;6673.933260667428;6695.46436285096;4744.572988431023;5221.39953905302;5649.067903795869;6042.335343112254;6093.177421048191;5944.970275148597;7304.342609165147;7364.852702945911;7381.66782494789;7384.593847338394;4867.172580661296;4870.220764677634;4875.804967801284;4885.2916327132725;4890.73100979446;7425.183229844767;7801.765947021541;7806.102298235662;7841.137474877759;7873.094594121692;3834.750741201813;4768.189407800683;4926.211806111005;4928.950710492921;4940.6788558743565;5011.874703132451;5019.52314530119;5020.497950205024;5022.949770502321;5029.371328583927;5959;5965.373635768182;5967.522598192221;5976.491998180117;5992.520598352121;7301.2333704961275;7334.853302933911;7371.410287177013;7383.778486645409;7483.513571617827;1527.2211172302207;1564.2257082744115;1703.769991051217;1720.872828297467;1754.561359660085;1131.7396998690347;1136.1251836086333;1148.8449059376876;1149.3908228638834;1150.1373969522858;5362.436944120889;6182.010878259457;6305.211848518935;6956.5478243913985;6978.965105174441;7640.80897977555;7647.235276472419;7651.464397492234;7670.846583068307;7701.422393320523;6889;6945.756898508528;6962.094927659372;6962.547434416848;6969.163700355888;3580.6240344763946;4037.354023356249;4073.348264277701;4083.7549747015273;4094.1402305516176;6810.455163586901;7960.323372513285;8060.798480038046;8061.959690201629;8102;7924.881126783102;7925.960370198112;7946.801329966797;7948.205179482121;7948.721794737272;8170.7957301067945;8198.795030124174;8204.892339534206;8208.835823283502;8214.26071653554;7545.773626791205;7810.016891385548;7817.218278172138;7834.921650783647;7868.095169055632;7596.734114305973;7626.428017898569;7626.428017898569;7629.046369203849;7640.8471830564185;8052.396070294634;8172.877406839021;8174.959125204336;8178.223068808454;8186.222308880647;4173.833046678099;5015.924761128513;5019.648624596243;5024.171011783015;5026.346574945233;7426.888596670946;7726.845463090819;7730.574818385043;7742.187070357531;7782.961085194538;7474.177840437439;7510.361619262424;7557.622118894144;7611;7616.04799400075;7500;7522.661480233293;7528.247175282428;7540.359069479156;7558.735444259424;6995.720171193096;7293.671784769592;7304.780856574312;7326.04761381017;7359.080114985627;5575.358833734011;6583.473322134314;7516.887246691414;7573.129090154703;7573.886391704239;7325.267473252845;7341;7344;7347.26527347261;7371.8157046074275 12:06:31 INFO - PROCESS | 1664 | |5;yui.html;685.5406877392147;694.4270976444435;780.2626517940548;785.5012067337241;803.6303300481776;15500.922495387522;15764.132972686526;15770.605734856634;15801.288941997609;15807.288672009758;14648.85351146491;14662;14704.338304776284;14744.189069601167;14759.557213283591;797.2983774278626;971.9222462203007;979.3878825733916;980.3725615606018;982.990170098297;939.4598106088991;989.48546755687;1003.282652903174;1003.5383723487205;1004.8743907011624;888.7911340834931;1024.4263212600968;1039.833626619741;1044.8171569975261;1052.7789164275512;1022.9795404091876;1028.5834237133972;1050.5955207245227;1050.9211809114347;1051.295631926611;672.6401375264259;765.873630850909;766.172533663642;789.7038610521055;792.3898598079446;15248.695026099527;15492.380304787795;15530;15555.98886072413;15649.765253521206;11123.777524449466;13033.674158146028;13450.529231476852;13479.191248525021;13607.624893503591;10155.593776248941;10445;10474.895251047468;10514.474276286155;10585.894141058568;3142.1987393214813;3625.220577575834;3760.4735337052834;3770.830312635938;3903.1413089120347;83872.58063709704;84031.5798421004;84092.15907840905;84305.99999999939;84368.31263374699;7965.800854978672;9696.0788725071;9747.707568772948;9840.458774767456;9844;21297.78702212989;21676.024578893986;22035.228766993077;22094;22347;7852.5288482690075;7997.240262175084;8036.839263214703;8117.147699491468;8170.305524030524;4256.7445953242905;4275.0594869128745;4342.848000319974;4374.650027997753;4497.3254011897825;3724.1062145084984;3725.850965961331;3743.9251214975548;3791.829367678461;3802.16352402471;609.2840911928466;667.7529314153794;671.53328436736;676.3540818518303;678.0541145102554;613.2640831002815;617.8053913017385;624.4785604020602;626.1359324132668;645.9515536334794;8453.408261421642;8490.023647280519;8523.105073967268;8554.486730796172;8649.697260595975;618.4959258204549;625.8060001399581;630.3759278314527;631.7757196195377;632.6235889645653;3790.450384694204;3919.118198405336;3977.443157957888;4001.7999100045463;4005.2790497710107;91905;92274.07725922654;93737.0626293742;94565.054349457;94622.5268873665;72117.63941180261;76994.23005769982;77106;78790;79988;64500;65362;65465;65630.67184664142;65901.01148482776;7465.888011679937;8690.91309086901;8692.000419951786;8770.12298770118;8865.936087669263;50373.24440133328;50869.74565127151;51516.712082198246;52057.95884082373;54125.91748165093;69861.65069174825;71916.28083719096;72716;72794.90807637783;73283;11563.479643415898;11622.70943226426;11640.53437862476;11836;11912.047036237254;9858;12332.938335308625;12367.381630918238;12541.623751287476;12938.288394138413;11691.590794322157;11942.402879856147;12078.27530348182;12105.455254513745;12218.778122188065;11730.941345293219;11926;11975.221610595283;12326.753464930473;12492;11512.424378781196;11781.293122412682;11850.111241657083;11859.644210673694;11908.34504102248;9993;10009.199264058712;10136.493175341351;10203.438810865473;10393.844092338772;9816.361936474106;10207;10324.741881453023;10343.844842327522;10348.896511034793 12:06:31 INFO - PROCESS | 1664 | __end_tp_report 12:06:31 INFO - PROCESS | 1664 | __start_cc_report 12:06:31 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,349 12:06:31 INFO - PROCESS | 1664 | __end_cc_report 12:06:31 INFO - PROCESS | 1664 | __startTimestamp1463684791328__endTimestamp 12:06:31 INFO - PROCESS | 1664 | 12:06:31 INFO - PROCESS | 1664 | ------- Summary: start ------- 12:06:31 INFO - PROCESS | 1664 | Number of tests: 6 12:06:31 INFO - PROCESS | 1664 | 12:06:31 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5844.94 Median:6113.21 stddev:664.64 (10.9%) stddev-sans-first:631.32 12:06:31 INFO - PROCESS | 1664 | Values: 3118.3 3705.9 3711.3 3736.1 3744.0 5986.4 5992.8 5993.6 5994.8 6008.4 5960.6 6028.7 6035.4 6046.7 6056.8 5355.5 5385.5 5408.8 5459.6 5503.9 4354.4 5409.8 5416.5 5424.2 5433.0 5417.6 5474.7 5479.4 5484.0 5509.4 5343.3 5363.5 5367.9 5383.3 5396.8 4328.6 5213.3 5233.5 5290.0 5345.7 5294.3 5681.2 5689.4 5777.3 5780.9 5284.4 6251.2 6261.3 6272.6 6322.9 6208.8 6256.2 6341.0 6354.6 6364.9 4997.9 6005.4 6020.8 6087.5 6107.8 5442.9 6507.9 6526.8 6535.2 6563.8 5846.1 5875.7 6224.5 6225.3 6269.8 6319.2 6353.5 6354.2 6358.7 6361.6 5348.9 6247.8 6277.6 6292.3 6307.6 6191.5 6227.6 6230.2 6272.4 6273.8 4975.8 5030.9 5034.2 5040.8 5046.2 4545.0 4554.7 4563.0 4564.1 4570.7 5868.3 5934.3 6067.8 6078.0 6141.9 6343.6 6359.6 6365.2 6371.0 6376.9 6113.2 6137.6 6164.7 6173.5 6177.2 5428.1 5512.8 5516.3 5552.4 5584.8 6561.6 6573.3 6605.9 6617.7 6622.3 6236.9 6381.9 6393.3 6399.0 6406.1 6454.7 6549.6 6551.9 6554.0 6591.7 6295.7 6313.2 6316.9 6328.1 6332.6 6196.1 6249.6 6310.1 6327.8 6329.0 6212.1 6282.7 6287.7 6322.3 6334.8 6257.7 6258.2 6297.4 6308.7 6322.2 5250.9 5698.9 6100.3 6132.6 6178.2 4866.4 5017.9 5321.9 6042.3 6308.6 5373.5 6194.8 6208.0 6214.4 6234.6 12:06:31 INFO - PROCESS | 1664 | 12:06:31 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:61711.81 Median:40332.80 stddev:122025.36 (302.5%) stddev-sans-first:122281.24 12:06:31 INFO - PROCESS | 1664 | Values: 542.6 597.5 600.9 622.4 678.2 38644.4 39157.0 39461.8 39462.4 39678.6 41412.6 41670.8 41955.8 42010.4 42059.6 8321.2 9578.5 9714.0 9830.8 9857.9 9654.0 9767.1 9892.0 9897.2 9934.1 9867.6 9910.0 9940.5 9943.0 9958.0 9805.7 9840.9 9872.3 9924.4 9928.9 9766.3 9797.2 9888.9 9912.0 9973.8 39933.8 40092.4 40236.0 40429.6 40510.4 3307.0 3431.1 3484.8 3502.6 3546.5 28995.9 29863.7 29932.0 30228.5 30407.8 2799.2 2808.8 2828.1 2834.7 2842.7 426116.0 452559.0 511917.0 512993.0 517024.0 48907.3 73331.6 73341.6 73469.0 73627.0 50177.0 50430.5 50540.5 50676.7 50862.5 17948.5 18010.9 18204.4 18410.9 18431.0 14264.5 14348.1 14394.8 14694.8 14772.7 12761.2 15338.2 15649.5 15657.3 15730.4 6481.8 6692.6 6694.3 6698.9 6704.5 965.8 1057.3 1065.3 1066.6 1142.6 30640.9 30944.1 31014.4 31254.8 31495.0 1107.9 1234.5 1240.0 1280.6 1297.7 15118.5 15728.9 15822.0 15843.7 16008.0 462718.0 466299.0 467228.0 467783.0 469484.0 62989.7 63259.0 63693.4 63879.0 63895.0 1516.0 1528.1 1556.4 1556.5 1568.5 29904.6 30471.5 30698.8 30806.2 30906.5 49044.5 49895.8 50115.0 50196.7 50346.0 422789.0 424992.0 429127.0 429830.0 430378.0 29568.9 35933.9 50053.5 51114.5 52215.5 48295.8 48484.5 49452.5 49926.0 50523.0 39234.6 39545.4 39581.4 40028.8 40049.6 38404.0 38650.8 39062.2 39452.8 39888.0 31002.7 35025.6 40673.0 41627.0 42234.4 27897.0 31842.7 32066.8 33023.5 33123.3 26143.3 26415.5 26795.0 26857.7 26940.9 12:06:31 INFO - PROCESS | 1664 | 12:06:31 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:35445.18 Median:21435.07 stddev:106052.86 (494.8%) stddev-sans-first:106317.62 12:06:31 INFO - PROCESS | 1664 | Values: 349.7 364.8 371.7 378.8 388.5 14743.5 19910.6 20400.0 20591.2 20623.8 17160.7 21244.9 21615.8 21826.3 22300.4 5957.2 6172.4 6205.7 6205.8 6211.3 4660.7 6120.6 6888.0 6899.6 6912.2 6813.1 6814.2 6815.1 6832.9 6840.9 5711.3 5866.2 5909.4 6000.3 6028.8 5533.4 5662.3 5675.9 5717.4 5720.1 12088.6 14207.8 14416.9 22949.4 26237.6 2183.2 2269.6 2313.3 2325.0 2672.5 10116.4 10297.5 10491.2 10599.8 11850.0 1751.9 1785.2 1808.8 1821.9 1859.9 103634.0 108987.0 110436.4 111267.9 113978.0 11452.9 11476.3 11839.8 11844.2 11911.1 14507.6 14617.1 14628.0 14638.8 14654.8 9144.0 9219.6 9261.7 9281.5 9358.3 9506.3 9536.3 9567.9 9663.0 9727.4 3860.7 4561.4 4667.9 4678.6 4686.5 1927.1 1942.3 1965.8 1991.6 2006.5 952.9 988.6 990.9 1026.2 1103.4 21254.4 21760.2 21962.7 22224.7 22241.0 1021.6 1033.2 1041.3 1052.6 1077.0 11634.9 11817.9 11831.6 11839.3 11857.0 620389.0 620478.0 638388.8 656817.0 661800.0 111296.0 121084.0 127581.0 130023.0 130652.0 1015.4 1022.4 1030.9 1044.5 1047.3 18347.1 18816.3 18995.5 19007.2 19237.0 39667.8 45616.5 47939.9 51728.2 52993.0 62202.0 64843.0 72320.6 74304.6 75946.0 6498.7 6561.0 8177.3 8294.2 8350.8 10431.6 13337.8 13508.7 13526.2 13674.9 11214.3 11484.1 11484.8 11537.6 11797.3 10349.0 10829.6 11553.7 11620.7 11886.6 11412.7 11420.9 11588.5 11635.3 11877.3 8232.3 8386.8 8398.6 8478.4 8566.0 9330.2 9955.6 10968.9 11106.7 11389.1 12:06:31 INFO - PROCESS | 1664 | 12:06:31 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:6356.78 Median:4832.25 stddev:3323.77 (68.8%) stddev-sans-first:3312.83 12:06:31 INFO - PROCESS | 1664 | Values: 1475.4 1632.0 1963.3 2093.9 2111.5 8394.9 9028.3 9135.1 9342.6 9365.0 9092.0 9097.5 9131.8 9193.4 9229.4 2552.2 2564.7 2575.3 2580.9 2585.6 2529.7 2593.9 2595.9 2600.9 2610.8 2568.3 2584.9 2586.2 2598.0 2611.8 2565.6 2566.3 2569.8 2581.8 2598.6 2553.0 2557.6 2587.5 2599.4 2602.9 9238.6 9282.7 9319.8 9333.1 9351.8 5770.3 5825.6 5888.6 5944.8 5964.2 3674.1 3758.8 3782.4 3820.1 3826.8 1071.8 1081.5 1088.1 1115.2 1135.5 12253.3 12588.1 12617.1 12672.1 12687.4 4938.3 5107.3 5127.3 5148.4 5160.3 10477.5 10532.5 10537.6 10595.4 10692.3 5608.6 5610.5 5696.1 5737.1 5835.9 3935.1 4466.3 4726.2 5091.7 5218.6 4120.0 4148.0 4153.5 4173.9 4195.7 1356.4 1383.5 1389.9 1390.3 1390.9 1210.2 1220.0 1414.9 1434.8 1445.0 8647.3 8697.4 8873.5 8876.0 8899.4 1270.4 1277.8 1289.6 1303.3 1318.5 6416.1 6480.1 6535.6 6584.5 6682.6 9000.8 10829.6 11179.3 11211.9 11351.6 10798.4 11084.4 11174.6 11271.1 11383.1 8748.2 8780.9 8782.6 8828.5 8928.9 8232.3 8246.6 8335.0 8393.6 8402.6 9747.0 10033.9 10064.2 10083.7 10095.8 10239.3 10369.4 10471.7 10531.0 10602.4 6787.7 6914.5 7222.1 7309.6 7533.2 7997.5 8635.6 8702.0 8706.7 8734.3 7548.4 7723.7 7763.3 7780.5 7834.9 7587.0 7640.1 7645.6 7677.0 7740.1 8026.0 8070.1 8180.4 8219.5 8226.0 7328.9 7386.2 7481.4 7485.9 7500.4 7525.1 7545.4 7590.2 7619.0 7629.7 12:06:31 INFO - PROCESS | 1664 | 12:06:31 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:6062.14 Median:6905.07 stddev:1964.81 (28.5%) stddev-sans-first:1922.82 12:06:31 INFO - PROCESS | 1664 | Values: 340.6 342.3 346.0 347.6 350.3 6904.8 6910.9 6916.6 6930.3 6944.3 6860.6 6871.4 6905.3 6917.1 6921.7 4844.0 4974.4 5054.7 5077.3 5152.4 5059.4 5079.0 5093.4 5094.6 5101.0 5038.5 5063.7 5116.9 5119.7 5141.6 5115.1 5144.9 5145.2 5147.1 5149.0 4367.8 4378.4 4389.6 4399.1 4415.1 6460.9 6653.5 6673.8 6673.9 6695.5 4744.6 5221.4 5649.1 6042.3 6093.2 5945.0 7304.3 7364.9 7381.7 7384.6 4867.2 4870.2 4875.8 4885.3 4890.7 7425.2 7801.8 7806.1 7841.1 7873.1 3834.8 4768.2 4926.2 4929.0 4940.7 5011.9 5019.5 5020.5 5022.9 5029.4 5959.0 5965.4 5967.5 5976.5 5992.5 7301.2 7334.9 7371.4 7383.8 7483.5 1527.2 1564.2 1703.8 1720.9 1754.6 1131.7 1136.1 1148.8 1149.4 1150.1 5362.4 6182.0 6305.2 6956.5 6979.0 7640.8 7647.2 7651.5 7670.8 7701.4 6889.0 6945.8 6962.1 6962.5 6969.2 3580.6 4037.4 4073.3 4083.8 4094.1 6810.5 7960.3 8060.8 8062.0 8102.0 7924.9 7926.0 7946.8 7948.2 7948.7 8170.8 8198.8 8204.9 8208.8 8214.3 7545.8 7810.0 7817.2 7834.9 7868.1 7596.7 7626.4 7626.4 7629.0 7640.8 8052.4 8172.9 8175.0 8178.2 8186.2 4173.8 5015.9 5019.6 5024.2 5026.3 7426.9 7726.8 7730.6 7742.2 7783.0 7474.2 7510.4 7557.6 7611.0 7616.0 7500.0 7522.7 7528.2 7540.4 7558.7 6995.7 7293.7 7304.8 7326.0 7359.1 5575.4 6583.5 7516.9 7573.1 7573.9 7325.3 7341.0 7344.0 7347.3 7371.8 12:06:31 INFO - PROCESS | 1664 | 12:06:31 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:18682.01 Median:4308.95 stddev:25937.67 (601.9%) stddev-sans-first:25975.23 12:06:31 INFO - PROCESS | 1664 | Values: 685.5 694.4 780.3 785.5 803.6 15500.9 15764.1 15770.6 15801.3 15807.3 14648.9 14662.0 14704.3 14744.2 14759.6 797.3 971.9 979.4 980.4 983.0 939.5 989.5 1003.3 1003.5 1004.9 888.8 1024.4 1039.8 1044.8 1052.8 1023.0 1028.6 1050.6 1050.9 1051.3 672.6 765.9 766.2 789.7 792.4 15248.7 15492.4 15530.0 15556.0 15649.8 11123.8 13033.7 13450.5 13479.2 13607.6 10155.6 10445.0 10474.9 10514.5 10585.9 3142.2 3625.2 3760.5 3770.8 3903.1 83872.6 84031.6 84092.2 84306.0 84368.3 7965.8 9696.1 9747.7 9840.5 9844.0 21297.8 21676.0 22035.2 22094.0 22347.0 7852.5 7997.2 8036.8 8117.1 8170.3 4256.7 4275.1 4342.8 4374.7 4497.3 3724.1 3725.9 3743.9 3791.8 3802.2 609.3 667.8 671.5 676.4 678.1 613.3 617.8 624.5 626.1 646.0 8453.4 8490.0 8523.1 8554.5 8649.7 618.5 625.8 630.4 631.8 632.6 3790.5 3919.1 3977.4 4001.8 4005.3 91905.0 92274.1 93737.1 94565.1 94622.5 72117.6 76994.2 77106.0 78790.0 79988.0 64500.0 65362.0 65465.0 65630.7 65901.0 7465.9 8690.9 8692.0 8770.1 8865.9 50373.2 50869.7 51516.7 52058.0 54125.9 69861.7 71916.3 72716.0 72794.9 73283.0 11563.5 11622.7 11640.5 11836.0 11912.0 9858.0 12332.9 12367.4 12541.6 12938.3 11691.6 11942.4 12078.3 12105.5 12218.8 11730.9 11926.0 11975.2 12326.8 12492.0 11512.4 11781.3 11850.1 11859.6 11908.3 9993.0 10009.2 10136.5 10203.4 10393.8 9816.4 10207.0 10324.7 10343.8 10348.9 12:06:31 INFO - PROCESS | 1664 | -------- Summary: end -------- 12:06:31 INFO - PROCESS | 1664 | 12:06:31 INFO - TEST-INFO | 1664: exit 0 12:06:31 INFO - TEST-OK | dromaeo_css | took 1109135ms 12:06:31 INFO - TEST-START | kraken 12:06:31 INFO - operating with platform_type : mac_ 12:06:31 INFO - Initialising browser for kraken test... 12:06:31 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/tmpnAGa6r/profile http://localhost:49274/getInfo.html) 12:06:34 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 12:06:34 INFO - PROCESS | 1676 | colorDepth:24 12:06:34 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 12:06:34 INFO - PROCESS | 1676 | __metrics 12:06:34 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 12:06:35 INFO - TEST-INFO | 1676: exit 0 12:06:35 INFO - Browser initialized. 12:06:35 INFO - Running cycle 1/1 for kraken test... 12:06:35 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/tmpnAGa6r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:06:47 INFO - PROCESS | 1680 | RSS: Main: 167956480 12:06:47 INFO - PROCESS | 1680 | 12:06:49 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 12:06:50 INFO - PROCESS | 1680 | RSS: Main: 179830784 12:06:50 INFO - PROCESS | 1680 | 12:06:53 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 12:06:53 INFO - PROCESS | 1680 | RSS: Main: 188755968 12:06:53 INFO - PROCESS | 1680 | 12:06:57 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 12:06:57 INFO - PROCESS | 1680 | RSS: Main: 192364544 12:06:57 INFO - PROCESS | 1680 | 12:06:59 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 12:07:00 INFO - PROCESS | 1680 | RSS: Main: 193925120 12:07:00 INFO - PROCESS | 1680 | 12:07:02 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:07:02 INFO - PROCESS | 1680 | RSS: Main: 194445312 12:07:02 INFO - PROCESS | 1680 | 12:07:05 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 12:07:06 INFO - PROCESS | 1680 | RSS: Main: 194686976 12:07:06 INFO - PROCESS | 1680 | 12:07:09 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 12:07:09 INFO - PROCESS | 1680 | RSS: Main: 194662400 12:07:09 INFO - PROCESS | 1680 | 12:07:12 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 12:07:13 INFO - PROCESS | 1680 | RSS: Main: 194736128 12:07:13 INFO - PROCESS | 1680 | 12:07:14 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:07:15 INFO - PROCESS | 1680 | RSS: Main: 194461696 12:07:15 INFO - PROCESS | 1680 | 12:07:17 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:07:17 INFO - PROCESS | 1680 | RSS: Main: 194371584 12:07:17 INFO - PROCESS | 1680 | 12:07:19 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:07:20 INFO - PROCESS | 1680 | RSS: Main: 194363392 12:07:20 INFO - PROCESS | 1680 | 12:07:23 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:07:23 INFO - PROCESS | 1680 | RSS: Main: 194420736 12:07:23 INFO - PROCESS | 1680 | 12:07:26 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:07:26 INFO - PROCESS | 1680 | RSS: Main: 194551808 12:07:26 INFO - PROCESS | 1680 | 12:07:28 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 12:07:28 INFO - PROCESS | 1680 | RSS: Main: 196198400 12:07:28 INFO - PROCESS | 1680 | 12:07:28 INFO - PROCESS | 1680 | __start_tp_report 12:07:28 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 12:07:28 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 12:07:28 INFO - PROCESS | 1680 | |i|pagename|runs| 12:07:28 INFO - PROCESS | 1680 | |0;ai-astar;127;160;120;116;117;130;115;115;116;114 12:07:28 INFO - PROCESS | 1680 | |1;audio-beat-detection;144;169;178;184;117;142;110;151;143;116 12:07:28 INFO - PROCESS | 1680 | |2;audio-dft;196;196;230;179;269;259;202;197;194;194 12:07:28 INFO - PROCESS | 1680 | |3;audio-fft;64;68;73;111;57;58;57;60;121;56 12:07:28 INFO - PROCESS | 1680 | |4;audio-oscillator;82;85;113;78;78;78;113;78;78;116 12:07:28 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;91;89;102;130;92;106;111;130;121;88 12:07:28 INFO - PROCESS | 1680 | |6;imaging-darkroom;151;146;97;97;96;95;97;97;93;151 12:07:28 INFO - PROCESS | 1680 | |7;imaging-desaturate;90;93;88;89;92;90;97;91;131;105 12:07:28 INFO - PROCESS | 1680 | |8;json-parse-financial;54;60;58;60;59;58;58;59;63;84 12:07:28 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;67;64;72;78;88;104;58;72;99;100 12:07:28 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;80;84;83;82;84;81;82;83;82;88 12:07:28 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;126;147;107;151;135;134;137;121;119;134 12:07:28 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;134;176;133;134;135;137;142;159;138;138 12:07:28 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;66;66;67;67;63;61;67;67;68;64 12:07:28 INFO - PROCESS | 1680 | __end_tp_report 12:07:28 INFO - PROCESS | 1680 | __start_cc_report 12:07:28 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,900 12:07:28 INFO - PROCESS | 1680 | __end_cc_report 12:07:28 INFO - PROCESS | 1680 | __startTimestamp1463684848828__endTimestamp 12:07:28 INFO - PROCESS | 1680 | 12:07:28 INFO - PROCESS | 1680 | ------- Summary: start ------- 12:07:28 INFO - PROCESS | 1680 | Number of tests: 14 12:07:28 INFO - PROCESS | 1680 | 12:07:28 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:123.00 Median:118.50 stddev:14.09 (11.9%) stddev-sans-first:14.87 12:07:28 INFO - PROCESS | 1680 | Values: 127.0 160.0 120.0 116.0 117.0 130.0 115.0 115.0 116.0 114.0 12:07:28 INFO - PROCESS | 1680 | 12:07:28 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:147.50 stddev:26.00 (17.6%) stddev-sans-first:27.57 12:07:28 INFO - PROCESS | 1680 | Values: 144.0 169.0 178.0 184.0 117.0 142.0 110.0 151.0 143.0 116.0 12:07:28 INFO - PROCESS | 1680 | 12:07:28 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:211.60 Median:199.50 stddev:30.47 (15.3%) stddev-sans-first:31.79 12:07:28 INFO - PROCESS | 1680 | Values: 196.0 196.0 230.0 179.0 269.0 259.0 202.0 197.0 194.0 194.0 12:07:28 INFO - PROCESS | 1680 | 12:07:28 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:72.50 Median:59.00 stddev:23.68 (40.1%) stddev-sans-first:24.92 12:07:28 INFO - PROCESS | 1680 | Values: 64.0 68.0 73.0 111.0 57.0 58.0 57.0 60.0 121.0 56.0 12:07:28 INFO - PROCESS | 1680 | 12:07:28 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:78.00 stddev:16.81 (21.6%) stddev-sans-first:17.58 12:07:28 INFO - PROCESS | 1680 | Values: 82.0 85.0 113.0 78.0 78.0 78.0 113.0 78.0 78.0 116.0 12:07:28 INFO - PROCESS | 1680 | 12:07:28 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:106.00 Median:109.00 stddev:16.51 (15.1%) stddev-sans-first:16.59 12:07:28 INFO - PROCESS | 1680 | Values: 91.0 89.0 102.0 130.0 92.0 106.0 111.0 130.0 121.0 88.0 12:07:28 INFO - PROCESS | 1680 | 12:07:28 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:112.00 Median:96.50 stddev:25.83 (26.8%) stddev-sans-first:23.22 12:07:28 INFO - PROCESS | 1680 | Values: 151.0 146.0 97.0 97.0 96.0 95.0 97.0 97.0 93.0 151.0 12:07:28 INFO - PROCESS | 1680 | 12:07:28 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:90.50 stddev:13.07 (14.4%) stddev-sans-first:13.65 12:07:28 INFO - PROCESS | 1680 | Values: 90.0 93.0 88.0 89.0 92.0 90.0 97.0 91.0 131.0 105.0 12:07:28 INFO - PROCESS | 1680 | 12:07:28 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:61.30 Median:59.50 stddev:8.29 (13.9%) stddev-sans-first:8.36 12:07:28 INFO - PROCESS | 1680 | Values: 54.0 60.0 58.0 60.0 59.0 58.0 58.0 59.0 63.0 84.0 12:07:28 INFO - PROCESS | 1680 | 12:07:28 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:80.20 Median:72.00 stddev:16.47 (22.9%) stddev-sans-first:16.76 12:07:28 INFO - PROCESS | 1680 | Values: 67.0 64.0 72.0 78.0 88.0 104.0 58.0 72.0 99.0 100.0 12:07:28 INFO - PROCESS | 1680 | 12:07:28 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:2.18 (2.6%) stddev-sans-first:2.05 12:07:28 INFO - PROCESS | 1680 | Values: 80.0 84.0 83.0 82.0 84.0 81.0 82.0 83.0 82.0 88.0 12:07:28 INFO - PROCESS | 1680 | 12:07:28 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:131.10 Median:134.50 stddev:13.21 (9.8%) stddev-sans-first:13.88 12:07:28 INFO - PROCESS | 1680 | Values: 126.0 147.0 107.0 151.0 135.0 134.0 137.0 121.0 119.0 134.0 12:07:28 INFO - PROCESS | 1680 | 12:07:28 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.60 Median:138.00 stddev:13.97 (10.1%) stddev-sans-first:14.47 12:07:28 INFO - PROCESS | 1680 | Values: 134.0 176.0 133.0 134.0 135.0 137.0 142.0 159.0 138.0 138.0 12:07:28 INFO - PROCESS | 1680 | 12:07:28 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:67.00 stddev:2.22 (3.3%) stddev-sans-first:2.35 12:07:28 INFO - PROCESS | 1680 | Values: 66.0 66.0 67.0 67.0 63.0 61.0 67.0 67.0 68.0 64.0 12:07:28 INFO - PROCESS | 1680 | -------- Summary: end -------- 12:07:28 INFO - PROCESS | 1680 | 12:07:29 INFO - TEST-INFO | 1680: exit 0 12:07:29 INFO - TEST-OK | kraken | took 57688ms 12:07:29 INFO - SUITE-END | took 1166s 12:07:29 INFO - Completed test suite (00:19:27) 12:07:29 INFO - javascript benchmark 12:07:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3118.345147519021, 3705.851765929363, 3711.294853977745, 3736.1406876418405, 3743.9812800936006, 5986.401359864017, 5992.7902523411685, 5993.550483713728, 5994.760209591622, 6008.369121242261, 5960.6423614583155, 6028.668423236721, 6035.366286539916, 6046.727897244624, 6056.757729690807, 5355.544778693806, 5385.488378604046, 5408.756605952722, 5459.617826752129, 5503.862403439906, 4354.390385346054, 5409.756560954766, 5416.51251387375, 5424.159255315432, 5432.967736130143, 5417.64785288957, 5474.72626368682, 5479.397266300703, 5484.0, 5509.421510741375, 5343.278657381243, 5363.517283444469, 5367.946320536803, 5383.300170977767, 5396.811111611075, 4328.610425061728, 5213.2701421800975, 5233.476652334774, 5290.0, 5345.679259244458, 5294.285271488338, 5681.204631351614, 5689.374168841424, 5777.335606405275, 5780.913286300667, 5284.4187139414635, 6251.249850018027, 6261.311255761862, 6272.5922815016875, 6322.9051564226575, 6208.844778880519, 6256.15541901842, 6340.968295158495, 6354.586951848115, 6364.936350636481, 4997.85006449807, 6005.399460054004, 6020.819375418744, 6087.4521293083835, 6107.816765497042, 5442.863928401822, 6507.869842603216, 6526.804195874131, 6535.183102112236, 6563.803085907431, 5846.123081537803, 5875.706214689249, 6224.533160013018, 6225.28409232944, 6269.843253918597, 6319.210098737658, 6353.491720662336, 6354.205724284465, 6358.650274234961, 6361.554691171574, 5348.8662783429945, 6247.812565623039, 6277.560570760094, 6292.276388215322, 6307.590006649553, 6191.535634827406, 6227.595206311576, 6230.190075290183, 6272.372762723691, 6273.780417685359, 4975.776090075883, 5030.924536131961, 5034.219695947134, 5040.84877453677, 5046.167382381939, 4545.045540436546, 4554.749488778149, 4562.954370456319, 4564.087182563434, 4570.657200709894, 5868.295804503487, 5934.287885453773, 6067.787627433018, 6078.027515597483, 6141.907871381933, 6343.5876668016435, 6359.586626869239, 6365.2361716594305, 6370.968145159337, 6376.872462550723, 6113.20528331323, 6137.570370074052, 6164.660943648142, 6173.536984726164, 6177.1969643945995, 5428.104362780097, 5512.80705175317, 5516.338039435213, 5552.444755524415, 5584.832455026356, 6561.573497722633, 6573.3098024706715, 6605.9009114864275, 6617.669116544153, 6622.304658010936, 6236.937630623817, 6381.93618063832, 6393.328700486382, 6399.04014397844, 6406.071119687526, 6454.709538070704, 6549.639769812516, 6551.934480655323, 6553.967230163818, 6591.736330546724, 6295.653739044396, 6313.2424109107205, 6316.905246421215, 6328.145700330397, 6332.620042797447, 6196.1015652731, 6249.593776404519, 6310.148130002574, 6327.778527751507, 6329.0, 6212.099245609452, 6282.717277722422, 6287.748490060347, 6322.272938612118, 6334.778282760081, 6257.655828929453, 6258.186435763321, 6297.4017468340435, 6308.747650093945, 6322.178116844781, 5250.89498210026, 5698.857528561653, 6100.267967843887, 6132.600268413531, 6178.196834411498, 4866.367372241586, 5017.924731129109, 5321.855801002803, 6042.2749270086115, 6308.558400911892, 5373.516383525502, 6194.752209911553, 6207.96896015517, 6214.40963108504, 6234.625922444668], "unit": "score", "name": "dojo.html", "value": 5806.510008442286}, {"lowerIsBetter": false, "replicates": [542.5659472422061, 597.5249676507174, 600.8918394688956, 622.3962756126562, 678.1556961582828, 38644.420333695016, 39157.0, 39461.80269098651, 39462.40806387906, 39678.60321396785, 41412.58587414125, 41670.791646041806, 41955.79022104893, 42010.369844452354, 42059.57940420602, 8321.16788321169, 9578.521073946293, 9714.0, 9830.803383932318, 9857.852132217986, 9653.951730241339, 9767.120959113678, 9892.0, 9897.208223342115, 9934.105930466256, 9867.60529578816, 9909.95045024774, 9940.502974851264, 9942.950285248564, 9958.004199580057, 9805.705828825146, 9840.852387214198, 9872.259580531489, 9924.404535727806, 9928.851067233998, 9766.316357854954, 9797.216222702167, 9888.851667224997, 9911.950440247825, 9973.750656233653, 39933.80033099845, 40092.398614020814, 40236.0, 40429.59570404288, 40510.392344114865, 3307.0, 3431.0907609483506, 3484.790912545255, 3502.6497350265026, 3546.4503002034726, 28995.85502072476, 29863.701362986525, 29932.0, 30228.546571801442, 30407.783688652427, 2799.1602519244148, 2808.8455134967567, 2828.1232817826335, 2834.702356252584, 2842.6873043965147, 426116.0, 452559.0, 511917.0, 512993.0, 517024.0, 48907.26639100417, 73331.63334183295, 73341.6332918332, 73469.0, 73627.0, 50176.99646007059, 50430.49569504258, 50540.49459505431, 50676.74661626742, 50862.491375086516, 17948.461546153638, 18010.90994545019, 18204.36284730028, 18410.895346279267, 18430.98629575386, 14264.500742473963, 14348.139111653334, 14394.784078238834, 14694.779578306334, 14772.704545909022, 12761.170523915916, 15338.233088345538, 15649.530514084596, 15657.29542170605, 15730.449434269745, 6481.805545833632, 6692.59844409337, 6694.330566943267, 6698.8995165072565, 6704.530682852251, 965.792354643755, 1057.3188630078212, 1065.3181963543338, 1066.5573786878513, 1142.5772464188303, 30640.92756753503, 30944.07167784925, 31014.379712405625, 31254.843725781226, 31495.0, 1107.8781334053247, 1234.456838990841, 1240.0079936051122, 1280.5838102616688, 1297.688554746854, 15118.546443606709, 15728.898977071723, 15822.0, 15843.683126337408, 16008.0, 462718.0, 466299.0, 467228.0, 467783.0, 469484.0, 62989.68505157445, 63259.0, 63693.36306636967, 63879.041814372824, 63895.0, 1515.9621009474631, 1528.0907859823387, 1556.4241230744697, 1556.5019193858084, 1568.4980806141925, 29904.551431728105, 30471.536916574558, 30698.846505767327, 30806.2154206002, 30906.53640195444, 49044.509554905424, 49895.75052124716, 50115.0, 50196.745081371795, 50346.0, 422789.0, 424992.0, 429127.0, 429830.0, 430378.0, 29568.852155739944, 35933.92198234057, 50053.49946500634, 51114.48885511246, 52215.47784522106, 48295.75852120717, 48484.54546363615, 49452.50547494479, 49926.0, 50522.989540208255, 39234.607653924235, 39545.406818897165, 39581.40627890641, 40028.799856000536, 40049.59950400459, 38404.039899002746, 38650.8404747858, 39062.21875562416, 39452.80273598729, 39888.0, 31002.68997309998, 35025.64974350224, 40672.98317542085, 41627.0, 42234.36648450337, 27897.0, 31842.6815731849, 32066.839665801523, 33023.50464742983, 33123.33753324968, 26143.346416339744, 26415.471690566465, 26795.0, 26857.731422686305, 26940.86529567418], "unit": "score", "name": "ext.html", "value": 20184.84958667646}, {"lowerIsBetter": false, "replicates": [349.74964501905686, 364.81029864470474, 371.74906937816985, 378.75570257184114, 388.4639197906888, 14743.48397806077, 19910.610726712795, 20400.0, 20591.176352945902, 20623.76257424554, 17160.656786864256, 21244.8937755311, 21615.783842161574, 21826.345209643736, 22300.442488937784, 5957.225560677106, 6172.351903050182, 6205.720742566573, 6205.782797602084, 6211.285702144243, 4660.6504512161555, 6120.571559990803, 6888.035675005503, 6899.62052087135, 6912.205096413926, 6813.080234168398, 6814.182298124208, 6815.148106486689, 6832.863342733142, 6840.931590684104, 5711.286089238845, 5866.20806191163, 5909.4090590941, 6000.339962604132, 6028.819135425944, 5533.391326954032, 5662.348829884575, 5675.9432405675825, 5717.371089180187, 5720.141978703186, 12088.637340879788, 14207.78688319676, 14416.855831441657, 22949.426264343358, 26237.606435903286, 2183.2358674463812, 2269.614165591853, 2313.3291345509783, 2325.0, 2672.4655068986085, 10116.443595602239, 10297.485125743682, 10491.213159013028, 10599.788004239948, 11850.0, 1751.9386821461187, 1785.1520527749215, 1808.7558179645712, 1821.9362322318789, 1859.9070046497757, 103634.0, 108987.0, 110436.4478177612, 111267.88732112656, 113978.0, 11452.942735286437, 11476.254043487146, 11839.763204735857, 11844.230125041844, 11911.10666700001, 14507.564773056825, 14617.122972621677, 14628.0, 14638.780418293734, 14654.780178297335, 9144.039875813078, 9219.585118669676, 9261.675841345655, 9281.48951807657, 9358.344915855962, 9506.301733913391, 9536.28477864163, 9567.90432095684, 9663.0, 9727.416355018722, 3860.7104467165077, 4561.407017087758, 4667.8599642010795, 4678.578927896506, 4686.461056978423, 1927.11352777721, 1942.2519732240814, 1965.7837637859825, 1991.5519008223323, 2006.5184355754513, 952.8761261036021, 988.5897352598735, 990.9454979976026, 1026.2303272545591, 1103.3545375954996, 21254.36236912895, 21760.238391656218, 21962.670559941613, 22224.666630000564, 22241.030798490356, 1021.5658345203259, 1033.1992705653029, 1041.3023274406166, 1052.5737076484036, 1077.0468135699805, 11634.94182529082, 11817.940910295394, 11831.585894493823, 11839.348835814113, 11856.992155666692, 620389.0, 620478.0, 638388.8080559567, 656817.0, 661800.0, 111296.0, 121084.0, 127581.0, 130023.0, 130652.0, 1015.3653966271081, 1022.4070039377143, 1030.927835051538, 1044.4882007816116, 1047.2669131607904, 18347.082645867387, 18816.341428049953, 18995.525111872314, 19007.23971041198, 19237.03814809226, 39667.801660991514, 45616.54383456123, 47939.8839075459, 51728.22407663813, 52993.0, 62202.0, 64843.0, 72320.63839680768, 74304.62847685727, 75946.0, 6498.74005039812, 6560.967195163994, 8177.304929081095, 8294.212049855254, 8350.791230219293, 10431.634892778717, 13337.799933001206, 13508.729825403634, 13526.18842869431, 13674.93162534181, 11214.327140371604, 11484.138689598147, 11484.827727583926, 11537.596184133516, 11797.29216247028, 10349.0, 10829.620963266249, 11553.711157221136, 11620.6513804586, 11886.583969561023, 11412.714682133013, 11420.94289528547, 11588.478518466858, 11635.301881887113, 11877.287362758263, 8232.300254478436, 8386.790330241793, 8398.580070996304, 8478.3641226907, 8565.95717021411, 9330.206932410549, 9955.601775928882, 10968.890311097106, 11106.666799996014, 11389.145814064144], "unit": "score", "name": "jquery.html", "value": 9661.593933343895}, {"lowerIsBetter": false, "replicates": [1475.3582191746589, 1632.0, 1963.312840505823, 2093.905774240159, 2111.4826867417487, 8394.874076888836, 9028.322875784326, 9135.08649135087, 9342.626294948193, 9365.0, 9092.0, 9097.454152750823, 9131.77170570736, 9193.40242884212, 9229.35394522382, 2552.1960582416573, 2564.7050589182204, 2575.304667739709, 2580.9096681616147, 2585.61215817627, 2529.7090834553987, 2593.870306484668, 2595.8578225580777, 2600.9089681861137, 2610.843349399033, 2568.2808813532242, 2584.8836802343844, 2586.237060067285, 2598.012755153039, 2611.830231034977, 2565.589505679092, 2566.2686134451683, 2569.820112592119, 2581.7676409123173, 2598.636190933271, 2552.974470255292, 2557.6163575463643, 2587.5083734090463, 2599.350162459385, 2602.856842873641, 9238.630454781867, 9282.675106371313, 9319.76700582484, 9333.06669333068, 9351.812963740687, 5770.336411312711, 5825.592208545403, 5888.558358123115, 5944.762209511614, 5964.194833697482, 3674.0998455378335, 3758.849646014156, 3782.3569993101237, 3820.102275965146, 3826.751261168043, 1071.7642118733866, 1081.5241293830688, 1088.0588291128197, 1115.219346457483, 1135.483355073448, 12253.264804111692, 12588.05589580785, 12617.053720970964, 12672.112952093357, 12687.365631718469, 4938.333325001079, 5107.259447380184, 5127.282180494733, 5148.382194136652, 5160.251763494272, 10477.47612619366, 10532.526036328383, 10537.57849686004, 10595.417252051056, 10692.251542392114, 5608.579356548275, 5610.4670056344585, 5696.060150075274, 5737.110747834093, 5835.941640583625, 3935.114599215211, 4466.307722303049, 4726.172919739032, 5091.66904151229, 5218.582513398919, 4119.958800411958, 4147.95638970476, 4153.460050193456, 4173.937390939138, 4195.664346852244, 1356.3828458051562, 1383.4604504243352, 1389.9151273090365, 1390.332640332646, 1390.9374078166506, 1210.2375503432957, 1220.0, 1414.9292535373397, 1434.791955166495, 1445.0173881760504, 8647.264982476434, 8697.391182617155, 8873.467591944374, 8876.0, 8899.377043607015, 1270.4156088199531, 1277.7508385864667, 1289.6195622291445, 1303.2636560343376, 1318.4726109556063, 6416.101745755598, 6480.092787009822, 6535.607863528204, 6584.5061620378665, 6682.599044057372, 9000.819983600291, 10829.566817327377, 11179.273347232403, 11211.887881121247, 11351.60269390584, 10798.352098874093, 11084.445777711082, 11174.553017879356, 11271.09831213501, 11383.14626403023, 8748.168923952342, 8780.912190878009, 8782.648694052294, 8828.51443170619, 8928.866067009, 8232.300254478436, 8246.628901699318, 8334.958325208578, 8393.580320983805, 8402.621882015446, 9747.025297470196, 10033.949830250802, 10064.194864410976, 10083.697489075339, 10095.798084038131, 10239.283250172715, 10369.429681367597, 10471.685849424224, 10531.0, 10602.416867072385, 6787.694553744995, 6914.481413893877, 7222.09723784527, 7309.634518273959, 7533.209013053551, 7997.480163789335, 8635.568221589021, 8702.0, 8706.695265665672, 8734.257588104829, 7548.396128309612, 7723.691052357843, 7763.301302882542, 7780.455368124177, 7834.921650783419, 7587.013688220496, 7640.121386040676, 7645.5794931279315, 7676.961615191888, 7740.14858365568, 8026.0, 8070.0719417267765, 8180.386471014579, 8219.465734727224, 8225.95887020561, 7328.890066649111, 7386.224446433047, 7481.4014878808475, 7485.925140748523, 7500.36246919018, 7525.096988361432, 7545.396368290633, 7590.20302868213, 7619.0, 7629.7329593463965], "unit": "score", "name": "mootools.html", "value": 5208.132193507341}, {"lowerIsBetter": false, "replicates": [340.58788865472775, 342.31536926147703, 345.97924124552543, 347.57075012359746, 350.2661923270747, 6904.8273793155195, 6910.89633655495, 6916.58500489971, 6930.272321406249, 6944.305569443053, 6860.622665753382, 6871.38157565819, 6905.3094690530925, 6917.13535808024, 6921.723131074751, 4844.0, 4974.403071631409, 5054.747262636872, 5077.263796749469, 5152.43323234443, 5059.4181669107975, 5079.0, 5093.414257360396, 5094.566961808251, 5100.974495127519, 5038.546530812227, 5063.696178229299, 5116.948830511703, 5119.744012799364, 5141.5886729061585, 5115.10485665009, 5144.871378215537, 5145.176771716526, 5147.124988751883, 5148.974255128738, 4367.847125350598, 4378.430803995492, 4389.582989615981, 4399.142167277382, 4415.094905544388, 6460.870782584369, 6653.500987425962, 6673.799786006428, 6673.933260667428, 6695.46436285096, 4744.572988431023, 5221.39953905302, 5649.067903795869, 6042.335343112254, 6093.177421048191, 5944.970275148597, 7304.342609165147, 7364.852702945911, 7381.66782494789, 7384.593847338394, 4867.172580661296, 4870.220764677634, 4875.804967801284, 4885.2916327132725, 4890.73100979446, 7425.183229844767, 7801.765947021541, 7806.102298235662, 7841.137474877759, 7873.094594121692, 3834.750741201813, 4768.189407800683, 4926.211806111005, 4928.950710492921, 4940.6788558743565, 5011.874703132451, 5019.52314530119, 5020.497950205024, 5022.949770502321, 5029.371328583927, 5959.0, 5965.373635768182, 5967.522598192221, 5976.491998180117, 5992.520598352121, 7301.2333704961275, 7334.853302933911, 7371.410287177013, 7383.778486645409, 7483.513571617827, 1527.2211172302207, 1564.2257082744115, 1703.769991051217, 1720.872828297467, 1754.561359660085, 1131.7396998690347, 1136.1251836086333, 1148.8449059376876, 1149.3908228638834, 1150.1373969522858, 5362.436944120889, 6182.010878259457, 6305.211848518935, 6956.5478243913985, 6978.965105174441, 7640.80897977555, 7647.235276472419, 7651.464397492234, 7670.846583068307, 7701.422393320523, 6889.0, 6945.756898508528, 6962.094927659372, 6962.547434416848, 6969.163700355888, 3580.6240344763946, 4037.354023356249, 4073.348264277701, 4083.7549747015273, 4094.1402305516176, 6810.455163586901, 7960.323372513285, 8060.798480038046, 8061.959690201629, 8102.0, 7924.881126783102, 7925.960370198112, 7946.801329966797, 7948.205179482121, 7948.721794737272, 8170.7957301067945, 8198.795030124174, 8204.892339534206, 8208.835823283502, 8214.26071653554, 7545.773626791205, 7810.016891385548, 7817.218278172138, 7834.921650783647, 7868.095169055632, 7596.734114305973, 7626.428017898569, 7626.428017898569, 7629.046369203849, 7640.8471830564185, 8052.396070294634, 8172.877406839021, 8174.959125204336, 8178.223068808454, 8186.222308880647, 4173.833046678099, 5015.924761128513, 5019.648624596243, 5024.171011783015, 5026.346574945233, 7426.888596670946, 7726.845463090819, 7730.574818385043, 7742.187070357531, 7782.961085194538, 7474.177840437439, 7510.361619262424, 7557.622118894144, 7611.0, 7616.04799400075, 7500.0, 7522.661480233293, 7528.247175282428, 7540.359069479156, 7558.735444259424, 6995.720171193096, 7293.671784769592, 7304.780856574312, 7326.04761381017, 7359.080114985627, 5575.358833734011, 6583.473322134314, 7516.887246691414, 7573.129090154703, 7573.886391704239, 7325.267473252845, 7341.0, 7344.0, 7347.26527347261, 7371.8157046074275], "unit": "score", "name": "prototype.html", "value": 5406.5733060091725}, {"lowerIsBetter": false, "replicates": [685.5406877392147, 694.4270976444435, 780.2626517940548, 785.5012067337241, 803.6303300481776, 15500.922495387522, 15764.132972686526, 15770.605734856634, 15801.288941997609, 15807.288672009758, 14648.85351146491, 14662.0, 14704.338304776284, 14744.189069601167, 14759.557213283591, 797.2983774278626, 971.9222462203007, 979.3878825733916, 980.3725615606018, 982.990170098297, 939.4598106088991, 989.48546755687, 1003.282652903174, 1003.5383723487205, 1004.8743907011624, 888.7911340834931, 1024.4263212600968, 1039.833626619741, 1044.8171569975261, 1052.7789164275512, 1022.9795404091876, 1028.5834237133972, 1050.5955207245227, 1050.9211809114347, 1051.295631926611, 672.6401375264259, 765.873630850909, 766.172533663642, 789.7038610521055, 792.3898598079446, 15248.695026099527, 15492.380304787795, 15530.0, 15555.98886072413, 15649.765253521206, 11123.777524449466, 13033.674158146028, 13450.529231476852, 13479.191248525021, 13607.624893503591, 10155.593776248941, 10445.0, 10474.895251047468, 10514.474276286155, 10585.894141058568, 3142.1987393214813, 3625.220577575834, 3760.4735337052834, 3770.830312635938, 3903.1413089120347, 83872.58063709704, 84031.5798421004, 84092.15907840905, 84305.99999999939, 84368.31263374699, 7965.800854978672, 9696.0788725071, 9747.707568772948, 9840.458774767456, 9844.0, 21297.78702212989, 21676.024578893986, 22035.228766993077, 22094.0, 22347.0, 7852.5288482690075, 7997.240262175084, 8036.839263214703, 8117.147699491468, 8170.305524030524, 4256.7445953242905, 4275.0594869128745, 4342.848000319974, 4374.650027997753, 4497.3254011897825, 3724.1062145084984, 3725.850965961331, 3743.9251214975548, 3791.829367678461, 3802.16352402471, 609.2840911928466, 667.7529314153794, 671.53328436736, 676.3540818518303, 678.0541145102554, 613.2640831002815, 617.8053913017385, 624.4785604020602, 626.1359324132668, 645.9515536334794, 8453.408261421642, 8490.023647280519, 8523.105073967268, 8554.486730796172, 8649.697260595975, 618.4959258204549, 625.8060001399581, 630.3759278314527, 631.7757196195377, 632.6235889645653, 3790.450384694204, 3919.118198405336, 3977.443157957888, 4001.7999100045463, 4005.2790497710107, 91905.0, 92274.07725922654, 93737.0626293742, 94565.054349457, 94622.5268873665, 72117.63941180261, 76994.23005769982, 77106.0, 78790.0, 79988.0, 64500.0, 65362.0, 65465.0, 65630.67184664142, 65901.01148482776, 7465.888011679937, 8690.91309086901, 8692.000419951786, 8770.12298770118, 8865.936087669263, 50373.24440133328, 50869.74565127151, 51516.712082198246, 52057.95884082373, 54125.91748165093, 69861.65069174825, 71916.28083719096, 72716.0, 72794.90807637783, 73283.0, 11563.479643415898, 11622.70943226426, 11640.53437862476, 11836.0, 11912.047036237254, 9858.0, 12332.938335308625, 12367.381630918238, 12541.623751287476, 12938.288394138413, 11691.590794322157, 11942.402879856147, 12078.27530348182, 12105.455254513745, 12218.778122188065, 11730.941345293219, 11926.0, 11975.221610595283, 12326.753464930473, 12492.0, 11512.424378781196, 11781.293122412682, 11850.111241657083, 11859.644210673694, 11908.34504102248, 9993.0, 10009.199264058712, 10136.493175341351, 10203.438810865473, 10393.844092338772, 9816.361936474106, 10207.0, 10324.741881453023, 10343.844842327522, 10348.896511034793], "unit": "score", "name": "yui.html", "value": 7199.730546726494}], "name": "dromaeo_css", "value": 7825.108184987333}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [127.0, 160.0, 120.0, 116.0, 117.0, 130.0, 115.0, 115.0, 116.0, 114.0], "unit": "score", "name": "ai-astar", "value": 123.0}, {"lowerIsBetter": true, "replicates": [144.0, 169.0, 178.0, 184.0, 117.0, 142.0, 110.0, 151.0, 143.0, 116.0], "unit": "score", "name": "audio-beat-detection", "value": 145.4}, {"lowerIsBetter": true, "replicates": [196.0, 196.0, 230.0, 179.0, 269.0, 259.0, 202.0, 197.0, 194.0, 194.0], "unit": "score", "name": "audio-dft", "value": 211.6}, {"lowerIsBetter": true, "replicates": [64.0, 68.0, 73.0, 111.0, 57.0, 58.0, 57.0, 60.0, 121.0, 56.0], "unit": "score", "name": "audio-fft", "value": 72.5}, {"lowerIsBetter": true, "replicates": [82.0, 85.0, 113.0, 78.0, 78.0, 78.0, 113.0, 78.0, 78.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 89.9}, {"lowerIsBetter": true, "replicates": [91.0, 89.0, 102.0, 130.0, 92.0, 106.0, 111.0, 130.0, 121.0, 88.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 106.0}, {"lowerIsBetter": true, "replicates": [151.0, 146.0, 97.0, 97.0, 96.0, 95.0, 97.0, 97.0, 93.0, 151.0], "unit": "score", "name": "imaging-darkroom", "value": 112.0}, {"lowerIsBetter": true, "replicates": [90.0, 93.0, 88.0, 89.0, 92.0, 90.0, 97.0, 91.0, 131.0, 105.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [54.0, 60.0, 58.0, 60.0, 59.0, 58.0, 58.0, 59.0, 63.0, 84.0], "unit": "score", "name": "json-parse-financial", "value": 61.3}, {"lowerIsBetter": true, "replicates": [67.0, 64.0, 72.0, 78.0, 88.0, 104.0, 58.0, 72.0, 99.0, 100.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 80.2}, {"lowerIsBetter": true, "replicates": [80.0, 84.0, 83.0, 82.0, 84.0, 81.0, 82.0, 83.0, 82.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [126.0, 147.0, 107.0, 151.0, 135.0, 134.0, 137.0, 121.0, 119.0, 134.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 131.1}, {"lowerIsBetter": true, "replicates": [134.0, 176.0, 133.0, 134.0, 135.0, 137.0, 142.0, 159.0, 138.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.6}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 67.0, 67.0, 63.0, 61.0, 67.0, 67.0, 68.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.6}], "name": "kraken", "value": 1520.6999999999998}]} 12:07:30 INFO - Return code: 0 12:07:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:07:30 ERROR - # TBPL SUCCESS # 12:07:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:07:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:07:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:07:30 INFO - 2016-05-19 12:07:30.168 screenresolution[1685:10274] starting screenresolution argv=screenresolution get 12:07:30 INFO - 2016-05-19 12:07:30.171 screenresolution[1685:10274] Display 0: 1600x1200x32@60 12:07:30 INFO - 2016-05-19 12:07:30.177 screenresolution[1686:10277] starting screenresolution argv=screenresolution list 12:07:30 INFO - Available Modes on Display 0 12:07:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:07:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:07:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:07:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:07:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:07:30 INFO - Intel Iris: 12:07:30 INFO - Chipset Model: Intel Iris 12:07:30 INFO - Type: GPU 12:07:30 INFO - Bus: Built-In 12:07:30 INFO - VRAM (Dynamic, Max): 1536 MB 12:07:30 INFO - Vendor: Intel (0x8086) 12:07:30 INFO - Device ID: 0x0a2e 12:07:30 INFO - Revision ID: 0x0009 12:07:30 INFO - Displays: 12:07:30 INFO - Display: 12:07:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:07:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:07:30 INFO - Display Serial Number: 1600x1200 60 12:07:30 INFO - Main Display: Yes 12:07:30 INFO - Mirror: Off 12:07:30 INFO - Online: Yes 12:07:30 INFO - Rotation: Supported 12:07:30 INFO - Return code: 0 12:07:30 INFO - Running post-action listener: _resource_record_post_action 12:07:30 INFO - Running post-run listener: _resource_record_post_run 12:07:31 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 36488704; Write bytes: 510640640; Read time: 236; Write time: 1571 12:07:31 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 206416384; Write bytes: 209102848; Read time: 19003; Write time: 438 12:07:31 INFO - run-tests - Wall time: 1169s; CPU: 53.0%; Read bytes: 34665984; Write bytes: 300689920; Read time: 219; Write time: 1131 12:07:31 INFO - Running post-run listener: _upload_blobber_files 12:07:31 INFO - Blob upload gear active. 12:07:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:07:31 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 12:07:31 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:07:31 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:07:31 INFO - (blobuploader) - INFO - Open directory for files ... 12:07:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:07:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:07:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:07:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:07:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:07:33 INFO - (blobuploader) - INFO - Done attempting. 12:07:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:07:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:07:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:07:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:07:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:07:34 INFO - (blobuploader) - INFO - Done attempting. 12:07:34 INFO - (blobuploader) - INFO - Iteration through files over. 12:07:34 INFO - Return code: 0 12:07:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:07:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:07:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0a34840c6dca5a7e425798c97361947f204583e128f9cd124e45fe8cd375f756796a81301f04ac32d4c6457b1eabe9a5cb0f47dbe4321ae50e029f4717acbf59", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/74578e21e6b8c783da759a61743c43f30072bc22e193da8da1813326d8e519685641733f18d56c308e19bce68007f2157950032865db8249ca90348886b4d1d9"} 12:07:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:07:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:07:34 INFO - Contents: 12:07:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0a34840c6dca5a7e425798c97361947f204583e128f9cd124e45fe8cd375f756796a81301f04ac32d4c6457b1eabe9a5cb0f47dbe4321ae50e029f4717acbf59", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/74578e21e6b8c783da759a61743c43f30072bc22e193da8da1813326d8e519685641733f18d56c308e19bce68007f2157950032865db8249ca90348886b4d1d9"} 12:07:34 INFO - Running post-run listener: copy_logs_to_upload_dir 12:07:34 INFO - Copying logs to upload dir... 12:07:34 INFO - mkdir: /builds/slave/test/build/upload/logs 12:07:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.484372 ========= master_lag: 0.39 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-05-19 12:07:34.524910) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 12:07:34.528787) ========= 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.0BST0xYy5U/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.I88PAs22zr/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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/Mozilla-Beta/sha512/0a34840c6dca5a7e425798c97361947f204583e128f9cd124e45fe8cd375f756796a81301f04ac32d4c6457b1eabe9a5cb0f47dbe4321ae50e029f4717acbf59", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/74578e21e6b8c783da759a61743c43f30072bc22e193da8da1813326d8e519685641733f18d56c308e19bce68007f2157950032865db8249ca90348886b4d1d9"} build_url:https://queue.taskcluster.net/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010983 build_url: 'https://queue.taskcluster.net/v1/task/E2oOpPORQNKE6nL8JJXHCg/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0a34840c6dca5a7e425798c97361947f204583e128f9cd124e45fe8cd375f756796a81301f04ac32d4c6457b1eabe9a5cb0f47dbe4321ae50e029f4717acbf59", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/74578e21e6b8c783da759a61743c43f30072bc22e193da8da1813326d8e519685641733f18d56c308e19bce68007f2157950032865db8249ca90348886b4d1d9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 12:07:34.559698) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 12:07:34.560230) ========= 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.0BST0xYy5U/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.I88PAs22zr/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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.005193 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 12:07:34.637493) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 12:07:34.637808) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 12:07:34.638657) ========= ========= Total master_lag: 0.55 =========