builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0360 starttime: 1466714080.62 results: success (0) buildid: 20160623122823 builduid: b5460e7bfd014a1ea1343355595f8464 revision: 13b02b96281e550c3cdbdf4eaed034aa1edefd69 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 13:34:40.622057) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 13:34:40.622593) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 13:34:40.622883) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 13:34:40.648821) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 13:34:40.649245) ========= 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.gIFnYp8FQZ/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.30WG9Jsuha/Listeners TMPDIR=/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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-06-23 13:34:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2016-06-23 13:34:41 (161 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.636581 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 13:34:41.364211) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 13:34:41.364528) ========= 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.gIFnYp8FQZ/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.30WG9Jsuha/Listeners TMPDIR=/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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.026200 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 13:34:41.427573) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-23 13:34:41.427955) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 13b02b96281e550c3cdbdf4eaed034aa1edefd69 --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 13b02b96281e550c3cdbdf4eaed034aa1edefd69 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gIFnYp8FQZ/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.30WG9Jsuha/Listeners TMPDIR=/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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-06-23 13:34:41,511 truncating revision to first 12 chars 2016-06-23 13:34:41,511 Setting DEBUG logging. 2016-06-23 13:34:41,511 attempt 1/10 2016-06-23 13:34:41,511 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/13b02b96281e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 13:34:42,888 unpacking tar archive at: mozilla-beta-13b02b96281e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.632770 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-23 13:34:43.091557) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 13:34:43.091850) ========= script_repo_revision: 13b02b96281e550c3cdbdf4eaed034aa1edefd69 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 13:34:43.092220) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 13:34:43.092536) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 13:34:43.138855) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2016-06-23 13:34:43.139172) ========= /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.gIFnYp8FQZ/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.30WG9Jsuha/Listeners TMPDIR=/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 13:34:43 INFO - MultiFileLogger online at 20160623 13:34:43 in /builds/slave/test 13:34:43 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 13:34:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:34:43 INFO - {'append_to_log': False, 13:34:43 INFO - 'base_work_dir': '/builds/slave/test', 13:34:43 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:34:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:34:43 INFO - 'branch': 'Mozilla-Beta', 13:34:43 INFO - 'buildbot_json_path': 'buildprops.json', 13:34:43 INFO - 'config_files': ('talos/mac_config.py',), 13:34:43 INFO - 'default_actions': ('clobber', 13:34:43 INFO - 'read-buildbot-config', 13:34:43 INFO - 'download-and-extract', 13:34:43 INFO - 'populate-webroot', 13:34:43 INFO - 'create-virtualenv', 13:34:43 INFO - 'install', 13:34:43 INFO - 'run-tests'), 13:34:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:34:43 INFO - 'download_minidump_stackwalk': True, 13:34:43 INFO - 'download_symbols': 'ondemand', 13:34:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:34:43 INFO - 'tooltool.py': '/tools/tooltool.py', 13:34:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:34:43 INFO - '/tools/misc-python/virtualenv.py')}, 13:34:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:34:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:34:43 INFO - 'installer_path': 'installer.exe', 13:34:43 INFO - 'log_level': 'info', 13:34:43 INFO - 'log_name': 'talos', 13:34:43 INFO - 'log_to_console': True, 13:34:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:34:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:34:43 INFO - 'opt_config_files': (), 13:34:43 INFO - 'pip_index': False, 13:34:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:34:43 INFO - 'cmd': ('bash', 13:34:43 INFO - '-c', 13:34:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:34:43 INFO - 'enabled': True, 13:34:43 INFO - 'halt_on_failure': False, 13:34:43 INFO - 'name': 'check_screen_resolution'},), 13:34:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:34:43 INFO - 'cmd': ('bash', 13:34:43 INFO - '-c', 13:34:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:34:43 INFO - 'enabled': True, 13:34:43 INFO - 'halt_on_failure': False, 13:34:43 INFO - 'name': 'check_screen_resolution'},), 13:34:43 INFO - 'run_cmd_checks_enabled': True, 13:34:43 INFO - 'sps_profile': False, 13:34:43 INFO - 'sps_profile_interval': 0, 13:34:43 INFO - 'suite': 'dromaeojs-e10s', 13:34:43 INFO - 'system_bits': '32', 13:34:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:34:43 INFO - 'title': 't-yosemite-r7-0360', 13:34:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:34:43 INFO - 'use_talos_json': True, 13:34:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:34:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:34:43 INFO - 'work_dir': 'build'} 13:34:43 INFO - ##### 13:34:43 INFO - ##### Running clobber step. 13:34:43 INFO - ##### 13:34:43 INFO - Running pre-action listener: _resource_record_pre_action 13:34:43 INFO - Running main action method: clobber 13:34:43 INFO - rmtree: /builds/slave/test/build 13:34:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:34:45 INFO - Running post-action listener: _resource_record_post_action 13:34:45 INFO - ##### 13:34:45 INFO - ##### Running read-buildbot-config step. 13:34:45 INFO - ##### 13:34:45 INFO - Running pre-action listener: _resource_record_pre_action 13:34:45 INFO - Running main action method: read_buildbot_config 13:34:45 INFO - Using buildbot properties: 13:34:45 INFO - { 13:34:45 INFO - "project": "", 13:34:45 INFO - "product": "firefox", 13:34:45 INFO - "script_repo_revision": "production", 13:34:45 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 13:34:45 INFO - "repository": "", 13:34:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 13:34:45 INFO - "buildid": "20160623122823", 13:34:45 INFO - "pgo_build": "False", 13:34:45 INFO - "basedir": "/builds/slave/test", 13:34:45 INFO - "buildnumber": 13, 13:34:45 INFO - "slavename": "t-yosemite-r7-0360", 13:34:45 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 13:34:45 INFO - "platform": "yosemite_r7", 13:34:45 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 13:34:45 INFO - "branch": "mozilla-beta", 13:34:45 INFO - "repo_path": "releases/mozilla-beta", 13:34:45 INFO - "revision": "13b02b96281e550c3cdbdf4eaed034aa1edefd69", 13:34:45 INFO - "stage_platform": "macosx64", 13:34:45 INFO - "builduid": "b5460e7bfd014a1ea1343355595f8464", 13:34:45 INFO - "slavebuilddir": "test" 13:34:45 INFO - } 13:34:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 13:34:45 INFO - Running post-action listener: _resource_record_post_action 13:34:45 INFO - ##### 13:34:45 INFO - ##### Running download-and-extract step. 13:34:45 INFO - ##### 13:34:45 INFO - Running pre-action listener: _resource_record_pre_action 13:34:45 INFO - Running main action method: download_and_extract 13:34:45 INFO - mkdir: /builds/slave/test/build/tests 13:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:34:45 INFO - https://queue.taskcluster.net/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:34:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 13:34:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 13:34:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 13:34:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 13:35:16 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json: timed out 13:35:16 INFO - retry: attempt #1 caught exception: timed out 13:35:16 INFO - retry: Failed, sleeping 30 seconds before retrying 13:35:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #2 13:35:51 INFO - Downloaded 1165 bytes. 13:35:51 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 13:35:51 INFO - Using the following test package requirements: 13:35:51 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 13:35:51 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:35:51 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 13:35:51 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:35:51 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 13:35:51 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 13:35:51 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:35:51 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 13:35:51 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 13:35:51 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:35:51 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 13:35:51 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:35:51 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 13:35:51 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:35:51 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 13:35:51 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:35:51 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 13:35:51 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 13:35: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')]} 13:35:51 INFO - https://queue.taskcluster.net/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:35:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 13:35:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 13:35:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 13:35:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 13:35:53 INFO - Downloaded 18301145 bytes. 13:35:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:35:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:35:56 INFO - Return code: 0 13:35:56 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 13:35:56 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')]} 13:35:56 INFO - https://queue.taskcluster.net/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:35:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 13:35:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 13:35:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 13:35:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 13:36:00 INFO - Downloaded 18301145 bytes. 13:36:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:36:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:36:03 INFO - Return code: 0 13:36:03 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')]} 13:36:03 INFO - https://queue.taskcluster.net/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:36:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 13:36:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 13:36:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 13:36:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 13:36:04 INFO - Downloaded 10840145 bytes. 13:36:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:36:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 13:36:05 INFO - Return code: 0 13:36:05 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')]} 13:36:05 INFO - https://queue.taskcluster.net/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 13:36:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 13:36:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 13:36:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 13:36:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 13:36:07 INFO - Downloaded 86251571 bytes. 13:36:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 13:36:07 INFO - mkdir: /builds/slave/test/properties 13:36:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:36:07 INFO - Writing to file /builds/slave/test/properties/build_url 13:36:07 INFO - Contents: 13:36:07 INFO - build_url:https://queue.taskcluster.net/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 13:36:08 INFO - Running post-action listener: _resource_record_post_action 13:36:08 INFO - Running post-action listener: set_extra_try_arguments 13:36:08 INFO - ##### 13:36:08 INFO - ##### Running populate-webroot step. 13:36:08 INFO - ##### 13:36:08 INFO - Running pre-action listener: _resource_record_pre_action 13:36:08 INFO - Running main action method: populate_webroot 13:36:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:36:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:36:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:36:08 INFO - '--tppagecycles', 13:36:08 INFO - '7'], 13:36:08 INFO - 'tests': ['tsvgm']}}, 13:36:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:36:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:36:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:36:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:36:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:36:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:36:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:08 INFO - 'talos_options': ['--disable-e10s'], 13:36:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:36:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:36:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:08 INFO - 'talos_options': ['--disable-e10s'], 13:36:08 INFO - 'tests': ['damp', 'tps']}, 13:36:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:08 INFO - 'tests': ['damp', 'tps']}, 13:36:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:36:08 INFO - 'tests': ['dromaeo_dom']}, 13:36:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:36:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:36:08 INFO - 'tests': ['a11yr', 13:36:08 INFO - 'ts_paint', 13:36:08 INFO - 'tpaint', 13:36:08 INFO - 'sessionrestore', 13:36:08 INFO - 'sessionrestore_no_auto_restore', 13:36:08 INFO - 'tabpaint']}, 13:36:08 INFO - 'other-e10s': {'tests': ['a11yr', 13:36:08 INFO - 'ts_paint', 13:36:08 INFO - 'tpaint', 13:36:08 INFO - 'sessionrestore', 13:36:08 INFO - 'sessionrestore_no_auto_restore', 13:36:08 INFO - 'tabpaint']}, 13:36:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:36:08 INFO - 'ts_paint', 13:36:08 INFO - 'tpaint', 13:36:08 INFO - 'sessionrestore', 13:36:08 INFO - 'sessionrestore_no_auto_restore', 13:36:08 INFO - 'tabpaint']}, 13:36:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:36:08 INFO - 'ts_paint', 13:36:08 INFO - 'tpaint', 13:36:08 INFO - 'sessionrestore', 13:36:08 INFO - 'sessionrestore_no_auto_restore', 13:36:08 INFO - 'tabpaint']}, 13:36:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:36:08 INFO - 'tests': ['a11yr', 13:36:08 INFO - 'ts_paint', 13:36:08 INFO - 'tpaint', 13:36:08 INFO - 'sessionrestore', 13:36:08 INFO - 'sessionrestore_no_auto_restore', 13:36:08 INFO - 'tabpaint']}, 13:36:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:36:08 INFO - 'tests': ['a11yr', 13:36:08 INFO - 'ts_paint', 13:36:08 INFO - 'tpaint', 13:36:08 INFO - 'sessionrestore', 13:36:08 INFO - 'sessionrestore_no_auto_restore', 13:36:08 INFO - 'tabpaint']}, 13:36:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:36:08 INFO - 'tests': ['tsvgx', 13:36:08 INFO - 'tsvgr_opacity', 13:36:08 INFO - 'tart', 13:36:08 INFO - 'tscrollx', 13:36:08 INFO - 'cart']}, 13:36:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:36:08 INFO - 'tsvgr_opacity', 13:36:08 INFO - 'tart', 13:36:08 INFO - 'tscrollx', 13:36:08 INFO - 'cart']}, 13:36:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:08 INFO - 'talos_options': ['--disable-e10s'], 13:36:08 INFO - 'tests': ['tp5o']}, 13:36:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:08 INFO - 'tests': ['tp5o']}, 13:36:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:08 INFO - 'talos_options': ['--disable-e10s', 13:36:08 INFO - '--xperf_path', 13:36:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:36:08 INFO - 'tests': ['tp5n']}, 13:36:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:36:08 INFO - 'talos_options': ['--xperf_path', 13:36:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:36:08 INFO - 'tests': ['tp5n']}}, 13:36:08 INFO - 'talos.zip': {'path': '', 13:36:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:36:08 INFO - Running post-action listener: _resource_record_post_action 13:36:08 INFO - ##### 13:36:08 INFO - ##### Running create-virtualenv step. 13:36:08 INFO - ##### 13:36:08 INFO - Running pre-action listener: _resource_record_pre_action 13:36:08 INFO - Running main action method: create_virtualenv 13:36:08 INFO - Creating virtualenv /builds/slave/test/build/venv 13:36:08 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 13:36:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:36:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:36:08 INFO - Using real prefix '/tools/python27' 13:36:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:36:09 INFO - Installing distribute.............................................................................................................................................................................................done. 13:36:12 INFO - Installing pip.................done. 13:36:12 INFO - Return code: 0 13:36:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:12 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 0x1031bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031cb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faac0c9c110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10305ae00>, '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 0x102ec3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103055b20>, '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.gIFnYp8FQZ/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.30WG9Jsuha/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 13:36:12 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 13:36:12 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 13:36:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIFnYp8FQZ/Render', 13:36:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:36:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:36:12 INFO - 'HOME': '/Users/cltbld', 13:36:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:36:12 INFO - 'LOGNAME': 'cltbld', 13:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:12 INFO - 'MOZ_NO_REMOTE': '1', 13:36:12 INFO - 'NO_EM_RESTART': '1', 13:36:12 INFO - 'PAGER': '/bin/cat', 13:36:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:12 INFO - 'PWD': '/builds/slave/test', 13:36:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:36:12 INFO - 'SHELL': '/bin/bash', 13:36:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.30WG9Jsuha/Listeners', 13:36:12 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 13:36:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:36:12 INFO - 'USER': 'cltbld', 13:36:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:36:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:12 INFO - 'XPC_FLAGS': '0x0', 13:36:12 INFO - 'XPC_SERVICE_NAME': '0', 13:36:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:12 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 13:36:12 INFO - Cleaning up... 13:36:12 INFO - Return code: 0 13:36:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:12 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 0x1031bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031cb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faac0c9c110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10305ae00>, '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 0x102ec3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103055b20>, '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.gIFnYp8FQZ/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.30WG9Jsuha/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 13:36:12 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 13:36:12 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 13:36:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIFnYp8FQZ/Render', 13:36:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:36:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:36:12 INFO - 'HOME': '/Users/cltbld', 13:36:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:36:12 INFO - 'LOGNAME': 'cltbld', 13:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:12 INFO - 'MOZ_NO_REMOTE': '1', 13:36:12 INFO - 'NO_EM_RESTART': '1', 13:36:12 INFO - 'PAGER': '/bin/cat', 13:36:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:12 INFO - 'PWD': '/builds/slave/test', 13:36:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:36:12 INFO - 'SHELL': '/bin/bash', 13:36:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.30WG9Jsuha/Listeners', 13:36:12 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 13:36:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:36:12 INFO - 'USER': 'cltbld', 13:36:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:36:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:12 INFO - 'XPC_FLAGS': '0x0', 13:36:12 INFO - 'XPC_SERVICE_NAME': '0', 13:36:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:12 INFO - Downloading/unpacking psutil>=0.7.1 13:36:12 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 13:36:12 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 13:36:12 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 13:36:12 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 13:36:12 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 13:36:12 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 13:36:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:36:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:36:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:36:16 INFO - Installing collected packages: psutil 13:36:16 INFO - Running setup.py install for psutil 13:36:16 INFO - building 'psutil._psutil_osx' extension 13:36:16 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 13:36:16 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 13:36:16 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 13:36:17 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 13:36:17 INFO - building 'psutil._psutil_posix' extension 13:36:17 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 13:36:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:36:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:36:17 INFO - ^ 13:36:17 INFO - 1 warning generated. 13:36:17 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 13:36:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:36:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:36:17 INFO - Successfully installed psutil 13:36:17 INFO - Cleaning up... 13:36:17 INFO - Return code: 0 13:36:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1031bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031cb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faac0c9c110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10305ae00>, '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 0x102ec3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103055b20>, '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.gIFnYp8FQZ/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.30WG9Jsuha/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 13:36:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:36:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIFnYp8FQZ/Render', 13:36:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:36:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:36:17 INFO - 'HOME': '/Users/cltbld', 13:36:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:36:17 INFO - 'LOGNAME': 'cltbld', 13:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:17 INFO - 'MOZ_NO_REMOTE': '1', 13:36:17 INFO - 'NO_EM_RESTART': '1', 13:36:17 INFO - 'PAGER': '/bin/cat', 13:36:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:17 INFO - 'PWD': '/builds/slave/test', 13:36:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:36:17 INFO - 'SHELL': '/bin/bash', 13:36:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.30WG9Jsuha/Listeners', 13:36:17 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 13:36:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:36:17 INFO - 'USER': 'cltbld', 13:36:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:36:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:17 INFO - 'XPC_FLAGS': '0x0', 13:36:17 INFO - 'XPC_SERVICE_NAME': '0', 13:36:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:36: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 13:36: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 13:36: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 13:36: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 13:36: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 13:36: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 13:36:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:36:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:36:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:36:20 INFO - Installing collected packages: mozsystemmonitor 13:36:20 INFO - Running setup.py install for mozsystemmonitor 13:36:20 INFO - Successfully installed mozsystemmonitor 13:36:20 INFO - Cleaning up... 13:36:20 INFO - Return code: 0 13:36:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:36:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:20 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 0x1031bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031cb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faac0c9c110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10305ae00>, '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 0x102ec3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103055b20>, '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.gIFnYp8FQZ/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.30WG9Jsuha/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 13:36:20 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 13:36:20 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 13:36:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIFnYp8FQZ/Render', 13:36:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:36:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:36:20 INFO - 'HOME': '/Users/cltbld', 13:36:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:36:20 INFO - 'LOGNAME': 'cltbld', 13:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:20 INFO - 'MOZ_NO_REMOTE': '1', 13:36:20 INFO - 'NO_EM_RESTART': '1', 13:36:20 INFO - 'PAGER': '/bin/cat', 13:36:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:20 INFO - 'PWD': '/builds/slave/test', 13:36:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:36:20 INFO - 'SHELL': '/bin/bash', 13:36:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.30WG9Jsuha/Listeners', 13:36:20 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 13:36:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:36:20 INFO - 'USER': 'cltbld', 13:36:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:36:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:20 INFO - 'XPC_FLAGS': '0x0', 13:36:20 INFO - 'XPC_SERVICE_NAME': '0', 13:36:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:36:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:20 INFO - Downloading/unpacking blobuploader==1.2.4 13:36:20 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 13:36:20 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 13:36:20 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 13:36:20 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 13:36:20 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 13:36:20 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 13:36:23 INFO - Downloading blobuploader-1.2.4.tar.gz 13:36:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:36:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:36:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:24 INFO - Downloading docopt-0.6.1.tar.gz 13:36:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:36:24 INFO - Installing collected packages: blobuploader, requests, docopt 13:36:24 INFO - Running setup.py install for blobuploader 13:36:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:36:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:36:24 INFO - Running setup.py install for requests 13:36:25 INFO - Running setup.py install for docopt 13:36:25 INFO - Successfully installed blobuploader requests docopt 13:36:25 INFO - Cleaning up... 13:36:25 INFO - Return code: 0 13:36:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:25 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 0x1031bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031cb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faac0c9c110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10305ae00>, '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 0x102ec3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103055b20>, '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.gIFnYp8FQZ/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.30WG9Jsuha/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 13:36:25 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 13:36:25 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 13:36:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIFnYp8FQZ/Render', 13:36:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:36:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:36:25 INFO - 'HOME': '/Users/cltbld', 13:36:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:36:25 INFO - 'LOGNAME': 'cltbld', 13:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:25 INFO - 'MOZ_NO_REMOTE': '1', 13:36:25 INFO - 'NO_EM_RESTART': '1', 13:36:25 INFO - 'PAGER': '/bin/cat', 13:36:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:25 INFO - 'PWD': '/builds/slave/test', 13:36:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:36:25 INFO - 'SHELL': '/bin/bash', 13:36:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.30WG9Jsuha/Listeners', 13:36:25 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 13:36:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:36:25 INFO - 'USER': 'cltbld', 13:36:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:36:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:25 INFO - 'XPC_FLAGS': '0x0', 13:36:25 INFO - 'XPC_SERVICE_NAME': '0', 13:36:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:36:25 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-wgBhHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:36:25 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-ExSqlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:36:25 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-BsDJ2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:36:25 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-t_ZHF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:36:26 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-L2pqnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:36:26 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-BCjEWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:36:26 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-TsIVhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:36:26 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-xhTIRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:36:26 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-MLQzUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:36:26 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-__7HOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:36:26 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-bShAw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:36:26 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-fGfdth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:36:26 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-hdc_ib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:36:26 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-9hqMw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:36:27 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-2cFvNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:36:27 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-oxV2aD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:36:27 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-BlpYC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:36:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:36:27 INFO - Running setup.py install for manifestparser 13:36:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:36:27 INFO - Running setup.py install for mozcrash 13:36:27 INFO - Running setup.py install for mozdebug 13:36:27 INFO - Running setup.py install for mozdevice 13:36:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:36:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:36:27 INFO - Running setup.py install for mozfile 13:36:28 INFO - Running setup.py install for mozhttpd 13:36:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:36:28 INFO - Running setup.py install for mozinfo 13:36:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:36:28 INFO - Running setup.py install for mozInstall 13:36:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:36:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:36:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:36:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:36:28 INFO - Running setup.py install for mozleak 13:36:28 INFO - Running setup.py install for mozlog 13:36:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:36:28 INFO - Running setup.py install for moznetwork 13:36:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:36:28 INFO - Running setup.py install for mozprocess 13:36:29 INFO - Running setup.py install for mozprofile 13:36:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:36:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:36:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:36:29 INFO - Running setup.py install for mozrunner 13:36:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:36:29 INFO - Running setup.py install for mozscreenshot 13:36:29 INFO - Running setup.py install for moztest 13:36:29 INFO - Running setup.py install for mozversion 13:36:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:36:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:36:29 INFO - Cleaning up... 13:36:29 INFO - Return code: 0 13:36:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:36: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')]} 13:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36: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')]} 13:36:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:29 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 0x1031bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031cb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faac0c9c110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10305ae00>, '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 0x102ec3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103055b20>, '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.gIFnYp8FQZ/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.30WG9Jsuha/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 13:36:29 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 13:36:29 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 13:36:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIFnYp8FQZ/Render', 13:36:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:36:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:36:29 INFO - 'HOME': '/Users/cltbld', 13:36:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:36:29 INFO - 'LOGNAME': 'cltbld', 13:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:29 INFO - 'MOZ_NO_REMOTE': '1', 13:36:29 INFO - 'NO_EM_RESTART': '1', 13:36:29 INFO - 'PAGER': '/bin/cat', 13:36:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:29 INFO - 'PWD': '/builds/slave/test', 13:36:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:36:29 INFO - 'SHELL': '/bin/bash', 13:36:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.30WG9Jsuha/Listeners', 13:36:29 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 13:36:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:36:29 INFO - 'USER': 'cltbld', 13:36:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:36:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:29 INFO - 'XPC_FLAGS': '0x0', 13:36:29 INFO - 'XPC_SERVICE_NAME': '0', 13:36:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:36:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:36:30 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-gdhPaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:36:30 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)) 13:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:36:30 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-QrfZx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:36:30 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)) 13:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:36:30 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-kOGT8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:36:30 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)) 13:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:36:30 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-5ixhrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:36:30 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)) 13:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:36:30 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-LJ1apD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:36:30 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)) 13:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:36:30 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-ikCqWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:36:30 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)) 13:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:36:30 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-JtPu8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:36:30 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)) 13:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:36:30 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-zx7voA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:36:30 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)) 13:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:36:30 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-qW9laJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:36:31 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)) 13:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:36:31 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-pYRLyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:36:31 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)) 13:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:36:31 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-h0HfzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:36:31 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)) 13:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:36:31 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-FQ8Hqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:36:31 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)) 13:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:36:31 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-Gj_sNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:36:31 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)) 13:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:36:31 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-ifkPHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:36:31 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)) 13:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:36:31 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-6Tw7rK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:36:31 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)) 13:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:36:31 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-VD8rHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:36:31 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)) 13:36:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:36:31 INFO - Running setup.py (path:/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/pip-aDfzo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:36:31 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)) 13:36:31 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)) 13:36:31 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)) 13:36:31 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)) 13:36:31 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)) 13:36:31 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)) 13:36:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:34 INFO - Downloading blessings-1.6.tar.gz 13:36:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:36:34 INFO - Installing collected packages: blessings 13:36:34 INFO - Running setup.py install for blessings 13:36:34 INFO - Successfully installed blessings 13:36:34 INFO - Cleaning up... 13:36:34 INFO - Return code: 0 13:36:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:36:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:36:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:36:34 INFO - Reading from file tmpfile_stdout 13:36:34 INFO - Current package versions: 13:36:34 INFO - blessings == 1.6 13:36:34 INFO - blobuploader == 1.2.4 13:36:34 INFO - docopt == 0.6.1 13:36:34 INFO - manifestparser == 1.1 13:36:34 INFO - mozInstall == 1.12 13:36:34 INFO - mozcrash == 0.17 13:36:34 INFO - mozdebug == 0.1 13:36:34 INFO - mozdevice == 0.48 13:36:34 INFO - mozfile == 1.2 13:36:34 INFO - mozhttpd == 0.7 13:36:34 INFO - mozinfo == 0.9 13:36:34 INFO - mozleak == 0.1 13:36:34 INFO - mozlog == 3.1 13:36:34 INFO - moznetwork == 0.27 13:36:34 INFO - mozprocess == 0.22 13:36:34 INFO - mozprofile == 0.28 13:36:34 INFO - mozrunner == 6.11 13:36:34 INFO - mozscreenshot == 0.1 13:36:34 INFO - mozsystemmonitor == 0.0 13:36:34 INFO - moztest == 0.7 13:36:34 INFO - mozversion == 1.4 13:36:34 INFO - psutil == 3.1.1 13:36:34 INFO - requests == 1.2.3 13:36:34 INFO - wsgiref == 0.1.2 13:36:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:36:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:34 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 0x1031bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031cb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faac0c9c110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10305ae00>, '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 0x102ec3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103055b20>, '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.gIFnYp8FQZ/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.30WG9Jsuha/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 13:36:34 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 13:36:34 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 13:36:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIFnYp8FQZ/Render', 13:36:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:36:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:36:34 INFO - 'HOME': '/Users/cltbld', 13:36:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:36:34 INFO - 'LOGNAME': 'cltbld', 13:36:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:34 INFO - 'MOZ_NO_REMOTE': '1', 13:36:34 INFO - 'NO_EM_RESTART': '1', 13:36:34 INFO - 'PAGER': '/bin/cat', 13:36:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:36:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:34 INFO - 'PWD': '/builds/slave/test', 13:36:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:36:34 INFO - 'SHELL': '/bin/bash', 13:36:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.30WG9Jsuha/Listeners', 13:36:34 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 13:36:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:36:34 INFO - 'USER': 'cltbld', 13:36:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:36:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:36:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:34 INFO - 'XPC_FLAGS': '0x0', 13:36:34 INFO - 'XPC_SERVICE_NAME': '0', 13:36:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:35 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)) 13:36:35 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)) 13:36:35 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)) 13:36:35 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)) 13:36:35 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)) 13:36:35 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)) 13:36:35 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)) 13:36:35 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)) 13:36:35 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)) 13:36:35 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)) 13:36:35 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)) 13:36:35 INFO - Cleaning up... 13:36:35 INFO - Return code: 0 13:36:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:35 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 0x1031bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031cb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faac0c9c110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10305ae00>, '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 0x102ec3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103055b20>, '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.gIFnYp8FQZ/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.30WG9Jsuha/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 13:36:35 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 13:36:35 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 13:36:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIFnYp8FQZ/Render', 13:36:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:36:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:36:35 INFO - 'HOME': '/Users/cltbld', 13:36:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:36:35 INFO - 'LOGNAME': 'cltbld', 13:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:35 INFO - 'MOZ_NO_REMOTE': '1', 13:36:35 INFO - 'NO_EM_RESTART': '1', 13:36:35 INFO - 'PAGER': '/bin/cat', 13:36:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:35 INFO - 'PWD': '/builds/slave/test', 13:36:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:36:35 INFO - 'SHELL': '/bin/bash', 13:36:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.30WG9Jsuha/Listeners', 13:36:35 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 13:36:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:36:35 INFO - 'USER': 'cltbld', 13:36:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:36:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:35 INFO - 'XPC_FLAGS': '0x0', 13:36:35 INFO - 'XPC_SERVICE_NAME': '0', 13:36:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:35 INFO - Downloading/unpacking jsonschema 13:36:35 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 13:36:35 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 13:36:35 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 13:36:35 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 13:36:35 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 13:36:35 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 13:36:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:36:37 INFO - Downloading/unpacking functools32 (from jsonschema) 13:36:37 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 13:36:37 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 13:36:37 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 13:36:37 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 13:36:37 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 13:36:37 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 13:36:38 INFO - Downloading functools32-3.2.3-2.tar.gz 13:36:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:36:38 INFO - warning: no files found matching '*.txt' 13:36:38 INFO - no previously-included directories found matching 'build' 13:36:38 INFO - no previously-included directories found matching 'dist' 13:36:38 INFO - no previously-included directories found matching '.git*' 13:36:38 INFO - Installing collected packages: jsonschema, functools32 13:36:38 INFO - Running setup.py install for functools32 13:36:38 INFO - warning: no files found matching '*.txt' 13:36:38 INFO - no previously-included directories found matching 'build' 13:36:38 INFO - no previously-included directories found matching 'dist' 13:36:38 INFO - no previously-included directories found matching '.git*' 13:36:38 INFO - Successfully installed jsonschema functools32 13:36:38 INFO - Cleaning up... 13:36:38 INFO - Return code: 0 13:36:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:36:38 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')]} 13:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:36:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:38 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')]} 13:36:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:36:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:36:38 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 0x1031bba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031cb420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faac0c9c110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10305ae00>, '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 0x102ec3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103055b20>, '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.gIFnYp8FQZ/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.30WG9Jsuha/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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 13:36:38 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 13:36:38 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 13:36:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIFnYp8FQZ/Render', 13:36:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:36:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:36:38 INFO - 'HOME': '/Users/cltbld', 13:36:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:36:38 INFO - 'LOGNAME': 'cltbld', 13:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:36:38 INFO - 'MOZ_NO_REMOTE': '1', 13:36:38 INFO - 'NO_EM_RESTART': '1', 13:36:38 INFO - 'PAGER': '/bin/cat', 13:36:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:36:38 INFO - 'PWD': '/builds/slave/test', 13:36:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:36:38 INFO - 'SHELL': '/bin/bash', 13:36:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.30WG9Jsuha/Listeners', 13:36:38 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 13:36:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:36:38 INFO - 'USER': 'cltbld', 13:36:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:36:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:36:38 INFO - 'XPC_FLAGS': '0x0', 13:36:38 INFO - 'XPC_SERVICE_NAME': '0', 13:36:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:36:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:36:38 INFO - Downloading/unpacking flake8 13:36:38 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 13:36:38 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 13:36:38 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 13:36:38 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 13:36:38 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 13:36:38 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 13:36:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:36:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:36:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:36:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:36:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:36:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:36:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:36:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:36:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:36:42 INFO - no previously-included directories found matching 'docs/_build' 13:36:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:36:42 INFO - Running setup.py install for pep8 13:36:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:36:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:36:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:36:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:36:42 INFO - no previously-included directories found matching 'docs/_build' 13:36:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:36:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:36:42 INFO - Cleaning up... 13:36:42 INFO - Return code: 0 13:36:42 INFO - Running post-action listener: _resource_record_post_action 13:36:42 INFO - Running post-action listener: _start_resource_monitoring 13:36:42 INFO - Starting resource monitoring. 13:36:42 INFO - ##### 13:36:42 INFO - ##### Running install step. 13:36:42 INFO - ##### 13:36:42 INFO - Running pre-action listener: _resource_record_pre_action 13:36:42 INFO - Running main action method: install 13:36:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:36:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:36:43 INFO - Reading from file tmpfile_stdout 13:36:43 INFO - Detecting whether we're running mozinstall >=1.0... 13:36:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:36:43 INFO - Reading from file tmpfile_stdout 13:36:43 INFO - Output received: 13:36:43 INFO - Usage: mozinstall [options] installer 13:36:43 INFO - Options: 13:36:43 INFO - -h, --help show this help message and exit 13:36:43 INFO - -d DEST, --destination=DEST 13:36:43 INFO - Directory to install application into. [default: 13:36:43 INFO - "/builds/slave/test"] 13:36:43 INFO - --app=APP Application being installed. [default: firefox] 13:36:43 INFO - mkdir: /builds/slave/test/build/application 13:36:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 13:37:05 INFO - Reading from file tmpfile_stdout 13:37:05 INFO - Output received: 13:37:05 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 13:37:05 INFO - Running post-action listener: _resource_record_post_action 13:37:05 INFO - ##### 13:37:05 INFO - ##### Running run-tests step. 13:37:05 INFO - ##### 13:37:05 INFO - Running pre-action listener: _resource_record_pre_action 13:37:05 INFO - Running main action method: run_tests 13:37:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:37:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:37:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:37:05 INFO - 2016-06-23 13:37:05.565 screenresolution[1647:8894] starting screenresolution argv=screenresolution get 13:37:05 INFO - 2016-06-23 13:37:05.568 screenresolution[1647:8894] Display 0: 1600x1200x32@60 13:37:05 INFO - 2016-06-23 13:37:05.574 screenresolution[1648:8896] starting screenresolution argv=screenresolution list 13:37:05 INFO - Available Modes on Display 0 13:37:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:37:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:37:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:37:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:37:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:37:05 INFO - Intel Iris: 13:37:05 INFO - Chipset Model: Intel Iris 13:37:05 INFO - Type: GPU 13:37:05 INFO - Bus: Built-In 13:37:05 INFO - VRAM (Dynamic, Max): 1536 MB 13:37:05 INFO - Vendor: Intel (0x8086) 13:37:05 INFO - Device ID: 0x0a2e 13:37:05 INFO - Revision ID: 0x0009 13:37:05 INFO - Displays: 13:37:05 INFO - Display: 13:37:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:37:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:37:05 INFO - Display Serial Number: 1600x1200 60 13:37:05 INFO - Main Display: Yes 13:37:05 INFO - Mirror: Off 13:37:05 INFO - Online: Yes 13:37:05 INFO - Rotation: Supported 13:37:05 INFO - Return code: 0 13:37:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:37:05 INFO - Python 2.7.3 13:37:05 INFO - Return code: 0 13:37:05 INFO - grabbing minidump binary from tooltool 13:37:05 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')]} 13:37:05 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 0x10305ae00>, '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 0x102ec3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103055b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:37:05 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 13:37:05 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 13:37:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:37:05 INFO - Return code: 0 13:37:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:37:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:37:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:37:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:37:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:37:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:37:06 INFO - Return code: 0 13:37:06 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/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0360', '--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 13:37:06 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/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0360 --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 13:37:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIFnYp8FQZ/Render', 13:37:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:37:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:37:06 INFO - 'HOME': '/Users/cltbld', 13:37:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:37:06 INFO - 'LOGNAME': 'cltbld', 13:37:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:37:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:06 INFO - 'MOZ_NO_REMOTE': '1', 13:37:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:37:06 INFO - 'NO_EM_RESTART': '1', 13:37:06 INFO - 'PAGER': '/bin/cat', 13:37:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:37:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:07 INFO - 'PWD': '/builds/slave/test', 13:37:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:37:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:37:07 INFO - 'SHELL': '/bin/bash', 13:37:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.30WG9Jsuha/Listeners', 13:37:07 INFO - 'TMPDIR': '/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/', 13:37:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:37:07 INFO - 'USER': 'cltbld', 13:37:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:37:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:37:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:07 INFO - 'XPC_FLAGS': '0x0', 13:37:07 INFO - 'XPC_SERVICE_NAME': '0', 13:37:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:37:07 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/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0360', '--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 13:37:07 INFO - mozversion application_buildid: 20160623122823 13:37:07 INFO - mozversion application_changeset: 13b02b96281e550c3cdbdf4eaed034aa1edefd69 13:37:07 INFO - mozversion application_display_name: Firefox 13:37:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:37:07 INFO - mozversion application_name: Firefox 13:37:07 INFO - mozversion application_remotingname: firefox 13:37:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:37:07 INFO - mozversion application_vendor: Mozilla 13:37:07 INFO - mozversion application_version: 48.0 13:37:07 INFO - mozversion platform_buildid: 20160623122823 13:37:07 INFO - mozversion platform_changeset: 13b02b96281e550c3cdbdf4eaed034aa1edefd69 13:37:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:37:07 INFO - mozversion platform_version: 48.0 13:37:07 INFO - using testdate: 1466714227 13:37:07 INFO - actual date: 1466714227 13:37:07 INFO - starting webserver on 'localhost:49279' 13:37:07 INFO - SUITE-START | Running 2 tests 13:37:07 INFO - TEST-START | dromaeo_css 13:37:07 INFO - operating with platform_type : mac_ 13:37:07 INFO - Initialising browser for dromaeo_css test... 13:37:07 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/tmpy5BoH9/profile http://localhost:49279/getInfo.html) 13:37:10 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 13:37:10 INFO - PROCESS | 1666 | colorDepth:24 13:37:10 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 13:37:10 INFO - PROCESS | 1666 | __metrics 13:37:10 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 13:37:10 INFO - TEST-INFO | 1666: exit 0 13:37:10 INFO - Browser initialized. 13:37:10 INFO - Running cycle 1/1 for dromaeo_css test... 13:37:10 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/tmpy5BoH9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:37:22 INFO - PROCESS | 1671 | RSS: Main: 170708992 13:37:22 INFO - PROCESS | 1671 | 13:38:12 INFO - PROCESS | 1671 | 1466714292391 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] 13:40:22 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 13:40:23 INFO - PROCESS | 1671 | RSS: Main: 181841920 13:40:23 INFO - PROCESS | 1671 | 13:43:25 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 13:43:26 INFO - PROCESS | 1671 | RSS: Main: 192466944 13:43:26 INFO - PROCESS | 1671 | 13:46:27 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 13:46:28 INFO - PROCESS | 1671 | RSS: Main: 195366912 13:46:28 INFO - PROCESS | 1671 | 13:49:30 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 13:49:30 INFO - PROCESS | 1671 | RSS: Main: 198340608 13:49:30 INFO - PROCESS | 1671 | 13:52:33 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 13:52:34 INFO - PROCESS | 1671 | RSS: Main: 197447680 13:52:34 INFO - PROCESS | 1671 | 13:55:36 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 13:55:36 INFO - PROCESS | 1671 | RSS: Main: 203059200 13:55:36 INFO - PROCESS | 1671 | 13:55:36 INFO - PROCESS | 1671 | __start_tp_report 13:55:36 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 13:55:36 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 13:55:36 INFO - PROCESS | 1671 | |i|pagename|runs| 13:55:36 INFO - PROCESS | 1671 | |0;dojo.html;3333.9833300833498;3680.4479328100783;3689.3728066228737;3720.9581317231177;3728.832202550885;5089.51649593288;5848.502877255439;5985.25184351956;5989.610675306102;6017.578769486137;5848.385919478446;5969.6418214907135;6011.458968692817;6051.304100028498;6068.423499767515;5343.225232341309;5389.218563308318;5404.351477822667;5471.398146203915;5552.5280351169995;5369.463053694639;5451.618386712932;5459.590530710193;5484.91772623411;5492.80775172869;5424.105022671254;5454.59090568209;5477.3427188737205;5510;5543.6119471637;5410.08028635131;5431.103867861798;5457.345118585795;5464.453554644543;5471.042567550702;5338.252644629755;5384.946150538483;5404.810831620914;5419.810306639288;5505.449455054502;5516.7517461714315;5751.683657398841;5764.33710123337;5912.9113063304085;5964.910526342108;6210.813675589739;6237.126802247689;6260.749570017194;6274.247090349188;6274.309825919146;6313.242410910674;6329.525285603599;6358.332375100594;6359.523035772336;6362.331955144736;4899.28960300758;5991.370906054889;6029.186059881859;6058.787942422038;6116.602420842631;6348.555601107971;6397.584157029778;6425.132607097982;6434.292227854932;6448.516361272923;6178.845528861724;6291.5281353898645;6291.5281353898645;6295.937040629627;6303.432691057827;6263.060540918898;6304;6324.114623952651;6347.492200623939;6365.745370185141;6226.688665566794;6259.342769009279;6260.624362538262;6267.843303917439;6277.435030847154;6166.81499555014;6168.537359698041;6199.318075011745;6246.562740608205;6253.062040693932;5033.370828646419;5054.620903432257;5065.746712664352;5068.41713202979;5091.821786237464;4618.445786505574;4620.052889157714;4636.86089417318;4647.140279048387;4681.227597446383;5872.794452194153;5965.433283838029;5999.610025348426;6006.219191505076;6109.816705498843;5084.3644544431945;5274.97362513185;6173.382661733791;6230.7819226326865;6311.053341998645;5020.2720605511995;5979.79070732531;5985.940140598538;6002.339742628307;6004.0693692477735;5276.551493123127;5414.214938833847;5492.890142197213;5509.944900550943;5545.085060964976;6037.9396206038255;6535.150430444107;6573.474122070318;6609.702563384659;6609.702563384659;5521.309836270466;6298.338674439118;6343.841403964938;6344.9048264277;6371.490280777434;6383.585066970632;6391.2330520337855;6444.903326450013;6495.480361571157;6514.609123452608;5442.183672449164;6143.1706719592285;6246.875062498815;6260.492445439277;6273.811785646438;6284.088807123033;6309.053641953744;6309.053641953744;6313.96843015782;6322.810315690536;6121.969390153021;6123.130109042633;6175.857466368736;6176.3514830943905;6213.347598502092;6136.110264011782;6177.413145751326;6180.072989051679;6202.4417802398;6219.689015549295;5714.171445140514;6121.632702037892;6176.629402235881;6184.567080304336;6190.133381326528;6135.630783975068;6188.381161883775;6193.597416167935;6209.937900620936;6217.533684973555;6168.228971378578;6203.069539569101;6212.596181248205;6213.1922850029205;6233.158523599256 13:55:36 INFO - PROCESS | 1671 | |1;ext.html;535.3281631552401;548.2571116137633;549.242045976552;607.7052629474704;655.5509476008931;37956.62043379565;38736.418953715714;38798;38801.641942531984;38816.02959926003;42718.35922461165;43388;43690.78154609223;43700.470483533085;43729.12541749171;9741.902580974189;9837.213022958182;9863.408195508293;9888.851667224997;9970.800583988315;9040.502772347518;9879.357841740264;9950.800983980316;9980.201583873273;10006.849897251546;9861.852072218922;9883.357581757198;9913.950430247838;9919.851202231972;10040.648577299797;8925.46447213166;9007;9299.48852813095;9521.761955951088;9850.704478865573;9714;9787.755306117333;9807.06832850885;9814.75463113428;9854.359466634718;37525;37665.870023899326;37832.81083594592;37847;38021.23957520834;2624.593188055854;3129.6557378688326;3176.1102144224383;3191.377681352137;3284.178955261185;26920.192394228205;27175.1847444575;27634;27937.301567460774;28065;2655.668041494813;2667.2798344447083;2710.4037111835364;2768.6816016157995;2829.5048366535775;417435;418057;422561;423749;423854;26825.597616035775;30051;37675.86972390833;53396.597153128205;63448.68275658592;35972;36292.455613165825;36418;36563.08592285161;36586.268274634356;16364.34542618282;16501.009939403673;16531.256093475822;16536.090515021788;16556.006639601663;13618.114822536503;13666.385012674453;13713.245771482665;13997.160170389809;14057.507987220399;8284.295834854105;8473.745787626382;8545.444546104483;8583.656653733906;8617.224449799549;3072.416240914219;3516.1561225306255;3550.183457804668;3554.804485753308;3572.2498275361945;956.8947415784259;1022.3048327137469;1059;1089.6404186618397;1137.137375936221;30482.194326361376;30500.694993049787;30804.383912321628;31009.379812404077;31172.688273117434;944.4994153098869;1045.6497073480468;1141.155544896787;1167.871534131245;1176.5352685689277;15441.768373474408;15591.922040389725;15780.605484862741;15815.367385304458;16163.676726465404;645381;647117;657408;657450;659129.7043514752;60816.08775868366;60937.39062609406;61129;61819.690901545204;61911.38088619056;1505.4956589542408;1516.0448917182105;1539.961500962485;1542.5141080559588;1543.6758280760941;30302.84848575743;30634.763575305125;30644.233894151934;30964.69035309708;31005.379892402478;52992.20511692405;53135.20297195468;53188.73405632947;53542.732286338316;53754.92490150097;564608;566061;570639;572639;573668;27194.184174474798;27526.724732753217;27534.586981195698;27848.582271265543;27944.30139246535;46623;47198.76400617975;48140;48462.273065904745;48597.757011214715;36877.44683829798;36945.63054369422;36971.815140924125;37081.629183708894;37308.440373393874;35933.64066359407;36355;36463.635363646026;36773.81613091917;37226.8138659305;35989.46015809713;36098.45852312165;36528;36707.26585468222;36887;31671.52492712565;32375.51436728404;33647.495287570215;33834.154146145556;34043.4893476603;21453.249136280156;24959.376015599028;25176.37059073538;25513.23460296194;25627.743722563282 13:55:36 INFO - PROCESS | 1671 | |2;jquery.html;355.752751837473;408.74861959894673;411.74471827466976;415.9206858202962;425.2197218104778;17904.28382864684;21055.47361315966;21272.680909786326;21428.89285553572;21720.89139554302;20018.399448016582;20169;20241.291554795585;20757.896210518964;20807.583848323062;5842.737076831531;5889.6171748836405;6074.392560743934;6096.237970253718;6150.354212807658;5953.255843019622;6007;6020.157177995085;6085.178500902366;6091.847703807396;5827.388124246957;6059.3637668044885;6100.389961003909;6103.1455596216565;6107.5113990880845;5944.613600116;5985.5810093293485;5998.580099393044;6002.099685047256;6007.729652165663;5149.9485005149845;5194;5274.498922602346;5307.495787900143;5308.495692909168;26150.73849261502;26276;26490.47019059608;26810.5978410324;26826.7927943243;2430.1980346485616;2467.3338198686433;2878.596996420503;2963.1406892001296;2978.627671541057;14832.25838708071;15062;15289.923550382176;15304.08175509473;15750.291236894367;1794.8115447878047;1825.3793710138616;1835.4768890866173;1859.2841755924067;1878.2017642501883;115078;119467;120779;121255;123026;11084;11479.598214062635;11687.474063667156;11793.410329483491;11980.221285616408;11330;12933.870661293267;14149.71700565983;14322.212278324583;14411.639709007359;8986.86519702205;9073.274138068939;9089.318301127441;9139.588718507683;9289.97810240873;8238.794030149294;9307.395019323721;9369.672061477815;9496.240300775922;9576.616935322649;6861.656917154222;6975.895361569581;6982.47631427645;7000.894986575206;7047.964760176166;1933.0141627769938;2001.9199232030846;2006;2008.9598208035757;2016.7781544030145;929.3680297397699;981.6809536900536;1008.5612758450097;1058.396713873085;1099.1920938110482;18596.721049184274;20476.66901651388;20619;21496.785032149477;21660.89169554142;1031.138998935882;1031.6595523477235;1067.6370034188412;1078.4661592511757;1119.7088756923258;10884.836727448936;11139.721506962229;11354;11660.30038197711;11725;613079;613875;624110;645252;659629;116154;116664.41667791607;116713.70897487497;118904;120098.3995080019;1068.3643232276784;1103.5034234594464;1113.6380676280241;1118.703543560957;1118.9160812939062;18720.625587488445;18883.433496995112;18899.244030239188;18944.810551894858;19302.61394772125;30760.846195768878;37297.627023729416;41367;51788.96422071613;54875;55333.72333138309;55595.722021389636;57557.71221144035;57757.711211443675;58317.125243120536;6732.966335168293;7902.68389264446;7947.5231486108705;8041.276285134366;8331.12523185081;12140.75718485643;12439.689007774516;12677.746445071232;12701.36493175319;12715.80926286125;10740.83888741654;10839.512221950188;11095.889041109485;11221.887781122085;11540.884591153981;10053.798924021625;10054.447005414773;11123.388213648002;11132.610358637408;11319.377434241196;11336.23776557634;11431.42842857837;11541.538338466367;11548.653540393801;11594;7701.3068823806125;7822.726204582812;8003.319717823817;8162.061362943337;8389.61571340722;11147.609833656108;11191.776164476827;11315.886841131813;11378;11485.598004069818 13:55:36 INFO - PROCESS | 1671 | |3;mootools.html;1505.5558610209987;1645.4323258475824;1861.8603604729649;1962.293574313248;2002.8397728181728;7361.337479626833;8326.583670816466;8559.914400855998;8743.693970711018;9146.131117543831;8874.334424918125;8931.508767017827;8959.23846473049;9022.503762293087;9054;2316.154603569702;2422.7401751089424;2430.817688673352;2540.64430979663;2541.9745802542016;2476.2942561370014;2525.1162093267394;2539.7587229213286;2545.6308835218974;2561.0908127614707;2497.4131079196372;2540.098265115885;2545.770880620744;2549.2734570647367;2563.3207200091992;2500.499900019994;2525.1919385796555;2525.5201511712808;2541.644169816227;2549.3371723351875;2529.582618867885;2553.948921021588;2563.4488584954324;2571.3057474481784;2584.630146022611;9251.398659087137;9277.165055145002;9284.25725941923;9299.581518831601;9346.813063738755;5775.1337299405;5871.647701137946;5878.441548052928;5928.992071347881;5982.37185095563;3620.583632882226;3697.242065376591;3722.4974628425357;3753.0242137044293;3767.190054138346;1045.686294111771;1059.6238335390901;1061.8725752909622;1063.1282348474253;1064.4411683866033;12546.1844980076;12629.747405051847;12633.93683031588;12640.178388404724;12666.923311518533;4261.829526818892;5071.619628527875;5175.7153356564995;5181.06740786662;5235.110031294613;10607.94696026515;10623.84064239037;10645.787084258427;10649;10678.73303167427;5070.6957582545165;5701.00232459318;5818.970905145447;5833.562482813806;5913.408659134138;4705.529447055267;5162.8967420652125;5259.132243179833;5259.263703081571;5349.465053494697;4112.300908845504;4121.278776214151;4303.698741088094;4342.044750154961;4376.452943382077;1396.1832328087978;1405.1779708870424;1416.8016477693131;1416.971660566783;1426.5862899758954;897.5691667999266;981.5632043740467;1005.5977608956476;1019.8062368150028;1023.5649848814224;6121.724522396503;6149.477294429934;6160.476359509402;6231.844203894939;6274.435300822948;468.43319583304583;481.5954598137581;481.8361757002566;486;489.6401145158306;4050.4531888194715;4108.548059713429;4116.176764647083;4152.356384760367;4154.335306350969;10911.618093366853;11066.948639879198;11184.552617895193;11247.606333778278;11403.885961140448;10539.262251642465;10868;10882.510287037103;11021.008109270204;11035.668929932115;8537.317014638938;8562.400631955703;8602.225799677934;8612.354073444392;8648.1784230498;5912.793052243151;6171.228596425447;6189.659568723763;6228.283747369111;6393.712282947372;10032.097111260022;10061.446620435947;10153.79692406133;10214.285000050222;10253.231007674305;8699.782505437415;9874.21006319507;10093.19254459656;10141.732283464567;10210.540525676512;6478.902816457851;6649.567778094409;7461.589612571143;7654.770356889302;7823.374130069467;8463.23830855226;8524.957375213084;8589.226969572768;8622.61198246068;8633.438826476258;6786.253512113763;7593.734219302519;7775.727849525239;7842.254985776342;7847.489913155627;7580.54516728998;7662.6934922604705;7685.846283074419;7768.106667733283;7792.181820908723;7295.489315747846;7334;7372.336489715952;7373.15208750979;7390.778276651709;4337.1976184405985;5102.979404119117;5194.35070616173;5268.868278293074;5289.259503669412;5199.792008319776;5204.609654276021;5286.20706893969;5296.867578310573;5349.757505429994 13:55:36 INFO - PROCESS | 1671 | |4;prototype.html;308.20790568239624;331.88881724622263;336.4885374231169;339.947308167234;344.19115079563016;6988.231294557601;7048.894266586005;7081.964590177048;7099.6450177491115;7129.358357747802;6945.479089068327;6947.374736273734;6963.686634101465;6979.581225126483;7002.964985175067;4203.8738837834835;4357.738535687853;5060.544550990428;5103.693778373291;5111.744412779365;5017.84946451607;5098.719570423626;5108.7304125359615;5134.6662466939715;5143.639945203838;4133.648639865615;5030.144875371196;5075.923861142086;5093.643444958854;5111.1566591512355;4158.958410415888;5103.209002604603;5106;5117.411497677777;5390.8921821563745;4362.781860906974;4375.343698445258;4397.846075387346;4406.69153159279;4414.690971631987;5322.760475778599;6377.107204991305;6702.19573651165;6710.396064354183;6740.157480314961;5083.898322033576;5698.6865722385255;5922;5940.613860099123;5974.894644490783;7407;7407.703691852319;7416.851662966765;7439.107307123126;7471.775846724607;4739.620830333565;4756.524347565216;4757.6907501012665;4758.095961767253;4759.524047595248;7475.588842613654;7764.145943946161;7863.13505514393;7891.2897839194175;7898;4928.8767780805765;4955.752212389366;4988.501149885055;5010.624203184776;5024.723640199824;5092.745362731848;5092.981403719271;5099.286099946011;5100.336956195671;5115.7442127893455;5910.4385083417865;5910.497607703307;5913.231279933581;5913.970430147821;5924.407559244041;6273;7384.409247260206;7414.555126692308;7475.102987641518;7477.401807855358;1715.8970461772333;1761.1370428489947;1782.7415024821328;1783.5006198264507;1784.857211423109;1134.325076579434;1139.88601139887;1149.8447709559102;1153.233099988515;1157.4212893553224;6840.486963477759;6945.756898508528;6947.7220911163995;6957.8956315655305;6971.6165610891885;7483.4013278937555;7658.310752032233;7661.157272699998;7683.654235559413;7697.4226932980255;5286.471352864683;6138.631682099089;7080.398166155935;7092.716291348392;7117.110361204849;3623.221007483404;3817.2747178036084;4125.64931980779;4128.298189307825;4143.917121657611;8195.95902020498;8200.835983280302;8200.917990820135;8203.876941845878;8212.712555060543;7767.067951845815;8076.798080047928;8079.555624440713;8087.838243235103;8141.674333026613;8112.594370281462;8118.391120665974;8130.959345203236;8138.226868447607;8163.469374490639;6591.780520603704;7344.889826652711;7723.266289702469;7750.108737495035;7761.146273909752;7675.53946763196;7718.53688778675;7732.1494635588915;7735.110462296908;7742.225777422213;7787.377009839312;8186.672533098609;8189.099199088215;8195.836083278182;8227.753167404988;4760.857174284777;4832.855014349575;4842.128416884994;4854.83008094715;4880;6294.527910406646;7759.68961241544;7794.844103118019;7808.609569521387;7835.921640783519;7178.892316615151;7501.774946751606;7513.361364284097;7524.811879703051;7530.171681115183;6900.275471075665;7377.889331659922;7400.444966627632;7401.888971665322;7442;5875.911861321998;7304.744333948286;7322.853542929218;7330.486865919334;7368.4842061055215;7474.289942455458;7487.3261406473675;7488.925110748823;7494.437917156344;7518.661660225193;7200.603966781878;7318.817029574303;7320.194778574246;7379.114506259283;7380.926190738024 13:55:36 INFO - PROCESS | 1671 | |5;yui.html;610.8106486989034;756.2626439221759;758.795125316165;762.5843915066288;790.7034861926777;15812.920935395321;16024.519264422072;16076.115813630246;16078.115703636295;16116.597085072879;12002.339871307075;14113.57659270221;14126.293685315744;14383.64040898978;14532.055416397927;612.2989177391884;915.7939463620698;923.5705396990398;924.4684306523742;949.7815502434444;893.1515060692336;906.2613969614775;915.6245939164944;921.2031592672357;930.7347405989294;987.2842189412654;1003.7390278527563;1004.5178314409088;1006.3609607898964;1006.5772375602264;897.5243121145803;966.3670295956125;972.8735264415616;982.3516479123743;1008.1430783833756;719.8200449887528;720.8522252938135;721.5923003503004;741.6921977379382;757.1444267977206;15087.773683394758;15143.697126057417;15326.770098448533;15494.225288735519;15494.5351639451;11318.434078296135;12577.874221257762;13315.600531983959;13360.265185414799;13443;10189.847152292721;10370.688879333633;10374.636887708893;10567.947160264226;10658.147348212124;3566.3045706087323;3588.74878758487;3613;3662.688671462929;3858.074062225046;70069;90425;90775.54612226963;90913.63629545562;91780.62329065069;9383.765405864908;9761.267904907161;9820;9868.555914983843;10145.239107067;22605;23078.65382019271;23086.769132308462;23110.53778924412;23121.42196445069;7606.429517786189;7701.345385642283;7729.3043626072795;7841.529508229524;7876.881846772303;4178.686598505064;4220.303649897794;4226.535081141072;4238.19474299882;4254.87235382939;3761.3793724035777;3796.8481260749813;3803.9619603804163;3804.2771873343977;3826.043489127718;617.6781687189329;657.9901301480481;680.0920770771075;681.8499930015389;709.5529816215854;492.6206820748004;557.5010365722736;572.0875204049618;622.1973653986307;623.0654018971543;8202.507849529047;8208.794780130545;8428.789280268042;8447.831043379098;8464.280536154496;595.9046552551571;598.5480961873844;607.4623957797293;618.3167599802243;622.7384498510636;3921.274564205631;3949.3483575210344;3955.64399204073;4059.2490389278078;4060.0864805419137;89696.551517242;91756;97252;98017.50991244998;99870;82691.5865420669;83467.7479837803;85714;86204.56897715597;88454;68713.31286687069;69581.30418695748;76437;77329.2267077322;77831;7198.896628921464;8595.785105372415;8621.655133794578;8778.561071946506;8786.692465763668;50833;51357.48642513527;52371.73814130905;52640.736796315774;54424.72787636037;69713;72074.27925720676;75127.62436187784;75142;77486;10925.672229833117;11028.338299702044;11046.226764126755;11238.83141752858;11321.886781132413;12118.757624847278;12128.393580320771;12271.69320766988;12322.445489952794;12760.936195318964;11056.226064175753;11573.18987670855;11838.585649502225;11856.940715296714;12178.512859485521;11431.828522572001;11442.084633229155;11614.187006909435;11764.588239411922;11921.986631136451;11467.082633389142;11491.195616306779;11712.063034957013;11771.411429428666;11845.881541184477;9414.905850941403;9719.611215551298;9783.364081334976;9876.604935802487;9930.453825039693;8454.704085356983;8722.389432739901;9781.462019588991;9785.36395134314;9889.258305626963 13:55:36 INFO - PROCESS | 1671 | __end_tp_report 13:55:36 INFO - PROCESS | 1671 | __start_cc_report 13:55:36 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,393 13:55:36 INFO - PROCESS | 1671 | __end_cc_report 13:55:36 INFO - PROCESS | 1671 | __startTimestamp1466715336480__endTimestamp 13:55:36 INFO - PROCESS | 1671 | 13:55:36 INFO - PROCESS | 1671 | ------- Summary: start ------- 13:55:36 INFO - PROCESS | 1671 | Number of tests: 6 13:55:36 INFO - PROCESS | 1671 | 13:55:36 INFO - PROCESS | 1671 | [#0] dojo.html Cycles:165 Average:5858.96 Median:6121.97 stddev:610.36 (10.0%) stddev-sans-first:579.20 13:55:36 INFO - PROCESS | 1671 | Values: 3334.0 3680.4 3689.4 3721.0 3728.8 5089.5 5848.5 5985.3 5989.6 6017.6 5848.4 5969.6 6011.5 6051.3 6068.4 5343.2 5389.2 5404.4 5471.4 5552.5 5369.5 5451.6 5459.6 5484.9 5492.8 5424.1 5454.6 5477.3 5510.0 5543.6 5410.1 5431.1 5457.3 5464.5 5471.0 5338.3 5384.9 5404.8 5419.8 5505.4 5516.8 5751.7 5764.3 5912.9 5964.9 6210.8 6237.1 6260.7 6274.2 6274.3 6313.2 6329.5 6358.3 6359.5 6362.3 4899.3 5991.4 6029.2 6058.8 6116.6 6348.6 6397.6 6425.1 6434.3 6448.5 6178.8 6291.5 6291.5 6295.9 6303.4 6263.1 6304.0 6324.1 6347.5 6365.7 6226.7 6259.3 6260.6 6267.8 6277.4 6166.8 6168.5 6199.3 6246.6 6253.1 5033.4 5054.6 5065.7 5068.4 5091.8 4618.4 4620.1 4636.9 4647.1 4681.2 5872.8 5965.4 5999.6 6006.2 6109.8 5084.4 5275.0 6173.4 6230.8 6311.1 5020.3 5979.8 5985.9 6002.3 6004.1 5276.6 5414.2 5492.9 5509.9 5545.1 6037.9 6535.2 6573.5 6609.7 6609.7 5521.3 6298.3 6343.8 6344.9 6371.5 6383.6 6391.2 6444.9 6495.5 6514.6 5442.2 6143.2 6246.9 6260.5 6273.8 6284.1 6309.1 6309.1 6314.0 6322.8 6122.0 6123.1 6175.9 6176.4 6213.3 6136.1 6177.4 6180.1 6202.4 6219.7 5714.2 6121.6 6176.6 6184.6 6190.1 6135.6 6188.4 6193.6 6209.9 6217.5 6168.2 6203.1 6212.6 6213.2 6233.2 13:55:36 INFO - PROCESS | 1671 | 13:55:36 INFO - PROCESS | 1671 | [#1] ext.html Cycles:180 Average:66833.35 Median:36882.22 stddev:149038.32 (404.1%) stddev-sans-first:149373.28 13:55:36 INFO - PROCESS | 1671 | Values: 535.3 548.3 549.2 607.7 655.6 37956.6 38736.4 38798.0 38801.6 38816.0 42718.4 43388.0 43690.8 43700.5 43729.1 9741.9 9837.2 9863.4 9888.9 9970.8 9040.5 9879.4 9950.8 9980.2 10006.8 9861.9 9883.4 9914.0 9919.9 10040.6 8925.5 9007.0 9299.5 9521.8 9850.7 9714.0 9787.8 9807.1 9814.8 9854.4 37525.0 37665.9 37832.8 37847.0 38021.2 2624.6 3129.7 3176.1 3191.4 3284.2 26920.2 27175.2 27634.0 27937.3 28065.0 2655.7 2667.3 2710.4 2768.7 2829.5 417435.0 418057.0 422561.0 423749.0 423854.0 26825.6 30051.0 37675.9 53396.6 63448.7 35972.0 36292.5 36418.0 36563.1 36586.3 16364.3 16501.0 16531.3 16536.1 16556.0 13618.1 13666.4 13713.2 13997.2 14057.5 8284.3 8473.7 8545.4 8583.7 8617.2 3072.4 3516.2 3550.2 3554.8 3572.2 956.9 1022.3 1059.0 1089.6 1137.1 30482.2 30500.7 30804.4 31009.4 31172.7 944.5 1045.6 1141.2 1167.9 1176.5 15441.8 15591.9 15780.6 15815.4 16163.7 645381.0 647117.0 657408.0 657450.0 659129.7 60816.1 60937.4 61129.0 61819.7 61911.4 1505.5 1516.0 1540.0 1542.5 1543.7 30302.8 30634.8 30644.2 30964.7 31005.4 52992.2 53135.2 53188.7 53542.7 53754.9 564608.0 566061.0 570639.0 572639.0 573668.0 27194.2 27526.7 27534.6 27848.6 27944.3 46623.0 47198.8 48140.0 48462.3 48597.8 36877.4 36945.6 36971.8 37081.6 37308.4 35933.6 36355.0 36463.6 36773.8 37226.8 35989.5 36098.5 36528.0 36707.3 36887.0 31671.5 32375.5 33647.5 33834.2 34043.5 21453.2 24959.4 25176.4 25513.2 25627.7 13:55:36 INFO - PROCESS | 1671 | 13:55:36 INFO - PROCESS | 1671 | [#2] jquery.html Cycles:180 Average:35150.49 Median:20782.74 stddev:104626.13 (503.4%) stddev-sans-first:104887.02 13:55:36 INFO - PROCESS | 1671 | Values: 355.8 408.7 411.7 415.9 425.2 17904.3 21055.5 21272.7 21428.9 21720.9 20018.4 20169.0 20241.3 20757.9 20807.6 5842.7 5889.6 6074.4 6096.2 6150.4 5953.3 6007.0 6020.2 6085.2 6091.8 5827.4 6059.4 6100.4 6103.1 6107.5 5944.6 5985.6 5998.6 6002.1 6007.7 5149.9 5194.0 5274.5 5307.5 5308.5 26150.7 26276.0 26490.5 26810.6 26826.8 2430.2 2467.3 2878.6 2963.1 2978.6 14832.3 15062.0 15289.9 15304.1 15750.3 1794.8 1825.4 1835.5 1859.3 1878.2 115078.0 119467.0 120779.0 121255.0 123026.0 11084.0 11479.6 11687.5 11793.4 11980.2 11330.0 12933.9 14149.7 14322.2 14411.6 8986.9 9073.3 9089.3 9139.6 9290.0 8238.8 9307.4 9369.7 9496.2 9576.6 6861.7 6975.9 6982.5 7000.9 7048.0 1933.0 2001.9 2006.0 2009.0 2016.8 929.4 981.7 1008.6 1058.4 1099.2 18596.7 20476.7 20619.0 21496.8 21660.9 1031.1 1031.7 1067.6 1078.5 1119.7 10884.8 11139.7 11354.0 11660.3 11725.0 613079.0 613875.0 624110.0 645252.0 659629.0 116154.0 116664.4 116713.7 118904.0 120098.4 1068.4 1103.5 1113.6 1118.7 1118.9 18720.6 18883.4 18899.2 18944.8 19302.6 30760.8 37297.6 41367.0 51789.0 54875.0 55333.7 55595.7 57557.7 57757.7 58317.1 6733.0 7902.7 7947.5 8041.3 8331.1 12140.8 12439.7 12677.7 12701.4 12715.8 10740.8 10839.5 11095.9 11221.9 11540.9 10053.8 10054.4 11123.4 11132.6 11319.4 11336.2 11431.4 11541.5 11548.7 11594.0 7701.3 7822.7 8003.3 8162.1 8389.6 11147.6 11191.8 11315.9 11378.0 11485.6 13:55:36 INFO - PROCESS | 1671 | 13:55:36 INFO - PROCESS | 1671 | [#3] mootools.html Cycles:180 Average:5936.28 Median:481.72 stddev:3304.70 (686.0%) stddev-sans-first:3297.19 13:55:36 INFO - PROCESS | 1671 | Values: 1505.6 1645.4 1861.9 1962.3 2002.8 7361.3 8326.6 8559.9 8743.7 9146.1 8874.3 8931.5 8959.2 9022.5 9054.0 2316.2 2422.7 2430.8 2540.6 2542.0 2476.3 2525.1 2539.8 2545.6 2561.1 2497.4 2540.1 2545.8 2549.3 2563.3 2500.5 2525.2 2525.5 2541.6 2549.3 2529.6 2553.9 2563.4 2571.3 2584.6 9251.4 9277.2 9284.3 9299.6 9346.8 5775.1 5871.6 5878.4 5929.0 5982.4 3620.6 3697.2 3722.5 3753.0 3767.2 1045.7 1059.6 1061.9 1063.1 1064.4 12546.2 12629.7 12633.9 12640.2 12666.9 4261.8 5071.6 5175.7 5181.1 5235.1 10607.9 10623.8 10645.8 10649.0 10678.7 5070.7 5701.0 5819.0 5833.6 5913.4 4705.5 5162.9 5259.1 5259.3 5349.5 4112.3 4121.3 4303.7 4342.0 4376.5 1396.2 1405.2 1416.8 1417.0 1426.6 897.6 981.6 1005.6 1019.8 1023.6 6121.7 6149.5 6160.5 6231.8 6274.4 468.4 481.6 481.8 486.0 489.6 4050.5 4108.5 4116.2 4152.4 4154.3 10911.6 11066.9 11184.6 11247.6 11403.9 10539.3 10868.0 10882.5 11021.0 11035.7 8537.3 8562.4 8602.2 8612.4 8648.2 5912.8 6171.2 6189.7 6228.3 6393.7 10032.1 10061.4 10153.8 10214.3 10253.2 8699.8 9874.2 10093.2 10141.7 10210.5 6478.9 6649.6 7461.6 7654.8 7823.4 8463.2 8525.0 8589.2 8622.6 8633.4 6786.3 7593.7 7775.7 7842.3 7847.5 7580.5 7662.7 7685.8 7768.1 7792.2 7295.5 7334.0 7372.3 7373.2 7390.8 4337.2 5103.0 5194.4 5268.9 5289.3 5199.8 5204.6 5286.2 5296.9 5349.8 13:55:36 INFO - PROCESS | 1671 | 13:55:36 INFO - PROCESS | 1671 | [#4] prototype.html Cycles:180 Average:6064.50 Median:6947.55 stddev:1971.96 (28.4%) stddev-sans-first:1929.58 13:55:36 INFO - PROCESS | 1671 | Values: 308.2 331.9 336.5 339.9 344.2 6988.2 7048.9 7082.0 7099.6 7129.4 6945.5 6947.4 6963.7 6979.6 7003.0 4203.9 4357.7 5060.5 5103.7 5111.7 5017.8 5098.7 5108.7 5134.7 5143.6 4133.6 5030.1 5075.9 5093.6 5111.2 4159.0 5103.2 5106.0 5117.4 5390.9 4362.8 4375.3 4397.8 4406.7 4414.7 5322.8 6377.1 6702.2 6710.4 6740.2 5083.9 5698.7 5922.0 5940.6 5974.9 7407.0 7407.7 7416.9 7439.1 7471.8 4739.6 4756.5 4757.7 4758.1 4759.5 7475.6 7764.1 7863.1 7891.3 7898.0 4928.9 4955.8 4988.5 5010.6 5024.7 5092.7 5093.0 5099.3 5100.3 5115.7 5910.4 5910.5 5913.2 5914.0 5924.4 6273.0 7384.4 7414.6 7475.1 7477.4 1715.9 1761.1 1782.7 1783.5 1784.9 1134.3 1139.9 1149.8 1153.2 1157.4 6840.5 6945.8 6947.7 6957.9 6971.6 7483.4 7658.3 7661.2 7683.7 7697.4 5286.5 6138.6 7080.4 7092.7 7117.1 3623.2 3817.3 4125.6 4128.3 4143.9 8196.0 8200.8 8200.9 8203.9 8212.7 7767.1 8076.8 8079.6 8087.8 8141.7 8112.6 8118.4 8131.0 8138.2 8163.5 6591.8 7344.9 7723.3 7750.1 7761.1 7675.5 7718.5 7732.1 7735.1 7742.2 7787.4 8186.7 8189.1 8195.8 8227.8 4760.9 4832.9 4842.1 4854.8 4880.0 6294.5 7759.7 7794.8 7808.6 7835.9 7178.9 7501.8 7513.4 7524.8 7530.2 6900.3 7377.9 7400.4 7401.9 7442.0 5875.9 7304.7 7322.9 7330.5 7368.5 7474.3 7487.3 7488.9 7494.4 7518.7 7200.6 7318.8 7320.2 7379.1 7380.9 13:55:36 INFO - PROCESS | 1671 | 13:55:36 INFO - PROCESS | 1671 | [#5] yui.html Cycles:180 Average:19265.39 Median:603.01 stddev:27481.63 (4557.4%) stddev-sans-first:27523.03 13:55:36 INFO - PROCESS | 1671 | Values: 610.8 756.3 758.8 762.6 790.7 15812.9 16024.5 16076.1 16078.1 16116.6 12002.3 14113.6 14126.3 14383.6 14532.1 612.3 915.8 923.6 924.5 949.8 893.2 906.3 915.6 921.2 930.7 987.3 1003.7 1004.5 1006.4 1006.6 897.5 966.4 972.9 982.4 1008.1 719.8 720.9 721.6 741.7 757.1 15087.8 15143.7 15326.8 15494.2 15494.5 11318.4 12577.9 13315.6 13360.3 13443.0 10189.8 10370.7 10374.6 10567.9 10658.1 3566.3 3588.7 3613.0 3662.7 3858.1 70069.0 90425.0 90775.5 90913.6 91780.6 9383.8 9761.3 9820.0 9868.6 10145.2 22605.0 23078.7 23086.8 23110.5 23121.4 7606.4 7701.3 7729.3 7841.5 7876.9 4178.7 4220.3 4226.5 4238.2 4254.9 3761.4 3796.8 3804.0 3804.3 3826.0 617.7 658.0 680.1 681.8 709.6 492.6 557.5 572.1 622.2 623.1 8202.5 8208.8 8428.8 8447.8 8464.3 595.9 598.5 607.5 618.3 622.7 3921.3 3949.3 3955.6 4059.2 4060.1 89696.6 91756.0 97252.0 98017.5 99870.0 82691.6 83467.7 85714.0 86204.6 88454.0 68713.3 69581.3 76437.0 77329.2 77831.0 7198.9 8595.8 8621.7 8778.6 8786.7 50833.0 51357.5 52371.7 52640.7 54424.7 69713.0 72074.3 75127.6 75142.0 77486.0 10925.7 11028.3 11046.2 11238.8 11321.9 12118.8 12128.4 12271.7 12322.4 12760.9 11056.2 11573.2 11838.6 11856.9 12178.5 11431.8 11442.1 11614.2 11764.6 11922.0 11467.1 11491.2 11712.1 11771.4 11845.9 9414.9 9719.6 9783.4 9876.6 9930.5 8454.7 8722.4 9781.5 9785.4 9889.3 13:55:36 INFO - PROCESS | 1671 | -------- Summary: end -------- 13:55:36 INFO - PROCESS | 1671 | 13:55:37 INFO - TEST-INFO | 1671: exit 0 13:55:37 INFO - TEST-OK | dromaeo_css | took 1109898ms 13:55:37 INFO - TEST-START | kraken 13:55:37 INFO - operating with platform_type : mac_ 13:55:37 INFO - Initialising browser for kraken test... 13:55:37 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/tmpijaEIf/profile http://localhost:49279/getInfo.html) 13:55:39 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 13:55:39 INFO - PROCESS | 1678 | colorDepth:24 13:55:39 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 13:55:39 INFO - PROCESS | 1678 | __metrics 13:55:39 ERROR - PROCESS | 1678 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 13:55:40 INFO - TEST-INFO | 1678: exit 0 13:55:40 INFO - Browser initialized. 13:55:40 INFO - Running cycle 1/1 for kraken test... 13:55:40 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/T/tmpijaEIf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:55:52 INFO - PROCESS | 1682 | RSS: Main: 170934272 13:55:52 INFO - PROCESS | 1682 | 13:55:54 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 13:55:55 INFO - PROCESS | 1682 | RSS: Main: 183328768 13:55:55 INFO - PROCESS | 1682 | 13:55:58 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 13:55:59 INFO - PROCESS | 1682 | RSS: Main: 192679936 13:55:59 INFO - PROCESS | 1682 | 13:56:02 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 13:56:02 INFO - PROCESS | 1682 | RSS: Main: 196157440 13:56:02 INFO - PROCESS | 1682 | 13:56:04 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 13:56:05 INFO - PROCESS | 1682 | RSS: Main: 196456448 13:56:05 INFO - PROCESS | 1682 | 13:56:07 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:56:08 INFO - PROCESS | 1682 | RSS: Main: 197414912 13:56:08 INFO - PROCESS | 1682 | 13:56:10 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 13:56:11 INFO - PROCESS | 1682 | RSS: Main: 198201344 13:56:11 INFO - PROCESS | 1682 | 13:56:14 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 13:56:15 INFO - PROCESS | 1682 | RSS: Main: 197943296 13:56:15 INFO - PROCESS | 1682 | 13:56:18 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 13:56:18 INFO - PROCESS | 1682 | RSS: Main: 198565888 13:56:18 INFO - PROCESS | 1682 | 13:56:20 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:56:21 INFO - PROCESS | 1682 | RSS: Main: 197464064 13:56:21 INFO - PROCESS | 1682 | 13:56:23 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:56:23 INFO - PROCESS | 1682 | RSS: Main: 198008832 13:56:23 INFO - PROCESS | 1682 | 13:56:25 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:56:26 INFO - PROCESS | 1682 | RSS: Main: 198176768 13:56:26 INFO - PROCESS | 1682 | 13:56:29 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:56:30 INFO - PROCESS | 1682 | RSS: Main: 197574656 13:56:30 INFO - PROCESS | 1682 | 13:56:33 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:56:33 INFO - PROCESS | 1682 | RSS: Main: 197517312 13:56:33 INFO - PROCESS | 1682 | 13:56:35 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 13:56:35 INFO - PROCESS | 1682 | RSS: Main: 199229440 13:56:35 INFO - PROCESS | 1682 | 13:56:35 INFO - PROCESS | 1682 | __start_tp_report 13:56:35 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 13:56:35 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 13:56:35 INFO - PROCESS | 1682 | |i|pagename|runs| 13:56:35 INFO - PROCESS | 1682 | |0;ai-astar;117;115;115;115;117;131;128;167;167;117 13:56:35 INFO - PROCESS | 1682 | |1;audio-beat-detection;152;125;140;152;121;139;120;159;159;121 13:56:35 INFO - PROCESS | 1682 | |2;audio-dft;198;201;200;197;200;192;197;194;200;195 13:56:35 INFO - PROCESS | 1682 | |3;audio-fft;65;68;79;145;56;56;58;68;125;56 13:56:35 INFO - PROCESS | 1682 | |4;audio-oscillator;76;88;139;76;77;83;117;80;79;119 13:56:35 INFO - PROCESS | 1682 | |5;imaging-gaussian-blur;104;110;90;88;90;104;91;88;90;86 13:56:35 INFO - PROCESS | 1682 | |6;imaging-darkroom;95;96;97;121;149;103;145;149;95;95 13:56:35 INFO - PROCESS | 1682 | |7;imaging-desaturate;138;150;126;90;90;98;135;140;144;92 13:56:35 INFO - PROCESS | 1682 | |8;json-parse-financial;53;79;94;90;93;79;64;84;81;85 13:56:35 INFO - PROCESS | 1682 | |9;json-stringify-tinderbox;60;62;89;96;79;87;106;94;63;83 13:56:35 INFO - PROCESS | 1682 | |10;stanford-crypto-aes;80;80;82;79;79;81;82;86;81;76 13:56:35 INFO - PROCESS | 1682 | |11;stanford-crypto-ccm;131;146;116;172;139;126;139;143;166;167 13:56:35 INFO - PROCESS | 1682 | |12;stanford-crypto-pbkdf2;208;216;171;166;190;200;152;202;216;196 13:56:35 INFO - PROCESS | 1682 | |13;stanford-crypto-sha256-iterative;68;66;67;67;65;69;65;64;69;67 13:56:35 INFO - PROCESS | 1682 | __end_tp_report 13:56:35 INFO - PROCESS | 1682 | __start_cc_report 13:56:35 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,1032 13:56:35 INFO - PROCESS | 1682 | __end_cc_report 13:56:35 INFO - PROCESS | 1682 | __startTimestamp1466715395619__endTimestamp 13:56:35 INFO - PROCESS | 1682 | 13:56:35 INFO - PROCESS | 1682 | ------- Summary: start ------- 13:56:35 INFO - PROCESS | 1682 | Number of tests: 14 13:56:35 INFO - PROCESS | 1682 | 13:56:35 INFO - PROCESS | 1682 | [#0] ai-astar Cycles:10 Average:128.90 Median:122.50 stddev:20.85 (17.0%) stddev-sans-first:21.67 13:56:35 INFO - PROCESS | 1682 | Values: 117.0 115.0 115.0 115.0 117.0 131.0 128.0 167.0 167.0 117.0 13:56:35 INFO - PROCESS | 1682 | 13:56:35 INFO - PROCESS | 1682 | [#1] audio-beat-detection Cycles:10 Average:138.80 Median:146.00 stddev:16.14 (11.1%) stddev-sans-first:16.39 13:56:35 INFO - PROCESS | 1682 | Values: 152.0 125.0 140.0 152.0 121.0 139.0 120.0 159.0 159.0 121.0 13:56:35 INFO - PROCESS | 1682 | 13:56:35 INFO - PROCESS | 1682 | [#2] audio-dft Cycles:10 Average:197.40 Median:199.00 stddev:2.99 (1.5%) stddev-sans-first:3.16 13:56:35 INFO - PROCESS | 1682 | Values: 198.0 201.0 200.0 197.0 200.0 192.0 197.0 194.0 200.0 195.0 13:56:35 INFO - PROCESS | 1682 | 13:56:35 INFO - PROCESS | 1682 | [#3] audio-fft Cycles:10 Average:77.60 Median:61.50 stddev:31.48 (51.2%) stddev-sans-first:33.06 13:56:35 INFO - PROCESS | 1682 | Values: 65.0 68.0 79.0 145.0 56.0 56.0 58.0 68.0 125.0 56.0 13:56:35 INFO - PROCESS | 1682 | 13:56:35 INFO - PROCESS | 1682 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:78.00 stddev:22.83 (29.3%) stddev-sans-first:23.33 13:56:35 INFO - PROCESS | 1682 | Values: 76.0 88.0 139.0 76.0 77.0 83.0 117.0 80.0 79.0 119.0 13:56:35 INFO - PROCESS | 1682 | 13:56:35 INFO - PROCESS | 1682 | [#5] imaging-gaussian-blur Cycles:10 Average:94.10 Median:89.00 stddev:8.49 (9.5%) stddev-sans-first:8.22 13:56:35 INFO - PROCESS | 1682 | Values: 104.0 110.0 90.0 88.0 90.0 104.0 91.0 88.0 90.0 86.0 13:56:35 INFO - PROCESS | 1682 | 13:56:35 INFO - PROCESS | 1682 | [#6] imaging-darkroom Cycles:10 Average:114.50 Median:95.00 stddev:24.21 (25.5%) stddev-sans-first:24.63 13:56:35 INFO - PROCESS | 1682 | Values: 95.0 96.0 97.0 121.0 149.0 103.0 145.0 149.0 95.0 95.0 13:56:35 INFO - PROCESS | 1682 | 13:56:35 INFO - PROCESS | 1682 | [#7] imaging-desaturate Cycles:10 Average:120.30 Median:120.00 stddev:24.78 (20.7%) stddev-sans-first:25.45 13:56:35 INFO - PROCESS | 1682 | Values: 138.0 150.0 126.0 90.0 90.0 98.0 135.0 140.0 144.0 92.0 13:56:35 INFO - PROCESS | 1682 | 13:56:35 INFO - PROCESS | 1682 | [#8] json-parse-financial Cycles:10 Average:80.20 Median:84.50 stddev:12.88 (15.2%) stddev-sans-first:9.16 13:56:35 INFO - PROCESS | 1682 | Values: 53.0 79.0 94.0 90.0 93.0 79.0 64.0 84.0 81.0 85.0 13:56:35 INFO - PROCESS | 1682 | 13:56:35 INFO - PROCESS | 1682 | [#9] json-stringify-tinderbox Cycles:10 Average:81.90 Median:85.00 stddev:15.79 (18.6%) stddev-sans-first:14.63 13:56:35 INFO - PROCESS | 1682 | Values: 60.0 62.0 89.0 96.0 79.0 87.0 106.0 94.0 63.0 83.0 13:56:35 INFO - PROCESS | 1682 | 13:56:35 INFO - PROCESS | 1682 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:81.00 stddev:2.59 (3.2%) stddev-sans-first:2.74 13:56:35 INFO - PROCESS | 1682 | Values: 80.0 80.0 82.0 79.0 79.0 81.0 82.0 86.0 81.0 76.0 13:56:35 INFO - PROCESS | 1682 | 13:56:35 INFO - PROCESS | 1682 | [#11] stanford-crypto-ccm Cycles:10 Average:144.50 Median:144.50 stddev:18.64 (12.9%) stddev-sans-first:19.12 13:56:35 INFO - PROCESS | 1682 | Values: 131.0 146.0 116.0 172.0 139.0 126.0 139.0 143.0 166.0 167.0 13:56:35 INFO - PROCESS | 1682 | 13:56:35 INFO - PROCESS | 1682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.70 Median:201.00 stddev:21.88 (10.9%) stddev-sans-first:22.40 13:56:35 INFO - PROCESS | 1682 | Values: 208.0 216.0 171.0 166.0 190.0 200.0 152.0 202.0 216.0 196.0 13:56:35 INFO - PROCESS | 1682 | 13:56:35 INFO - PROCESS | 1682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.70 (2.5%) stddev-sans-first:1.74 13:56:35 INFO - PROCESS | 1682 | Values: 68.0 66.0 67.0 67.0 65.0 69.0 65.0 64.0 69.0 67.0 13:56:35 INFO - PROCESS | 1682 | -------- Summary: end -------- 13:56:35 INFO - PROCESS | 1682 | 13:56:36 INFO - TEST-INFO | 1682: exit 0 13:56:36 INFO - TEST-OK | kraken | took 59219ms 13:56:36 INFO - SUITE-END | took 1169s 13:56:36 INFO - Completed test suite (00:19:29) 13:56:36 INFO - javascript benchmark 13:56:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3333.9833300833498, 3680.4479328100783, 3689.3728066228737, 3720.9581317231177, 3728.832202550885, 5089.51649593288, 5848.502877255439, 5985.25184351956, 5989.610675306102, 6017.578769486137, 5848.385919478446, 5969.6418214907135, 6011.458968692817, 6051.304100028498, 6068.423499767515, 5343.225232341309, 5389.218563308318, 5404.351477822667, 5471.398146203915, 5552.5280351169995, 5369.463053694639, 5451.618386712932, 5459.590530710193, 5484.91772623411, 5492.80775172869, 5424.105022671254, 5454.59090568209, 5477.3427188737205, 5510.0, 5543.6119471637, 5410.08028635131, 5431.103867861798, 5457.345118585795, 5464.453554644543, 5471.042567550702, 5338.252644629755, 5384.946150538483, 5404.810831620914, 5419.810306639288, 5505.449455054502, 5516.7517461714315, 5751.683657398841, 5764.33710123337, 5912.9113063304085, 5964.910526342108, 6210.813675589739, 6237.126802247689, 6260.749570017194, 6274.247090349188, 6274.309825919146, 6313.242410910674, 6329.525285603599, 6358.332375100594, 6359.523035772336, 6362.331955144736, 4899.28960300758, 5991.370906054889, 6029.186059881859, 6058.787942422038, 6116.602420842631, 6348.555601107971, 6397.584157029778, 6425.132607097982, 6434.292227854932, 6448.516361272923, 6178.845528861724, 6291.5281353898645, 6291.5281353898645, 6295.937040629627, 6303.432691057827, 6263.060540918898, 6304.0, 6324.114623952651, 6347.492200623939, 6365.745370185141, 6226.688665566794, 6259.342769009279, 6260.624362538262, 6267.843303917439, 6277.435030847154, 6166.81499555014, 6168.537359698041, 6199.318075011745, 6246.562740608205, 6253.062040693932, 5033.370828646419, 5054.620903432257, 5065.746712664352, 5068.41713202979, 5091.821786237464, 4618.445786505574, 4620.052889157714, 4636.86089417318, 4647.140279048387, 4681.227597446383, 5872.794452194153, 5965.433283838029, 5999.610025348426, 6006.219191505076, 6109.816705498843, 5084.3644544431945, 5274.97362513185, 6173.382661733791, 6230.7819226326865, 6311.053341998645, 5020.2720605511995, 5979.79070732531, 5985.940140598538, 6002.339742628307, 6004.0693692477735, 5276.551493123127, 5414.214938833847, 5492.890142197213, 5509.944900550943, 5545.085060964976, 6037.9396206038255, 6535.150430444107, 6573.474122070318, 6609.702563384659, 6609.702563384659, 5521.309836270466, 6298.338674439118, 6343.841403964938, 6344.9048264277, 6371.490280777434, 6383.585066970632, 6391.2330520337855, 6444.903326450013, 6495.480361571157, 6514.609123452608, 5442.183672449164, 6143.1706719592285, 6246.875062498815, 6260.492445439277, 6273.811785646438, 6284.088807123033, 6309.053641953744, 6309.053641953744, 6313.96843015782, 6322.810315690536, 6121.969390153021, 6123.130109042633, 6175.857466368736, 6176.3514830943905, 6213.347598502092, 6136.110264011782, 6177.413145751326, 6180.072989051679, 6202.4417802398, 6219.689015549295, 5714.171445140514, 6121.632702037892, 6176.629402235881, 6184.567080304336, 6190.133381326528, 6135.630783975068, 6188.381161883775, 6193.597416167935, 6209.937900620936, 6217.533684973555, 6168.228971378578, 6203.069539569101, 6212.596181248205, 6213.1922850029205, 6233.158523599256], "value": 5825.280558742719, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.3281631552401, 548.2571116137633, 549.242045976552, 607.7052629474704, 655.5509476008931, 37956.62043379565, 38736.418953715714, 38798.0, 38801.641942531984, 38816.02959926003, 42718.35922461165, 43388.0, 43690.78154609223, 43700.470483533085, 43729.12541749171, 9741.902580974189, 9837.213022958182, 9863.408195508293, 9888.851667224997, 9970.800583988315, 9040.502772347518, 9879.357841740264, 9950.800983980316, 9980.201583873273, 10006.849897251546, 9861.852072218922, 9883.357581757198, 9913.950430247838, 9919.851202231972, 10040.648577299797, 8925.46447213166, 9007.0, 9299.48852813095, 9521.761955951088, 9850.704478865573, 9714.0, 9787.755306117333, 9807.06832850885, 9814.75463113428, 9854.359466634718, 37525.0, 37665.870023899326, 37832.81083594592, 37847.0, 38021.23957520834, 2624.593188055854, 3129.6557378688326, 3176.1102144224383, 3191.377681352137, 3284.178955261185, 26920.192394228205, 27175.1847444575, 27634.0, 27937.301567460774, 28065.0, 2655.668041494813, 2667.2798344447083, 2710.4037111835364, 2768.6816016157995, 2829.5048366535775, 417435.0, 418057.0, 422561.0, 423749.0, 423854.0, 26825.597616035775, 30051.0, 37675.86972390833, 53396.597153128205, 63448.68275658592, 35972.0, 36292.455613165825, 36418.0, 36563.08592285161, 36586.268274634356, 16364.34542618282, 16501.009939403673, 16531.256093475822, 16536.090515021788, 16556.006639601663, 13618.114822536503, 13666.385012674453, 13713.245771482665, 13997.160170389809, 14057.507987220399, 8284.295834854105, 8473.745787626382, 8545.444546104483, 8583.656653733906, 8617.224449799549, 3072.416240914219, 3516.1561225306255, 3550.183457804668, 3554.804485753308, 3572.2498275361945, 956.8947415784259, 1022.3048327137469, 1059.0, 1089.6404186618397, 1137.137375936221, 30482.194326361376, 30500.694993049787, 30804.383912321628, 31009.379812404077, 31172.688273117434, 944.4994153098869, 1045.6497073480468, 1141.155544896787, 1167.871534131245, 1176.5352685689277, 15441.768373474408, 15591.922040389725, 15780.605484862741, 15815.367385304458, 16163.676726465404, 645381.0, 647117.0, 657408.0, 657450.0, 659129.7043514752, 60816.08775868366, 60937.39062609406, 61129.0, 61819.690901545204, 61911.38088619056, 1505.4956589542408, 1516.0448917182105, 1539.961500962485, 1542.5141080559588, 1543.6758280760941, 30302.84848575743, 30634.763575305125, 30644.233894151934, 30964.69035309708, 31005.379892402478, 52992.20511692405, 53135.20297195468, 53188.73405632947, 53542.732286338316, 53754.92490150097, 564608.0, 566061.0, 570639.0, 572639.0, 573668.0, 27194.184174474798, 27526.724732753217, 27534.586981195698, 27848.582271265543, 27944.30139246535, 46623.0, 47198.76400617975, 48140.0, 48462.273065904745, 48597.757011214715, 36877.44683829798, 36945.63054369422, 36971.815140924125, 37081.629183708894, 37308.440373393874, 35933.64066359407, 36355.0, 36463.635363646026, 36773.81613091917, 37226.8138659305, 35989.46015809713, 36098.45852312165, 36528.0, 36707.26585468222, 36887.0, 31671.52492712565, 32375.51436728404, 33647.495287570215, 33834.154146145556, 34043.4893476603, 21453.249136280156, 24959.376015599028, 25176.37059073538, 25513.23460296194, 25627.743722563282], "value": 18641.541981279082, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.752751837473, 408.74861959894673, 411.74471827466976, 415.9206858202962, 425.2197218104778, 17904.28382864684, 21055.47361315966, 21272.680909786326, 21428.89285553572, 21720.89139554302, 20018.399448016582, 20169.0, 20241.291554795585, 20757.896210518964, 20807.583848323062, 5842.737076831531, 5889.6171748836405, 6074.392560743934, 6096.237970253718, 6150.354212807658, 5953.255843019622, 6007.0, 6020.157177995085, 6085.178500902366, 6091.847703807396, 5827.388124246957, 6059.3637668044885, 6100.389961003909, 6103.1455596216565, 6107.5113990880845, 5944.613600116, 5985.5810093293485, 5998.580099393044, 6002.099685047256, 6007.729652165663, 5149.9485005149845, 5194.0, 5274.498922602346, 5307.495787900143, 5308.495692909168, 26150.73849261502, 26276.0, 26490.47019059608, 26810.5978410324, 26826.7927943243, 2430.1980346485616, 2467.3338198686433, 2878.596996420503, 2963.1406892001296, 2978.627671541057, 14832.25838708071, 15062.0, 15289.923550382176, 15304.08175509473, 15750.291236894367, 1794.8115447878047, 1825.3793710138616, 1835.4768890866173, 1859.2841755924067, 1878.2017642501883, 115078.0, 119467.0, 120779.0, 121255.0, 123026.0, 11084.0, 11479.598214062635, 11687.474063667156, 11793.410329483491, 11980.221285616408, 11330.0, 12933.870661293267, 14149.71700565983, 14322.212278324583, 14411.639709007359, 8986.86519702205, 9073.274138068939, 9089.318301127441, 9139.588718507683, 9289.97810240873, 8238.794030149294, 9307.395019323721, 9369.672061477815, 9496.240300775922, 9576.616935322649, 6861.656917154222, 6975.895361569581, 6982.47631427645, 7000.894986575206, 7047.964760176166, 1933.0141627769938, 2001.9199232030846, 2006.0, 2008.9598208035757, 2016.7781544030145, 929.3680297397699, 981.6809536900536, 1008.5612758450097, 1058.396713873085, 1099.1920938110482, 18596.721049184274, 20476.66901651388, 20619.0, 21496.785032149477, 21660.89169554142, 1031.138998935882, 1031.6595523477235, 1067.6370034188412, 1078.4661592511757, 1119.7088756923258, 10884.836727448936, 11139.721506962229, 11354.0, 11660.30038197711, 11725.0, 613079.0, 613875.0, 624110.0, 645252.0, 659629.0, 116154.0, 116664.41667791607, 116713.70897487497, 118904.0, 120098.3995080019, 1068.3643232276784, 1103.5034234594464, 1113.6380676280241, 1118.703543560957, 1118.9160812939062, 18720.625587488445, 18883.433496995112, 18899.244030239188, 18944.810551894858, 19302.61394772125, 30760.846195768878, 37297.627023729416, 41367.0, 51788.96422071613, 54875.0, 55333.72333138309, 55595.722021389636, 57557.71221144035, 57757.711211443675, 58317.125243120536, 6732.966335168293, 7902.68389264446, 7947.5231486108705, 8041.276285134366, 8331.12523185081, 12140.75718485643, 12439.689007774516, 12677.746445071232, 12701.36493175319, 12715.80926286125, 10740.83888741654, 10839.512221950188, 11095.889041109485, 11221.887781122085, 11540.884591153981, 10053.798924021625, 10054.447005414773, 11123.388213648002, 11132.610358637408, 11319.377434241196, 11336.23776557634, 11431.42842857837, 11541.538338466367, 11548.653540393801, 11594.0, 7701.3068823806125, 7822.726204582812, 8003.319717823817, 8162.061362943337, 8389.61571340722, 11147.609833656108, 11191.776164476827, 11315.886841131813, 11378.0, 11485.598004069818], "value": 9864.464332022364, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1505.5558610209987, 1645.4323258475824, 1861.8603604729649, 1962.293574313248, 2002.8397728181728, 7361.337479626833, 8326.583670816466, 8559.914400855998, 8743.693970711018, 9146.131117543831, 8874.334424918125, 8931.508767017827, 8959.23846473049, 9022.503762293087, 9054.0, 2316.154603569702, 2422.7401751089424, 2430.817688673352, 2540.64430979663, 2541.9745802542016, 2476.2942561370014, 2525.1162093267394, 2539.7587229213286, 2545.6308835218974, 2561.0908127614707, 2497.4131079196372, 2540.098265115885, 2545.770880620744, 2549.2734570647367, 2563.3207200091992, 2500.499900019994, 2525.1919385796555, 2525.5201511712808, 2541.644169816227, 2549.3371723351875, 2529.582618867885, 2553.948921021588, 2563.4488584954324, 2571.3057474481784, 2584.630146022611, 9251.398659087137, 9277.165055145002, 9284.25725941923, 9299.581518831601, 9346.813063738755, 5775.1337299405, 5871.647701137946, 5878.441548052928, 5928.992071347881, 5982.37185095563, 3620.583632882226, 3697.242065376591, 3722.4974628425357, 3753.0242137044293, 3767.190054138346, 1045.686294111771, 1059.6238335390901, 1061.8725752909622, 1063.1282348474253, 1064.4411683866033, 12546.1844980076, 12629.747405051847, 12633.93683031588, 12640.178388404724, 12666.923311518533, 4261.829526818892, 5071.619628527875, 5175.7153356564995, 5181.06740786662, 5235.110031294613, 10607.94696026515, 10623.84064239037, 10645.787084258427, 10649.0, 10678.73303167427, 5070.6957582545165, 5701.00232459318, 5818.970905145447, 5833.562482813806, 5913.408659134138, 4705.529447055267, 5162.8967420652125, 5259.132243179833, 5259.263703081571, 5349.465053494697, 4112.300908845504, 4121.278776214151, 4303.698741088094, 4342.044750154961, 4376.452943382077, 1396.1832328087978, 1405.1779708870424, 1416.8016477693131, 1416.971660566783, 1426.5862899758954, 897.5691667999266, 981.5632043740467, 1005.5977608956476, 1019.8062368150028, 1023.5649848814224, 6121.724522396503, 6149.477294429934, 6160.476359509402, 6231.844203894939, 6274.435300822948, 468.43319583304583, 481.5954598137581, 481.8361757002566, 486.0, 489.6401145158306, 4050.4531888194715, 4108.548059713429, 4116.176764647083, 4152.356384760367, 4154.335306350969, 10911.618093366853, 11066.948639879198, 11184.552617895193, 11247.606333778278, 11403.885961140448, 10539.262251642465, 10868.0, 10882.510287037103, 11021.008109270204, 11035.668929932115, 8537.317014638938, 8562.400631955703, 8602.225799677934, 8612.354073444392, 8648.1784230498, 5912.793052243151, 6171.228596425447, 6189.659568723763, 6228.283747369111, 6393.712282947372, 10032.097111260022, 10061.446620435947, 10153.79692406133, 10214.285000050222, 10253.231007674305, 8699.782505437415, 9874.21006319507, 10093.19254459656, 10141.732283464567, 10210.540525676512, 6478.902816457851, 6649.567778094409, 7461.589612571143, 7654.770356889302, 7823.374130069467, 8463.23830855226, 8524.957375213084, 8589.226969572768, 8622.61198246068, 8633.438826476258, 6786.253512113763, 7593.734219302519, 7775.727849525239, 7842.254985776342, 7847.489913155627, 7580.54516728998, 7662.6934922604705, 7685.846283074419, 7768.106667733283, 7792.181820908723, 7295.489315747846, 7334.0, 7372.336489715952, 7373.15208750979, 7390.778276651709, 4337.1976184405985, 5102.979404119117, 5194.35070616173, 5268.868278293074, 5289.259503669412, 5199.792008319776, 5204.609654276021, 5286.20706893969, 5296.867578310573, 5349.757505429994], "value": 4725.4003501020525, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.20790568239624, 331.88881724622263, 336.4885374231169, 339.947308167234, 344.19115079563016, 6988.231294557601, 7048.894266586005, 7081.964590177048, 7099.6450177491115, 7129.358357747802, 6945.479089068327, 6947.374736273734, 6963.686634101465, 6979.581225126483, 7002.964985175067, 4203.8738837834835, 4357.738535687853, 5060.544550990428, 5103.693778373291, 5111.744412779365, 5017.84946451607, 5098.719570423626, 5108.7304125359615, 5134.6662466939715, 5143.639945203838, 4133.648639865615, 5030.144875371196, 5075.923861142086, 5093.643444958854, 5111.1566591512355, 4158.958410415888, 5103.209002604603, 5106.0, 5117.411497677777, 5390.8921821563745, 4362.781860906974, 4375.343698445258, 4397.846075387346, 4406.69153159279, 4414.690971631987, 5322.760475778599, 6377.107204991305, 6702.19573651165, 6710.396064354183, 6740.157480314961, 5083.898322033576, 5698.6865722385255, 5922.0, 5940.613860099123, 5974.894644490783, 7407.0, 7407.703691852319, 7416.851662966765, 7439.107307123126, 7471.775846724607, 4739.620830333565, 4756.524347565216, 4757.6907501012665, 4758.095961767253, 4759.524047595248, 7475.588842613654, 7764.145943946161, 7863.13505514393, 7891.2897839194175, 7898.0, 4928.8767780805765, 4955.752212389366, 4988.501149885055, 5010.624203184776, 5024.723640199824, 5092.745362731848, 5092.981403719271, 5099.286099946011, 5100.336956195671, 5115.7442127893455, 5910.4385083417865, 5910.497607703307, 5913.231279933581, 5913.970430147821, 5924.407559244041, 6273.0, 7384.409247260206, 7414.555126692308, 7475.102987641518, 7477.401807855358, 1715.8970461772333, 1761.1370428489947, 1782.7415024821328, 1783.5006198264507, 1784.857211423109, 1134.325076579434, 1139.88601139887, 1149.8447709559102, 1153.233099988515, 1157.4212893553224, 6840.486963477759, 6945.756898508528, 6947.7220911163995, 6957.8956315655305, 6971.6165610891885, 7483.4013278937555, 7658.310752032233, 7661.157272699998, 7683.654235559413, 7697.4226932980255, 5286.471352864683, 6138.631682099089, 7080.398166155935, 7092.716291348392, 7117.110361204849, 3623.221007483404, 3817.2747178036084, 4125.64931980779, 4128.298189307825, 4143.917121657611, 8195.95902020498, 8200.835983280302, 8200.917990820135, 8203.876941845878, 8212.712555060543, 7767.067951845815, 8076.798080047928, 8079.555624440713, 8087.838243235103, 8141.674333026613, 8112.594370281462, 8118.391120665974, 8130.959345203236, 8138.226868447607, 8163.469374490639, 6591.780520603704, 7344.889826652711, 7723.266289702469, 7750.108737495035, 7761.146273909752, 7675.53946763196, 7718.53688778675, 7732.1494635588915, 7735.110462296908, 7742.225777422213, 7787.377009839312, 8186.672533098609, 8189.099199088215, 8195.836083278182, 8227.753167404988, 4760.857174284777, 4832.855014349575, 4842.128416884994, 4854.83008094715, 4880.0, 6294.527910406646, 7759.68961241544, 7794.844103118019, 7808.609569521387, 7835.921640783519, 7178.892316615151, 7501.774946751606, 7513.361364284097, 7524.811879703051, 7530.171681115183, 6900.275471075665, 7377.889331659922, 7400.444966627632, 7401.888971665322, 7442.0, 5875.911861321998, 7304.744333948286, 7322.853542929218, 7330.486865919334, 7368.4842061055215, 7474.289942455458, 7487.3261406473675, 7488.925110748823, 7494.437917156344, 7518.661660225193, 7200.603966781878, 7318.817029574303, 7320.194778574246, 7379.114506259283, 7380.926190738024], "value": 5407.753375800918, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.8106486989034, 756.2626439221759, 758.795125316165, 762.5843915066288, 790.7034861926777, 15812.920935395321, 16024.519264422072, 16076.115813630246, 16078.115703636295, 16116.597085072879, 12002.339871307075, 14113.57659270221, 14126.293685315744, 14383.64040898978, 14532.055416397927, 612.2989177391884, 915.7939463620698, 923.5705396990398, 924.4684306523742, 949.7815502434444, 893.1515060692336, 906.2613969614775, 915.6245939164944, 921.2031592672357, 930.7347405989294, 987.2842189412654, 1003.7390278527563, 1004.5178314409088, 1006.3609607898964, 1006.5772375602264, 897.5243121145803, 966.3670295956125, 972.8735264415616, 982.3516479123743, 1008.1430783833756, 719.8200449887528, 720.8522252938135, 721.5923003503004, 741.6921977379382, 757.1444267977206, 15087.773683394758, 15143.697126057417, 15326.770098448533, 15494.225288735519, 15494.5351639451, 11318.434078296135, 12577.874221257762, 13315.600531983959, 13360.265185414799, 13443.0, 10189.847152292721, 10370.688879333633, 10374.636887708893, 10567.947160264226, 10658.147348212124, 3566.3045706087323, 3588.74878758487, 3613.0, 3662.688671462929, 3858.074062225046, 70069.0, 90425.0, 90775.54612226963, 90913.63629545562, 91780.62329065069, 9383.765405864908, 9761.267904907161, 9820.0, 9868.555914983843, 10145.239107067, 22605.0, 23078.65382019271, 23086.769132308462, 23110.53778924412, 23121.42196445069, 7606.429517786189, 7701.345385642283, 7729.3043626072795, 7841.529508229524, 7876.881846772303, 4178.686598505064, 4220.303649897794, 4226.535081141072, 4238.19474299882, 4254.87235382939, 3761.3793724035777, 3796.8481260749813, 3803.9619603804163, 3804.2771873343977, 3826.043489127718, 617.6781687189329, 657.9901301480481, 680.0920770771075, 681.8499930015389, 709.5529816215854, 492.6206820748004, 557.5010365722736, 572.0875204049618, 622.1973653986307, 623.0654018971543, 8202.507849529047, 8208.794780130545, 8428.789280268042, 8447.831043379098, 8464.280536154496, 595.9046552551571, 598.5480961873844, 607.4623957797293, 618.3167599802243, 622.7384498510636, 3921.274564205631, 3949.3483575210344, 3955.64399204073, 4059.2490389278078, 4060.0864805419137, 89696.551517242, 91756.0, 97252.0, 98017.50991244998, 99870.0, 82691.5865420669, 83467.7479837803, 85714.0, 86204.56897715597, 88454.0, 68713.31286687069, 69581.30418695748, 76437.0, 77329.2267077322, 77831.0, 7198.896628921464, 8595.785105372415, 8621.655133794578, 8778.561071946506, 8786.692465763668, 50833.0, 51357.48642513527, 52371.73814130905, 52640.736796315774, 54424.72787636037, 69713.0, 72074.27925720676, 75127.62436187784, 75142.0, 77486.0, 10925.672229833117, 11028.338299702044, 11046.226764126755, 11238.83141752858, 11321.886781132413, 12118.757624847278, 12128.393580320771, 12271.69320766988, 12322.445489952794, 12760.936195318964, 11056.226064175753, 11573.18987670855, 11838.585649502225, 11856.940715296714, 12178.512859485521, 11431.828522572001, 11442.084633229155, 11614.187006909435, 11764.588239411922, 11921.986631136451, 11467.082633389142, 11491.195616306779, 11712.063034957013, 11771.411429428666, 11845.881541184477, 9414.905850941403, 9719.611215551298, 9783.364081334976, 9876.604935802487, 9930.453825039693, 8454.704085356983, 8722.389432739901, 9781.462019588991, 9785.36395134314, 9889.258305626963], "value": 7125.594451491708, "unit": "score"}], "name": "dromaeo_css", "value": 7615.474004145753, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 115.0, 115.0, 117.0, 131.0, 128.0, 167.0, 167.0, 117.0], "value": 128.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 140.0, 152.0, 121.0, 139.0, 120.0, 159.0, 159.0, 121.0], "value": 138.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 201.0, 200.0, 197.0, 200.0, 192.0, 197.0, 194.0, 200.0, 195.0], "value": 197.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 79.0, 145.0, 56.0, 56.0, 58.0, 68.0, 125.0, 56.0], "value": 77.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 88.0, 139.0, 76.0, 77.0, 83.0, 117.0, 80.0, 79.0, 119.0], "value": 93.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 110.0, 90.0, 88.0, 90.0, 104.0, 91.0, 88.0, 90.0, 86.0], "value": 94.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 121.0, 149.0, 103.0, 145.0, 149.0, 95.0, 95.0], "value": 114.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 150.0, 126.0, 90.0, 90.0, 98.0, 135.0, 140.0, 144.0, 92.0], "value": 120.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 79.0, 94.0, 90.0, 93.0, 79.0, 64.0, 84.0, 81.0, 85.0], "value": 80.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 89.0, 96.0, 79.0, 87.0, 106.0, 94.0, 63.0, 83.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 82.0, 79.0, 79.0, 81.0, 82.0, 86.0, 81.0, 76.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 146.0, 116.0, 172.0, 139.0, 126.0, 139.0, 143.0, 166.0, 167.0], "value": 144.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [208.0, 216.0, 171.0, 166.0, 190.0, 200.0, 152.0, 202.0, 216.0, 196.0], "value": 191.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 67.0, 65.0, 69.0, 65.0, 64.0, 69.0, 67.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1610.6000000000001, "alertThreshold": 2.0}]} 13:56:36 INFO - Return code: 0 13:56:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:56:36 ERROR - # TBPL SUCCESS # 13:56:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:56:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:56:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:56:36 INFO - 2016-06-23 13:56:36.928 screenresolution[1687:11746] starting screenresolution argv=screenresolution get 13:56:36 INFO - 2016-06-23 13:56:36.930 screenresolution[1687:11746] Display 0: 1600x1200x32@60 13:56:36 INFO - 2016-06-23 13:56:36.936 screenresolution[1688:11749] starting screenresolution argv=screenresolution list 13:56:36 INFO - Available Modes on Display 0 13:56:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:56:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:56:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:56:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:56:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:56:37 INFO - Intel Iris: 13:56:37 INFO - Chipset Model: Intel Iris 13:56:37 INFO - Type: GPU 13:56:37 INFO - Bus: Built-In 13:56:37 INFO - VRAM (Dynamic, Max): 1536 MB 13:56:37 INFO - Vendor: Intel (0x8086) 13:56:37 INFO - Device ID: 0x0a2e 13:56:37 INFO - Revision ID: 0x0009 13:56:37 INFO - Displays: 13:56:37 INFO - Display: 13:56:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:56:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:56:37 INFO - Display Serial Number: 1600x1200 60 13:56:37 INFO - Main Display: Yes 13:56:37 INFO - Mirror: Off 13:56:37 INFO - Online: Yes 13:56:37 INFO - Rotation: Supported 13:56:37 INFO - Return code: 0 13:56:37 INFO - Running post-action listener: _resource_record_post_action 13:56:37 INFO - Running post-run listener: _resource_record_post_run 13:56:38 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 31231488; Write bytes: 496561152; Read time: 194; Write time: 1607 13:56:38 INFO - install - Wall time: 23s; CPU: 55.0%; Read bytes: 189209088; Write bytes: 184684544; Read time: 17344; Write time: 419 13:56:38 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 29474304; Write bytes: 301087744; Read time: 180; Write time: 1153 13:56:38 INFO - Running post-run listener: _upload_blobber_files 13:56:38 INFO - Blob upload gear active. 13:56:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:56:38 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 13:56:38 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'] 13:56:38 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 13:56:38 INFO - (blobuploader) - INFO - Open directory for files ... 13:56:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:56:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:56:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:56:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:56:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:56:39 INFO - (blobuploader) - INFO - Done attempting. 13:56:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:56:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:56:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:56:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:56:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:56:40 INFO - (blobuploader) - INFO - Done attempting. 13:56:40 INFO - (blobuploader) - INFO - Iteration through files over. 13:56:40 INFO - Return code: 0 13:56:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:56:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:56:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4560da47f0ae5f215e7bd4fbf99bf43350bf3c06d449dc089b28a3275ce7fe5b57b534b2c3181fe68fe5dd7cfe7920009699451f20e6ffc981d197e1f9fdcbcd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/10a897e9a4ee7ef549d773ae2447ec801bdf4ba80ddad0827bf7323d2e9c61579ff580a0dfd715b870260eacb9c3997468d36f444da9f380825274e721bdbd38"} 13:56:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:56:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:56:40 INFO - Contents: 13:56:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4560da47f0ae5f215e7bd4fbf99bf43350bf3c06d449dc089b28a3275ce7fe5b57b534b2c3181fe68fe5dd7cfe7920009699451f20e6ffc981d197e1f9fdcbcd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/10a897e9a4ee7ef549d773ae2447ec801bdf4ba80ddad0827bf7323d2e9c61579ff580a0dfd715b870260eacb9c3997468d36f444da9f380825274e721bdbd38"} 13:56:40 INFO - Running post-run listener: copy_logs_to_upload_dir 13:56:40 INFO - Copying logs to upload dir... 13:56:40 INFO - mkdir: /builds/slave/test/build/upload/logs 13:56:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1317.657247 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2016-06-23 13:56:40.836536) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 13:56:40.840183) ========= 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.gIFnYp8FQZ/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.30WG9Jsuha/Listeners TMPDIR=/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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/4560da47f0ae5f215e7bd4fbf99bf43350bf3c06d449dc089b28a3275ce7fe5b57b534b2c3181fe68fe5dd7cfe7920009699451f20e6ffc981d197e1f9fdcbcd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/10a897e9a4ee7ef549d773ae2447ec801bdf4ba80ddad0827bf7323d2e9c61579ff580a0dfd715b870260eacb9c3997468d36f444da9f380825274e721bdbd38"} build_url:https://queue.taskcluster.net/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011218 build_url: 'https://queue.taskcluster.net/v1/task/SXOHT5lCSmehasHcdWroBQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4560da47f0ae5f215e7bd4fbf99bf43350bf3c06d449dc089b28a3275ce7fe5b57b534b2c3181fe68fe5dd7cfe7920009699451f20e6ffc981d197e1f9fdcbcd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/10a897e9a4ee7ef549d773ae2447ec801bdf4ba80ddad0827bf7323d2e9c61579ff580a0dfd715b870260eacb9c3997468d36f444da9f380825274e721bdbd38"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 13:56:40.873667) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 13:56:40.874027) ========= 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.gIFnYp8FQZ/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.30WG9Jsuha/Listeners TMPDIR=/var/folders/0_/1mzt9_fn191_pm4dgt9z87g000000w/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.005077 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 13:56:40.922740) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 13:56:40.923089) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 13:56:40.923430) ========= ========= Total master_lag: 0.25 =========