builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0340 starttime: 1468593958.02 results: success (0) buildid: 20160714100743 builduid: c872b8ab7bb44532a943333c2596d4c5 revision: 36faf180f49d6e6af84f55231052b1bac85b3bcd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 07:45:58.023409) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 07:45:58.023958) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 07:45:58.024241) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 07:45:58.050182) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:45:58.050506) ========= 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.lUB8XKh3fq/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.FA7NbLhR6v/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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-07-15 07:45:58-- 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% 30.9M=0s 2016-07-15 07:45:58 (30.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.450170 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:45:58.525993) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:45:58.526712) ========= 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.lUB8XKh3fq/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.FA7NbLhR6v/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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.024955 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:45:58.576761) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:45:58.577124) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 36faf180f49d6e6af84f55231052b1bac85b3bcd --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 36faf180f49d6e6af84f55231052b1bac85b3bcd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lUB8XKh3fq/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.FA7NbLhR6v/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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-07-15 07:45:58,659 truncating revision to first 12 chars 2016-07-15 07:45:58,659 Setting DEBUG logging. 2016-07-15 07:45:58,659 attempt 1/10 2016-07-15 07:45:58,659 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/36faf180f49d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 07:45:59,358 unpacking tar archive at: mozilla-beta-36faf180f49d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.963972 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:45:59.562427) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 07:45:59.562772) ========= script_repo_revision: 36faf180f49d6e6af84f55231052b1bac85b3bcd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 07:45:59.563151) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 07:45:59.563405) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 07:45:59.581229) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-15 07:45:59.581509) ========= /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.lUB8XKh3fq/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.FA7NbLhR6v/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 07:45:59 INFO - MultiFileLogger online at 20160715 07:45:59 in /builds/slave/test 07:45:59 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 07:45:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:45:59 INFO - {'append_to_log': False, 07:45:59 INFO - 'base_work_dir': '/builds/slave/test', 07:45:59 INFO - 'blob_upload_branch': 'Mozilla-Beta', 07:45:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:45:59 INFO - 'branch': 'Mozilla-Beta', 07:45:59 INFO - 'buildbot_json_path': 'buildprops.json', 07:45:59 INFO - 'config_files': ('talos/mac_config.py',), 07:45:59 INFO - 'default_actions': ('clobber', 07:45:59 INFO - 'read-buildbot-config', 07:45:59 INFO - 'download-and-extract', 07:45:59 INFO - 'populate-webroot', 07:45:59 INFO - 'create-virtualenv', 07:45:59 INFO - 'install', 07:45:59 INFO - 'run-tests'), 07:45:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:45:59 INFO - 'download_minidump_stackwalk': True, 07:45:59 INFO - 'download_symbols': 'ondemand', 07:45:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:45:59 INFO - 'tooltool.py': '/tools/tooltool.py', 07:45:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:45:59 INFO - '/tools/misc-python/virtualenv.py')}, 07:45:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:45:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:45:59 INFO - 'installer_path': 'installer.exe', 07:45:59 INFO - 'log_level': 'info', 07:45:59 INFO - 'log_name': 'talos', 07:45:59 INFO - 'log_to_console': True, 07:45:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:45:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:45:59 INFO - 'opt_config_files': (), 07:45:59 INFO - 'pip_index': False, 07:45:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:45:59 INFO - 'cmd': ('bash', 07:45:59 INFO - '-c', 07:45:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:45:59 INFO - 'enabled': True, 07:45:59 INFO - 'halt_on_failure': False, 07:45:59 INFO - 'name': 'check_screen_resolution'},), 07:45:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:45:59 INFO - 'cmd': ('bash', 07:45:59 INFO - '-c', 07:45:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:45:59 INFO - 'enabled': True, 07:45:59 INFO - 'halt_on_failure': False, 07:45:59 INFO - 'name': 'check_screen_resolution'},), 07:45:59 INFO - 'run_cmd_checks_enabled': True, 07:45:59 INFO - 'sps_profile': False, 07:45:59 INFO - 'sps_profile_interval': 0, 07:45:59 INFO - 'suite': 'dromaeojs-e10s', 07:45:59 INFO - 'system_bits': '32', 07:45:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:45:59 INFO - 'title': 't-yosemite-r7-0340', 07:45:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:45:59 INFO - 'use_talos_json': True, 07:45:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:45:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:45:59 INFO - 'work_dir': 'build'} 07:45:59 INFO - ##### 07:45:59 INFO - ##### Running clobber step. 07:45:59 INFO - ##### 07:45:59 INFO - Running pre-action listener: _resource_record_pre_action 07:45:59 INFO - Running main action method: clobber 07:45:59 INFO - rmtree: /builds/slave/test/build 07:45:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:46:01 INFO - Running post-action listener: _resource_record_post_action 07:46:01 INFO - ##### 07:46:01 INFO - ##### Running read-buildbot-config step. 07:46:01 INFO - ##### 07:46:01 INFO - Running pre-action listener: _resource_record_pre_action 07:46:01 INFO - Running main action method: read_buildbot_config 07:46:01 INFO - Using buildbot properties: 07:46:01 INFO - { 07:46:01 INFO - "project": "", 07:46:01 INFO - "product": "firefox", 07:46:01 INFO - "script_repo_revision": "production", 07:46:01 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 07:46:01 INFO - "repository": "", 07:46:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 07:46:01 INFO - "buildid": "20160714100743", 07:46:01 INFO - "pgo_build": "False", 07:46:01 INFO - "basedir": "/builds/slave/test", 07:46:01 INFO - "buildnumber": 61, 07:46:01 INFO - "slavename": "t-yosemite-r7-0340", 07:46:01 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 07:46:01 INFO - "platform": "yosemite_r7", 07:46:01 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 07:46:01 INFO - "branch": "mozilla-beta", 07:46:01 INFO - "repo_path": "releases/mozilla-beta", 07:46:01 INFO - "revision": "36faf180f49d6e6af84f55231052b1bac85b3bcd", 07:46:01 INFO - "stage_platform": "macosx64", 07:46:01 INFO - "builduid": "c872b8ab7bb44532a943333c2596d4c5", 07:46:01 INFO - "slavebuilddir": "test" 07:46:01 INFO - } 07:46:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/Hbohv7t2S46VHo5jpoEfHg/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 07:46:01 INFO - Running post-action listener: _resource_record_post_action 07:46:01 INFO - ##### 07:46:01 INFO - ##### Running download-and-extract step. 07:46:01 INFO - ##### 07:46:01 INFO - Running pre-action listener: _resource_record_pre_action 07:46:01 INFO - Running main action method: download_and_extract 07:46:01 INFO - mkdir: /builds/slave/test/build/tests 07:46:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:01 INFO - https://queue.taskcluster.net/v1/task/Hbohv7t2S46VHo5jpoEfHg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 07:46:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hbohv7t2S46VHo5jpoEfHg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 07:46:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hbohv7t2S46VHo5jpoEfHg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 07:46:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hbohv7t2S46VHo5jpoEfHg/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 07:46:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hbohv7t2S46VHo5jpoEfHg/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 07:46:02 INFO - Downloaded 1165 bytes. 07:46:02 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 07:46:02 INFO - Using the following test package requirements: 07:46:02 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 07:46:02 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:46:02 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 07:46:02 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:46:02 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 07:46:02 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 07:46:02 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:46:02 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 07:46:02 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 07:46:02 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:46:02 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 07:46:02 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:46:02 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 07:46:02 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:46:02 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 07:46:02 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:46:02 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 07:46:02 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 07:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:46:02 INFO - https://queue.taskcluster.net/v1/task/Hbohv7t2S46VHo5jpoEfHg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:46:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hbohv7t2S46VHo5jpoEfHg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 07:46:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hbohv7t2S46VHo5jpoEfHg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 07:46:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hbohv7t2S46VHo5jpoEfHg/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 07:46:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hbohv7t2S46VHo5jpoEfHg/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 07:46:03 INFO - Downloaded 18314840 bytes. 07:46:03 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'] 07:46:03 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 07:46:06 INFO - Return code: 0 07:46:06 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 07:46:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:06 INFO - https://queue.taskcluster.net/v1/task/Hbohv7t2S46VHo5jpoEfHg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:46:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hbohv7t2S46VHo5jpoEfHg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 07:46:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hbohv7t2S46VHo5jpoEfHg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 07:46:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hbohv7t2S46VHo5jpoEfHg/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 07:46:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hbohv7t2S46VHo5jpoEfHg/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 07:46:08 INFO - Downloaded 18314840 bytes. 07:46:08 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'] 07:46:08 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 07:46:12 INFO - Return code: 0 07:46: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')]} 07:46:12 INFO - https://queue.taskcluster.net/v1/task/Hbohv7t2S46VHo5jpoEfHg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:46:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hbohv7t2S46VHo5jpoEfHg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 07:46:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hbohv7t2S46VHo5jpoEfHg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 07:46:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hbohv7t2S46VHo5jpoEfHg/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 07:46:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hbohv7t2S46VHo5jpoEfHg/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 07:46:13 INFO - Downloaded 10840145 bytes. 07:46:13 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'] 07:46:13 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 07:46:13 INFO - Return code: 0 07:46:13 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')]} 07:46:13 INFO - https://queue.taskcluster.net/v1/task/Hbohv7t2S46VHo5jpoEfHg/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 07:46:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hbohv7t2S46VHo5jpoEfHg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 07:46:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hbohv7t2S46VHo5jpoEfHg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 07:46:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hbohv7t2S46VHo5jpoEfHg/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 07:46:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hbohv7t2S46VHo5jpoEfHg/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 07:46:15 INFO - Downloaded 86190619 bytes. 07:46:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Hbohv7t2S46VHo5jpoEfHg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 07:46:15 INFO - mkdir: /builds/slave/test/properties 07:46:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:46:15 INFO - Writing to file /builds/slave/test/properties/build_url 07:46:15 INFO - Contents: 07:46:15 INFO - build_url:https://queue.taskcluster.net/v1/task/Hbohv7t2S46VHo5jpoEfHg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 07:46:17 INFO - Running post-action listener: _resource_record_post_action 07:46:17 INFO - Running post-action listener: set_extra_try_arguments 07:46:17 INFO - ##### 07:46:17 INFO - ##### Running populate-webroot step. 07:46:17 INFO - ##### 07:46:17 INFO - Running pre-action listener: _resource_record_pre_action 07:46:17 INFO - Running main action method: populate_webroot 07:46:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:46:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:46:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:46:17 INFO - '--tppagecycles', 07:46:17 INFO - '7'], 07:46:17 INFO - 'tests': ['tsvgm']}}, 07:46:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:46:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:46:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:46:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:46:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:46:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:46:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:17 INFO - 'talos_options': ['--disable-e10s'], 07:46:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:17 INFO - 'talos_options': ['--disable-e10s'], 07:46:17 INFO - 'tests': ['damp', 'tps']}, 07:46:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:17 INFO - 'tests': ['damp', 'tps']}, 07:46:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:46:17 INFO - 'tests': ['dromaeo_dom']}, 07:46:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:46:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:46:17 INFO - 'tests': ['a11yr', 07:46:17 INFO - 'ts_paint', 07:46:17 INFO - 'tpaint', 07:46:17 INFO - 'sessionrestore', 07:46:17 INFO - 'sessionrestore_no_auto_restore', 07:46:17 INFO - 'tabpaint']}, 07:46:17 INFO - 'other-e10s': {'tests': ['a11yr', 07:46:17 INFO - 'ts_paint', 07:46:17 INFO - 'tpaint', 07:46:17 INFO - 'sessionrestore', 07:46:17 INFO - 'sessionrestore_no_auto_restore', 07:46:17 INFO - 'tabpaint']}, 07:46:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:46:17 INFO - 'ts_paint', 07:46:17 INFO - 'tpaint', 07:46:17 INFO - 'sessionrestore', 07:46:17 INFO - 'sessionrestore_no_auto_restore', 07:46:17 INFO - 'tabpaint']}, 07:46:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:46:17 INFO - 'ts_paint', 07:46:17 INFO - 'tpaint', 07:46:17 INFO - 'sessionrestore', 07:46:17 INFO - 'sessionrestore_no_auto_restore', 07:46:17 INFO - 'tabpaint']}, 07:46:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:46:17 INFO - 'tests': ['a11yr', 07:46:17 INFO - 'ts_paint', 07:46:17 INFO - 'tpaint', 07:46:17 INFO - 'sessionrestore', 07:46:17 INFO - 'sessionrestore_no_auto_restore', 07:46:17 INFO - 'tabpaint']}, 07:46:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:46:17 INFO - 'tests': ['a11yr', 07:46:17 INFO - 'ts_paint', 07:46:17 INFO - 'tpaint', 07:46:17 INFO - 'sessionrestore', 07:46:17 INFO - 'sessionrestore_no_auto_restore', 07:46:17 INFO - 'tabpaint']}, 07:46:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:46:17 INFO - 'tests': ['tsvgx', 07:46:17 INFO - 'tsvgr_opacity', 07:46:17 INFO - 'tart', 07:46:17 INFO - 'tscrollx', 07:46:17 INFO - 'cart']}, 07:46:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:46:17 INFO - 'tsvgr_opacity', 07:46:17 INFO - 'tart', 07:46:17 INFO - 'tscrollx', 07:46:17 INFO - 'cart']}, 07:46:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:17 INFO - 'talos_options': ['--disable-e10s'], 07:46:17 INFO - 'tests': ['tp5o']}, 07:46:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:17 INFO - 'tests': ['tp5o']}, 07:46:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:17 INFO - 'talos_options': ['--disable-e10s', 07:46:17 INFO - '--xperf_path', 07:46:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:17 INFO - 'tests': ['tp5n']}, 07:46:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:46:17 INFO - 'talos_options': ['--xperf_path', 07:46:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:17 INFO - 'tests': ['tp5n']}}, 07:46:17 INFO - 'talos.zip': {'path': '', 07:46:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:46:17 INFO - Running post-action listener: _resource_record_post_action 07:46:17 INFO - ##### 07:46:17 INFO - ##### Running create-virtualenv step. 07:46:17 INFO - ##### 07:46:17 INFO - Running pre-action listener: _resource_record_pre_action 07:46:17 INFO - Running main action method: create_virtualenv 07:46:17 INFO - Creating virtualenv /builds/slave/test/build/venv 07:46:17 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 07:46:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:46:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:46:17 INFO - Using real prefix '/tools/python27' 07:46:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:46:17 INFO - Installing distribute.............................................................................................................................................................................................done. 07:46:20 INFO - Installing pip.................done. 07:46:20 INFO - Return code: 0 07:46:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:46: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')]} 07:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46: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')]} 07:46:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fba8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbb8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff958d8a740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa47e00>, '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 0x10f8b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa42b20>, '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.lUB8XKh3fq/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.FA7NbLhR6v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 07:46: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', 'pip>=1.5'] in /builds/slave/test/build 07:46: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 pip>=1.5 07:46:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lUB8XKh3fq/Render', 07:46:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:20 INFO - 'HOME': '/Users/cltbld', 07:46:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:20 INFO - 'LOGNAME': 'cltbld', 07:46:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:20 INFO - 'MOZ_NO_REMOTE': '1', 07:46:20 INFO - 'NO_EM_RESTART': '1', 07:46:20 INFO - 'PAGER': '/bin/cat', 07:46:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:20 INFO - 'PWD': '/builds/slave/test', 07:46:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:20 INFO - 'SHELL': '/bin/bash', 07:46:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FA7NbLhR6v/Listeners', 07:46:20 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 07:46:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:20 INFO - 'USER': 'cltbld', 07:46:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:20 INFO - 'XPC_FLAGS': '0x0', 07:46:20 INFO - 'XPC_SERVICE_NAME': '0', 07:46:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:21 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 07:46:21 INFO - Cleaning up... 07:46:21 INFO - Return code: 0 07:46:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:46:21 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')]} 07:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:21 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')]} 07:46:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:21 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 0x10fba8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbb8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff958d8a740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa47e00>, '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 0x10f8b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa42b20>, '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.lUB8XKh3fq/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.FA7NbLhR6v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 07:46:21 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 07:46:21 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 07:46:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lUB8XKh3fq/Render', 07:46:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:21 INFO - 'HOME': '/Users/cltbld', 07:46:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:21 INFO - 'LOGNAME': 'cltbld', 07:46:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:21 INFO - 'MOZ_NO_REMOTE': '1', 07:46:21 INFO - 'NO_EM_RESTART': '1', 07:46:21 INFO - 'PAGER': '/bin/cat', 07:46:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:21 INFO - 'PWD': '/builds/slave/test', 07:46:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:21 INFO - 'SHELL': '/bin/bash', 07:46:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FA7NbLhR6v/Listeners', 07:46:21 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 07:46:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:21 INFO - 'USER': 'cltbld', 07:46:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:21 INFO - 'XPC_FLAGS': '0x0', 07:46:21 INFO - 'XPC_SERVICE_NAME': '0', 07:46:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:21 INFO - Downloading/unpacking psutil>=0.7.1 07:46:21 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 07:46:21 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 07:46:21 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 07:46:21 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 07:46:21 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 07:46:21 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 07:46:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:46:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:24 INFO - Installing collected packages: psutil 07:46:24 INFO - Running setup.py install for psutil 07:46:24 INFO - building 'psutil._psutil_osx' extension 07:46:24 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 07:46:24 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 07:46:25 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 07:46:25 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 07:46:25 INFO - building 'psutil._psutil_posix' extension 07:46:25 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 07:46:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:46:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:46:25 INFO - ^ 07:46:25 INFO - 1 warning generated. 07:46:25 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 07:46:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:25 INFO - Successfully installed psutil 07:46:25 INFO - Cleaning up... 07:46:25 INFO - Return code: 0 07:46:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:46: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')]} 07:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46: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')]} 07:46:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fba8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbb8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff958d8a740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa47e00>, '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 0x10f8b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa42b20>, '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.lUB8XKh3fq/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.FA7NbLhR6v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 07:46:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:46:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:46:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lUB8XKh3fq/Render', 07:46:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:25 INFO - 'HOME': '/Users/cltbld', 07:46:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:25 INFO - 'LOGNAME': 'cltbld', 07:46:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:25 INFO - 'MOZ_NO_REMOTE': '1', 07:46:25 INFO - 'NO_EM_RESTART': '1', 07:46:25 INFO - 'PAGER': '/bin/cat', 07:46:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:25 INFO - 'PWD': '/builds/slave/test', 07:46:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:25 INFO - 'SHELL': '/bin/bash', 07:46:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FA7NbLhR6v/Listeners', 07:46:25 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 07:46:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:25 INFO - 'USER': 'cltbld', 07:46:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:25 INFO - 'XPC_FLAGS': '0x0', 07:46:25 INFO - 'XPC_SERVICE_NAME': '0', 07:46:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:46:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:46:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:46:28 INFO - Installing collected packages: mozsystemmonitor 07:46:28 INFO - Running setup.py install for mozsystemmonitor 07:46:28 INFO - Successfully installed mozsystemmonitor 07:46:28 INFO - Cleaning up... 07:46:28 INFO - Return code: 0 07:46:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:46:28 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')]} 07:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:28 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')]} 07:46:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:28 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 0x10fba8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbb8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff958d8a740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa47e00>, '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 0x10f8b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa42b20>, '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.lUB8XKh3fq/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.FA7NbLhR6v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 07:46:28 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 07:46:28 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 07:46:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lUB8XKh3fq/Render', 07:46:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:28 INFO - 'HOME': '/Users/cltbld', 07:46:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:28 INFO - 'LOGNAME': 'cltbld', 07:46:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:28 INFO - 'MOZ_NO_REMOTE': '1', 07:46:28 INFO - 'NO_EM_RESTART': '1', 07:46:28 INFO - 'PAGER': '/bin/cat', 07:46:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:28 INFO - 'PWD': '/builds/slave/test', 07:46:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:28 INFO - 'SHELL': '/bin/bash', 07:46:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FA7NbLhR6v/Listeners', 07:46:28 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 07:46:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:28 INFO - 'USER': 'cltbld', 07:46:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:28 INFO - 'XPC_FLAGS': '0x0', 07:46:28 INFO - 'XPC_SERVICE_NAME': '0', 07:46:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:28 INFO - Downloading/unpacking blobuploader==1.2.4 07:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:31 INFO - Downloading blobuploader-1.2.4.tar.gz 07:46:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:46:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:46: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 07:46: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 07:46: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 07:46: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 07:46: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 07:46: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 07:46:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:46:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:32 INFO - Downloading docopt-0.6.1.tar.gz 07:46:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:46:32 INFO - Installing collected packages: blobuploader, requests, docopt 07:46:32 INFO - Running setup.py install for blobuploader 07:46:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:46:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:46:32 INFO - Running setup.py install for requests 07:46:33 INFO - Running setup.py install for docopt 07:46:33 INFO - Successfully installed blobuploader requests docopt 07:46:33 INFO - Cleaning up... 07:46:33 INFO - Return code: 0 07:46:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:33 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 0x10fba8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbb8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff958d8a740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa47e00>, '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 0x10f8b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa42b20>, '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.lUB8XKh3fq/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.FA7NbLhR6v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 07:46:33 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 07:46:33 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 07:46:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lUB8XKh3fq/Render', 07:46:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:33 INFO - 'HOME': '/Users/cltbld', 07:46:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:33 INFO - 'LOGNAME': 'cltbld', 07:46:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:33 INFO - 'MOZ_NO_REMOTE': '1', 07:46:33 INFO - 'NO_EM_RESTART': '1', 07:46:33 INFO - 'PAGER': '/bin/cat', 07:46:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:33 INFO - 'PWD': '/builds/slave/test', 07:46:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:33 INFO - 'SHELL': '/bin/bash', 07:46:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FA7NbLhR6v/Listeners', 07:46:33 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 07:46:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:33 INFO - 'USER': 'cltbld', 07:46:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:33 INFO - 'XPC_FLAGS': '0x0', 07:46:33 INFO - 'XPC_SERVICE_NAME': '0', 07:46:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:46:33 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-wOmmYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:46:33 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-WmoMiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:46:33 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-iYeZiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:46:33 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-PFMGlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:46:34 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-2SXOqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:46:34 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-9xrcyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:46:34 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-nde4bI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:46:34 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-mktPMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:46:34 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-UhlUgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:46:34 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-CuHkF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:46:34 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-NYKPZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:46:34 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-oDvuvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:46:34 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-DPjj5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:46:35 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-TKThJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:35 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-UySQoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:46:35 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-AUXs5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:46:35 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-Ztugnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:46:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:46:35 INFO - Running setup.py install for manifestparser 07:46:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:46:35 INFO - Running setup.py install for mozcrash 07:46:35 INFO - Running setup.py install for mozdebug 07:46:35 INFO - Running setup.py install for mozdevice 07:46:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:46:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:46:36 INFO - Running setup.py install for mozfile 07:46:36 INFO - Running setup.py install for mozhttpd 07:46:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:46:36 INFO - Running setup.py install for mozinfo 07:46:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:46:36 INFO - Running setup.py install for mozInstall 07:46:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:46:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:46:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:46:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:46:36 INFO - Running setup.py install for mozleak 07:46:36 INFO - Running setup.py install for mozlog 07:46:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:46:36 INFO - Running setup.py install for moznetwork 07:46:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:46:37 INFO - Running setup.py install for mozprocess 07:46:37 INFO - Running setup.py install for mozprofile 07:46:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:46:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:46:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:46:37 INFO - Running setup.py install for mozrunner 07:46:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:46:37 INFO - Running setup.py install for mozscreenshot 07:46:37 INFO - Running setup.py install for moztest 07:46:37 INFO - Running setup.py install for mozversion 07:46:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:46:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:46:37 INFO - Cleaning up... 07:46:37 INFO - Return code: 0 07:46:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:46:37 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')]} 07:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:37 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')]} 07:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:37 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 0x10fba8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbb8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff958d8a740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa47e00>, '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 0x10f8b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa42b20>, '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.lUB8XKh3fq/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.FA7NbLhR6v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 07:46:37 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 07:46:37 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 07:46:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lUB8XKh3fq/Render', 07:46:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:37 INFO - 'HOME': '/Users/cltbld', 07:46:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:37 INFO - 'LOGNAME': 'cltbld', 07:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:37 INFO - 'MOZ_NO_REMOTE': '1', 07:46:37 INFO - 'NO_EM_RESTART': '1', 07:46:37 INFO - 'PAGER': '/bin/cat', 07:46:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:37 INFO - 'PWD': '/builds/slave/test', 07:46:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:37 INFO - 'SHELL': '/bin/bash', 07:46:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FA7NbLhR6v/Listeners', 07:46:37 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 07:46:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:37 INFO - 'USER': 'cltbld', 07:46:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:37 INFO - 'XPC_FLAGS': '0x0', 07:46:37 INFO - 'XPC_SERVICE_NAME': '0', 07:46:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:46:38 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-cfFsxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:46:38 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)) 07:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:46:38 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-Y8YAVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:46:38 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)) 07:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:46:38 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-jbmsIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:46:38 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)) 07:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:46:38 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-iP1rgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:46:38 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)) 07:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:46:38 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-uLlIsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:46:38 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)) 07:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:46:38 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-oYM7p8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:46:38 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)) 07:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:46:38 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-XfB_2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:46:38 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)) 07:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:46:38 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-SQgkii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:46:39 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)) 07:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:46:39 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-0KXgPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:46:39 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)) 07:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:46:39 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-SU65eO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:46:39 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)) 07:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:46:39 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-bb9XY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:46:39 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)) 07:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:46:39 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-Buug2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:46:39 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)) 07:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:46:39 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-mrBZCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:46:39 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)) 07:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:46:39 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-gjPTiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:46:39 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)) 07:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:39 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-t9loFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:39 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)) 07:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:46:39 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-p_F5oY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:46:39 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)) 07:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:46:39 INFO - Running setup.py (path:/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/pip-QCQ0wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:46:40 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)) 07:46:40 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)) 07:46:40 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)) 07:46:40 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)) 07:46:40 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)) 07:46:40 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)) 07:46:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:46:40 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 07:46:40 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 07:46:40 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 07:46:40 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 07:46:40 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 07:46:40 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 07:46:42 INFO - Downloading blessings-1.6.tar.gz 07:46:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:46:42 INFO - Installing collected packages: blessings 07:46:42 INFO - Running setup.py install for blessings 07:46:42 INFO - Successfully installed blessings 07:46:42 INFO - Cleaning up... 07:46:42 INFO - Return code: 0 07:46:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:46:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:46:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:46:43 INFO - Reading from file tmpfile_stdout 07:46:43 INFO - Current package versions: 07:46:43 INFO - blessings == 1.6 07:46:43 INFO - blobuploader == 1.2.4 07:46:43 INFO - docopt == 0.6.1 07:46:43 INFO - manifestparser == 1.1 07:46:43 INFO - mozInstall == 1.12 07:46:43 INFO - mozcrash == 0.17 07:46:43 INFO - mozdebug == 0.1 07:46:43 INFO - mozdevice == 0.48 07:46:43 INFO - mozfile == 1.2 07:46:43 INFO - mozhttpd == 0.7 07:46:43 INFO - mozinfo == 0.9 07:46:43 INFO - mozleak == 0.1 07:46:43 INFO - mozlog == 3.1 07:46:43 INFO - moznetwork == 0.27 07:46:43 INFO - mozprocess == 0.22 07:46:43 INFO - mozprofile == 0.28 07:46:43 INFO - mozrunner == 6.11 07:46:43 INFO - mozscreenshot == 0.1 07:46:43 INFO - mozsystemmonitor == 0.0 07:46:43 INFO - moztest == 0.7 07:46:43 INFO - mozversion == 1.4 07:46:43 INFO - psutil == 3.1.1 07:46:43 INFO - requests == 1.2.3 07:46:43 INFO - wsgiref == 0.1.2 07:46:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:46:43 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')]} 07:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:43 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')]} 07:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:43 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 0x10fba8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbb8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff958d8a740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa47e00>, '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 0x10f8b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa42b20>, '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.lUB8XKh3fq/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.FA7NbLhR6v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 07:46:43 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 07:46:43 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 07:46:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lUB8XKh3fq/Render', 07:46:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:43 INFO - 'HOME': '/Users/cltbld', 07:46:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:43 INFO - 'LOGNAME': 'cltbld', 07:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:43 INFO - 'MOZ_NO_REMOTE': '1', 07:46:43 INFO - 'NO_EM_RESTART': '1', 07:46:43 INFO - 'PAGER': '/bin/cat', 07:46:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:43 INFO - 'PWD': '/builds/slave/test', 07:46:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:43 INFO - 'SHELL': '/bin/bash', 07:46:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FA7NbLhR6v/Listeners', 07:46:43 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 07:46:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:43 INFO - 'USER': 'cltbld', 07:46:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:43 INFO - 'XPC_FLAGS': '0x0', 07:46:43 INFO - 'XPC_SERVICE_NAME': '0', 07:46:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:43 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)) 07:46:43 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)) 07:46:43 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)) 07:46:43 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)) 07:46:43 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)) 07:46:43 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)) 07:46:43 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)) 07:46:43 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)) 07:46:43 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)) 07:46:43 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)) 07:46:43 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)) 07:46:43 INFO - Cleaning up... 07:46:43 INFO - Return code: 0 07:46:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:46:43 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')]} 07:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:43 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')]} 07:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:43 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 0x10fba8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbb8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff958d8a740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa47e00>, '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 0x10f8b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa42b20>, '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.lUB8XKh3fq/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.FA7NbLhR6v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 07:46:43 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 07:46:43 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 07:46:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lUB8XKh3fq/Render', 07:46:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:43 INFO - 'HOME': '/Users/cltbld', 07:46:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:43 INFO - 'LOGNAME': 'cltbld', 07:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:43 INFO - 'MOZ_NO_REMOTE': '1', 07:46:43 INFO - 'NO_EM_RESTART': '1', 07:46:43 INFO - 'PAGER': '/bin/cat', 07:46:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:43 INFO - 'PWD': '/builds/slave/test', 07:46:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:43 INFO - 'SHELL': '/bin/bash', 07:46:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FA7NbLhR6v/Listeners', 07:46:43 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 07:46:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:43 INFO - 'USER': 'cltbld', 07:46:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:43 INFO - 'XPC_FLAGS': '0x0', 07:46:43 INFO - 'XPC_SERVICE_NAME': '0', 07:46:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:43 INFO - Downloading/unpacking jsonschema 07:46:43 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 07:46:43 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 07:46:43 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 07:46:43 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 07:46:43 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 07:46:43 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 07:46:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:46:46 INFO - Downloading/unpacking functools32 (from jsonschema) 07:46:46 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 07:46:46 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 07:46:46 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 07:46:46 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 07:46:46 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 07:46:46 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 07:46:46 INFO - Downloading functools32-3.2.3-2.tar.gz 07:46:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:46:46 INFO - warning: no files found matching '*.txt' 07:46:46 INFO - no previously-included directories found matching 'build' 07:46:46 INFO - no previously-included directories found matching 'dist' 07:46:46 INFO - no previously-included directories found matching '.git*' 07:46:46 INFO - Installing collected packages: jsonschema, functools32 07:46:46 INFO - Running setup.py install for functools32 07:46:46 INFO - warning: no files found matching '*.txt' 07:46:46 INFO - no previously-included directories found matching 'build' 07:46:46 INFO - no previously-included directories found matching 'dist' 07:46:46 INFO - no previously-included directories found matching '.git*' 07:46:46 INFO - Successfully installed jsonschema functools32 07:46:46 INFO - Cleaning up... 07:46:46 INFO - Return code: 0 07:46:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:46:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:46 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 0x10fba8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbb8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff958d8a740>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa47e00>, '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 0x10f8b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa42b20>, '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.lUB8XKh3fq/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.FA7NbLhR6v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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 07:46:46 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 07:46:46 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 07:46:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lUB8XKh3fq/Render', 07:46:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:46 INFO - 'HOME': '/Users/cltbld', 07:46:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:46 INFO - 'LOGNAME': 'cltbld', 07:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:46 INFO - 'MOZ_NO_REMOTE': '1', 07:46:46 INFO - 'NO_EM_RESTART': '1', 07:46:46 INFO - 'PAGER': '/bin/cat', 07:46:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:46 INFO - 'PWD': '/builds/slave/test', 07:46:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:46 INFO - 'SHELL': '/bin/bash', 07:46:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FA7NbLhR6v/Listeners', 07:46:46 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 07:46:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:46 INFO - 'USER': 'cltbld', 07:46:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:46 INFO - 'XPC_FLAGS': '0x0', 07:46:46 INFO - 'XPC_SERVICE_NAME': '0', 07:46:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:47 INFO - Downloading/unpacking flake8 07:46:47 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 07:46:47 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 07:46:47 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 07:46:47 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 07:46:47 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 07:46:47 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 07:46:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:46:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:46:49 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 07:46:49 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 07:46:49 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 07:46:49 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 07:46:49 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 07:46:49 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 07:46:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:46:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:46:50 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 07:46:50 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 07:46:50 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 07:46:50 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 07:46:50 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 07:46:50 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 07:46:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:46:50 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 07:46:50 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 07:46:50 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 07:46:50 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 07:46:50 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 07:46:50 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 07:46:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:46:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:46:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:46:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:46:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:46:51 INFO - no previously-included directories found matching 'docs/_build' 07:46:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:46:51 INFO - Running setup.py install for pep8 07:46:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:46:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:46:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:46:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:46:51 INFO - no previously-included directories found matching 'docs/_build' 07:46:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:46:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:46:51 INFO - Cleaning up... 07:46:51 INFO - Return code: 0 07:46:51 INFO - Running post-action listener: _resource_record_post_action 07:46:51 INFO - Running post-action listener: _start_resource_monitoring 07:46:51 INFO - Starting resource monitoring. 07:46:51 INFO - ##### 07:46:51 INFO - ##### Running install step. 07:46:51 INFO - ##### 07:46:51 INFO - Running pre-action listener: _resource_record_pre_action 07:46:51 INFO - Running main action method: install 07:46:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:46:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:46:51 INFO - Reading from file tmpfile_stdout 07:46:51 INFO - Detecting whether we're running mozinstall >=1.0... 07:46:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:46:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:46:51 INFO - Reading from file tmpfile_stdout 07:46:51 INFO - Output received: 07:46:51 INFO - Usage: mozinstall [options] installer 07:46:51 INFO - Options: 07:46:51 INFO - -h, --help show this help message and exit 07:46:51 INFO - -d DEST, --destination=DEST 07:46:51 INFO - Directory to install application into. [default: 07:46:51 INFO - "/builds/slave/test"] 07:46:51 INFO - --app=APP Application being installed. [default: firefox] 07:46:51 INFO - mkdir: /builds/slave/test/build/application 07:46:51 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'] 07:46:51 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 07:47:13 INFO - Reading from file tmpfile_stdout 07:47:13 INFO - Output received: 07:47:13 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 07:47:13 INFO - Running post-action listener: _resource_record_post_action 07:47:13 INFO - ##### 07:47:13 INFO - ##### Running run-tests step. 07:47:13 INFO - ##### 07:47:13 INFO - Running pre-action listener: _resource_record_pre_action 07:47:13 INFO - Running main action method: run_tests 07:47:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:47:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:47:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:47:13 INFO - 2016-07-15 07:47:13.262 screenresolution[1658:8810] starting screenresolution argv=screenresolution get 07:47:13 INFO - 2016-07-15 07:47:13.265 screenresolution[1658:8810] Display 0: 1600x1200x32@60 07:47:13 INFO - 2016-07-15 07:47:13.271 screenresolution[1659:8812] starting screenresolution argv=screenresolution list 07:47:13 INFO - Available Modes on Display 0 07:47:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:47:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:47:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:47:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:47:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:47:13 INFO - Intel Iris: 07:47:13 INFO - Chipset Model: Intel Iris 07:47:13 INFO - Type: GPU 07:47:13 INFO - Bus: Built-In 07:47:13 INFO - VRAM (Dynamic, Max): 1536 MB 07:47:13 INFO - Vendor: Intel (0x8086) 07:47:13 INFO - Device ID: 0x0a2e 07:47:13 INFO - Revision ID: 0x0009 07:47:13 INFO - Displays: 07:47:13 INFO - Display: 07:47:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:47:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:47:13 INFO - Display Serial Number: 1600x1200 60 07:47:13 INFO - Main Display: Yes 07:47:13 INFO - Mirror: Off 07:47:13 INFO - Online: Yes 07:47:13 INFO - Rotation: Supported 07:47:13 INFO - Return code: 0 07:47:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:47:13 INFO - Python 2.7.3 07:47:13 INFO - Return code: 0 07:47:13 INFO - grabbing minidump binary from tooltool 07:47:13 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')]} 07:47:13 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 0x10fa47e00>, '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 0x10f8b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fa42b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:47:13 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 07:47:13 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 07:47:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:47:13 INFO - Return code: 0 07:47:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:47:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:47:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:47:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:47:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:47:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:47:14 INFO - Return code: 0 07:47:14 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/Hbohv7t2S46VHo5jpoEfHg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0340', '--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 07:47:14 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/Hbohv7t2S46VHo5jpoEfHg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0340 --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 07:47:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lUB8XKh3fq/Render', 07:47:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:14 INFO - 'HOME': '/Users/cltbld', 07:47:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:14 INFO - 'LOGNAME': 'cltbld', 07:47:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:47:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:14 INFO - 'MOZ_NO_REMOTE': '1', 07:47:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:47:14 INFO - 'NO_EM_RESTART': '1', 07:47:14 INFO - 'PAGER': '/bin/cat', 07:47:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:14 INFO - 'PWD': '/builds/slave/test', 07:47:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:47:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:14 INFO - 'SHELL': '/bin/bash', 07:47:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FA7NbLhR6v/Listeners', 07:47:14 INFO - 'TMPDIR': '/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/', 07:47:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:14 INFO - 'USER': 'cltbld', 07:47:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:14 INFO - 'XPC_FLAGS': '0x0', 07:47:14 INFO - 'XPC_SERVICE_NAME': '0', 07:47:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:14 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/Hbohv7t2S46VHo5jpoEfHg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0340', '--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 07:47:14 INFO - mozversion application_buildid: 20160714100743 07:47:14 INFO - mozversion application_changeset: 36faf180f49d6e6af84f55231052b1bac85b3bcd 07:47:14 INFO - mozversion application_display_name: Firefox 07:47:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:47:14 INFO - mozversion application_name: Firefox 07:47:14 INFO - mozversion application_remotingname: firefox 07:47:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:47:14 INFO - mozversion application_vendor: Mozilla 07:47:14 INFO - mozversion application_version: 48.0 07:47:14 INFO - mozversion platform_buildid: 20160714100743 07:47:14 INFO - mozversion platform_changeset: 36faf180f49d6e6af84f55231052b1bac85b3bcd 07:47:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:47:14 INFO - mozversion platform_version: 48.0 07:47:14 INFO - using testdate: 1468594034 07:47:14 INFO - actual date: 1468594034 07:47:14 INFO - starting webserver on 'localhost:49280' 07:47:14 INFO - SUITE-START | Running 2 tests 07:47:14 INFO - TEST-START | dromaeo_css 07:47:14 INFO - operating with platform_type : mac_ 07:47:14 INFO - Initialising browser for dromaeo_css test... 07:47:14 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmpBxFRlm/profile http://localhost:49280/getInfo.html) 07:47:17 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 07:47:17 INFO - PROCESS | 1677 | colorDepth:24 07:47:17 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 07:47:17 INFO - PROCESS | 1677 | __metrics 07:47:17 ERROR - PROCESS | 1677 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 07:47:18 INFO - TEST-INFO | 1677: exit 0 07:47:18 INFO - Browser initialized. 07:47:18 INFO - Running cycle 1/1 for dromaeo_css test... 07:47:18 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmpBxFRlm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:47:30 INFO - PROCESS | 1682 | RSS: Main: 170790912 07:47:30 INFO - PROCESS | 1682 | 07:48:20 INFO - PROCESS | 1682 | 1468594100150 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] 07:50:30 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 07:50:31 INFO - PROCESS | 1682 | RSS: Main: 181620736 07:50:31 INFO - PROCESS | 1682 | 07:53:33 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 07:53:34 INFO - PROCESS | 1682 | RSS: Main: 192401408 07:53:34 INFO - PROCESS | 1682 | 07:56:35 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 07:56:36 INFO - PROCESS | 1682 | RSS: Main: 194510848 07:56:36 INFO - PROCESS | 1682 | 07:59:37 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 07:59:38 INFO - PROCESS | 1682 | RSS: Main: 198275072 07:59:38 INFO - PROCESS | 1682 | 08:02:41 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 08:02:41 INFO - PROCESS | 1682 | RSS: Main: 197369856 08:02:41 INFO - PROCESS | 1682 | 08:05:43 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 08:05:43 INFO - PROCESS | 1682 | RSS: Main: 203300864 08:05:43 INFO - PROCESS | 1682 | 08:05:43 INFO - PROCESS | 1682 | __start_tp_report 08:05:43 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 08:05:43 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 08:05:43 INFO - PROCESS | 1682 | |i|pagename|runs| 08:05:43 INFO - PROCESS | 1682 | |0;dojo.html;3633.5094762207104;3669.7064234861214;3708.221273532558;3709.0727318170457;3730.5336832895873;4858.2712593111055;6020.247469066367;6061.66660833654;6099.451049405547;6121.204243448351;4929.507049295069;4988.725620090893;5004.724740139291;6099.115628233903;6112.724927378267;5445.319335083124;5475.370332411764;5516.91724624131;5547.694876781776;5577.749001294951;5498.505134537891;5509.752061157257;5573.888522229553;5589.496945274925;5721.570882183832;5569;5582.609217354787;5584;5598.412166722476;5599.524040456566;5524.419935906712;5527.336719593654;5552;5583.748731307101;5586.804461843816;5316.3620365556;5381.165919282517;5426.9185962210595;5487.149491828773;5506.724663766796;5874.882502349972;5991.191189189447;6024.728887200086;6031.185789918349;6039.275286965592;6321.715522801485;6323;6341.778037768702;6353.809385718436;6372.872542549169;6312.084747711602;6335.873282534323;6351.809445716636;6386.10594516768;6386.10594516768;5186.844394668166;6185.474234690057;6208.441240288395;6216;6220.657863817488;6301.747930082745;6506.991416330477;6532.314107018789;6546.443552298013;6553.803385898431;6226.750929962751;6238.937610623926;6276.529260305404;6287;6287.811365659038;6401.519886008568;6417.326180751047;6439.484841212692;6446.000869865178;6464.838379040468;6198.256209254918;6234.594751341148;6289.182406287154;6303.117563541108;6306.684665766693;5262.236975638511;6301.96849015752;6312.936870631235;6320.652364120017;6324.209473815773;5132.46109158533;5179.430262671103;5184.611154163453;5185.662931909414;5200;4622.14490319292;4633.189191891405;4665.4634717007975;4692.436907571113;4702.106599746037;6114.144019837227;6143.174139895698;6167.814965551041;6179.073139029092;6219.502439804895;6450.064740612679;6450.870982580323;6453.128827608213;6500.122483464766;6550.0174973753365;6135.722664536883;6135.785247516315;6212.9378706213265;6237.4698150657705;6255.78104766331;5720.11338242573;5721.113227449752;5738.684372359477;5745.741441635053;5759.913601295984;6715.630640314732;6719.529632925648;6769.22153952292;6777.864442711217;6780.559263647946;6380.521460890544;6411.294757576756;6459.224893012869;6477.546571739933;6485.351464853666;5829.59192856496;6577.835554111186;6721.294264102395;6746.561473504206;6752.155980502437;5468.589855760754;6357.650329231937;6361.522885783677;6387.680615969276;6401.7119229633845;6227.906581401373;6328.272248691275;6437.871242575216;6453.838654033687;6457.418832305115;5367.919481207863;6286.057091436322;6293.874122517433;6332.366763323631;6416.230052393743;6289.685515724104;6301.527385446201;6307.274663413767;6310.11658367838;6432.517561182836;5205.505476979681;6121.816345509642;6128.625347140905;6160.44555989963;6222.782202622887;5271.341082364705;6151.630902145886;6249.7187626557825;6280.434760871543;6284.214473190851;6109.9816581254145;6159.4456498915315;6212.534059945432;6227.719752611234;6227.844303892439 08:05:43 INFO - PROCESS | 1682 | |1;ext.html;562.372954156116;571.1489880078683;582.4916453522022;610.5420934299273;638.3361304243587;40799;42015.57984420155;42047.159056818884;42094;42182.94542636436;34443.65556344442;41369.7931510342;41505.96235094124;41510.58489415105;41580.79209603955;9674.371165874196;9733.221342292634;9754.46350450725;9777.12005919467;9785.755356116118;9671.323007389485;9748.805023899518;9772.511374431286;9773;9793.26550508711;9749.171320437772;9752.219822414225;9822.263330250224;9823.803523929517;9826.70519884401;8254.504729716236;9636.277279204018;9728.464934428604;9745.171660408874;9774.31579789415;9691.90308096917;9716.61133554664;9755.170810481117;9804.803903921953;9825.459599722013;41415.378769318486;41813.1637367254;41898.37152442716;41919.79040104811;41952.370714439305;3307.3054658521737;3363.276895467486;3381.6956473917467;3743.6069212732814;3799.9430008549894;28972.27569310763;29033;29631.259218519495;29783;29985.550216746768;2818.2672505148603;2857.2571131505956;2879.280179955011;2900.3764190699103;2936.2219011961847;360332.39667603513;360675.9999999974;362452;363212.9999999974;364124.17937910405;64806.0279095814;65299.67350163314;65382.019269710996;65516.672416637615;66009.33990660032;62944.370556294765;71522.2847771526;73001.6349918247;74442.62778686071;74525.62737186279;17472.65054698899;17984.910075449538;18056.729149062776;18198.272069117353;18294.908525457555;13799.2410417428;13939.721205575832;13983.650408739659;14009.859901400856;14075.225862577656;7709.922900771033;7714.768556943301;7717.2282771722375;7774.1837107104075;7827;3408.6761757632985;3431.3995050865997;3453.2920751245933;3455.87904423344;3488.8778892738633;862.1938487514194;983.6327504768377;1049.6116436918237;1058.433737950193;1081.3619964221148;23611.7638823613;25362.239132826046;27984;28758;28839.2790180243;1077.8706555213425;1179.9115066370057;1246.9750604987848;1250.7554982791999;1274.4902039184215;14694.63263418423;15020.774688379683;15574.454894078654;15650.765238521431;15996.920015400081;518601;527002;533619;535729;536674;47786.76106619514;58974.70512647495;60422.09366859413;60429.697851510464;60591;1565.3347327385816;1571.8821088418185;1572.7955365802372;1585.1836304303292;1592.8646065084365;29731;30643.387132257674;30751.846240768653;30958.486897255683;31287.53068704017;54309.18536221881;54599.45400545944;54852.45147548473;55070.17394739002;55314.89370212493;603507.9824601024;606258;607883;612146;613531;26804;26936.865315673294;27121.321966950985;27387.726122738517;27416.314592135357;43873.34189987217;45844.31233531433;46186;46770;46930;37358.439623405124;37599.06002349963;37725.245495089395;37849;37927.24145517129;36988.890333290045;37492.81253593715;37531;38031.239375211786;38506.03734906538;37258.06854828651;37356.81321593375;37466.2506749858;38232.426513601764;38616;32286;33184;33710.325793483506;33768.1557961053;33999.66000339965;25381.364821530755;25455.745442545336;25709.742902570735;25926.740732593185;26127 08:05:43 INFO - PROCESS | 1682 | |2;jquery.html;382.60782697734817;416.45444467747234;418.96438802701766;419.50498411873986;421.19761853668757;14718;20398.796012039875;21134.57730845384;21182.470438239052;21306.93465326735;15189.620259493491;20355.59288814223;20505.282315118973;20742.585148297025;21608.459788505294;5565.638233514829;6015.398460153993;6037.969810150943;6137.864495068427;6398.552101352907;6214.067889816519;6224.346443623423;6228.0657901314935;6337.651429171394;6338.904916426234;5140.794368225266;6159.414855588712;6165.599236049642;6275.309715931244;6305.306416294227;6156.230471191101;6169.043798211284;6203.31763506014;6287.2140982377205;6291.370862913741;5340.25236466895;5395.568354531628;5506.64206826555;5511.255980442629;5541.919325731484;27095.593566096526;27211.591826122625;27633.447331053267;27736.30659233515;27738.5839212412;2062.05145633009;2175.7280339957506;2176.68438076478;2183.2795177591356;2192.4628466025765;10253;10432.32189907661;11324.603638872682;11557.24877882935;15535.300911458899;1796.4431026381733;1807.204829874864;1830.057520377007;1843.9446816595523;1916.9361004642558;111520.4423977875;122385;122600;123031.76968230293;123060.38469807773;12118;12170.634880953585;12187.878121218851;12326.32205228703;12332.568360107352;15458.690826183638;15483;15863.682726345409;15866;15885.602859928364;8764.298856091498;9114.908850911539;9185.724428267162;9219.90780092204;9280.860787088199;8957.552122393854;9076.8638470423;9134.223590994707;9195.356325057315;9217.539123043955;4809.591184749265;4841.782119804618;4890.877728056756;4909.656324057353;4912.459629440758;1783.3669047488215;1969.8522610804248;2044.6115238104712;2092.686097085419;2095.853290269697;918.3938600523622;991.6479649724388;995.7062666513395;998.32612986234;1052.4369462337613;17394.652106958045;20654.896725516275;20816.47958801012;21077.473063173544;21122.260720875;1012.7721262715977;1094.5457635081352;1102.1293178389144;1113.9944300278446;1120.9327440353604;11020.944895275472;11359.204855660024;11362.48868800906;11364;11367.147463940237;649370;650012;666009;682024.5898770475;683393;102038.48980755049;131802;133416;136688;137043;1009.9242556808268;1013;1018.2261481274285;1020.5458570936011;1026.230327254574;15817.65549928269;16865.578360541083;18390.816091839446;18483.722744159117;18728.06359682038;45338.77330613458;47618;48656.756716216194;48916.51083489262;49989;72387.27612724015;72994.63502682453;74313;74475;76744.61627691826;8141.715039973573;8153.714619988272;8184.386171037077;8481.83036339282;8589.44168629037;11449.14131440162;12224.266544007389;12368.876311236772;12760.808587871375;12831.486740530647;10263.897361026295;10925.235233533576;11158.386288753873;11212.327260364404;11295.830562541732;10722.785544289227;10840.024397804236;10904.291221070605;11114.833277501006;11115.666530004113;11106.777864442827;11272.718182045186;11484.540618375506;11547.595834145764;11733.413329333329;7151.213366529573;8221.424500284922;8356.54039027835;8378.916210837813;8433.072362040293;8381.916180838358;10652.041316281571;11214;11290.548378064785;11470.483828227916 08:05:43 INFO - PROCESS | 1682 | |3;mootools.html;1450.9564713058608;1631.1762559907245;1906.4852489827747;2060.0729671647764;2064.783197764236;8288.91711082889;8980.910190898105;9018.72943811686;9272.907270927297;9328.580213890375;8941.91058089419;8974.967878693953;9040.321975851804;9068.546572671374;9086.81826363474;2506.5613517634433;2523.2556395863267;2527;2529.6837895263093;2549.1715192562397;2487.3035550046015;2534.353739796349;2541.3265484646586;2544.262163972455;2550.081970490622;2517.0686845866962;2518.1438310974263;2535.1887396033276;2551.8979240830345;2552.923412297625;2520.5589021921182;2539.8857051432637;2556.1053631229106;2557.181701855407;2561.743825617442;2524.911628093026;2546.630738542901;2552.34915096651;2558.590625499911;2562.6156076588472;9180.586873590704;9250.907490925072;9255.398399104037;9269.397489163182;9309.069093090637;4649.395578574764;5627.184058311563;5684.261046063985;5759.913601295984;5793.4785869271545;3660.4692319613505;3787.8863634090744;3795.430685397185;3821.426785982097;3838.2323535292776;960.9471479068649;1067.4022547373495;1083.7399024234128;1092.268180319188;1097.5554900265406;12045.698857528545;12163.695907602292;12377.071719620975;12381.319027453486;12423.565175218824;4921.655484116149;4970.975145124251;5033.496650334937;5054.444011158769;5058.747062646853;10470.267081304235;10471.057604815604;10518.316309439862;10530.15758739299;10542.051215390651;4737.218358970731;5512.062949298549;5582.637128586629;5649.830505084854;5668.433156684381;4575.7483338416705;4965.1807451770055;4978.427480839678;5010.473900240422;5124.205748109049;3580.3913334733156;4101.921096233978;4109.794510274474;4185.769782661922;4186.911403035172;1409.9083559568596;1411.125102436496;1412.4067891485602;1416.9716605668036;1421.8151640286696;855.4268640011207;946.6781294359951;963.7446076789656;1003.2325271167563;1007.1539906478594;5233.842984710464;5985.760569577168;6048.243969503812;6119.418655227746;6176.980798168252;465.54144167994497;477.1983068444976;480.32034670940226;482.9758512074382;483.0941983780412;3509.9119273025444;4053.7365071270274;4083.1221287423346;4096.651784598343;4138.461999939988;10705.571777128984;10900.618478353219;11001.669949901516;11087.667369978913;11307.265027773168;10447.738806529745;10961.287516311415;11078.667639970814;11095.44522773858;11147.888521114684;8377.874331885027;8392.370572207108;8587.141285871488;8590.699325523701;8713.433626814236;5965.821025369246;5992.970035149797;6027.57806953509;6105.938940610537;6110.419510146529;8017.358611310964;8209.71266005687;9854.063863932915;9956.950215248877;10009.449480278654;9643.9035609643;9935.20518358544;9950.253730970062;10174.440405777754;10258.230632702427;7008.684609192701;7426.665800038903;7725.266099720518;7774.144844067261;7896.3288120508105;8522.147785221676;8543.957280213559;8566.914330856862;8579.227869491775;8604.61279242423;7481;7561.659725312485;7639.961800190964;7681.807954801175;7702.961485192538;7369.299916507923;7458.589777562286;7476.962615186889;7582.431317651088;7590.0891892973195;7168.498205125591;7207.207207207098;7231.602261875437;7239.167495738057;7248.673809678683;4948.901021979468;4963.379577552806;5042.924356134734;5122.871928201825;5163.27714120016;4128.772917489447;4581.450225972904;5058.797648094035;5097.286379906742;5222.9554089183075 08:05:43 INFO - PROCESS | 1682 | |4;prototype.html;298.6535618682328;328.49575900991965;344.8103543051322;350.9964900350997;352.55754028693985;5023.874403139924;6841.863162736755;6871.450283977282;7073.08049953506;7135.821604459885;6601.2738598754095;6738;6783.898241526381;6817.079694241276;6949.548279361838;5163;5209.635325527214;5209.869753256161;5233.3981592116825;5257.290265814105;4689.718616882981;4744.0511897620445;5202.8179013734525;5221;5234.345706786652;5154.664946778466;5167.095758242312;5171.534561889429;5174.611904107207;5215.660982036175;4659.718577391211;4844.951550484485;5251.081060814361;5256.658317209388;5258.2638430619745;4000.659778974047;4247.193033323659;4313.202057619351;4492.505824359318;4503.842365517191;5369.194620806871;6755.7973260802255;6768.729250829961;6788.524803263774;6794;6059.303180134297;6087.726052327655;6095.359987201325;6154;6155.261368635793;7617.885731714029;7618.390528757686;7632.389408847279;7656.9617151914445;7659.961700191519;5029.547340739351;5041;5046.84859454217;5047.343845300087;5062.012907483042;5914.349421563625;5989.790357337516;7626.923730762677;7967.211475983418;7993.680252789882;4270.274053410928;5046.243063540498;5104.846854594368;5106.336176297058;5115.948840511622;5143.459936706667;5150.8969820604125;5216.243644671501;5217.426083130853;5221.321228240305;5004.324416203839;5988.371221021817;6034.48706859913;6037.78867739627;6069.575129740964;7327.670254838545;7549.0941087069905;7573.734919277799;7580.431467639839;7593.240675932473;1811.918463669138;1824.7536582561183;1829.8719089663596;1837.0998210876573;1838.0901453780198;1061.6782106277733;1103.189155970361;1168.1647621950347;1186.7151883547886;1190.9523619055315;6893.586384816927;7124.679389427488;7191.676374563157;7197.46019048563;7224.711011559584;7092;7291.8541629168185;7814.413918955987;8017.679292828221;8080.878786818203;7270.745523906744;7275.527090739085;7279.636018199175;7298.598577078312;7300.671469783872;4224.957750422456;4274.529801721808;4279.293916503742;4291.914161716748;4297.957020429818;6922.757703480454;7480.70077196906;8313.882294139697;8469.449485783527;8525.19010693983;8202.835943281101;8276.544790036485;8299.543525106057;8300.875486867702;8309.293710034715;8406.201410865959;8407.8318433631;8428.325733941392;8430.620622072021;8458.788530286669;7905.920940790748;7910.406719495946;7918.683252669829;7932.16712245206;7934.841303174019;7499.325060744559;7784.9610751945875;7787.922120778946;7804.726834560764;7815;8329.583520823813;8417.663293468193;8474.957625211835;8514.61684224199;8519.616617252115;4925.113479573711;4967.950320496749;4971.552560269593;4986.850394488171;4997.800087996439;7790.298873101448;7959.9602001989615;8017.959910200411;8056.315213206709;8076.071251806117;7695.769126926201;7709.768706938801;7736.7292144774665;7738.651760670671;7747.573883436465;7679.539227646359;7695.807604809701;7699.923000770144;7740.225977402215;7740.26467485588;7490.101187857274;7522.924770752223;7524.811879702832;7531.246875312425;7550.169481356937;7405.888911666437;7616.162222155669;7649.732259370895;7658.119316278477;7679.923200767921;6158.107074474266;7517.097948246027;7581.50720203185;7598.20218877032;7628.80927976805 08:05:43 INFO - PROCESS | 1682 | |5;yui.html;721.7041013184594;731.6414956671233;764.2586690909816;773.2074623510897;800.9038915330159;15131.924340378297;15150.621234469143;15275.465358712447;15283.770743438858;15286.770698439532;14054.227017514033;14082.225477598728;14109.082909610868;14121.364538595762;16191.433299834509;951.7477868364889;972.4214092614883;1002.1231422505308;1002.6340385759182;1003.8544411060392;840.6679361652174;950.282536684802;974.3374505336368;991.7024892532212;992.9156021738124;937.2455173585261;961.9182369498601;1034.3948789957883;1041.1410586266322;1044.3211912257018;996.3722854601591;1009.2531526670284;1035.7824856780085;1045.0698877998586;1047.481496659151;737.1007371007363;739.2127384335719;753.5403403923602;773.4894969320221;788.467784245632;15086;15400;15579.688406231926;15585.376584936588;15615;12830.679233019157;12836.55072072473;12918.41867115982;13101.475940962446;13147.14543554666;10309.432981186032;10642;10648.57405703771;10687.358758474516;10795.83806242907;3512.613612502623;3539.610642829287;3585.748997570171;3674.9632503675157;3737.7009839212797;79484.20515794826;79818.6009069951;80185.59907200484;80294;89363;9477.857832132524;9479.763005924908;9525.952370238243;9722.951385243028;9731.978142294956;21683.349499514723;21700.457488562595;21753.67369489459;21771.67342489864;21785.673214901788;7440.851182976418;7511.098668159856;7511.399088072941;7518.473706840578;7569.735059272899;4060.7360521566;4150.460440142762;4211.936820947688;4212.326027835593;4223.873283801491;3771.1891943232336;3776.981115094407;3778.3576791944884;3817.7518461300483;3862.9956211385243;597.7788218359235;694.9756758513428;696;697.6232834269539;698.4866123399297;512.9923051154236;557.9748911298921;595.4462350014442;602.3614968133792;604.6976511744128;7234.819129521698;7316.853662926818;7408.444366672521;7415.768328095697;7522.435817313723;528.5560129491246;562.963407378519;593.4658807073669;608.5435923057706;628.5882746800853;3386.356592247465;3815.4467602197524;3847.8076096195077;3849.826757795906;4027.5368332641533;87216.6917496238;87874.56062719645;88585.11414885898;88635.55682221548;89571.55214223887;74499;75756.62121689356;79061.60469197617;79342;80837.59581202174;67390;68330;69364;69405.65297173584;70017;7711.190325016017;7797.99813478426;7804.141544429995;7867.984821250296;7882.330001949898;49146.52560423193;49470.76323091952;49892.750536247084;50128.74935625445;51150.97698045944;63361;64992.67503662452;66937;67273.66363168153;68109;8400.83198336042;9312.394694344846;9885.060919212663;9976.950115249378;10181.490925453845;9959.900400996186;10800.351978880977;10920.017198452177;11042.282251653616;11547.307161570332;10336;10345.793084138124;10477.37135771856;10556.84164737545;10631.043206111488;7312.634368281671;8939.821203575762;8970.910290897269;8990.55047247622;9173.862392064259;10158.08577228053;10542.314749541256;11106.61126860556;11531.769364612494;11890.464929078385;9474.7019013857;9562.61749530011;9826.705198844045;9916;9934.056264654846;8003.439759216799;9547.23431319956;9811.509424528602;9819.754506137404;9940.652077177265 08:05:43 INFO - PROCESS | 1682 | __end_tp_report 08:05:43 INFO - PROCESS | 1682 | __start_cc_report 08:05:43 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,390 08:05:43 INFO - PROCESS | 1682 | __end_cc_report 08:05:43 INFO - PROCESS | 1682 | __startTimestamp1468595143968__endTimestamp 08:05:43 INFO - PROCESS | 1682 | 08:05:43 INFO - PROCESS | 1682 | ------- Summary: start ------- 08:05:43 INFO - PROCESS | 1682 | Number of tests: 6 08:05:43 INFO - PROCESS | 1682 | 08:05:43 INFO - PROCESS | 1682 | [#0] dojo.html Cycles:165 Average:5946.67 Median:6212.53 stddev:639.34 (10.3%) stddev-sans-first:615.01 08:05:43 INFO - PROCESS | 1682 | Values: 3633.5 3669.7 3708.2 3709.1 3730.5 4858.3 6020.2 6061.7 6099.5 6121.2 4929.5 4988.7 5004.7 6099.1 6112.7 5445.3 5475.4 5516.9 5547.7 5577.7 5498.5 5509.8 5573.9 5589.5 5721.6 5569.0 5582.6 5584.0 5598.4 5599.5 5524.4 5527.3 5552.0 5583.7 5586.8 5316.4 5381.2 5426.9 5487.1 5506.7 5874.9 5991.2 6024.7 6031.2 6039.3 6321.7 6323.0 6341.8 6353.8 6372.9 6312.1 6335.9 6351.8 6386.1 6386.1 5186.8 6185.5 6208.4 6216.0 6220.7 6301.7 6507.0 6532.3 6546.4 6553.8 6226.8 6238.9 6276.5 6287.0 6287.8 6401.5 6417.3 6439.5 6446.0 6464.8 6198.3 6234.6 6289.2 6303.1 6306.7 5262.2 6302.0 6312.9 6320.7 6324.2 5132.5 5179.4 5184.6 5185.7 5200.0 4622.1 4633.2 4665.5 4692.4 4702.1 6114.1 6143.2 6167.8 6179.1 6219.5 6450.1 6450.9 6453.1 6500.1 6550.0 6135.7 6135.8 6212.9 6237.5 6255.8 5720.1 5721.1 5738.7 5745.7 5759.9 6715.6 6719.5 6769.2 6777.9 6780.6 6380.5 6411.3 6459.2 6477.5 6485.4 5829.6 6577.8 6721.3 6746.6 6752.2 5468.6 6357.7 6361.5 6387.7 6401.7 6227.9 6328.3 6437.9 6453.8 6457.4 5367.9 6286.1 6293.9 6332.4 6416.2 6289.7 6301.5 6307.3 6310.1 6432.5 5205.5 6121.8 6128.6 6160.4 6222.8 5271.3 6151.6 6249.7 6280.4 6284.2 6110.0 6159.4 6212.5 6227.7 6227.8 08:05:43 INFO - PROCESS | 1682 | 08:05:43 INFO - PROCESS | 1682 | [#1] ext.html Cycles:180 Average:64562.32 Median:38131.83 stddev:136443.39 (357.8%) stddev-sans-first:136741.54 08:05:43 INFO - PROCESS | 1682 | Values: 562.4 571.1 582.5 610.5 638.3 40799.0 42015.6 42047.2 42094.0 42182.9 34443.7 41369.8 41506.0 41510.6 41580.8 9674.4 9733.2 9754.5 9777.1 9785.8 9671.3 9748.8 9772.5 9773.0 9793.3 9749.2 9752.2 9822.3 9823.8 9826.7 8254.5 9636.3 9728.5 9745.2 9774.3 9691.9 9716.6 9755.2 9804.8 9825.5 41415.4 41813.2 41898.4 41919.8 41952.4 3307.3 3363.3 3381.7 3743.6 3799.9 28972.3 29033.0 29631.3 29783.0 29985.6 2818.3 2857.3 2879.3 2900.4 2936.2 360332.4 360676.0 362452.0 363213.0 364124.2 64806.0 65299.7 65382.0 65516.7 66009.3 62944.4 71522.3 73001.6 74442.6 74525.6 17472.7 17984.9 18056.7 18198.3 18294.9 13799.2 13939.7 13983.7 14009.9 14075.2 7709.9 7714.8 7717.2 7774.2 7827.0 3408.7 3431.4 3453.3 3455.9 3488.9 862.2 983.6 1049.6 1058.4 1081.4 23611.8 25362.2 27984.0 28758.0 28839.3 1077.9 1179.9 1247.0 1250.8 1274.5 14694.6 15020.8 15574.5 15650.8 15996.9 518601.0 527002.0 533619.0 535729.0 536674.0 47786.8 58974.7 60422.1 60429.7 60591.0 1565.3 1571.9 1572.8 1585.2 1592.9 29731.0 30643.4 30751.8 30958.5 31287.5 54309.2 54599.5 54852.5 55070.2 55314.9 603508.0 606258.0 607883.0 612146.0 613531.0 26804.0 26936.9 27121.3 27387.7 27416.3 43873.3 45844.3 46186.0 46770.0 46930.0 37358.4 37599.1 37725.2 37849.0 37927.2 36988.9 37492.8 37531.0 38031.2 38506.0 37258.1 37356.8 37466.3 38232.4 38616.0 32286.0 33184.0 33710.3 33768.2 33999.7 25381.4 25455.7 25709.7 25926.7 26127.0 08:05:43 INFO - PROCESS | 1682 | 08:05:43 INFO - PROCESS | 1682 | [#2] jquery.html Cycles:180 Average:36896.76 Median:21099.87 stddev:110616.63 (524.3%) stddev-sans-first:110892.96 08:05:43 INFO - PROCESS | 1682 | Values: 382.6 416.5 419.0 419.5 421.2 14718.0 20398.8 21134.6 21182.5 21306.9 15189.6 20355.6 20505.3 20742.6 21608.5 5565.6 6015.4 6038.0 6137.9 6398.6 6214.1 6224.3 6228.1 6337.7 6338.9 5140.8 6159.4 6165.6 6275.3 6305.3 6156.2 6169.0 6203.3 6287.2 6291.4 5340.3 5395.6 5506.6 5511.3 5541.9 27095.6 27211.6 27633.4 27736.3 27738.6 2062.1 2175.7 2176.7 2183.3 2192.5 10253.0 10432.3 11324.6 11557.2 15535.3 1796.4 1807.2 1830.1 1843.9 1916.9 111520.4 122385.0 122600.0 123031.8 123060.4 12118.0 12170.6 12187.9 12326.3 12332.6 15458.7 15483.0 15863.7 15866.0 15885.6 8764.3 9114.9 9185.7 9219.9 9280.9 8957.6 9076.9 9134.2 9195.4 9217.5 4809.6 4841.8 4890.9 4909.7 4912.5 1783.4 1969.9 2044.6 2092.7 2095.9 918.4 991.6 995.7 998.3 1052.4 17394.7 20654.9 20816.5 21077.5 21122.3 1012.8 1094.5 1102.1 1114.0 1120.9 11020.9 11359.2 11362.5 11364.0 11367.1 649370.0 650012.0 666009.0 682024.6 683393.0 102038.5 131802.0 133416.0 136688.0 137043.0 1009.9 1013.0 1018.2 1020.5 1026.2 15817.7 16865.6 18390.8 18483.7 18728.1 45338.8 47618.0 48656.8 48916.5 49989.0 72387.3 72994.6 74313.0 74475.0 76744.6 8141.7 8153.7 8184.4 8481.8 8589.4 11449.1 12224.3 12368.9 12760.8 12831.5 10263.9 10925.2 11158.4 11212.3 11295.8 10722.8 10840.0 10904.3 11114.8 11115.7 11106.8 11272.7 11484.5 11547.6 11733.4 7151.2 8221.4 8356.5 8378.9 8433.1 8381.9 10652.0 11214.0 11290.5 11470.5 08:05:43 INFO - PROCESS | 1682 | 08:05:43 INFO - PROCESS | 1682 | [#3] mootools.html Cycles:180 Average:5863.28 Median:4956.14 stddev:3274.41 (66.1%) stddev-sans-first:3266.81 08:05:43 INFO - PROCESS | 1682 | Values: 1451.0 1631.2 1906.5 2060.1 2064.8 8288.9 8980.9 9018.7 9272.9 9328.6 8941.9 8975.0 9040.3 9068.5 9086.8 2506.6 2523.3 2527.0 2529.7 2549.2 2487.3 2534.4 2541.3 2544.3 2550.1 2517.1 2518.1 2535.2 2551.9 2552.9 2520.6 2539.9 2556.1 2557.2 2561.7 2524.9 2546.6 2552.3 2558.6 2562.6 9180.6 9250.9 9255.4 9269.4 9309.1 4649.4 5627.2 5684.3 5759.9 5793.5 3660.5 3787.9 3795.4 3821.4 3838.2 960.9 1067.4 1083.7 1092.3 1097.6 12045.7 12163.7 12377.1 12381.3 12423.6 4921.7 4971.0 5033.5 5054.4 5058.7 10470.3 10471.1 10518.3 10530.2 10542.1 4737.2 5512.1 5582.6 5649.8 5668.4 4575.7 4965.2 4978.4 5010.5 5124.2 3580.4 4101.9 4109.8 4185.8 4186.9 1409.9 1411.1 1412.4 1417.0 1421.8 855.4 946.7 963.7 1003.2 1007.2 5233.8 5985.8 6048.2 6119.4 6177.0 465.5 477.2 480.3 483.0 483.1 3509.9 4053.7 4083.1 4096.7 4138.5 10705.6 10900.6 11001.7 11087.7 11307.3 10447.7 10961.3 11078.7 11095.4 11147.9 8377.9 8392.4 8587.1 8590.7 8713.4 5965.8 5993.0 6027.6 6105.9 6110.4 8017.4 8209.7 9854.1 9957.0 10009.4 9643.9 9935.2 9950.3 10174.4 10258.2 7008.7 7426.7 7725.3 7774.1 7896.3 8522.1 8544.0 8566.9 8579.2 8604.6 7481.0 7561.7 7640.0 7681.8 7703.0 7369.3 7458.6 7477.0 7582.4 7590.1 7168.5 7207.2 7231.6 7239.2 7248.7 4948.9 4963.4 5042.9 5122.9 5163.3 4128.8 4581.5 5058.8 5097.3 5223.0 08:05:43 INFO - PROCESS | 1682 | 08:05:43 INFO - PROCESS | 1682 | [#4] prototype.html Cycles:180 Average:6200.43 Median:6908.17 stddev:2010.76 (29.1%) stddev-sans-first:1967.00 08:05:43 INFO - PROCESS | 1682 | Values: 298.7 328.5 344.8 351.0 352.6 5023.9 6841.9 6871.5 7073.1 7135.8 6601.3 6738.0 6783.9 6817.1 6949.5 5163.0 5209.6 5209.9 5233.4 5257.3 4689.7 4744.1 5202.8 5221.0 5234.3 5154.7 5167.1 5171.5 5174.6 5215.7 4659.7 4845.0 5251.1 5256.7 5258.3 4000.7 4247.2 4313.2 4492.5 4503.8 5369.2 6755.8 6768.7 6788.5 6794.0 6059.3 6087.7 6095.4 6154.0 6155.3 7617.9 7618.4 7632.4 7657.0 7660.0 5029.5 5041.0 5046.8 5047.3 5062.0 5914.3 5989.8 7626.9 7967.2 7993.7 4270.3 5046.2 5104.8 5106.3 5115.9 5143.5 5150.9 5216.2 5217.4 5221.3 5004.3 5988.4 6034.5 6037.8 6069.6 7327.7 7549.1 7573.7 7580.4 7593.2 1811.9 1824.8 1829.9 1837.1 1838.1 1061.7 1103.2 1168.2 1186.7 1191.0 6893.6 7124.7 7191.7 7197.5 7224.7 7092.0 7291.9 7814.4 8017.7 8080.9 7270.7 7275.5 7279.6 7298.6 7300.7 4225.0 4274.5 4279.3 4291.9 4298.0 6922.8 7480.7 8313.9 8469.4 8525.2 8202.8 8276.5 8299.5 8300.9 8309.3 8406.2 8407.8 8428.3 8430.6 8458.8 7905.9 7910.4 7918.7 7932.2 7934.8 7499.3 7785.0 7787.9 7804.7 7815.0 8329.6 8417.7 8475.0 8514.6 8519.6 4925.1 4968.0 4971.6 4986.9 4997.8 7790.3 7960.0 8018.0 8056.3 8076.1 7695.8 7709.8 7736.7 7738.7 7747.6 7679.5 7695.8 7699.9 7740.2 7740.3 7490.1 7522.9 7524.8 7531.2 7550.2 7405.9 7616.2 7649.7 7658.1 7679.9 6158.1 7517.1 7581.5 7598.2 7628.8 08:05:43 INFO - PROCESS | 1682 | 08:05:43 INFO - PROCESS | 1682 | [#5] yui.html Cycles:180 Average:18009.91 Median:31994.79 stddev:25350.26 (79.2%) stddev-sans-first:25388.14 08:05:43 INFO - PROCESS | 1682 | Values: 721.7 731.6 764.3 773.2 800.9 15131.9 15150.6 15275.5 15283.8 15286.8 14054.2 14082.2 14109.1 14121.4 16191.4 951.7 972.4 1002.1 1002.6 1003.9 840.7 950.3 974.3 991.7 992.9 937.2 961.9 1034.4 1041.1 1044.3 996.4 1009.3 1035.8 1045.1 1047.5 737.1 739.2 753.5 773.5 788.5 15086.0 15400.0 15579.7 15585.4 15615.0 12830.7 12836.6 12918.4 13101.5 13147.1 10309.4 10642.0 10648.6 10687.4 10795.8 3512.6 3539.6 3585.7 3675.0 3737.7 79484.2 79818.6 80185.6 80294.0 89363.0 9477.9 9479.8 9526.0 9723.0 9732.0 21683.3 21700.5 21753.7 21771.7 21785.7 7440.9 7511.1 7511.4 7518.5 7569.7 4060.7 4150.5 4211.9 4212.3 4223.9 3771.2 3777.0 3778.4 3817.8 3863.0 597.8 695.0 696.0 697.6 698.5 513.0 558.0 595.4 602.4 604.7 7234.8 7316.9 7408.4 7415.8 7522.4 528.6 563.0 593.5 608.5 628.6 3386.4 3815.4 3847.8 3849.8 4027.5 87216.7 87874.6 88585.1 88635.6 89571.6 74499.0 75756.6 79061.6 79342.0 80837.6 67390.0 68330.0 69364.0 69405.7 70017.0 7711.2 7798.0 7804.1 7868.0 7882.3 49146.5 49470.8 49892.8 50128.7 51151.0 63361.0 64992.7 66937.0 67273.7 68109.0 8400.8 9312.4 9885.1 9977.0 10181.5 9959.9 10800.4 10920.0 11042.3 11547.3 10336.0 10345.8 10477.4 10556.8 10631.0 7312.6 8939.8 8970.9 8990.6 9173.9 10158.1 10542.3 11106.6 11531.8 11890.5 9474.7 9562.6 9826.7 9916.0 9934.1 8003.4 9547.2 9811.5 9819.8 9940.7 08:05:43 INFO - PROCESS | 1682 | -------- Summary: end -------- 08:05:43 INFO - PROCESS | 1682 | 08:05:44 INFO - TEST-INFO | 1682: exit 0 08:05:44 INFO - TEST-OK | dromaeo_css | took 1109594ms 08:05:44 INFO - TEST-START | kraken 08:05:44 INFO - operating with platform_type : mac_ 08:05:44 INFO - Initialising browser for kraken test... 08:05:44 INFO - TEST-INFO | started process 1690 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmpiBOPR3/profile http://localhost:49280/getInfo.html) 08:05:47 INFO - PROCESS | 1690 | __metrics Screen width/height:1600/1200 08:05:47 INFO - PROCESS | 1690 | colorDepth:24 08:05:47 INFO - PROCESS | 1690 | Browser inner width/height: 1024/689 08:05:47 INFO - PROCESS | 1690 | __metrics 08:05:47 ERROR - PROCESS | 1690 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 08:05:47 INFO - TEST-INFO | 1690: exit 0 08:05:47 INFO - Browser initialized. 08:05:47 INFO - Running cycle 1/1 for kraken test... 08:05:47 INFO - TEST-INFO | started process 1694 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/T/tmpiBOPR3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:05:59 INFO - PROCESS | 1694 | RSS: Main: 171167744 08:05:59 INFO - PROCESS | 1694 | 08:06:02 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection) 08:06:03 INFO - PROCESS | 1694 | RSS: Main: 183713792 08:06:03 INFO - PROCESS | 1694 | 08:06:05 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-dft) 08:06:06 INFO - PROCESS | 1694 | RSS: Main: 192872448 08:06:06 INFO - PROCESS | 1694 | 08:06:09 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-fft) 08:06:10 INFO - PROCESS | 1694 | RSS: Main: 196149248 08:06:10 INFO - PROCESS | 1694 | 08:06:12 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator) 08:06:13 INFO - PROCESS | 1694 | RSS: Main: 197210112 08:06:13 INFO - PROCESS | 1694 | 08:06:15 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:06:15 INFO - PROCESS | 1694 | RSS: Main: 197537792 08:06:15 INFO - PROCESS | 1694 | 08:06:18 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom) 08:06:19 INFO - PROCESS | 1694 | RSS: Main: 198438912 08:06:19 INFO - PROCESS | 1694 | 08:06:22 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate) 08:06:22 INFO - PROCESS | 1694 | RSS: Main: 198541312 08:06:22 INFO - PROCESS | 1694 | 08:06:25 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial) 08:06:26 INFO - PROCESS | 1694 | RSS: Main: 198701056 08:06:26 INFO - PROCESS | 1694 | 08:06:27 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:06:28 INFO - PROCESS | 1694 | RSS: Main: 197799936 08:06:28 INFO - PROCESS | 1694 | 08:06:30 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:06:30 INFO - PROCESS | 1694 | RSS: Main: 197935104 08:06:30 INFO - PROCESS | 1694 | 08:06:33 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:06:33 INFO - PROCESS | 1694 | RSS: Main: 198131712 08:06:33 INFO - PROCESS | 1694 | 08:06:36 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:06:37 INFO - PROCESS | 1694 | RSS: Main: 198193152 08:06:37 INFO - PROCESS | 1694 | 08:06:40 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:06:40 INFO - PROCESS | 1694 | RSS: Main: 198184960 08:06:40 INFO - PROCESS | 1694 | 08:06:42 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49280/tests/kraken/driver.html?testName=ai-astar) 08:06:42 INFO - PROCESS | 1694 | RSS: Main: 200224768 08:06:42 INFO - PROCESS | 1694 | 08:06:42 INFO - PROCESS | 1694 | __start_tp_report 08:06:42 INFO - PROCESS | 1694 | _x_x_mozilla_page_load 08:06:42 INFO - PROCESS | 1694 | _x_x_mozilla_page_load_details 08:06:42 INFO - PROCESS | 1694 | |i|pagename|runs| 08:06:42 INFO - PROCESS | 1694 | |0;ai-astar;127;157;166;103;172;192;166;113;116;114 08:06:42 INFO - PROCESS | 1694 | |1;audio-beat-detection;149;119;145;158;118;137;119;155;152;118 08:06:42 INFO - PROCESS | 1694 | |2;audio-dft;194;195;196;199;199;196;200;196;195;194 08:06:42 INFO - PROCESS | 1694 | |3;audio-fft;64;73;106;133;69;73;82;86;132;70 08:06:42 INFO - PROCESS | 1694 | |4;audio-oscillator;77;81;124;80;79;94;116;78;80;122 08:06:42 INFO - PROCESS | 1694 | |5;imaging-gaussian-blur;119;129;88;85;88;85;97;116;89;85 08:06:42 INFO - PROCESS | 1694 | |6;imaging-darkroom;94;111;149;94;94;94;95;95;94;93 08:06:42 INFO - PROCESS | 1694 | |7;imaging-desaturate;90;92;119;121;91;111;146;140;89;91 08:06:42 INFO - PROCESS | 1694 | |8;json-parse-financial;51;92;62;63;63;63;64;78;61;59 08:06:42 INFO - PROCESS | 1694 | |9;json-stringify-tinderbox;62;63;63;69;73;73;71;66;65;66 08:06:42 INFO - PROCESS | 1694 | |10;stanford-crypto-aes;84;103;104;70;91;101;106;103;83;81 08:06:42 INFO - PROCESS | 1694 | |11;stanford-crypto-ccm;142;136;113;145;151;142;151;153;164;140 08:06:42 INFO - PROCESS | 1694 | |12;stanford-crypto-pbkdf2;151;176;164;164;166;160;175;163;165;159 08:06:42 INFO - PROCESS | 1694 | |13;stanford-crypto-sha256-iterative;67;70;87;94;94;97;84;71;68;63 08:06:42 INFO - PROCESS | 1694 | __end_tp_report 08:06:42 INFO - PROCESS | 1694 | __start_cc_report 08:06:42 INFO - PROCESS | 1694 | _x_x_mozilla_cycle_collect,1046 08:06:42 INFO - PROCESS | 1694 | __end_cc_report 08:06:42 INFO - PROCESS | 1694 | __startTimestamp1468595202705__endTimestamp 08:06:42 INFO - PROCESS | 1694 | 08:06:42 INFO - PROCESS | 1694 | ------- Summary: start ------- 08:06:42 INFO - PROCESS | 1694 | Number of tests: 14 08:06:42 INFO - PROCESS | 1694 | 08:06:42 INFO - PROCESS | 1694 | [#0] ai-astar Cycles:10 Average:142.60 Median:161.50 stddev:31.31 (19.4%) stddev-sans-first:32.69 08:06:42 INFO - PROCESS | 1694 | Values: 127.0 157.0 166.0 103.0 172.0 192.0 166.0 113.0 116.0 114.0 08:06:42 INFO - PROCESS | 1694 | 08:06:42 INFO - PROCESS | 1694 | [#1] audio-beat-detection Cycles:10 Average:137.00 Median:147.00 stddev:16.89 (11.5%) stddev-sans-first:17.35 08:06:42 INFO - PROCESS | 1694 | Values: 149.0 119.0 145.0 158.0 118.0 137.0 119.0 155.0 152.0 118.0 08:06:42 INFO - PROCESS | 1694 | 08:06:42 INFO - PROCESS | 1694 | [#2] audio-dft Cycles:10 Average:196.40 Median:196.00 stddev:2.17 (1.1%) stddev-sans-first:2.12 08:06:42 INFO - PROCESS | 1694 | Values: 194.0 195.0 196.0 199.0 199.0 196.0 200.0 196.0 195.0 194.0 08:06:42 INFO - PROCESS | 1694 | 08:06:42 INFO - PROCESS | 1694 | [#3] audio-fft Cycles:10 Average:88.80 Median:71.50 stddev:25.88 (36.2%) stddev-sans-first:25.85 08:06:42 INFO - PROCESS | 1694 | Values: 64.0 73.0 106.0 133.0 69.0 73.0 82.0 86.0 132.0 70.0 08:06:42 INFO - PROCESS | 1694 | 08:06:42 INFO - PROCESS | 1694 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:79.50 stddev:19.69 (24.8%) stddev-sans-first:20.01 08:06:42 INFO - PROCESS | 1694 | Values: 77.0 81.0 124.0 80.0 79.0 94.0 116.0 78.0 80.0 122.0 08:06:42 INFO - PROCESS | 1694 | 08:06:42 INFO - PROCESS | 1694 | [#5] imaging-gaussian-blur Cycles:10 Average:98.10 Median:86.50 stddev:16.72 (19.3%) stddev-sans-first:15.93 08:06:42 INFO - PROCESS | 1694 | Values: 119.0 129.0 88.0 85.0 88.0 85.0 97.0 116.0 89.0 85.0 08:06:42 INFO - PROCESS | 1694 | 08:06:42 INFO - PROCESS | 1694 | [#6] imaging-darkroom Cycles:10 Average:101.30 Median:94.00 stddev:17.59 (18.7%) stddev-sans-first:18.46 08:06:42 INFO - PROCESS | 1694 | Values: 94.0 111.0 149.0 94.0 94.0 94.0 95.0 95.0 94.0 93.0 08:06:42 INFO - PROCESS | 1694 | 08:06:42 INFO - PROCESS | 1694 | [#7] imaging-desaturate Cycles:10 Average:109.00 Median:89.50 stddev:21.80 (24.4%) stddev-sans-first:22.01 08:06:42 INFO - PROCESS | 1694 | Values: 90.0 92.0 119.0 121.0 91.0 111.0 146.0 140.0 89.0 91.0 08:06:42 INFO - PROCESS | 1694 | 08:06:42 INFO - PROCESS | 1694 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:63.00 stddev:11.37 (18.1%) stddev-sans-first:10.77 08:06:42 INFO - PROCESS | 1694 | Values: 51.0 92.0 62.0 63.0 63.0 63.0 64.0 78.0 61.0 59.0 08:06:42 INFO - PROCESS | 1694 | 08:06:42 INFO - PROCESS | 1694 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.50 stddev:4.15 (6.1%) stddev-sans-first:3.97 08:06:42 INFO - PROCESS | 1694 | Values: 62.0 63.0 63.0 69.0 73.0 73.0 71.0 66.0 65.0 66.0 08:06:42 INFO - PROCESS | 1694 | 08:06:42 INFO - PROCESS | 1694 | [#10] stanford-crypto-aes Cycles:10 Average:92.60 Median:75.50 stddev:12.52 (16.6%) stddev-sans-first:12.89 08:06:42 INFO - PROCESS | 1694 | Values: 84.0 103.0 104.0 70.0 91.0 101.0 106.0 103.0 83.0 81.0 08:06:42 INFO - PROCESS | 1694 | 08:06:42 INFO - PROCESS | 1694 | [#11] stanford-crypto-ccm Cycles:10 Average:143.70 Median:148.00 stddev:13.45 (9.1%) stddev-sans-first:14.25 08:06:42 INFO - PROCESS | 1694 | Values: 142.0 136.0 113.0 145.0 151.0 142.0 151.0 153.0 164.0 140.0 08:06:42 INFO - PROCESS | 1694 | 08:06:42 INFO - PROCESS | 1694 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.30 Median:164.50 stddev:7.30 (4.4%) stddev-sans-first:5.95 08:06:42 INFO - PROCESS | 1694 | Values: 151.0 176.0 164.0 164.0 166.0 160.0 175.0 163.0 165.0 159.0 08:06:42 INFO - PROCESS | 1694 | 08:06:42 INFO - PROCESS | 1694 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.50 Median:85.50 stddev:13.02 (15.2%) stddev-sans-first:13.00 08:06:42 INFO - PROCESS | 1694 | Values: 67.0 70.0 87.0 94.0 94.0 97.0 84.0 71.0 68.0 63.0 08:06:42 INFO - PROCESS | 1694 | -------- Summary: end -------- 08:06:42 INFO - PROCESS | 1694 | 08:06:43 INFO - TEST-INFO | 1694: exit 0 08:06:43 INFO - TEST-OK | kraken | took 58935ms 08:06:43 INFO - SUITE-END | took 1168s 08:06:43 INFO - Completed test suite (00:19:28) 08:06:43 INFO - javascript benchmark 08:06:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3633.5094762207104, 3669.7064234861214, 3708.221273532558, 3709.0727318170457, 3730.5336832895873, 4858.2712593111055, 6020.247469066367, 6061.66660833654, 6099.451049405547, 6121.204243448351, 4929.507049295069, 4988.725620090893, 5004.724740139291, 6099.115628233903, 6112.724927378267, 5445.319335083124, 5475.370332411764, 5516.91724624131, 5547.694876781776, 5577.749001294951, 5498.505134537891, 5509.752061157257, 5573.888522229553, 5589.496945274925, 5721.570882183832, 5569.0, 5582.609217354787, 5584.0, 5598.412166722476, 5599.524040456566, 5524.419935906712, 5527.336719593654, 5552.0, 5583.748731307101, 5586.804461843816, 5316.3620365556, 5381.165919282517, 5426.9185962210595, 5487.149491828773, 5506.724663766796, 5874.882502349972, 5991.191189189447, 6024.728887200086, 6031.185789918349, 6039.275286965592, 6321.715522801485, 6323.0, 6341.778037768702, 6353.809385718436, 6372.872542549169, 6312.084747711602, 6335.873282534323, 6351.809445716636, 6386.10594516768, 6386.10594516768, 5186.844394668166, 6185.474234690057, 6208.441240288395, 6216.0, 6220.657863817488, 6301.747930082745, 6506.991416330477, 6532.314107018789, 6546.443552298013, 6553.803385898431, 6226.750929962751, 6238.937610623926, 6276.529260305404, 6287.0, 6287.811365659038, 6401.519886008568, 6417.326180751047, 6439.484841212692, 6446.000869865178, 6464.838379040468, 6198.256209254918, 6234.594751341148, 6289.182406287154, 6303.117563541108, 6306.684665766693, 5262.236975638511, 6301.96849015752, 6312.936870631235, 6320.652364120017, 6324.209473815773, 5132.46109158533, 5179.430262671103, 5184.611154163453, 5185.662931909414, 5200.0, 4622.14490319292, 4633.189191891405, 4665.4634717007975, 4692.436907571113, 4702.106599746037, 6114.144019837227, 6143.174139895698, 6167.814965551041, 6179.073139029092, 6219.502439804895, 6450.064740612679, 6450.870982580323, 6453.128827608213, 6500.122483464766, 6550.0174973753365, 6135.722664536883, 6135.785247516315, 6212.9378706213265, 6237.4698150657705, 6255.78104766331, 5720.11338242573, 5721.113227449752, 5738.684372359477, 5745.741441635053, 5759.913601295984, 6715.630640314732, 6719.529632925648, 6769.22153952292, 6777.864442711217, 6780.559263647946, 6380.521460890544, 6411.294757576756, 6459.224893012869, 6477.546571739933, 6485.351464853666, 5829.59192856496, 6577.835554111186, 6721.294264102395, 6746.561473504206, 6752.155980502437, 5468.589855760754, 6357.650329231937, 6361.522885783677, 6387.680615969276, 6401.7119229633845, 6227.906581401373, 6328.272248691275, 6437.871242575216, 6453.838654033687, 6457.418832305115, 5367.919481207863, 6286.057091436322, 6293.874122517433, 6332.366763323631, 6416.230052393743, 6289.685515724104, 6301.527385446201, 6307.274663413767, 6310.11658367838, 6432.517561182836, 5205.505476979681, 6121.816345509642, 6128.625347140905, 6160.44555989963, 6222.782202622887, 5271.341082364705, 6151.630902145886, 6249.7187626557825, 6280.434760871543, 6284.214473190851, 6109.9816581254145, 6159.4456498915315, 6212.534059945432, 6227.719752611234, 6227.844303892439], "value": 5911.619894374617, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.372954156116, 571.1489880078683, 582.4916453522022, 610.5420934299273, 638.3361304243587, 40799.0, 42015.57984420155, 42047.159056818884, 42094.0, 42182.94542636436, 34443.65556344442, 41369.7931510342, 41505.96235094124, 41510.58489415105, 41580.79209603955, 9674.371165874196, 9733.221342292634, 9754.46350450725, 9777.12005919467, 9785.755356116118, 9671.323007389485, 9748.805023899518, 9772.511374431286, 9773.0, 9793.26550508711, 9749.171320437772, 9752.219822414225, 9822.263330250224, 9823.803523929517, 9826.70519884401, 8254.504729716236, 9636.277279204018, 9728.464934428604, 9745.171660408874, 9774.31579789415, 9691.90308096917, 9716.61133554664, 9755.170810481117, 9804.803903921953, 9825.459599722013, 41415.378769318486, 41813.1637367254, 41898.37152442716, 41919.79040104811, 41952.370714439305, 3307.3054658521737, 3363.276895467486, 3381.6956473917467, 3743.6069212732814, 3799.9430008549894, 28972.27569310763, 29033.0, 29631.259218519495, 29783.0, 29985.550216746768, 2818.2672505148603, 2857.2571131505956, 2879.280179955011, 2900.3764190699103, 2936.2219011961847, 360332.39667603513, 360675.9999999974, 362452.0, 363212.9999999974, 364124.17937910405, 64806.0279095814, 65299.67350163314, 65382.019269710996, 65516.672416637615, 66009.33990660032, 62944.370556294765, 71522.2847771526, 73001.6349918247, 74442.62778686071, 74525.62737186279, 17472.65054698899, 17984.910075449538, 18056.729149062776, 18198.272069117353, 18294.908525457555, 13799.2410417428, 13939.721205575832, 13983.650408739659, 14009.859901400856, 14075.225862577656, 7709.922900771033, 7714.768556943301, 7717.2282771722375, 7774.1837107104075, 7827.0, 3408.6761757632985, 3431.3995050865997, 3453.2920751245933, 3455.87904423344, 3488.8778892738633, 862.1938487514194, 983.6327504768377, 1049.6116436918237, 1058.433737950193, 1081.3619964221148, 23611.7638823613, 25362.239132826046, 27984.0, 28758.0, 28839.2790180243, 1077.8706555213425, 1179.9115066370057, 1246.9750604987848, 1250.7554982791999, 1274.4902039184215, 14694.63263418423, 15020.774688379683, 15574.454894078654, 15650.765238521431, 15996.920015400081, 518601.0, 527002.0, 533619.0, 535729.0, 536674.0, 47786.76106619514, 58974.70512647495, 60422.09366859413, 60429.697851510464, 60591.0, 1565.3347327385816, 1571.8821088418185, 1572.7955365802372, 1585.1836304303292, 1592.8646065084365, 29731.0, 30643.387132257674, 30751.846240768653, 30958.486897255683, 31287.53068704017, 54309.18536221881, 54599.45400545944, 54852.45147548473, 55070.17394739002, 55314.89370212493, 603507.9824601024, 606258.0, 607883.0, 612146.0, 613531.0, 26804.0, 26936.865315673294, 27121.321966950985, 27387.726122738517, 27416.314592135357, 43873.34189987217, 45844.31233531433, 46186.0, 46770.0, 46930.0, 37358.439623405124, 37599.06002349963, 37725.245495089395, 37849.0, 37927.24145517129, 36988.890333290045, 37492.81253593715, 37531.0, 38031.239375211786, 38506.03734906538, 37258.06854828651, 37356.81321593375, 37466.2506749858, 38232.426513601764, 38616.0, 32286.0, 33184.0, 33710.325793483506, 33768.1557961053, 33999.66000339965, 25381.364821530755, 25455.745442545336, 25709.742902570735, 25926.740732593185, 26127.0], "value": 19247.180103049785, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.60782697734817, 416.45444467747234, 418.96438802701766, 419.50498411873986, 421.19761853668757, 14718.0, 20398.796012039875, 21134.57730845384, 21182.470438239052, 21306.93465326735, 15189.620259493491, 20355.59288814223, 20505.282315118973, 20742.585148297025, 21608.459788505294, 5565.638233514829, 6015.398460153993, 6037.969810150943, 6137.864495068427, 6398.552101352907, 6214.067889816519, 6224.346443623423, 6228.0657901314935, 6337.651429171394, 6338.904916426234, 5140.794368225266, 6159.414855588712, 6165.599236049642, 6275.309715931244, 6305.306416294227, 6156.230471191101, 6169.043798211284, 6203.31763506014, 6287.2140982377205, 6291.370862913741, 5340.25236466895, 5395.568354531628, 5506.64206826555, 5511.255980442629, 5541.919325731484, 27095.593566096526, 27211.591826122625, 27633.447331053267, 27736.30659233515, 27738.5839212412, 2062.05145633009, 2175.7280339957506, 2176.68438076478, 2183.2795177591356, 2192.4628466025765, 10253.0, 10432.32189907661, 11324.603638872682, 11557.24877882935, 15535.300911458899, 1796.4431026381733, 1807.204829874864, 1830.057520377007, 1843.9446816595523, 1916.9361004642558, 111520.4423977875, 122385.0, 122600.0, 123031.76968230293, 123060.38469807773, 12118.0, 12170.634880953585, 12187.878121218851, 12326.32205228703, 12332.568360107352, 15458.690826183638, 15483.0, 15863.682726345409, 15866.0, 15885.602859928364, 8764.298856091498, 9114.908850911539, 9185.724428267162, 9219.90780092204, 9280.860787088199, 8957.552122393854, 9076.8638470423, 9134.223590994707, 9195.356325057315, 9217.539123043955, 4809.591184749265, 4841.782119804618, 4890.877728056756, 4909.656324057353, 4912.459629440758, 1783.3669047488215, 1969.8522610804248, 2044.6115238104712, 2092.686097085419, 2095.853290269697, 918.3938600523622, 991.6479649724388, 995.7062666513395, 998.32612986234, 1052.4369462337613, 17394.652106958045, 20654.896725516275, 20816.47958801012, 21077.473063173544, 21122.260720875, 1012.7721262715977, 1094.5457635081352, 1102.1293178389144, 1113.9944300278446, 1120.9327440353604, 11020.944895275472, 11359.204855660024, 11362.48868800906, 11364.0, 11367.147463940237, 649370.0, 650012.0, 666009.0, 682024.5898770475, 683393.0, 102038.48980755049, 131802.0, 133416.0, 136688.0, 137043.0, 1009.9242556808268, 1013.0, 1018.2261481274285, 1020.5458570936011, 1026.230327254574, 15817.65549928269, 16865.578360541083, 18390.816091839446, 18483.722744159117, 18728.06359682038, 45338.77330613458, 47618.0, 48656.756716216194, 48916.51083489262, 49989.0, 72387.27612724015, 72994.63502682453, 74313.0, 74475.0, 76744.61627691826, 8141.715039973573, 8153.714619988272, 8184.386171037077, 8481.83036339282, 8589.44168629037, 11449.14131440162, 12224.266544007389, 12368.876311236772, 12760.808587871375, 12831.486740530647, 10263.897361026295, 10925.235233533576, 11158.386288753873, 11212.327260364404, 11295.830562541732, 10722.785544289227, 10840.024397804236, 10904.291221070605, 11114.833277501006, 11115.666530004113, 11106.777864442827, 11272.718182045186, 11484.540618375506, 11547.595834145764, 11733.413329333329, 7151.213366529573, 8221.424500284922, 8356.54039027835, 8378.916210837813, 8433.072362040293, 8381.916180838358, 10652.041316281571, 11214.0, 11290.548378064785, 11470.483828227916], "value": 9802.965567444862, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1450.9564713058608, 1631.1762559907245, 1906.4852489827747, 2060.0729671647764, 2064.783197764236, 8288.91711082889, 8980.910190898105, 9018.72943811686, 9272.907270927297, 9328.580213890375, 8941.91058089419, 8974.967878693953, 9040.321975851804, 9068.546572671374, 9086.81826363474, 2506.5613517634433, 2523.2556395863267, 2527.0, 2529.6837895263093, 2549.1715192562397, 2487.3035550046015, 2534.353739796349, 2541.3265484646586, 2544.262163972455, 2550.081970490622, 2517.0686845866962, 2518.1438310974263, 2535.1887396033276, 2551.8979240830345, 2552.923412297625, 2520.5589021921182, 2539.8857051432637, 2556.1053631229106, 2557.181701855407, 2561.743825617442, 2524.911628093026, 2546.630738542901, 2552.34915096651, 2558.590625499911, 2562.6156076588472, 9180.586873590704, 9250.907490925072, 9255.398399104037, 9269.397489163182, 9309.069093090637, 4649.395578574764, 5627.184058311563, 5684.261046063985, 5759.913601295984, 5793.4785869271545, 3660.4692319613505, 3787.8863634090744, 3795.430685397185, 3821.426785982097, 3838.2323535292776, 960.9471479068649, 1067.4022547373495, 1083.7399024234128, 1092.268180319188, 1097.5554900265406, 12045.698857528545, 12163.695907602292, 12377.071719620975, 12381.319027453486, 12423.565175218824, 4921.655484116149, 4970.975145124251, 5033.496650334937, 5054.444011158769, 5058.747062646853, 10470.267081304235, 10471.057604815604, 10518.316309439862, 10530.15758739299, 10542.051215390651, 4737.218358970731, 5512.062949298549, 5582.637128586629, 5649.830505084854, 5668.433156684381, 4575.7483338416705, 4965.1807451770055, 4978.427480839678, 5010.473900240422, 5124.205748109049, 3580.3913334733156, 4101.921096233978, 4109.794510274474, 4185.769782661922, 4186.911403035172, 1409.9083559568596, 1411.125102436496, 1412.4067891485602, 1416.9716605668036, 1421.8151640286696, 855.4268640011207, 946.6781294359951, 963.7446076789656, 1003.2325271167563, 1007.1539906478594, 5233.842984710464, 5985.760569577168, 6048.243969503812, 6119.418655227746, 6176.980798168252, 465.54144167994497, 477.1983068444976, 480.32034670940226, 482.9758512074382, 483.0941983780412, 3509.9119273025444, 4053.7365071270274, 4083.1221287423346, 4096.651784598343, 4138.461999939988, 10705.571777128984, 10900.618478353219, 11001.669949901516, 11087.667369978913, 11307.265027773168, 10447.738806529745, 10961.287516311415, 11078.667639970814, 11095.44522773858, 11147.888521114684, 8377.874331885027, 8392.370572207108, 8587.141285871488, 8590.699325523701, 8713.433626814236, 5965.821025369246, 5992.970035149797, 6027.57806953509, 6105.938940610537, 6110.419510146529, 8017.358611310964, 8209.71266005687, 9854.063863932915, 9956.950215248877, 10009.449480278654, 9643.9035609643, 9935.20518358544, 9950.253730970062, 10174.440405777754, 10258.230632702427, 7008.684609192701, 7426.665800038903, 7725.266099720518, 7774.144844067261, 7896.3288120508105, 8522.147785221676, 8543.957280213559, 8566.914330856862, 8579.227869491775, 8604.61279242423, 7481.0, 7561.659725312485, 7639.961800190964, 7681.807954801175, 7702.961485192538, 7369.299916507923, 7458.589777562286, 7476.962615186889, 7582.431317651088, 7590.0891892973195, 7168.498205125591, 7207.207207207098, 7231.602261875437, 7239.167495738057, 7248.673809678683, 4948.901021979468, 4963.379577552806, 5042.924356134734, 5122.871928201825, 5163.27714120016, 4128.772917489447, 4581.450225972904, 5058.797648094035, 5097.286379906742, 5222.9554089183075], "value": 4670.481573089762, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.6535618682328, 328.49575900991965, 344.8103543051322, 350.9964900350997, 352.55754028693985, 5023.874403139924, 6841.863162736755, 6871.450283977282, 7073.08049953506, 7135.821604459885, 6601.2738598754095, 6738.0, 6783.898241526381, 6817.079694241276, 6949.548279361838, 5163.0, 5209.635325527214, 5209.869753256161, 5233.3981592116825, 5257.290265814105, 4689.718616882981, 4744.0511897620445, 5202.8179013734525, 5221.0, 5234.345706786652, 5154.664946778466, 5167.095758242312, 5171.534561889429, 5174.611904107207, 5215.660982036175, 4659.718577391211, 4844.951550484485, 5251.081060814361, 5256.658317209388, 5258.2638430619745, 4000.659778974047, 4247.193033323659, 4313.202057619351, 4492.505824359318, 4503.842365517191, 5369.194620806871, 6755.7973260802255, 6768.729250829961, 6788.524803263774, 6794.0, 6059.303180134297, 6087.726052327655, 6095.359987201325, 6154.0, 6155.261368635793, 7617.885731714029, 7618.390528757686, 7632.389408847279, 7656.9617151914445, 7659.961700191519, 5029.547340739351, 5041.0, 5046.84859454217, 5047.343845300087, 5062.012907483042, 5914.349421563625, 5989.790357337516, 7626.923730762677, 7967.211475983418, 7993.680252789882, 4270.274053410928, 5046.243063540498, 5104.846854594368, 5106.336176297058, 5115.948840511622, 5143.459936706667, 5150.8969820604125, 5216.243644671501, 5217.426083130853, 5221.321228240305, 5004.324416203839, 5988.371221021817, 6034.48706859913, 6037.78867739627, 6069.575129740964, 7327.670254838545, 7549.0941087069905, 7573.734919277799, 7580.431467639839, 7593.240675932473, 1811.918463669138, 1824.7536582561183, 1829.8719089663596, 1837.0998210876573, 1838.0901453780198, 1061.6782106277733, 1103.189155970361, 1168.1647621950347, 1186.7151883547886, 1190.9523619055315, 6893.586384816927, 7124.679389427488, 7191.676374563157, 7197.46019048563, 7224.711011559584, 7092.0, 7291.8541629168185, 7814.413918955987, 8017.679292828221, 8080.878786818203, 7270.745523906744, 7275.527090739085, 7279.636018199175, 7298.598577078312, 7300.671469783872, 4224.957750422456, 4274.529801721808, 4279.293916503742, 4291.914161716748, 4297.957020429818, 6922.757703480454, 7480.70077196906, 8313.882294139697, 8469.449485783527, 8525.19010693983, 8202.835943281101, 8276.544790036485, 8299.543525106057, 8300.875486867702, 8309.293710034715, 8406.201410865959, 8407.8318433631, 8428.325733941392, 8430.620622072021, 8458.788530286669, 7905.920940790748, 7910.406719495946, 7918.683252669829, 7932.16712245206, 7934.841303174019, 7499.325060744559, 7784.9610751945875, 7787.922120778946, 7804.726834560764, 7815.0, 8329.583520823813, 8417.663293468193, 8474.957625211835, 8514.61684224199, 8519.616617252115, 4925.113479573711, 4967.950320496749, 4971.552560269593, 4986.850394488171, 4997.800087996439, 7790.298873101448, 7959.9602001989615, 8017.959910200411, 8056.315213206709, 8076.071251806117, 7695.769126926201, 7709.768706938801, 7736.7292144774665, 7738.651760670671, 7747.573883436465, 7679.539227646359, 7695.807604809701, 7699.923000770144, 7740.225977402215, 7740.26467485588, 7490.101187857274, 7522.924770752223, 7524.811879702832, 7531.246875312425, 7550.169481356937, 7405.888911666437, 7616.162222155669, 7649.732259370895, 7658.119316278477, 7679.923200767921, 6158.107074474266, 7517.097948246027, 7581.50720203185, 7598.20218877032, 7628.80927976805], "value": 5528.490846850113, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.7041013184594, 731.6414956671233, 764.2586690909816, 773.2074623510897, 800.9038915330159, 15131.924340378297, 15150.621234469143, 15275.465358712447, 15283.770743438858, 15286.770698439532, 14054.227017514033, 14082.225477598728, 14109.082909610868, 14121.364538595762, 16191.433299834509, 951.7477868364889, 972.4214092614883, 1002.1231422505308, 1002.6340385759182, 1003.8544411060392, 840.6679361652174, 950.282536684802, 974.3374505336368, 991.7024892532212, 992.9156021738124, 937.2455173585261, 961.9182369498601, 1034.3948789957883, 1041.1410586266322, 1044.3211912257018, 996.3722854601591, 1009.2531526670284, 1035.7824856780085, 1045.0698877998586, 1047.481496659151, 737.1007371007363, 739.2127384335719, 753.5403403923602, 773.4894969320221, 788.467784245632, 15086.0, 15400.0, 15579.688406231926, 15585.376584936588, 15615.0, 12830.679233019157, 12836.55072072473, 12918.41867115982, 13101.475940962446, 13147.14543554666, 10309.432981186032, 10642.0, 10648.57405703771, 10687.358758474516, 10795.83806242907, 3512.613612502623, 3539.610642829287, 3585.748997570171, 3674.9632503675157, 3737.7009839212797, 79484.20515794826, 79818.6009069951, 80185.59907200484, 80294.0, 89363.0, 9477.857832132524, 9479.763005924908, 9525.952370238243, 9722.951385243028, 9731.978142294956, 21683.349499514723, 21700.457488562595, 21753.67369489459, 21771.67342489864, 21785.673214901788, 7440.851182976418, 7511.098668159856, 7511.399088072941, 7518.473706840578, 7569.735059272899, 4060.7360521566, 4150.460440142762, 4211.936820947688, 4212.326027835593, 4223.873283801491, 3771.1891943232336, 3776.981115094407, 3778.3576791944884, 3817.7518461300483, 3862.9956211385243, 597.7788218359235, 694.9756758513428, 696.0, 697.6232834269539, 698.4866123399297, 512.9923051154236, 557.9748911298921, 595.4462350014442, 602.3614968133792, 604.6976511744128, 7234.819129521698, 7316.853662926818, 7408.444366672521, 7415.768328095697, 7522.435817313723, 528.5560129491246, 562.963407378519, 593.4658807073669, 608.5435923057706, 628.5882746800853, 3386.356592247465, 3815.4467602197524, 3847.8076096195077, 3849.826757795906, 4027.5368332641533, 87216.6917496238, 87874.56062719645, 88585.11414885898, 88635.55682221548, 89571.55214223887, 74499.0, 75756.62121689356, 79061.60469197617, 79342.0, 80837.59581202174, 67390.0, 68330.0, 69364.0, 69405.65297173584, 70017.0, 7711.190325016017, 7797.99813478426, 7804.141544429995, 7867.984821250296, 7882.330001949898, 49146.52560423193, 49470.76323091952, 49892.750536247084, 50128.74935625445, 51150.97698045944, 63361.0, 64992.67503662452, 66937.0, 67273.66363168153, 68109.0, 8400.83198336042, 9312.394694344846, 9885.060919212663, 9976.950115249378, 10181.490925453845, 9959.900400996186, 10800.351978880977, 10920.017198452177, 11042.282251653616, 11547.307161570332, 10336.0, 10345.793084138124, 10477.37135771856, 10556.84164737545, 10631.043206111488, 7312.634368281671, 8939.821203575762, 8970.910290897269, 8990.55047247622, 9173.862392064259, 10158.08577228053, 10542.314749541256, 11106.61126860556, 11531.769364612494, 11890.464929078385, 9474.7019013857, 9562.61749530011, 9826.705198844045, 9916.0, 9934.056264654846, 8003.439759216799, 9547.23431319956, 9811.509424528602, 9819.754506137404, 9940.652077177265], "value": 6881.707145417905, "unit": "score"}], "name": "dromaeo_css", "value": 7635.805813823416, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 157.0, 166.0, 103.0, 172.0, 192.0, 166.0, 113.0, 116.0, 114.0], "value": 142.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 119.0, 145.0, 158.0, 118.0, 137.0, 119.0, 155.0, 152.0, 118.0], "value": 137.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 195.0, 196.0, 199.0, 199.0, 196.0, 200.0, 196.0, 195.0, 194.0], "value": 196.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 73.0, 106.0, 133.0, 69.0, 73.0, 82.0, 86.0, 132.0, 70.0], "value": 88.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 81.0, 124.0, 80.0, 79.0, 94.0, 116.0, 78.0, 80.0, 122.0], "value": 93.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 129.0, 88.0, 85.0, 88.0, 85.0, 97.0, 116.0, 89.0, 85.0], "value": 98.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 111.0, 149.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 93.0], "value": 101.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 92.0, 119.0, 121.0, 91.0, 111.0, 146.0, 140.0, 89.0, 91.0], "value": 109.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 92.0, 62.0, 63.0, 63.0, 63.0, 64.0, 78.0, 61.0, 59.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 69.0, 73.0, 73.0, 71.0, 66.0, 65.0, 66.0], "value": 67.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 103.0, 104.0, 70.0, 91.0, 101.0, 106.0, 103.0, 83.0, 81.0], "value": 92.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 136.0, 113.0, 145.0, 151.0, 142.0, 151.0, 153.0, 164.0, 140.0], "value": 143.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 176.0, 164.0, 164.0, 166.0, 160.0, 175.0, 163.0, 165.0, 159.0], "value": 164.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 87.0, 94.0, 94.0, 97.0, 84.0, 71.0, 68.0, 63.0], "value": 79.5, "unit": "score"}], "name": "kraken", "value": 1579.0999999999997, "alertThreshold": 2.0}]} 08:06:43 INFO - Return code: 0 08:06:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:06:44 ERROR - # TBPL SUCCESS # 08:06:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:06:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:06:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:06:44 INFO - 2016-07-15 08:06:44.047 screenresolution[1699:11715] starting screenresolution argv=screenresolution get 08:06:44 INFO - 2016-07-15 08:06:44.049 screenresolution[1699:11715] Display 0: 1600x1200x32@60 08:06:44 INFO - 2016-07-15 08:06:44.055 screenresolution[1700:11718] starting screenresolution argv=screenresolution list 08:06:44 INFO - Available Modes on Display 0 08:06:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:06:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:06:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:06:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:06:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:06:44 INFO - Intel Iris: 08:06:44 INFO - Chipset Model: Intel Iris 08:06:44 INFO - Type: GPU 08:06:44 INFO - Bus: Built-In 08:06:44 INFO - VRAM (Dynamic, Max): 1536 MB 08:06:44 INFO - Vendor: Intel (0x8086) 08:06:44 INFO - Device ID: 0x0a2e 08:06:44 INFO - Revision ID: 0x0009 08:06:44 INFO - Displays: 08:06:44 INFO - Display: 08:06:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:06:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:06:44 INFO - Display Serial Number: 1600x1200 60 08:06:44 INFO - Main Display: Yes 08:06:44 INFO - Mirror: Off 08:06:44 INFO - Online: Yes 08:06:44 INFO - Rotation: Supported 08:06:44 INFO - Return code: 0 08:06:44 INFO - Running post-action listener: _resource_record_post_action 08:06:44 INFO - Running post-run listener: _resource_record_post_run 08:06:45 INFO - Total resource usage - Wall time: 1192s; CPU: 54.0%; Read bytes: 31718912; Write bytes: 496858624; Read time: 197; Write time: 1547 08:06:45 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 185303552; Write bytes: 186787840; Read time: 16548; Write time: 398 08:06:45 INFO - run-tests - Wall time: 1171s; CPU: 54.0%; Read bytes: 30797312; Write bytes: 300047872; Read time: 186; Write time: 1113 08:06:45 INFO - Running post-run listener: _upload_blobber_files 08:06:45 INFO - Blob upload gear active. 08:06:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:06:45 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 08:06:45 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'] 08:06:45 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 08:06:45 INFO - (blobuploader) - INFO - Open directory for files ... 08:06:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:06:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:06:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:06:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:06:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:06:47 INFO - (blobuploader) - INFO - Done attempting. 08:06:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:06:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:06:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:06:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:06:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:06:47 INFO - (blobuploader) - INFO - Done attempting. 08:06:47 INFO - (blobuploader) - INFO - Iteration through files over. 08:06:47 INFO - Return code: 0 08:06:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:06:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:06:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ac354f215cf4993cad0a9eecd45201a5889ef165cbc570bb3d59974b4745a0c779eccd068c5ded95a67ae20eb506316e460e6a90eda8c2134bc776b36146105d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/72b01fd3aaf817ea4c9f773d9068169c194dbb06a509771c63510c54e11eaf11740d8e2bf5d5258e0670feb730e7bcc45499a51456822273057c0d4b226a13dd"} 08:06:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:06:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:06:47 INFO - Contents: 08:06:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ac354f215cf4993cad0a9eecd45201a5889ef165cbc570bb3d59974b4745a0c779eccd068c5ded95a67ae20eb506316e460e6a90eda8c2134bc776b36146105d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/72b01fd3aaf817ea4c9f773d9068169c194dbb06a509771c63510c54e11eaf11740d8e2bf5d5258e0670feb730e7bcc45499a51456822273057c0d4b226a13dd"} 08:06:47 INFO - Running post-run listener: copy_logs_to_upload_dir 08:06:47 INFO - Copying logs to upload dir... 08:06:47 INFO - mkdir: /builds/slave/test/build/upload/logs 08:06:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.403308 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-15 08:06:48.021684) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 08:06:48.025280) ========= 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.lUB8XKh3fq/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.FA7NbLhR6v/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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/ac354f215cf4993cad0a9eecd45201a5889ef165cbc570bb3d59974b4745a0c779eccd068c5ded95a67ae20eb506316e460e6a90eda8c2134bc776b36146105d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/72b01fd3aaf817ea4c9f773d9068169c194dbb06a509771c63510c54e11eaf11740d8e2bf5d5258e0670feb730e7bcc45499a51456822273057c0d4b226a13dd"} build_url:https://queue.taskcluster.net/v1/task/Hbohv7t2S46VHo5jpoEfHg/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010858 build_url: 'https://queue.taskcluster.net/v1/task/Hbohv7t2S46VHo5jpoEfHg/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/ac354f215cf4993cad0a9eecd45201a5889ef165cbc570bb3d59974b4745a0c779eccd068c5ded95a67ae20eb506316e460e6a90eda8c2134bc776b36146105d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/72b01fd3aaf817ea4c9f773d9068169c194dbb06a509771c63510c54e11eaf11740d8e2bf5d5258e0670feb730e7bcc45499a51456822273057c0d4b226a13dd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 08:06:48.057657) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 08:06:48.057979) ========= 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.lUB8XKh3fq/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.FA7NbLhR6v/Listeners TMPDIR=/var/folders/7d/hhvqsjp50qbbmc1b90zffcn000000w/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.004549 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 08:06:48.105692) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 08:06:48.106012) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 08:06:48.106360) ========= ========= Total master_lag: 0.17 =========