builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0288 starttime: 1467931144.17 results: success (0) buildid: 20160706073358 builduid: 1f733ccafb1b4c028e2bfb2937406a20 revision: 01a1714a1d049ff43ad0fe73d0c81ba5c04fad8d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 15:39:04.165575) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 15:39:04.166108) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 15:39:04.166400) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 15:39:04.191477) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 15:39:04.191812) ========= 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.w7pQa17GnI/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.LkDeL8tmIi/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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-07 15:39:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 170M=0s 2016-07-07 15:39:04 (170 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.542068 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 15:39:04.755836) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 15:39:04.756136) ========= 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.w7pQa17GnI/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.LkDeL8tmIi/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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.026241 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 15:39:04.804452) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-07 15:39:04.804772) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 01a1714a1d049ff43ad0fe73d0c81ba5c04fad8d --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 01a1714a1d049ff43ad0fe73d0c81ba5c04fad8d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.w7pQa17GnI/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.LkDeL8tmIi/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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-07 15:39:04,889 truncating revision to first 12 chars 2016-07-07 15:39:04,889 Setting DEBUG logging. 2016-07-07 15:39:04,889 attempt 1/10 2016-07-07 15:39:04,889 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/01a1714a1d04?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 15:39:07,181 unpacking tar archive at: mozilla-beta-01a1714a1d04/testing/mozharness/ program finished with exit code 0 elapsedTime=2.545255 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-07 15:39:07.372257) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 15:39:07.372581) ========= script_repo_revision: 01a1714a1d049ff43ad0fe73d0c81ba5c04fad8d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 15:39:07.372979) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 15:39:07.373261) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 15:39:07.393678) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-07 15:39:07.394038) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.w7pQa17GnI/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.LkDeL8tmIi/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 15:39:07 INFO - MultiFileLogger online at 20160707 15:39:07 in /builds/slave/test 15:39:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:39:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:39:07 INFO - {'append_to_log': False, 15:39:07 INFO - 'base_work_dir': '/builds/slave/test', 15:39:07 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:39:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:39:07 INFO - 'branch': 'Mozilla-Beta', 15:39:07 INFO - 'buildbot_json_path': 'buildprops.json', 15:39:07 INFO - 'config_files': ('talos/mac_config.py',), 15:39:07 INFO - 'default_actions': ('clobber', 15:39:07 INFO - 'read-buildbot-config', 15:39:07 INFO - 'download-and-extract', 15:39:07 INFO - 'populate-webroot', 15:39:07 INFO - 'create-virtualenv', 15:39:07 INFO - 'install', 15:39:07 INFO - 'run-tests'), 15:39:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:39:07 INFO - 'download_minidump_stackwalk': True, 15:39:07 INFO - 'download_symbols': 'ondemand', 15:39:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:39:07 INFO - 'tooltool.py': '/tools/tooltool.py', 15:39:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:39:07 INFO - '/tools/misc-python/virtualenv.py')}, 15:39:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:39:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:39:07 INFO - 'installer_path': 'installer.exe', 15:39:07 INFO - 'log_level': 'info', 15:39:07 INFO - 'log_name': 'talos', 15:39:07 INFO - 'log_to_console': True, 15:39:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:39:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:39:07 INFO - 'opt_config_files': (), 15:39:07 INFO - 'pip_index': False, 15:39:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:39:07 INFO - 'cmd': ('bash', 15:39:07 INFO - '-c', 15:39:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:39:07 INFO - 'enabled': True, 15:39:07 INFO - 'halt_on_failure': False, 15:39:07 INFO - 'name': 'check_screen_resolution'},), 15:39:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:39:07 INFO - 'cmd': ('bash', 15:39:07 INFO - '-c', 15:39:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:39:07 INFO - 'enabled': True, 15:39:07 INFO - 'halt_on_failure': False, 15:39:07 INFO - 'name': 'check_screen_resolution'},), 15:39:07 INFO - 'run_cmd_checks_enabled': True, 15:39:07 INFO - 'sps_profile': False, 15:39:07 INFO - 'sps_profile_interval': 0, 15:39:07 INFO - 'suite': 'dromaeojs', 15:39:07 INFO - 'system_bits': '32', 15:39:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:39:07 INFO - 'title': 't-yosemite-r7-0288', 15:39:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:39:07 INFO - 'use_talos_json': True, 15:39:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:39:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:39:07 INFO - 'work_dir': 'build'} 15:39:07 INFO - ##### 15:39:07 INFO - ##### Running clobber step. 15:39:07 INFO - ##### 15:39:07 INFO - Running pre-action listener: _resource_record_pre_action 15:39:07 INFO - Running main action method: clobber 15:39:07 INFO - rmtree: /builds/slave/test/build 15:39:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:39:09 INFO - Running post-action listener: _resource_record_post_action 15:39:09 INFO - ##### 15:39:09 INFO - ##### Running read-buildbot-config step. 15:39:09 INFO - ##### 15:39:09 INFO - Running pre-action listener: _resource_record_pre_action 15:39:09 INFO - Running main action method: read_buildbot_config 15:39:09 INFO - Using buildbot properties: 15:39:09 INFO - { 15:39:09 INFO - "project": "", 15:39:09 INFO - "product": "firefox", 15:39:09 INFO - "script_repo_revision": "production", 15:39:09 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 15:39:09 INFO - "repository": "", 15:39:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 15:39:09 INFO - "buildid": "20160706073358", 15:39:09 INFO - "pgo_build": "False", 15:39:09 INFO - "basedir": "/builds/slave/test", 15:39:09 INFO - "buildnumber": 23, 15:39:09 INFO - "slavename": "t-yosemite-r7-0288", 15:39:09 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 15:39:09 INFO - "platform": "yosemite_r7", 15:39:09 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 15:39:09 INFO - "branch": "mozilla-beta", 15:39:09 INFO - "repo_path": "releases/mozilla-beta", 15:39:09 INFO - "revision": "01a1714a1d049ff43ad0fe73d0c81ba5c04fad8d", 15:39:09 INFO - "stage_platform": "macosx64", 15:39:09 INFO - "builduid": "1f733ccafb1b4c028e2bfb2937406a20", 15:39:09 INFO - "slavebuilddir": "test" 15:39:09 INFO - } 15:39:09 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.dmg. 15:39:09 INFO - Running post-action listener: _resource_record_post_action 15:39:09 INFO - ##### 15:39:09 INFO - ##### Running download-and-extract step. 15:39:09 INFO - ##### 15:39:09 INFO - Running pre-action listener: _resource_record_pre_action 15:39:09 INFO - Running main action method: download_and_extract 15:39:09 INFO - mkdir: /builds/slave/test/build/tests 15:39:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:39:09 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.test_packages.json 15:39:09 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 15:39:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/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 15:39:09 INFO - Downloaded 1165 bytes. 15:39:09 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 15:39:09 INFO - Using the following test package requirements: 15:39:09 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 15:39:09 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:39:09 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 15:39:09 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:39:09 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 15:39:09 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 15:39:09 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:39:09 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 15:39:09 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 15:39:09 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:39:09 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 15:39:09 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:39:09 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 15:39:09 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:39:09 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 15:39:09 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:39:09 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 15:39:09 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 15:39:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:39:09 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.common.tests.zip 15:39:09 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 15:39:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/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 15:39:11 INFO - Downloaded 18351403 bytes. 15:39:11 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'] 15:39:11 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 15:39:14 INFO - Return code: 0 15:39:14 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 15:39:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:14 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.common.tests.zip 15:39:14 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 15:39:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/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 15:39:14 INFO - Downloaded 18351403 bytes. 15:39:14 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'] 15:39:14 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 15:39:18 INFO - Return code: 0 15:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:39:18 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.talos.tests.zip 15:39:18 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 15:39:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/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 15:39:20 INFO - Downloaded 10840145 bytes. 15:39:20 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'] 15:39:20 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 15:39:20 INFO - Return code: 0 15:39: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')]} 15:39:20 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.dmg 15:39:20 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 15:39:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 15:39:23 INFO - Downloaded 86190842 bytes. 15:39:23 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.dmg 15:39:23 INFO - mkdir: /builds/slave/test/properties 15:39:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:39:23 INFO - Writing to file /builds/slave/test/properties/build_url 15:39:23 INFO - Contents: 15:39:23 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.dmg 15:39:24 INFO - Running post-action listener: _resource_record_post_action 15:39:24 INFO - Running post-action listener: set_extra_try_arguments 15:39:24 INFO - ##### 15:39:24 INFO - ##### Running populate-webroot step. 15:39:24 INFO - ##### 15:39:24 INFO - Running pre-action listener: _resource_record_pre_action 15:39:24 INFO - Running main action method: populate_webroot 15:39:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:39:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:39:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:39:24 INFO - '--tppagecycles', 15:39:24 INFO - '7'], 15:39:24 INFO - 'tests': ['tsvgm']}}, 15:39:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:39:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:39:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:39:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:39:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:24 INFO - 'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:39:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:39:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:24 INFO - 'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['damp', 'tps']}, 15:39:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:24 INFO - 'tests': ['damp', 'tps']}, 15:39:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['dromaeo_dom']}, 15:39:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:39:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['a11yr', 15:39:24 INFO - 'ts_paint', 15:39:24 INFO - 'tpaint', 15:39:24 INFO - 'sessionrestore', 15:39:24 INFO - 'sessionrestore_no_auto_restore', 15:39:24 INFO - 'tabpaint']}, 15:39:24 INFO - 'other-e10s': {'tests': ['a11yr', 15:39:24 INFO - 'ts_paint', 15:39:24 INFO - 'tpaint', 15:39:24 INFO - 'sessionrestore', 15:39:24 INFO - 'sessionrestore_no_auto_restore', 15:39:24 INFO - 'tabpaint']}, 15:39:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:39:24 INFO - 'ts_paint', 15:39:24 INFO - 'tpaint', 15:39:24 INFO - 'sessionrestore', 15:39:24 INFO - 'sessionrestore_no_auto_restore', 15:39:24 INFO - 'tabpaint']}, 15:39:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:39:24 INFO - 'ts_paint', 15:39:24 INFO - 'tpaint', 15:39:24 INFO - 'sessionrestore', 15:39:24 INFO - 'sessionrestore_no_auto_restore', 15:39:24 INFO - 'tabpaint']}, 15:39:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['a11yr', 15:39:24 INFO - 'ts_paint', 15:39:24 INFO - 'tpaint', 15:39:24 INFO - 'sessionrestore', 15:39:24 INFO - 'sessionrestore_no_auto_restore', 15:39:24 INFO - 'tabpaint']}, 15:39:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['a11yr', 15:39:24 INFO - 'ts_paint', 15:39:24 INFO - 'tpaint', 15:39:24 INFO - 'sessionrestore', 15:39:24 INFO - 'sessionrestore_no_auto_restore', 15:39:24 INFO - 'tabpaint']}, 15:39:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['tsvgx', 15:39:24 INFO - 'tsvgr_opacity', 15:39:24 INFO - 'tart', 15:39:24 INFO - 'tscrollx', 15:39:24 INFO - 'cart']}, 15:39:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:39:24 INFO - 'tsvgr_opacity', 15:39:24 INFO - 'tart', 15:39:24 INFO - 'tscrollx', 15:39:24 INFO - 'cart']}, 15:39:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:24 INFO - 'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['tp5o']}, 15:39:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:24 INFO - 'tests': ['tp5o']}, 15:39:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:24 INFO - 'talos_options': ['--disable-e10s', 15:39:24 INFO - '--xperf_path', 15:39:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:39:24 INFO - 'tests': ['tp5n']}, 15:39:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:24 INFO - 'talos_options': ['--xperf_path', 15:39:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:39:24 INFO - 'tests': ['tp5n']}}, 15:39:24 INFO - 'talos.zip': {'path': '', 15:39:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:39:24 INFO - Running post-action listener: _resource_record_post_action 15:39:24 INFO - ##### 15:39:24 INFO - ##### Running create-virtualenv step. 15:39:24 INFO - ##### 15:39:24 INFO - Running pre-action listener: _resource_record_pre_action 15:39:24 INFO - Running main action method: create_virtualenv 15:39:24 INFO - Creating virtualenv /builds/slave/test/build/venv 15:39:24 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 15:39:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:39:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:39:24 INFO - Using real prefix '/tools/python27' 15:39:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:39:25 INFO - Installing distribute.............................................................................................................................................................................................done. 15:39:28 INFO - Installing pip.................done. 15:39:28 INFO - Return code: 0 15:39:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:39: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')]} 15:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39: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')]} 15:39:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ec54a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec64420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc3a4a0fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eaf3e00>, '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 0x10e95cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eaeeb20>, '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.w7pQa17GnI/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.LkDeL8tmIi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 15:39: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', 'pip>=1.5'] in /builds/slave/test/build 15:39: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 pip>=1.5 15:39:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w7pQa17GnI/Render', 15:39:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:39:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:39:28 INFO - 'HOME': '/Users/cltbld', 15:39:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:39:28 INFO - 'LOGNAME': 'cltbld', 15:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:28 INFO - 'MOZ_NO_REMOTE': '1', 15:39:28 INFO - 'NO_EM_RESTART': '1', 15:39:28 INFO - 'PAGER': '/bin/cat', 15:39:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:28 INFO - 'PWD': '/builds/slave/test', 15:39:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:39:28 INFO - 'SHELL': '/bin/bash', 15:39:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LkDeL8tmIi/Listeners', 15:39:28 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 15:39:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:39:28 INFO - 'USER': 'cltbld', 15:39:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:39:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:28 INFO - 'XPC_FLAGS': '0x0', 15:39:28 INFO - 'XPC_SERVICE_NAME': '0', 15:39:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:28 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 15:39:28 INFO - Cleaning up... 15:39:28 INFO - Return code: 0 15:39:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:39: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')]} 15:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39: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')]} 15:39:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39: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', '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 0x10ec54a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec64420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc3a4a0fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eaf3e00>, '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 0x10e95cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eaeeb20>, '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.w7pQa17GnI/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.LkDeL8tmIi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 15:39: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', 'psutil>=0.7.1'] in /builds/slave/test/build 15:39: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 psutil>=0.7.1 15:39:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w7pQa17GnI/Render', 15:39:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:39:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:39:28 INFO - 'HOME': '/Users/cltbld', 15:39:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:39:28 INFO - 'LOGNAME': 'cltbld', 15:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:28 INFO - 'MOZ_NO_REMOTE': '1', 15:39:28 INFO - 'NO_EM_RESTART': '1', 15:39:28 INFO - 'PAGER': '/bin/cat', 15:39:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:28 INFO - 'PWD': '/builds/slave/test', 15:39:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:39:28 INFO - 'SHELL': '/bin/bash', 15:39:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LkDeL8tmIi/Listeners', 15:39:28 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 15:39:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:39:28 INFO - 'USER': 'cltbld', 15:39:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:39:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:28 INFO - 'XPC_FLAGS': '0x0', 15:39:28 INFO - 'XPC_SERVICE_NAME': '0', 15:39:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:28 INFO - Downloading/unpacking psutil>=0.7.1 15:39: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 15:39: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 15:39: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 15:39: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 15:39: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 15:39: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 15:39:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:39:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:39:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:39:32 INFO - Installing collected packages: psutil 15:39:32 INFO - Running setup.py install for psutil 15:39:32 INFO - building 'psutil._psutil_osx' extension 15:39:32 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 15:39:33 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 15:39:33 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 15:39:33 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 15:39:33 INFO - building 'psutil._psutil_posix' extension 15:39:33 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 15:39:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:39:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:39:33 INFO - ^ 15:39:33 INFO - 1 warning generated. 15:39:33 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 15:39:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:39:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:39:33 INFO - Successfully installed psutil 15:39:33 INFO - Cleaning up... 15:39:33 INFO - Return code: 0 15:39:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:39: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')]} 15:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39: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')]} 15:39:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ec54a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec64420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc3a4a0fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eaf3e00>, '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 0x10e95cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eaeeb20>, '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.w7pQa17GnI/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.LkDeL8tmIi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 15:39:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:39:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:39:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w7pQa17GnI/Render', 15:39:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:39:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:39:33 INFO - 'HOME': '/Users/cltbld', 15:39:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:39:33 INFO - 'LOGNAME': 'cltbld', 15:39:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:33 INFO - 'MOZ_NO_REMOTE': '1', 15:39:33 INFO - 'NO_EM_RESTART': '1', 15:39:33 INFO - 'PAGER': '/bin/cat', 15:39:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:39:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:33 INFO - 'PWD': '/builds/slave/test', 15:39:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:39:33 INFO - 'SHELL': '/bin/bash', 15:39:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LkDeL8tmIi/Listeners', 15:39:33 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 15:39:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:39:33 INFO - 'USER': 'cltbld', 15:39:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:39:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:39:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:33 INFO - 'XPC_FLAGS': '0x0', 15:39:33 INFO - 'XPC_SERVICE_NAME': '0', 15:39:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:39:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:39:34 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 15:39:34 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 15:39:34 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 15:39:34 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 15:39:34 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 15:39:34 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 15:39:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:39:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:39:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:39:36 INFO - Installing collected packages: mozsystemmonitor 15:39:36 INFO - Running setup.py install for mozsystemmonitor 15:39:36 INFO - Successfully installed mozsystemmonitor 15:39:36 INFO - Cleaning up... 15:39:36 INFO - Return code: 0 15:39:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:39:36 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')]} 15:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:36 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')]} 15:39:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:36 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 0x10ec54a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec64420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc3a4a0fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eaf3e00>, '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 0x10e95cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eaeeb20>, '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.w7pQa17GnI/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.LkDeL8tmIi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 15:39:36 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 15:39:36 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 15:39:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w7pQa17GnI/Render', 15:39:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:39:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:39:36 INFO - 'HOME': '/Users/cltbld', 15:39:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:39:36 INFO - 'LOGNAME': 'cltbld', 15:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:36 INFO - 'MOZ_NO_REMOTE': '1', 15:39:36 INFO - 'NO_EM_RESTART': '1', 15:39:36 INFO - 'PAGER': '/bin/cat', 15:39:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:36 INFO - 'PWD': '/builds/slave/test', 15:39:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:39:36 INFO - 'SHELL': '/bin/bash', 15:39:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LkDeL8tmIi/Listeners', 15:39:36 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 15:39:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:39:36 INFO - 'USER': 'cltbld', 15:39:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:39:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:36 INFO - 'XPC_FLAGS': '0x0', 15:39:36 INFO - 'XPC_SERVICE_NAME': '0', 15:39:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:39:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:37 INFO - Downloading/unpacking blobuploader==1.2.4 15:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:39 INFO - Downloading blobuploader-1.2.4.tar.gz 15:39:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:39:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:39:39 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 15:39:39 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 15:39:39 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 15:39:39 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 15:39:39 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 15:39:39 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 15:39:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:39:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:39: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 15:39: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 15:39: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 15:39: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 15:39: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 15:39: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 15:39:40 INFO - Downloading docopt-0.6.1.tar.gz 15:39:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:39:41 INFO - Installing collected packages: blobuploader, requests, docopt 15:39:41 INFO - Running setup.py install for blobuploader 15:39:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:39:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:39:41 INFO - Running setup.py install for requests 15:39:41 INFO - Running setup.py install for docopt 15:39:41 INFO - Successfully installed blobuploader requests docopt 15:39:41 INFO - Cleaning up... 15:39:41 INFO - Return code: 0 15:39:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:39:41 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')]} 15:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:41 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')]} 15:39:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:41 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 0x10ec54a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec64420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc3a4a0fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eaf3e00>, '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 0x10e95cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eaeeb20>, '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.w7pQa17GnI/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.LkDeL8tmIi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 15:39:41 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 15:39:41 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 15:39:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w7pQa17GnI/Render', 15:39:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:39:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:39:41 INFO - 'HOME': '/Users/cltbld', 15:39:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:39:41 INFO - 'LOGNAME': 'cltbld', 15:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:41 INFO - 'MOZ_NO_REMOTE': '1', 15:39:41 INFO - 'NO_EM_RESTART': '1', 15:39:41 INFO - 'PAGER': '/bin/cat', 15:39:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:41 INFO - 'PWD': '/builds/slave/test', 15:39:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:39:41 INFO - 'SHELL': '/bin/bash', 15:39:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LkDeL8tmIi/Listeners', 15:39:41 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 15:39:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:39:41 INFO - 'USER': 'cltbld', 15:39:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:39:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:41 INFO - 'XPC_FLAGS': '0x0', 15:39:41 INFO - 'XPC_SERVICE_NAME': '0', 15:39:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:39:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:39:42 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-Gg_oAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:39:42 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-X3Eo85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:39:42 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-ux2JIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:39:42 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-mMXGVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:39:42 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-j6BAC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:39:42 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-p8qRFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:39:42 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-McbhSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:39:42 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-rpb8_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:39:42 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-3D8BJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:39:43 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-gyD2gT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:39:43 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-3caviK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:39:43 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-5dmJSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:39:43 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-R4E8ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:39:43 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-3m1X5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:39:43 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-ni23fx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:39:43 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-xtlVuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:39:43 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-7YrJZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:39:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:39:43 INFO - Running setup.py install for manifestparser 15:39:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:39:44 INFO - Running setup.py install for mozcrash 15:39:44 INFO - Running setup.py install for mozdebug 15:39:44 INFO - Running setup.py install for mozdevice 15:39:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:39:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:39:44 INFO - Running setup.py install for mozfile 15:39:44 INFO - Running setup.py install for mozhttpd 15:39:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:39:44 INFO - Running setup.py install for mozinfo 15:39:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:39:45 INFO - Running setup.py install for mozInstall 15:39:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:39:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:39:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:39:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:39:45 INFO - Running setup.py install for mozleak 15:39:45 INFO - Running setup.py install for mozlog 15:39:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:39:45 INFO - Running setup.py install for moznetwork 15:39:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:39:45 INFO - Running setup.py install for mozprocess 15:39:45 INFO - Running setup.py install for mozprofile 15:39:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:39:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:39:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:39:45 INFO - Running setup.py install for mozrunner 15:39:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:39:46 INFO - Running setup.py install for mozscreenshot 15:39:46 INFO - Running setup.py install for moztest 15:39:46 INFO - Running setup.py install for mozversion 15:39:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:39:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:39:46 INFO - Cleaning up... 15:39:46 INFO - Return code: 0 15:39:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:39: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')]} 15:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39: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')]} 15:39:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:46 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 0x10ec54a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec64420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc3a4a0fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eaf3e00>, '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 0x10e95cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eaeeb20>, '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.w7pQa17GnI/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.LkDeL8tmIi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 15:39:46 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 15:39:46 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 15:39:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w7pQa17GnI/Render', 15:39:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:39:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:39:46 INFO - 'HOME': '/Users/cltbld', 15:39:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:39:46 INFO - 'LOGNAME': 'cltbld', 15:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:46 INFO - 'MOZ_NO_REMOTE': '1', 15:39:46 INFO - 'NO_EM_RESTART': '1', 15:39:46 INFO - 'PAGER': '/bin/cat', 15:39:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:46 INFO - 'PWD': '/builds/slave/test', 15:39:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:39:46 INFO - 'SHELL': '/bin/bash', 15:39:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LkDeL8tmIi/Listeners', 15:39:46 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 15:39:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:39:46 INFO - 'USER': 'cltbld', 15:39:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:39:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:46 INFO - 'XPC_FLAGS': '0x0', 15:39:46 INFO - 'XPC_SERVICE_NAME': '0', 15:39:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:39:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:39:46 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-uFf2p5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:39:46 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)) 15:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:39:46 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-_wNa3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:39:47 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)) 15:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:39:47 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-ywkNCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:39:47 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)) 15:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:39:47 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-Uh58JH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:39:47 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)) 15:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:39:47 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-S73r2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:39:47 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)) 15:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:39:47 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-GDVIAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:39:47 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)) 15:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:39:47 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-cDGmYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:39:47 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)) 15:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:39:47 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-5WPMPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:39:47 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)) 15:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:39:47 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-09IOGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:39:47 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)) 15:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:39:47 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-slPDeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:39:47 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)) 15:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:39:47 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-5LL1E0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:39:48 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)) 15:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:39:48 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-N00ujB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:39:48 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)) 15:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:39:48 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-pPFOi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:39:48 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)) 15:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:39:48 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-_dUCY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:39:48 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)) 15:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:39:48 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-31tMID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:39:48 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)) 15:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:39:48 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-og1r7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:39:48 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)) 15:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:39:48 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-nMxfzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:39:48 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)) 15:39:48 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)) 15:39:48 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)) 15:39:48 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)) 15:39:48 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)) 15:39:48 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)) 15:39:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:39:48 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 15:39:48 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 15:39:48 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 15:39:48 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 15:39:48 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 15:39:48 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 15:39:51 INFO - Downloading blessings-1.6.tar.gz 15:39:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:39:51 INFO - Installing collected packages: blessings 15:39:51 INFO - Running setup.py install for blessings 15:39:51 INFO - Successfully installed blessings 15:39:51 INFO - Cleaning up... 15:39:51 INFO - Return code: 0 15:39:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:39:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:39:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:39:51 INFO - Reading from file tmpfile_stdout 15:39:51 INFO - Current package versions: 15:39:51 INFO - blessings == 1.6 15:39:51 INFO - blobuploader == 1.2.4 15:39:51 INFO - docopt == 0.6.1 15:39:51 INFO - manifestparser == 1.1 15:39:51 INFO - mozInstall == 1.12 15:39:51 INFO - mozcrash == 0.17 15:39:51 INFO - mozdebug == 0.1 15:39:51 INFO - mozdevice == 0.48 15:39:51 INFO - mozfile == 1.2 15:39:51 INFO - mozhttpd == 0.7 15:39:51 INFO - mozinfo == 0.9 15:39:51 INFO - mozleak == 0.1 15:39:51 INFO - mozlog == 3.1 15:39:51 INFO - moznetwork == 0.27 15:39:51 INFO - mozprocess == 0.22 15:39:51 INFO - mozprofile == 0.28 15:39:51 INFO - mozrunner == 6.11 15:39:51 INFO - mozscreenshot == 0.1 15:39:51 INFO - mozsystemmonitor == 0.0 15:39:51 INFO - moztest == 0.7 15:39:51 INFO - mozversion == 1.4 15:39:51 INFO - psutil == 3.1.1 15:39:51 INFO - requests == 1.2.3 15:39:51 INFO - wsgiref == 0.1.2 15:39:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:51 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 0x10ec54a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec64420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc3a4a0fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eaf3e00>, '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 0x10e95cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eaeeb20>, '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.w7pQa17GnI/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.LkDeL8tmIi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 15:39:51 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 15:39:51 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 15:39:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w7pQa17GnI/Render', 15:39:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:39:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:39:51 INFO - 'HOME': '/Users/cltbld', 15:39:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:39:51 INFO - 'LOGNAME': 'cltbld', 15:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:51 INFO - 'MOZ_NO_REMOTE': '1', 15:39:51 INFO - 'NO_EM_RESTART': '1', 15:39:51 INFO - 'PAGER': '/bin/cat', 15:39:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:51 INFO - 'PWD': '/builds/slave/test', 15:39:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:39:51 INFO - 'SHELL': '/bin/bash', 15:39:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LkDeL8tmIi/Listeners', 15:39:51 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 15:39:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:39:51 INFO - 'USER': 'cltbld', 15:39:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:39:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:51 INFO - 'XPC_FLAGS': '0x0', 15:39:51 INFO - 'XPC_SERVICE_NAME': '0', 15:39:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:39:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:51 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)) 15:39:51 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)) 15:39:51 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)) 15:39:51 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)) 15:39:51 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)) 15:39:51 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)) 15:39:51 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)) 15:39:51 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)) 15:39:51 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)) 15:39:51 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)) 15:39:51 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)) 15:39:51 INFO - Cleaning up... 15:39:52 INFO - Return code: 0 15:39:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:39:52 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')]} 15:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:52 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')]} 15:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:52 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 0x10ec54a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec64420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc3a4a0fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eaf3e00>, '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 0x10e95cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eaeeb20>, '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.w7pQa17GnI/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.LkDeL8tmIi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 15:39:52 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 15:39:52 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 15:39:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w7pQa17GnI/Render', 15:39:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:39:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:39:52 INFO - 'HOME': '/Users/cltbld', 15:39:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:39:52 INFO - 'LOGNAME': 'cltbld', 15:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:52 INFO - 'MOZ_NO_REMOTE': '1', 15:39:52 INFO - 'NO_EM_RESTART': '1', 15:39:52 INFO - 'PAGER': '/bin/cat', 15:39:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:52 INFO - 'PWD': '/builds/slave/test', 15:39:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:39:52 INFO - 'SHELL': '/bin/bash', 15:39:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LkDeL8tmIi/Listeners', 15:39:52 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 15:39:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:39:52 INFO - 'USER': 'cltbld', 15:39:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:39:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:52 INFO - 'XPC_FLAGS': '0x0', 15:39:52 INFO - 'XPC_SERVICE_NAME': '0', 15:39:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:52 INFO - Downloading/unpacking jsonschema 15:39:52 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 15:39:52 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 15:39:52 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 15:39:52 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 15:39:52 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 15:39:52 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 15:39:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:39:54 INFO - Downloading/unpacking functools32 (from jsonschema) 15:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:55 INFO - Downloading functools32-3.2.3-2.tar.gz 15:39:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:39:55 INFO - warning: no files found matching '*.txt' 15:39:55 INFO - no previously-included directories found matching 'build' 15:39:55 INFO - no previously-included directories found matching 'dist' 15:39:55 INFO - no previously-included directories found matching '.git*' 15:39:55 INFO - Installing collected packages: jsonschema, functools32 15:39:55 INFO - Running setup.py install for functools32 15:39:55 INFO - warning: no files found matching '*.txt' 15:39:55 INFO - no previously-included directories found matching 'build' 15:39:55 INFO - no previously-included directories found matching 'dist' 15:39:55 INFO - no previously-included directories found matching '.git*' 15:39:55 INFO - Successfully installed jsonschema functools32 15:39:55 INFO - Cleaning up... 15:39:55 INFO - Return code: 0 15:39:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:39:55 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')]} 15:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:55 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')]} 15:39:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:55 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 0x10ec54a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec64420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc3a4a0fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eaf3e00>, '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 0x10e95cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eaeeb20>, '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.w7pQa17GnI/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.LkDeL8tmIi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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 15:39:55 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 15:39:55 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 15:39:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w7pQa17GnI/Render', 15:39:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:39:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:39:55 INFO - 'HOME': '/Users/cltbld', 15:39:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:39:55 INFO - 'LOGNAME': 'cltbld', 15:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:55 INFO - 'MOZ_NO_REMOTE': '1', 15:39:55 INFO - 'NO_EM_RESTART': '1', 15:39:55 INFO - 'PAGER': '/bin/cat', 15:39:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:55 INFO - 'PWD': '/builds/slave/test', 15:39:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:39:55 INFO - 'SHELL': '/bin/bash', 15:39:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LkDeL8tmIi/Listeners', 15:39:55 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 15:39:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:39:55 INFO - 'USER': 'cltbld', 15:39:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:39:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:55 INFO - 'XPC_FLAGS': '0x0', 15:39:55 INFO - 'XPC_SERVICE_NAME': '0', 15:39:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:55 INFO - Downloading/unpacking flake8 15:39:55 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 15:39:55 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 15:39:55 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 15:39:55 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 15:39:55 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 15:39:55 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 15:39:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:39:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:39:58 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 15:39:58 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 15:39:58 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 15:39:58 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 15:39:58 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 15:39:58 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 15:39:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:39:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:39:58 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 15:39:58 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 15:39:58 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 15:39:58 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 15:39:58 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 15:39:58 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 15:39:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:39:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:39:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:39:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:39:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:39:59 INFO - no previously-included directories found matching 'docs/_build' 15:39:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:39:59 INFO - Running setup.py install for pep8 15:39:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:39:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:39:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:39:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:39:59 INFO - no previously-included directories found matching 'docs/_build' 15:39:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:39:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:39:59 INFO - Cleaning up... 15:39:59 INFO - Return code: 0 15:39:59 INFO - Running post-action listener: _resource_record_post_action 15:39:59 INFO - Running post-action listener: _start_resource_monitoring 15:39:59 INFO - Starting resource monitoring. 15:39:59 INFO - ##### 15:39:59 INFO - ##### Running install step. 15:39:59 INFO - ##### 15:39:59 INFO - Running pre-action listener: _resource_record_pre_action 15:39:59 INFO - Running main action method: install 15:39:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:39:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:40:00 INFO - Reading from file tmpfile_stdout 15:40:00 INFO - Detecting whether we're running mozinstall >=1.0... 15:40:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:40:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:40:00 INFO - Reading from file tmpfile_stdout 15:40:00 INFO - Output received: 15:40:00 INFO - Usage: mozinstall [options] installer 15:40:00 INFO - Options: 15:40:00 INFO - -h, --help show this help message and exit 15:40:00 INFO - -d DEST, --destination=DEST 15:40:00 INFO - Directory to install application into. [default: 15:40:00 INFO - "/builds/slave/test"] 15:40:00 INFO - --app=APP Application being installed. [default: firefox] 15:40:00 INFO - mkdir: /builds/slave/test/build/application 15:40:00 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'] 15:40:00 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 15:40:22 INFO - Reading from file tmpfile_stdout 15:40:22 INFO - Output received: 15:40:22 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 15:40:22 INFO - Running post-action listener: _resource_record_post_action 15:40:22 INFO - ##### 15:40:22 INFO - ##### Running run-tests step. 15:40:22 INFO - ##### 15:40:22 INFO - Running pre-action listener: _resource_record_pre_action 15:40:22 INFO - Running main action method: run_tests 15:40:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:40:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:40:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:40:22 INFO - 2016-07-07 15:40:22.825 screenresolution[1654:8077] starting screenresolution argv=screenresolution get 15:40:22 INFO - 2016-07-07 15:40:22.828 screenresolution[1654:8077] Display 0: 1600x1200x32@60 15:40:22 INFO - 2016-07-07 15:40:22.833 screenresolution[1655:8080] starting screenresolution argv=screenresolution list 15:40:22 INFO - Available Modes on Display 0 15:40:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:40:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:40:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:40:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:40:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:40:23 INFO - Intel Iris: 15:40:23 INFO - Chipset Model: Intel Iris 15:40:23 INFO - Type: GPU 15:40:23 INFO - Bus: Built-In 15:40:23 INFO - VRAM (Dynamic, Max): 1536 MB 15:40:23 INFO - Vendor: Intel (0x8086) 15:40:23 INFO - Device ID: 0x0a2e 15:40:23 INFO - Revision ID: 0x0009 15:40:23 INFO - Displays: 15:40:23 INFO - Display: 15:40:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:40:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:40:23 INFO - Display Serial Number: 1600x1200 60 15:40:23 INFO - Main Display: Yes 15:40:23 INFO - Mirror: Off 15:40:23 INFO - Online: Yes 15:40:23 INFO - Rotation: Supported 15:40:23 INFO - Return code: 0 15:40:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:40:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:40:23 INFO - Python 2.7.3 15:40:23 INFO - Return code: 0 15:40:23 INFO - grabbing minidump binary from tooltool 15:40:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:40:23 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 0x10eaf3e00>, '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 0x10e95cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10eaeeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:40:23 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 15:40:23 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 15:40:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:40:23 INFO - Return code: 0 15:40:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:40:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:40:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:40:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:40:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:40:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:40:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:40:24 INFO - Return code: 0 15:40:24 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', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0288', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:40:24 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 --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0288 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:40:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.w7pQa17GnI/Render', 15:40:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:40:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:40:24 INFO - 'HOME': '/Users/cltbld', 15:40:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:40:24 INFO - 'LOGNAME': 'cltbld', 15:40:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:40:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:40:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:24 INFO - 'MOZ_NO_REMOTE': '1', 15:40:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:40:24 INFO - 'NO_EM_RESTART': '1', 15:40:24 INFO - 'PAGER': '/bin/cat', 15:40:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:40:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:24 INFO - 'PWD': '/builds/slave/test', 15:40:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:40:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:40:24 INFO - 'SHELL': '/bin/bash', 15:40:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LkDeL8tmIi/Listeners', 15:40:24 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 15:40:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:40:24 INFO - 'USER': 'cltbld', 15:40:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:40:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:40:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:24 INFO - 'XPC_FLAGS': '0x0', 15:40:24 INFO - 'XPC_SERVICE_NAME': '0', 15:40:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:40:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0288', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:40:24 INFO - mozversion application_buildid: 20160706073358 15:40:24 INFO - mozversion application_changeset: 01a1714a1d049ff43ad0fe73d0c81ba5c04fad8d 15:40:24 INFO - mozversion application_display_name: Firefox 15:40:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:40:24 INFO - mozversion application_name: Firefox 15:40:24 INFO - mozversion application_remotingname: firefox 15:40:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:40:24 INFO - mozversion application_vendor: Mozilla 15:40:24 INFO - mozversion application_version: 48.0 15:40:24 INFO - mozversion platform_buildid: 20160706073358 15:40:24 INFO - mozversion platform_changeset: 01a1714a1d049ff43ad0fe73d0c81ba5c04fad8d 15:40:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:40:24 INFO - mozversion platform_version: 48.0 15:40:24 INFO - using testdate: 1467931224 15:40:24 INFO - actual date: 1467931224 15:40:24 INFO - starting webserver on 'localhost:49270' 15:40:24 INFO - SUITE-START | Running 2 tests 15:40:24 INFO - TEST-START | dromaeo_css 15:40:24 INFO - operating with platform_type : mac_ 15:40:24 INFO - Initialising browser for dromaeo_css test... 15:40:24 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/tmpMLyGWU/profile http://localhost:49270/getInfo.html) 15:40:26 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 15:40:26 INFO - PROCESS | 1673 | colorDepth:24 15:40:26 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 15:40:26 INFO - PROCESS | 1673 | __metrics 15:40:26 INFO - PROCESS | 1673 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:40:26 ERROR - PROCESS | 1673 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:40:27 INFO - TEST-INFO | 1673: exit 0 15:40:27 INFO - Browser initialized. 15:40:27 INFO - Running cycle 1/1 for dromaeo_css test... 15:40:27 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/tmpMLyGWU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:40:39 INFO - PROCESS | 1677 | RSS: Main: 161804288 15:40:39 INFO - PROCESS | 1677 | 15:41:30 INFO - PROCESS | 1677 | 1467931290716 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] 15:43:40 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 15:43:42 INFO - PROCESS | 1677 | RSS: Main: 297889792 15:43:42 INFO - PROCESS | 1677 | 15:46:45 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 15:46:45 INFO - PROCESS | 1677 | RSS: Main: 304283648 15:46:45 INFO - PROCESS | 1677 | 15:49:47 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 15:49:48 INFO - PROCESS | 1677 | RSS: Main: 313200640 15:49:48 INFO - PROCESS | 1677 | 15:52:50 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 15:52:51 INFO - PROCESS | 1677 | RSS: Main: 312778752 15:52:51 INFO - PROCESS | 1677 | 15:55:54 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 15:55:54 INFO - PROCESS | 1677 | RSS: Main: 277172224 15:55:54 INFO - PROCESS | 1677 | 15:58:57 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 15:58:57 INFO - PROCESS | 1677 | RSS: Main: 318124032 15:58:57 INFO - PROCESS | 1677 | 15:58:57 INFO - PROCESS | 1677 | __start_tp_report 15:58:57 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 15:58:57 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 15:58:57 INFO - PROCESS | 1677 | |i|pagename|runs| 15:58:57 INFO - PROCESS | 1677 | |0;dojo.html;3238.5951756030495;3567.304375646747;3575.767575107617;3581.0689220802615;3656.4149736042236;5628.268325117729;5654.886902261952;5678.829635110943;5686.3744988051285;5687.260656114704;5653.1237658162945;5661.377248502661;5673.205751194836;5683.772649094041;5691.459311365424;5148.073346797575;5193.246979188016;5231.764570594313;5283.788648454057;5290.709011004393;5230.660007099526;5288.048151332759;5300.257963885059;5300.363956325227;5302.655327403726;4404.493483249419;5268.789248430058;5300.761465734051;5315.601329900253;5324.813631522898;5303.575713942894;5347.812826551091;5348.893022139536;5358.598105142091;5394.406615272317;5166.199239117943;5171.327727395452;5192.71440070796;5268.81559145428;5276.129438642658;5591.245181900432;5604.495595396393;5609.579281553859;5652.123920792284;5653.0955047192665;5710.600257981943;6045.941960156999;6258.780942666985;6264.780732674334;6283.214598175228;6150.985087460564;6195.814125576195;6241.500679945593;6250.468710159642;6287.182666253403;5874.853128671817;5888.646681199141;5922.378150294243;5942.078977758454;5961.731722072517;6259.71831267594;6281.3404592518045;6283.37166283368;6283.6858157091965;6287.434130928238;6083.239595050619;6152.200213972155;6154.5384096192965;6162.969185154136;6215.285242197205;6172.722227499773;6206.906896396557;6257.186565746424;6266.216722909637;6295.276043254993;6241.21984751906;6255.343188965093;6276.780312689125;6280.089387038854;6285.9057114143325;6208.1308616793685;6209.130721698965;6279.152314437584;6289.339619339995;6299.6535190564955;4939.580135688507;4946.777395017233;5006.89986200274;5033.848984530397;5050.722210278396;4521.095780843844;4521.751303678264;4523.819047238139;4552.7495987720995;4561.771911404417;5781.855453613609;6001.2498437695285;6001.759929602855;6029.246344206974;6034.63792172471;5527.944720552823;6104.298005729309;6174.073888916699;6262.499000079983;6305.842353941096;5984.401559843981;6019.518438524995;6021.277446706424;6028.457438830438;6041.456268935817;5462.590305727086;5468.64453810509;5472.589555783332;5489.945100548944;5490.725463726798;6355.237371515355;6409.519286053472;6495.935040649533;6502.512311576746;6505.902411463927;6239.344868788712;6252.9374706254175;6255.124282600531;6279.372062793684;6282.748690052346;6469.126667899774;6483;6487.837804054936;6491.383318584727;6519.967400162969;6098.908516372347;6183.165272688129;6235.781747638811;6248.375162483715;6278.434940855345;6239.188905442264;6247.718852651551;6258.342873998165;6262.123302737529;6278.4035516625845;6017.157597936205;6206.782762603287;6208.503319734501;6227.626342419469;6240.219972503437;6118.541109416722;6179.3820617937845;6206.162168107428;6226.875462490815;6331.588446750947;6050.2437195350585;6079.848003799941;6101.389861013863;6121.3572574879;6122.357152498924;6022.608530445507;6112.663803490851;6145.754169833157;6190.81427557174;6203.2245969253845;6008.309044459943;6028.758849645965;6092;6109.480694141048;6130.111133885473 15:58:57 INFO - PROCESS | 1677 | |1;ext.html;503.62228328753434;527.6174773289365;541.7020638648745;546.5136028934247;563.9379668236495;32713.345733085323;33535.16162095949;39837.60162398375;40540.58107966222;40743;44168;44604.88487787807;44624.21503139871;44653;45090;9757.804843903117;9935.602575896955;9936.900630993707;9953.402795832237;9955.452450115241;9260.166585007348;12011.159218854684;12275.140740148194;12275.447604857804;12306.81539776904;11946.462409191563;12031.759364812699;12052.819207711891;12058.819117713241;12072.517099316017;12038.81941770874;12137.575184868532;12142.696432589168;12148.878511214863;12154.5138194473;11879.821802672966;12036.277823330629;12040.036797056215;12043.976262017739;12047.216930899463;42824.57175428237;43167;43214.919627009265;43238.78380608108;43307.78346108281;3271.803691778477;3431.0564594736397;3645.325614761251;3701.130234394915;4002.1595464952393;29531.261718456997;29969.70030299691;30240;30473.933412330683;30635.38729225403;2770.1051209188668;2785.4986102501543;2786.9827512957622;2792.9720702792915;2823.520001599733;359099;360279;360431;360928.19535902416;361369;37806.81096594499;67714.98427523591;68340;68357.65821170862;68581;36758.44862327067;36840.63159368372;36855.07862303464;36880.89357319285;36968.26063478769;16220.918895405448;16525.33898644041;16536.917315413346;16554.42059527911;16589.834101658827;12940.935295323463;13966.441342346396;14032.08791428554;14199.077059991068;14225.64435889111;8451.535165565952;8455.308938212382;8458.28104611115;8537.359698022548;8545.230929216275;2982.2693440107314;3468.791872487659;3514.9297014059575;3517.402041652925;3542.051871470681;933.6965486217007;980.9705708828747;1029.583018877356;1035.6323505155713;1055.171690223171;31261.687383126333;31374.52938205929;31426.685733142833;31617;31884;904.4876886417687;1180.3390101543164;1195.1275568834799;1213.4842691855927;1230.6861750253806;11818.054555635528;13352.732945341038;15228.695426091415;15852.920735396248;16041.138768818144;629841;642307;642659;642872;643709;63810.40473988095;65268.34731652718;65322.67338663276;65345.01982470267;65582;1425.978610320846;1485.376142020354;1538.8999715018488;1552.154076028567;1560.7034663413915;29681.109566713032;30705;31155.844220778752;31341.52987705232;31362.843185783924;54274;55239;55341;55361.72319138378;55479.445205547425;454389;475840;477127;477751;478057;37657;45249.77375113235;45321;45938.540614593425;46621.766891166684;48225.276620851415;49652.75173624109;50392.24411633902;50706.74646626743;50821.22125725582;30999.69000309968;39883.604073858434;40969;41607.58392416158;41750.79124604358;39643.603563965145;40025;40154.59845401509;41252.38121428241;41459.7927010363;40272.798636006635;40468;40474.39288410617;40523;40983.59016409798;34067.82966085154;34362.656373435944;34903.82548087243;35179.648203518664;35291.117722057155;26071.17864640638;26113.608295875198;26377.868110659325;26494.205173844817;26751.598726019514 15:58:57 INFO - PROCESS | 1677 | |2;jquery.html;409.6640754581244;410.0589147905557;411.6830040868533;416.1967402912378;420.18274456182735;16027.278772455238;21025.264115755952;21724.89137554314;21733;21752.456188595293;19958.20167193314;20711.896440517816;21408.92955352234;21558;22630.54738905225;4838.346823178878;6068.969655151718;6242.656653884034;6249.468795152417;6258.687065646723;6150;6175.6294622322575;6184.226971628546;6191.566590338678;6193.876122477548;3646.7994260315672;5933.5549833762425;6212.347703491136;6220.253569571658;6223.906641400383;6140.232470941132;6194.349593292684;6197.504199664016;6199.4110559497;6213.099100630406;5900.881982360372;6042.5165986721395;6070.2108725865355;6081.17904082952;6090.147379366892;14101.78847317291;14359.641008974859;21739;27225;27254.863725681444;2168.544605632819;2249.662550617404;2422.4186195313173;2930.9706902931125;2936.3393236521824;10090.949545252226;10167.89832101677;10396.220283478693;10474.685759427153;10836.729081772939;1810.5292623917744;1850.380122658911;1868.5795695968297;1914.339552854263;1956.5108722819296;115094;115548;117776;119026.21460678011;119729;11678.76642467146;11738.70653233659;11746;11792.9927868393;11798.331880990912;14012.089214201249;14508.854911450962;14568.635784105481;15444.45944391941;15492.07047577149;8795.912040879637;9140.54297285133;9184.403013804214;9272.211861991806;9303.674371397105;8308.626111824982;8824.691135810215;9233.399829011227;9254.50128465324;9302.86045709315;3920.3923391874305;4737.549932756383;4772.472808701252;4831.9275210871865;4863.732494712754;1983.4545499987619;2034.5523984723336;2045.3966080006435;2048.7643920948985;2069.813716765498;894.7986702991775;945.2768631996528;956.1108169402384;1029.7899967538112;1036.383351905615;20596.691049634268;20866;21303.78696213049;21723.13107475683;21877.453063673536;1012.9189664826796;1034.234666346913;1037.8806437259811;1039.1063685230695;1080.4111759091313;8952.597133129026;11205.60780372683;11486.712832179262;11506.654800356002;11542.480588373543;641691;642888;652443;653478.7326063435;658457;119128;123373;124958;127139.36430317974;133499;1040.6877936618985;1103.6027030269258;1112.8163852964333;1115.2694984784978;1117.620009196877;18973.33593324227;18988.810111898703;19103.904480477508;19791.802081978996;20057.29799457012;56608.71695641495;57377.85244295174;57463;58384.4161558379;59478.70260648842;61938;78279.04302392485;82760.58619706862;83099;84230;8204.302634276153;8412.62143203545;8424.83150337002;8545.316374689886;8734.388592798443;12540.184887982252;12822;12917.61247162549;13142.868571314548;13153.342332883127;11163.88836111661;11378.601748939078;11494.942525287655;11547.711307217387;11613.941930290295;11257.662270131908;11351.035162011322;11405.828912566152;11469.922123331202;11498;11222;11340.94329528347;11459.989003848586;11640.417979101181;11951.641450756491;8251.711190108557;8356.456830306011;8515.659373624985;8535.53054582004;8713.695020674246;8016.959915200387;11413.486393112164;11423.371714555778;11635.360055197045;11804.881951180378 15:58:57 INFO - PROCESS | 1677 | |3;mootools.html;1508.8717459015984;1620.3842539834864;1651.8182999870012;1902.5433895864987;2012.2856385982984;8274.66901323947;8908.910910890889;9069.365144439875;9093.13615206556;9108.225800806931;8714.346424018193;9049.819003619923;9055.094490550942;9060.728178154666;9071.773205669862;2536.6575512305835;2562.1032638576535;2570.241778675286;2573.240893936293;2575.1115865026536;2499.562576549106;2544.134994102005;2548.2227920484247;2553.6041913503345;2559.5264875997905;2489.539435204484;2515.220281712675;2524.00301880757;2527.9620805687928;2533.240027991604;2099.9160033598637;2523.3060908250286;2542.6694529711112;2556.821022528424;2567.460833225025;2489.4647650755173;2524.0913271222344;2533.961990570143;2537.6320433537217;2543.987280063588;8760.518171500566;8920.776980575472;9124.680636177702;9126.361154719172;9213.2168765655;5589.944100558983;5760.135979603051;5807.477327040587;5819.709014549256;5820.912686309709;3282.868685252587;3534.9469757953652;3683.557973043252;3732.7387082904206;3738.476613274144;1049.601151562409;1067.1889364083274;1085.7991271614776;1088.542812018954;1092.1699508373613;12199;12464.750704985849;12467.75064498714;12487.937560312232;12488.687782805411;4735.21868891629;4751.524847515221;4840.467548569654;4871.318015477836;4879.853604391874;9652.22782177424;9654.420734755797;9671.854922176173;9704.417734935927;9731.221502279801;5557.5831812614215;5584;5603.7478313475995;5610.915836262459;5624.184493248456;4610.561996610317;4711.52884711533;5047.848564543069;5166.199239117943;5216.035033518811;3850.403187505941;3909;3972.2651309507255;4070.470838790938;4111.506619205715;1246.9625911222497;1280.2638482872385;1287.414226526928;1293.8447386313703;1295.475332490343;863.9395242333102;956.0726095687172;968.9951550242204;979.8138353712772;1015.1320620869199;5959.463648271676;6123.295820980555;6149.631022138686;6162.599431036968;6208.844778880564;477.9091972525209;483.74603333250326;486.3288661646975;1027.291169093323;1037.444966942682;3454.188265757595;3902.3561112416132;4016.136530645925;4053.4527838741983;4080.7755573443746;10676.306040107369;11102.389368584643;11132;11135.220534562664;11142.331460112418;10708.03627673513;10990.615328463466;11097.44512774358;11097.611583594535;11126.332420054823;8550.144985501525;8617.267532259702;8727.65089396417;8758.912410875937;8784.736457906272;5145.434002259673;5911.467967882912;5959.986802243542;5986.730597123227;6008.939910600838;9510.809783804423;9604.327697061139;9788.608455661693;9973.252006099427;10268.589256429957;9878.357906736039;9900.455474948947;9927.751806204613;10070.395776253448;10101.646442374482;7551.773446796605;7600.429967752551;7636.923630763621;7737.883931741141;7768;8390.622421990904;8433.156684331518;8499.107593702573;8500.70247541333;8502.659893604186;7485.214052524407;7512.21121782205;7658.502197357377;7660.310572048543;7847.489913155627;7381.188069312264;7485.438592105723;7495.850082998419;7595.240475952361;7625.275598818103;7110.502264841618;7134.928650713427;7163.570185788869;7184.425245980205;7190.137183538009;4564.566366195206;4759.95281038171;4870;4912.680675756064;5094.083065048327;5089.440161582297;5144.742762861917;5156.922646160236;5208.401033881;5327.520523152934 15:58:57 INFO - PROCESS | 1677 | |4;prototype.html;331.3174859788835;334.8208708341038;338.90849470642934;346.0621715151938;348.7680692339594;6491;6561.409473147416;6564.081028655992;6580.572262802914;6592.835179120524;6429.935700642992;6433.067205255235;6441.516886233528;6445.90419628663;6472.385123413268;4594.517575654559;4737.242041273397;4765.404324459442;4827.734474603895;4849.393825771778;4811.350467686852;4874.97562512187;4890.24201248807;4893.902121957559;4900.58345040672;4843.273508973647;4847.175980083377;4851.490593487668;4854.499932534747;4869.245266983606;3681.355762741523;4711.222648263032;4772.926091629391;4788.4253889533475;4797.808087676489;4031.1937612477623;4140.875773726793;4140.958590414118;4144.046869220097;4148.253314403406;5549.418415751532;5688.203651488795;6093.421124993119;6191.7926004429155;6195.2255968004;5028.673136246132;5298.443663415363;5706.914396284059;5712.371639119693;5716;6923.619200943946;6926.099607051102;6932.445404367639;6958.547694399847;6964.651767411609;4350.129974005212;4494.640428765723;4515.706479078882;4529.139463501924;4529.932051019237;7045.436365090781;7198;7223.638818059076;7231.855362892766;7286.635668216621;4620.699654522446;4643.071385722869;4643.582077612963;4644.628429725613;4645.628349732014;4689.882752931136;4692.366530518337;4698.083873644675;4702.57676809082;4702.965347623517;5618.747156377973;5623.690697011703;5630.71846407678;5638.633488823213;5644.74598643062;6648.96675516629;6886.586804791728;6902.344277293649;6908.896366554506;6966;1600.3998500562288;1619.7165496038147;1630.7635392868206;1635.5992781768543;1635.6156303268722;845.6763688094039;1013.5236438873718;1040.0535512683573;1042.910158883968;1045.6915210013065;6409.903851442232;6619.635920024445;6657.300983396771;6689.1972963244725;6695.531312808057;7017.754378596725;7163.820904477429;7165.641717914188;7176.246494118147;7196.820079498055;6642.368974947372;6654.201495820435;6713.932860671429;6735.057092007123;6746.662666866637;3167.160702413862;3784.848606055782;3790.3745881929726;3827.0432391902023;3832.0419895026243;7460.142083660448;7734.690612375442;7755.844883102306;7772.961135194288;7818.960905195438;7415.3326200642205;7434.739784107638;7442.106947166375;7450.515716478411;7502.2122677119205;7750.689972401041;7753.728619498291;7766.456348055582;7773.5724535149975;7779.8833017504785;7144.64276786169;7210.134783825974;7212.8918066228;7227.49407541467;7237.203907570269;5886;6776.86446271062;7080.575165490087;7088.04311417952;7095.325944035309;7698.923010770045;7739.690412383667;7740.148583655906;7764.456488045783;7786.33816125613;4607.746573938465;4615.007773328751;4621.745803980813;4627.6066534344955;4630.930536042029;7163.570185788869;7179.389751871149;7186.748463803742;7209.855802883808;7213.71145154188;6692.397684208445;6920.861582768417;6953;6962.164540255202;6968.616726080114;5603.215549822947;6909.79270621862;6922.926946323328;6944.166699995831;6946.16646002483;5492.231087647652;5554.250176226158;6779.93220067793;6787.01588269708;6799.694013769294;6921.550099243533;6935.375816176568;6941.132358455193;6943.236244013054;6958.338957799001;6489.351064893662;6585.670716464253;6822.8635427292165;6823.249442561413;6832.965835170792 15:58:57 INFO - PROCESS | 1677 | |5;yui.html;658.8023592922123;711.1643818513246;753.2542782645183;768.7347864986577;819.1439945257204;15220.315085821137;15434.768478472832;15609.92195039026;15624.218789060544;15628.531144065682;14285;14451.638709032279;14454.638634034129;14459.855401445982;14477.63805904853;798.0901771979948;811.3022800391658;956.9712908612736;964.6334392930677;971.2763990826844;988.0613417253602;991.4497453913075;992.8312186928204;993.2600212841443;997.1574019953129;1041.9374837509774;1042.8487869258952;1043.6242952537082;1045.430240518919;1047.4029803012247;814.2468216899374;1012.8379459286479;1036.4092467293647;1037.7198156497702;1037.8495118207893;771.5987686403039;772.3473664753275;775.329340120797;775.4920527054788;776.3362325211918;14862.182579958098;15244.23778811055;15259.08445493274;15269.847301527065;15285.235738213045;12714.838477458854;12738;12831.615051548468;13004.154729942524;13264.801027984588;10194.388336699747;10224.897751022543;10516.369017858877;10533.052025317682;10644.201684873588;3525.1715846775987;3564;3568.7323450741037;3631.94552081719;3819.0643292393265;78406;78727.21272787314;79452.41095178122;80018;80194;9488.667896623585;9587.952060239653;9626.229901607854;9685.612575496902;9755.317127801127;21583.56832863334;21761.455963601038;21813.345599632037;21822.45443863916;22324.10703571839;7581.6209189540305;7582.658780354897;7722.498037627536;7785.571793551409;8004.07953085391;4202.243596152661;4215.557366476476;4221.894452638647;4251.319788833772;4263.573642635712;3719.6466335698065;3743.6256374362893;3780.3006443807985;3785.6592906638534;3785.716071294609;580.2051189869906;686.8385929306609;689.4553302890661;703.8592281543712;727.29089138091;539.6222644149111;542.2219115569171;603.3694788945562;605.1860247966478;616.8735409241095;7734.7679569613;8008.935219657484;8122.75631731049;8262.958685206655;8434.367422443342;503.97732102055494;540.065686362587;546.4535464535464;596.0969131765379;602.5631417222479;3788.124878185261;3841.2893614681375;3860.6911447084167;3922.3332033554366;4069.877903662895;92727.07272927319;93920;95307.57038644426;95413.61465963407;95436.52281738547;66044.01867943969;75151.62424187953;75496;75733.621331893;77396.61301693456;64619;70580.6470967642;71232;71364.28635713784;72076;7631.3894888407685;7795.883061754192;7903.802404939923;8365.498070115813;8390.916090839013;47474.52525474701;47624.761876190394;47758.76120619375;48405;49611.751941240065;64822;68550.65724671345;70065.89802305939;70434.29565704483;71127.28872711207;10980.450977451255;11072.97120907896;11169.553217871518;11367.43162841838;11639.709007274547;11928.257366253396;11994;12084.45619947122;12176.939115304367;12571.49714011466;11268.38023908693;11535.192536522363;11651.168784820775;11891.345975971404;11954.940225298818;11562.4441487779;11573.305601663928;11679.474423651127;11871.169018168644;12066.577669781516;11064.723381915195;11192.552297908318;11314;11633.59282425111;11757.529698812294;9648.71053868385;9750.756231093996;9914.670052537504;10087.04173103554;10229.795404092025;9508.286878484003;9607.855882161914;9655.372400794207;9679.70960871175;9733.561989710339 15:58:57 INFO - PROCESS | 1677 | __end_tp_report 15:58:57 INFO - PROCESS | 1677 | __start_cc_report 15:58:57 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1183 15:58:57 INFO - PROCESS | 1677 | __end_cc_report 15:58:57 INFO - PROCESS | 1677 | __startTimestamp1467932337579__endTimestamp 15:58:57 INFO - PROCESS | 1677 | 15:58:57 INFO - PROCESS | 1677 | ------- Summary: start ------- 15:58:57 INFO - PROCESS | 1677 | Number of tests: 6 15:58:57 INFO - PROCESS | 1677 | 15:58:57 INFO - PROCESS | 1677 | [#0] dojo.html Cycles:165 Average:5805.52 Median:6050.24 stddev:630.17 (10.4%) stddev-sans-first:599.07 15:58:57 INFO - PROCESS | 1677 | Values: 3238.6 3567.3 3575.8 3581.1 3656.4 5628.3 5654.9 5678.8 5686.4 5687.3 5653.1 5661.4 5673.2 5683.8 5691.5 5148.1 5193.2 5231.8 5283.8 5290.7 5230.7 5288.0 5300.3 5300.4 5302.7 4404.5 5268.8 5300.8 5315.6 5324.8 5303.6 5347.8 5348.9 5358.6 5394.4 5166.2 5171.3 5192.7 5268.8 5276.1 5591.2 5604.5 5609.6 5652.1 5653.1 5710.6 6045.9 6258.8 6264.8 6283.2 6151.0 6195.8 6241.5 6250.5 6287.2 5874.9 5888.6 5922.4 5942.1 5961.7 6259.7 6281.3 6283.4 6283.7 6287.4 6083.2 6152.2 6154.5 6163.0 6215.3 6172.7 6206.9 6257.2 6266.2 6295.3 6241.2 6255.3 6276.8 6280.1 6285.9 6208.1 6209.1 6279.2 6289.3 6299.7 4939.6 4946.8 5006.9 5033.8 5050.7 4521.1 4521.8 4523.8 4552.7 4561.8 5781.9 6001.2 6001.8 6029.2 6034.6 5527.9 6104.3 6174.1 6262.5 6305.8 5984.4 6019.5 6021.3 6028.5 6041.5 5462.6 5468.6 5472.6 5489.9 5490.7 6355.2 6409.5 6495.9 6502.5 6505.9 6239.3 6252.9 6255.1 6279.4 6282.7 6469.1 6483.0 6487.8 6491.4 6520.0 6098.9 6183.2 6235.8 6248.4 6278.4 6239.2 6247.7 6258.3 6262.1 6278.4 6017.2 6206.8 6208.5 6227.6 6240.2 6118.5 6179.4 6206.2 6226.9 6331.6 6050.2 6079.8 6101.4 6121.4 6122.4 6022.6 6112.7 6145.8 6190.8 6203.2 6008.3 6028.8 6092.0 6109.5 6130.1 15:58:57 INFO - PROCESS | 1677 | 15:58:57 INFO - PROCESS | 1677 | [#1] ext.html Cycles:180 Average:64185.84 Median:182507.16 stddev:134585.48 (73.7%) stddev-sans-first:134878.09 15:58:57 INFO - PROCESS | 1677 | Values: 503.6 527.6 541.7 546.5 563.9 32713.3 33535.2 39837.6 40540.6 40743.0 44168.0 44604.9 44624.2 44653.0 45090.0 9757.8 9935.6 9936.9 9953.4 9955.5 9260.2 12011.2 12275.1 12275.4 12306.8 11946.5 12031.8 12052.8 12058.8 12072.5 12038.8 12137.6 12142.7 12148.9 12154.5 11879.8 12036.3 12040.0 12044.0 12047.2 42824.6 43167.0 43214.9 43238.8 43307.8 3271.8 3431.1 3645.3 3701.1 4002.2 29531.3 29969.7 30240.0 30473.9 30635.4 2770.1 2785.5 2787.0 2793.0 2823.5 359099.0 360279.0 360431.0 360928.2 361369.0 37806.8 67715.0 68340.0 68357.7 68581.0 36758.4 36840.6 36855.1 36880.9 36968.3 16220.9 16525.3 16536.9 16554.4 16589.8 12940.9 13966.4 14032.1 14199.1 14225.6 8451.5 8455.3 8458.3 8537.4 8545.2 2982.3 3468.8 3514.9 3517.4 3542.1 933.7 981.0 1029.6 1035.6 1055.2 31261.7 31374.5 31426.7 31617.0 31884.0 904.5 1180.3 1195.1 1213.5 1230.7 11818.1 13352.7 15228.7 15852.9 16041.1 629841.0 642307.0 642659.0 642872.0 643709.0 63810.4 65268.3 65322.7 65345.0 65582.0 1426.0 1485.4 1538.9 1552.2 1560.7 29681.1 30705.0 31155.8 31341.5 31362.8 54274.0 55239.0 55341.0 55361.7 55479.4 454389.0 475840.0 477127.0 477751.0 478057.0 37657.0 45249.8 45321.0 45938.5 46621.8 48225.3 49652.8 50392.2 50706.7 50821.2 30999.7 39883.6 40969.0 41607.6 41750.8 39643.6 40025.0 40154.6 41252.4 41459.8 40272.8 40468.0 40474.4 40523.0 40983.6 34067.8 34362.7 34903.8 35179.6 35291.1 26071.2 26113.6 26377.9 26494.2 26751.6 15:58:57 INFO - PROCESS | 1677 | 15:58:57 INFO - PROCESS | 1677 | [#2] jquery.html Cycles:180 Average:36604.03 Median:11863.27 stddev:107941.22 (909.9%) stddev-sans-first:108209.81 15:58:57 INFO - PROCESS | 1677 | Values: 409.7 410.1 411.7 416.2 420.2 16027.3 21025.3 21724.9 21733.0 21752.5 19958.2 20711.9 21408.9 21558.0 22630.5 4838.3 6069.0 6242.7 6249.5 6258.7 6150.0 6175.6 6184.2 6191.6 6193.9 3646.8 5933.6 6212.3 6220.3 6223.9 6140.2 6194.3 6197.5 6199.4 6213.1 5900.9 6042.5 6070.2 6081.2 6090.1 14101.8 14359.6 21739.0 27225.0 27254.9 2168.5 2249.7 2422.4 2931.0 2936.3 10090.9 10167.9 10396.2 10474.7 10836.7 1810.5 1850.4 1868.6 1914.3 1956.5 115094.0 115548.0 117776.0 119026.2 119729.0 11678.8 11738.7 11746.0 11793.0 11798.3 14012.1 14508.9 14568.6 15444.5 15492.1 8795.9 9140.5 9184.4 9272.2 9303.7 8308.6 8824.7 9233.4 9254.5 9302.9 3920.4 4737.5 4772.5 4831.9 4863.7 1983.5 2034.6 2045.4 2048.8 2069.8 894.8 945.3 956.1 1029.8 1036.4 20596.7 20866.0 21303.8 21723.1 21877.5 1012.9 1034.2 1037.9 1039.1 1080.4 8952.6 11205.6 11486.7 11506.7 11542.5 641691.0 642888.0 652443.0 653478.7 658457.0 119128.0 123373.0 124958.0 127139.4 133499.0 1040.7 1103.6 1112.8 1115.3 1117.6 18973.3 18988.8 19103.9 19791.8 20057.3 56608.7 57377.9 57463.0 58384.4 59478.7 61938.0 78279.0 82760.6 83099.0 84230.0 8204.3 8412.6 8424.8 8545.3 8734.4 12540.2 12822.0 12917.6 13142.9 13153.3 11163.9 11378.6 11494.9 11547.7 11613.9 11257.7 11351.0 11405.8 11469.9 11498.0 11222.0 11340.9 11460.0 11640.4 11951.6 8251.7 8356.5 8515.7 8535.5 8713.7 8017.0 11413.5 11423.4 11635.4 11804.9 15:58:57 INFO - PROCESS | 1677 | 15:58:57 INFO - PROCESS | 1677 | [#3] mootools.html Cycles:180 Average:5858.08 Median:5068.64 stddev:3267.93 (64.5%) stddev-sans-first:3260.75 15:58:57 INFO - PROCESS | 1677 | Values: 1508.9 1620.4 1651.8 1902.5 2012.3 8274.7 8908.9 9069.4 9093.1 9108.2 8714.3 9049.8 9055.1 9060.7 9071.8 2536.7 2562.1 2570.2 2573.2 2575.1 2499.6 2544.1 2548.2 2553.6 2559.5 2489.5 2515.2 2524.0 2528.0 2533.2 2099.9 2523.3 2542.7 2556.8 2567.5 2489.5 2524.1 2534.0 2537.6 2544.0 8760.5 8920.8 9124.7 9126.4 9213.2 5589.9 5760.1 5807.5 5819.7 5820.9 3282.9 3534.9 3683.6 3732.7 3738.5 1049.6 1067.2 1085.8 1088.5 1092.2 12199.0 12464.8 12467.8 12487.9 12488.7 4735.2 4751.5 4840.5 4871.3 4879.9 9652.2 9654.4 9671.9 9704.4 9731.2 5557.6 5584.0 5603.7 5610.9 5624.2 4610.6 4711.5 5047.8 5166.2 5216.0 3850.4 3909.0 3972.3 4070.5 4111.5 1247.0 1280.3 1287.4 1293.8 1295.5 863.9 956.1 969.0 979.8 1015.1 5959.5 6123.3 6149.6 6162.6 6208.8 477.9 483.7 486.3 1027.3 1037.4 3454.2 3902.4 4016.1 4053.5 4080.8 10676.3 11102.4 11132.0 11135.2 11142.3 10708.0 10990.6 11097.4 11097.6 11126.3 8550.1 8617.3 8727.7 8758.9 8784.7 5145.4 5911.5 5960.0 5986.7 6008.9 9510.8 9604.3 9788.6 9973.3 10268.6 9878.4 9900.5 9927.8 10070.4 10101.6 7551.8 7600.4 7636.9 7737.9 7768.0 8390.6 8433.2 8499.1 8500.7 8502.7 7485.2 7512.2 7658.5 7660.3 7847.5 7381.2 7485.4 7495.9 7595.2 7625.3 7110.5 7134.9 7163.6 7184.4 7190.1 4564.6 4760.0 4870.0 4912.7 5094.1 5089.4 5144.7 5156.9 5208.4 5327.5 15:58:57 INFO - PROCESS | 1677 | 15:58:57 INFO - PROCESS | 1677 | [#4] prototype.html Cycles:180 Average:5697.59 Median:6526.20 stddev:1836.53 (28.1%) stddev-sans-first:1796.97 15:58:57 INFO - PROCESS | 1677 | Values: 331.3 334.8 338.9 346.1 348.8 6491.0 6561.4 6564.1 6580.6 6592.8 6429.9 6433.1 6441.5 6445.9 6472.4 4594.5 4737.2 4765.4 4827.7 4849.4 4811.4 4875.0 4890.2 4893.9 4900.6 4843.3 4847.2 4851.5 4854.5 4869.2 3681.4 4711.2 4772.9 4788.4 4797.8 4031.2 4140.9 4141.0 4144.0 4148.3 5549.4 5688.2 6093.4 6191.8 6195.2 5028.7 5298.4 5706.9 5712.4 5716.0 6923.6 6926.1 6932.4 6958.5 6964.7 4350.1 4494.6 4515.7 4529.1 4529.9 7045.4 7198.0 7223.6 7231.9 7286.6 4620.7 4643.1 4643.6 4644.6 4645.6 4689.9 4692.4 4698.1 4702.6 4703.0 5618.7 5623.7 5630.7 5638.6 5644.7 6649.0 6886.6 6902.3 6908.9 6966.0 1600.4 1619.7 1630.8 1635.6 1635.6 845.7 1013.5 1040.1 1042.9 1045.7 6409.9 6619.6 6657.3 6689.2 6695.5 7017.8 7163.8 7165.6 7176.2 7196.8 6642.4 6654.2 6713.9 6735.1 6746.7 3167.2 3784.8 3790.4 3827.0 3832.0 7460.1 7734.7 7755.8 7773.0 7819.0 7415.3 7434.7 7442.1 7450.5 7502.2 7750.7 7753.7 7766.5 7773.6 7779.9 7144.6 7210.1 7212.9 7227.5 7237.2 5886.0 6776.9 7080.6 7088.0 7095.3 7698.9 7739.7 7740.1 7764.5 7786.3 4607.7 4615.0 4621.7 4627.6 4630.9 7163.6 7179.4 7186.7 7209.9 7213.7 6692.4 6920.9 6953.0 6962.2 6968.6 5603.2 6909.8 6922.9 6944.2 6946.2 5492.2 5554.3 6779.9 6787.0 6799.7 6921.6 6935.4 6941.1 6943.2 6958.3 6489.4 6585.7 6822.9 6823.2 6833.0 15:58:57 INFO - PROCESS | 1677 | 15:58:57 INFO - PROCESS | 1677 | [#5] yui.html Cycles:180 Average:18315.84 Median:25057.86 stddev:25508.37 (101.8%) stddev-sans-first:25545.48 15:58:57 INFO - PROCESS | 1677 | Values: 658.8 711.2 753.3 768.7 819.1 15220.3 15434.8 15609.9 15624.2 15628.5 14285.0 14451.6 14454.6 14459.9 14477.6 798.1 811.3 957.0 964.6 971.3 988.1 991.4 992.8 993.3 997.2 1041.9 1042.8 1043.6 1045.4 1047.4 814.2 1012.8 1036.4 1037.7 1037.8 771.6 772.3 775.3 775.5 776.3 14862.2 15244.2 15259.1 15269.8 15285.2 12714.8 12738.0 12831.6 13004.2 13264.8 10194.4 10224.9 10516.4 10533.1 10644.2 3525.2 3564.0 3568.7 3631.9 3819.1 78406.0 78727.2 79452.4 80018.0 80194.0 9488.7 9588.0 9626.2 9685.6 9755.3 21583.6 21761.5 21813.3 21822.5 22324.1 7581.6 7582.7 7722.5 7785.6 8004.1 4202.2 4215.6 4221.9 4251.3 4263.6 3719.6 3743.6 3780.3 3785.7 3785.7 580.2 686.8 689.5 703.9 727.3 539.6 542.2 603.4 605.2 616.9 7734.8 8008.9 8122.8 8263.0 8434.4 504.0 540.1 546.5 596.1 602.6 3788.1 3841.3 3860.7 3922.3 4069.9 92727.1 93920.0 95307.6 95413.6 95436.5 66044.0 75151.6 75496.0 75733.6 77396.6 64619.0 70580.6 71232.0 71364.3 72076.0 7631.4 7795.9 7903.8 8365.5 8390.9 47474.5 47624.8 47758.8 48405.0 49611.8 64822.0 68550.7 70065.9 70434.3 71127.3 10980.5 11073.0 11169.6 11367.4 11639.7 11928.3 11994.0 12084.5 12176.9 12571.5 11268.4 11535.2 11651.2 11891.3 11954.9 11562.4 11573.3 11679.5 11871.2 12066.6 11064.7 11192.6 11314.0 11633.6 11757.5 9648.7 9750.8 9914.7 10087.0 10229.8 9508.3 9607.9 9655.4 9679.7 9733.6 15:58:57 INFO - PROCESS | 1677 | -------- Summary: end -------- 15:58:57 INFO - PROCESS | 1677 | 15:58:58 INFO - TEST-INFO | 1677: exit 0 15:58:58 INFO - TEST-OK | dromaeo_css | took 1113653ms 15:58:58 INFO - TEST-START | kraken 15:58:58 INFO - operating with platform_type : mac_ 15:58:58 INFO - Initialising browser for kraken test... 15:58:58 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/tmpVGjcgr/profile http://localhost:49270/getInfo.html) 15:59:00 INFO - PROCESS | 1682 | __metrics Screen width/height:1600/1200 15:59:00 INFO - PROCESS | 1682 | colorDepth:24 15:59:00 INFO - PROCESS | 1682 | Browser inner width/height: 1024/689 15:59:00 INFO - PROCESS | 1682 | __metrics 15:59:00 INFO - PROCESS | 1682 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:59:00 ERROR - PROCESS | 1682 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:59:01 INFO - TEST-INFO | 1682: exit 0 15:59:01 INFO - Browser initialized. 15:59:01 INFO - Running cycle 1/1 for kraken test... 15:59:01 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/tmpVGjcgr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:59:12 INFO - PROCESS | 1685 | RSS: Main: 161796096 15:59:12 INFO - PROCESS | 1685 | 15:59:15 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 15:59:16 INFO - PROCESS | 1685 | RSS: Main: 223449088 15:59:16 INFO - PROCESS | 1685 | 15:59:19 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 15:59:19 INFO - PROCESS | 1685 | RSS: Main: 239550464 15:59:19 INFO - PROCESS | 1685 | 15:59:22 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 15:59:23 INFO - PROCESS | 1685 | RSS: Main: 324554752 15:59:23 INFO - PROCESS | 1685 | 15:59:25 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 15:59:26 INFO - PROCESS | 1685 | RSS: Main: 230617088 15:59:26 INFO - PROCESS | 1685 | 15:59:28 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:59:28 INFO - PROCESS | 1685 | RSS: Main: 231153664 15:59:28 INFO - PROCESS | 1685 | 15:59:31 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 15:59:32 INFO - PROCESS | 1685 | RSS: Main: 268881920 15:59:32 INFO - PROCESS | 1685 | 15:59:35 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 15:59:35 INFO - PROCESS | 1685 | RSS: Main: 270417920 15:59:35 INFO - PROCESS | 1685 | 15:59:38 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 15:59:39 INFO - PROCESS | 1685 | RSS: Main: 267972608 15:59:39 INFO - PROCESS | 1685 | 15:59:40 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:59:41 INFO - PROCESS | 1685 | RSS: Main: 260231168 15:59:41 INFO - PROCESS | 1685 | 15:59:43 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:59:43 INFO - PROCESS | 1685 | RSS: Main: 267587584 15:59:43 INFO - PROCESS | 1685 | 15:59:45 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:59:46 INFO - PROCESS | 1685 | RSS: Main: 270790656 15:59:46 INFO - PROCESS | 1685 | 15:59:49 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:59:49 INFO - PROCESS | 1685 | RSS: Main: 277975040 15:59:49 INFO - PROCESS | 1685 | 15:59:52 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:59:53 INFO - PROCESS | 1685 | RSS: Main: 274661376 15:59:53 INFO - PROCESS | 1685 | 15:59:55 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 15:59:55 INFO - PROCESS | 1685 | RSS: Main: 335941632 15:59:55 INFO - PROCESS | 1685 | 15:59:55 INFO - PROCESS | 1685 | __start_tp_report 15:59:55 INFO - PROCESS | 1685 | _x_x_mozilla_page_load 15:59:55 INFO - PROCESS | 1685 | _x_x_mozilla_page_load_details 15:59:55 INFO - PROCESS | 1685 | |i|pagename|runs| 15:59:55 INFO - PROCESS | 1685 | |0;ai-astar;114;113;121;113;112;112;114;114;115;137 15:59:55 INFO - PROCESS | 1685 | |1;audio-beat-detection;156;121;143;163;113;139;118;152;159;115 15:59:55 INFO - PROCESS | 1685 | |2;audio-dft;186;185;185;185;186;193;264;210;184;186 15:59:55 INFO - PROCESS | 1685 | |3;audio-fft;71;75;102;188;83;55;57;58;130;55 15:59:55 INFO - PROCESS | 1685 | |4;audio-oscillator;89;89;143;78;77;80;123;80;79;123 15:59:55 INFO - PROCESS | 1685 | |5;imaging-gaussian-blur;90;87;91;88;90;86;90;88;91;87 15:59:55 INFO - PROCESS | 1685 | |6;imaging-darkroom;96;96;95;95;95;96;96;95;94;95 15:59:55 INFO - PROCESS | 1685 | |7;imaging-desaturate;84;84;85;84;84;83;93;130;133;87 15:59:55 INFO - PROCESS | 1685 | |8;json-parse-financial;58;62;62;61;62;62;64;78;60;56 15:59:55 INFO - PROCESS | 1685 | |9;json-stringify-tinderbox;62;64;69;75;74;70;69;68;68;67 15:59:55 INFO - PROCESS | 1685 | |10;stanford-crypto-aes;77;78;79;79;80;76;80;80;80;84 15:59:55 INFO - PROCESS | 1685 | |11;stanford-crypto-ccm;127;128;124;124;121;126;126;126;147;129 15:59:55 INFO - PROCESS | 1685 | |12;stanford-crypto-pbkdf2;168;166;164;162;167;166;162;214;226;171 15:59:55 INFO - PROCESS | 1685 | |13;stanford-crypto-sha256-iterative;66;67;66;66;67;66;65;67;66;69 15:59:55 INFO - PROCESS | 1685 | __end_tp_report 15:59:55 INFO - PROCESS | 1685 | __start_cc_report 15:59:55 INFO - PROCESS | 1685 | _x_x_mozilla_cycle_collect,1906 15:59:55 INFO - PROCESS | 1685 | __end_cc_report 15:59:55 INFO - PROCESS | 1685 | __startTimestamp1467932395383__endTimestamp 15:59:55 INFO - PROCESS | 1685 | 15:59:55 INFO - PROCESS | 1685 | ------- Summary: start ------- 15:59:55 INFO - PROCESS | 1685 | Number of tests: 14 15:59:55 INFO - PROCESS | 1685 | 15:59:55 INFO - PROCESS | 1685 | [#0] ai-astar Cycles:10 Average:116.50 Median:114.00 stddev:7.65 (6.7%) stddev-sans-first:8.06 15:59:55 INFO - PROCESS | 1685 | Values: 114.0 113.0 121.0 113.0 112.0 112.0 114.0 114.0 115.0 137.0 15:59:55 INFO - PROCESS | 1685 | 15:59:55 INFO - PROCESS | 1685 | [#1] audio-beat-detection Cycles:10 Average:137.90 Median:147.50 stddev:19.59 (13.3%) stddev-sans-first:19.66 15:59:55 INFO - PROCESS | 1685 | Values: 156.0 121.0 143.0 163.0 113.0 139.0 118.0 152.0 159.0 115.0 15:59:55 INFO - PROCESS | 1685 | 15:59:55 INFO - PROCESS | 1685 | [#2] audio-dft Cycles:10 Average:196.40 Median:186.00 stddev:25.02 (13.5%) stddev-sans-first:26.25 15:59:55 INFO - PROCESS | 1685 | Values: 186.0 185.0 185.0 185.0 186.0 193.0 264.0 210.0 184.0 186.0 15:59:55 INFO - PROCESS | 1685 | 15:59:55 INFO - PROCESS | 1685 | [#3] audio-fft Cycles:10 Average:87.40 Median:57.50 stddev:42.79 (74.4%) stddev-sans-first:44.97 15:59:55 INFO - PROCESS | 1685 | Values: 71.0 75.0 102.0 188.0 83.0 55.0 57.0 58.0 130.0 55.0 15:59:55 INFO - PROCESS | 1685 | 15:59:55 INFO - PROCESS | 1685 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:79.50 stddev:24.15 (30.4%) stddev-sans-first:25.48 15:59:55 INFO - PROCESS | 1685 | Values: 89.0 89.0 143.0 78.0 77.0 80.0 123.0 80.0 79.0 123.0 15:59:55 INFO - PROCESS | 1685 | 15:59:55 INFO - PROCESS | 1685 | [#5] imaging-gaussian-blur Cycles:10 Average:88.80 Median:90.00 stddev:1.81 (2.0%) stddev-sans-first:1.87 15:59:55 INFO - PROCESS | 1685 | Values: 90.0 87.0 91.0 88.0 90.0 86.0 90.0 88.0 91.0 87.0 15:59:55 INFO - PROCESS | 1685 | 15:59:55 INFO - PROCESS | 1685 | [#6] imaging-darkroom Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 15:59:55 INFO - PROCESS | 1685 | Values: 96.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 94.0 95.0 15:59:55 INFO - PROCESS | 1685 | 15:59:55 INFO - PROCESS | 1685 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:84.00 stddev:19.62 (23.4%) stddev-sans-first:20.42 15:59:55 INFO - PROCESS | 1685 | Values: 84.0 84.0 85.0 84.0 84.0 83.0 93.0 130.0 133.0 87.0 15:59:55 INFO - PROCESS | 1685 | 15:59:55 INFO - PROCESS | 1685 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:62.00 stddev:5.91 (9.5%) stddev-sans-first:6.04 15:59:55 INFO - PROCESS | 1685 | Values: 58.0 62.0 62.0 61.0 62.0 62.0 64.0 78.0 60.0 56.0 15:59:55 INFO - PROCESS | 1685 | 15:59:55 INFO - PROCESS | 1685 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:3.95 (5.7%) stddev-sans-first:3.39 15:59:55 INFO - PROCESS | 1685 | Values: 62.0 64.0 69.0 75.0 74.0 70.0 69.0 68.0 68.0 67.0 15:59:55 INFO - PROCESS | 1685 | 15:59:55 INFO - PROCESS | 1685 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:80.00 stddev:2.16 (2.7%) stddev-sans-first:2.13 15:59:55 INFO - PROCESS | 1685 | Values: 77.0 78.0 79.0 79.0 80.0 76.0 80.0 80.0 80.0 84.0 15:59:55 INFO - PROCESS | 1685 | 15:59:55 INFO - PROCESS | 1685 | [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:126.50 stddev:7.11 (5.6%) stddev-sans-first:7.54 15:59:55 INFO - PROCESS | 1685 | Values: 127.0 128.0 124.0 124.0 121.0 126.0 126.0 126.0 147.0 129.0 15:59:55 INFO - PROCESS | 1685 | 15:59:55 INFO - PROCESS | 1685 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.60 Median:167.50 stddev:23.21 (13.9%) stddev-sans-first:24.40 15:59:55 INFO - PROCESS | 1685 | Values: 168.0 166.0 164.0 162.0 167.0 166.0 162.0 214.0 226.0 171.0 15:59:55 INFO - PROCESS | 1685 | 15:59:55 INFO - PROCESS | 1685 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.50 stddev:1.08 (1.6%) stddev-sans-first:1.13 15:59:55 INFO - PROCESS | 1685 | Values: 66.0 67.0 66.0 66.0 67.0 66.0 65.0 67.0 66.0 69.0 15:59:55 INFO - PROCESS | 1685 | -------- Summary: end -------- 15:59:55 INFO - PROCESS | 1685 | 15:59:56 INFO - TEST-INFO | 1685: exit 0 15:59:56 INFO - TEST-OK | kraken | took 57976ms 15:59:56 INFO - SUITE-END | took 1171s 15:59:56 INFO - Completed test suite (00:19:32) 15:59:56 INFO - javascript benchmark 15:59:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3238.5951756030495, 3567.304375646747, 3575.767575107617, 3581.0689220802615, 3656.4149736042236, 5628.268325117729, 5654.886902261952, 5678.829635110943, 5686.3744988051285, 5687.260656114704, 5653.1237658162945, 5661.377248502661, 5673.205751194836, 5683.772649094041, 5691.459311365424, 5148.073346797575, 5193.246979188016, 5231.764570594313, 5283.788648454057, 5290.709011004393, 5230.660007099526, 5288.048151332759, 5300.257963885059, 5300.363956325227, 5302.655327403726, 4404.493483249419, 5268.789248430058, 5300.761465734051, 5315.601329900253, 5324.813631522898, 5303.575713942894, 5347.812826551091, 5348.893022139536, 5358.598105142091, 5394.406615272317, 5166.199239117943, 5171.327727395452, 5192.71440070796, 5268.81559145428, 5276.129438642658, 5591.245181900432, 5604.495595396393, 5609.579281553859, 5652.123920792284, 5653.0955047192665, 5710.600257981943, 6045.941960156999, 6258.780942666985, 6264.780732674334, 6283.214598175228, 6150.985087460564, 6195.814125576195, 6241.500679945593, 6250.468710159642, 6287.182666253403, 5874.853128671817, 5888.646681199141, 5922.378150294243, 5942.078977758454, 5961.731722072517, 6259.71831267594, 6281.3404592518045, 6283.37166283368, 6283.6858157091965, 6287.434130928238, 6083.239595050619, 6152.200213972155, 6154.5384096192965, 6162.969185154136, 6215.285242197205, 6172.722227499773, 6206.906896396557, 6257.186565746424, 6266.216722909637, 6295.276043254993, 6241.21984751906, 6255.343188965093, 6276.780312689125, 6280.089387038854, 6285.9057114143325, 6208.1308616793685, 6209.130721698965, 6279.152314437584, 6289.339619339995, 6299.6535190564955, 4939.580135688507, 4946.777395017233, 5006.89986200274, 5033.848984530397, 5050.722210278396, 4521.095780843844, 4521.751303678264, 4523.819047238139, 4552.7495987720995, 4561.771911404417, 5781.855453613609, 6001.2498437695285, 6001.759929602855, 6029.246344206974, 6034.63792172471, 5527.944720552823, 6104.298005729309, 6174.073888916699, 6262.499000079983, 6305.842353941096, 5984.401559843981, 6019.518438524995, 6021.277446706424, 6028.457438830438, 6041.456268935817, 5462.590305727086, 5468.64453810509, 5472.589555783332, 5489.945100548944, 5490.725463726798, 6355.237371515355, 6409.519286053472, 6495.935040649533, 6502.512311576746, 6505.902411463927, 6239.344868788712, 6252.9374706254175, 6255.124282600531, 6279.372062793684, 6282.748690052346, 6469.126667899774, 6483.0, 6487.837804054936, 6491.383318584727, 6519.967400162969, 6098.908516372347, 6183.165272688129, 6235.781747638811, 6248.375162483715, 6278.434940855345, 6239.188905442264, 6247.718852651551, 6258.342873998165, 6262.123302737529, 6278.4035516625845, 6017.157597936205, 6206.782762603287, 6208.503319734501, 6227.626342419469, 6240.219972503437, 6118.541109416722, 6179.3820617937845, 6206.162168107428, 6226.875462490815, 6331.588446750947, 6050.2437195350585, 6079.848003799941, 6101.389861013863, 6121.3572574879, 6122.357152498924, 6022.608530445507, 6112.663803490851, 6145.754169833157, 6190.81427557174, 6203.2245969253845, 6008.309044459943, 6028.758849645965, 6092.0, 6109.480694141048, 6130.111133885473], "value": 5766.649502341849, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [503.62228328753434, 527.6174773289365, 541.7020638648745, 546.5136028934247, 563.9379668236495, 32713.345733085323, 33535.16162095949, 39837.60162398375, 40540.58107966222, 40743.0, 44168.0, 44604.88487787807, 44624.21503139871, 44653.0, 45090.0, 9757.804843903117, 9935.602575896955, 9936.900630993707, 9953.402795832237, 9955.452450115241, 9260.166585007348, 12011.159218854684, 12275.140740148194, 12275.447604857804, 12306.81539776904, 11946.462409191563, 12031.759364812699, 12052.819207711891, 12058.819117713241, 12072.517099316017, 12038.81941770874, 12137.575184868532, 12142.696432589168, 12148.878511214863, 12154.5138194473, 11879.821802672966, 12036.277823330629, 12040.036797056215, 12043.976262017739, 12047.216930899463, 42824.57175428237, 43167.0, 43214.919627009265, 43238.78380608108, 43307.78346108281, 3271.803691778477, 3431.0564594736397, 3645.325614761251, 3701.130234394915, 4002.1595464952393, 29531.261718456997, 29969.70030299691, 30240.0, 30473.933412330683, 30635.38729225403, 2770.1051209188668, 2785.4986102501543, 2786.9827512957622, 2792.9720702792915, 2823.520001599733, 359099.0, 360279.0, 360431.0, 360928.19535902416, 361369.0, 37806.81096594499, 67714.98427523591, 68340.0, 68357.65821170862, 68581.0, 36758.44862327067, 36840.63159368372, 36855.07862303464, 36880.89357319285, 36968.26063478769, 16220.918895405448, 16525.33898644041, 16536.917315413346, 16554.42059527911, 16589.834101658827, 12940.935295323463, 13966.441342346396, 14032.08791428554, 14199.077059991068, 14225.64435889111, 8451.535165565952, 8455.308938212382, 8458.28104611115, 8537.359698022548, 8545.230929216275, 2982.2693440107314, 3468.791872487659, 3514.9297014059575, 3517.402041652925, 3542.051871470681, 933.6965486217007, 980.9705708828747, 1029.583018877356, 1035.6323505155713, 1055.171690223171, 31261.687383126333, 31374.52938205929, 31426.685733142833, 31617.0, 31884.0, 904.4876886417687, 1180.3390101543164, 1195.1275568834799, 1213.4842691855927, 1230.6861750253806, 11818.054555635528, 13352.732945341038, 15228.695426091415, 15852.920735396248, 16041.138768818144, 629841.0, 642307.0, 642659.0, 642872.0, 643709.0, 63810.40473988095, 65268.34731652718, 65322.67338663276, 65345.01982470267, 65582.0, 1425.978610320846, 1485.376142020354, 1538.8999715018488, 1552.154076028567, 1560.7034663413915, 29681.109566713032, 30705.0, 31155.844220778752, 31341.52987705232, 31362.843185783924, 54274.0, 55239.0, 55341.0, 55361.72319138378, 55479.445205547425, 454389.0, 475840.0, 477127.0, 477751.0, 478057.0, 37657.0, 45249.77375113235, 45321.0, 45938.540614593425, 46621.766891166684, 48225.276620851415, 49652.75173624109, 50392.24411633902, 50706.74646626743, 50821.22125725582, 30999.69000309968, 39883.604073858434, 40969.0, 41607.58392416158, 41750.79124604358, 39643.603563965145, 40025.0, 40154.59845401509, 41252.38121428241, 41459.7927010363, 40272.798636006635, 40468.0, 40474.39288410617, 40523.0, 40983.59016409798, 34067.82966085154, 34362.656373435944, 34903.82548087243, 35179.648203518664, 35291.117722057155, 26071.17864640638, 26113.608295875198, 26377.868110659325, 26494.205173844817, 26751.598726019514], "value": 19765.82801086314, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.6640754581244, 410.0589147905557, 411.6830040868533, 416.1967402912378, 420.18274456182735, 16027.278772455238, 21025.264115755952, 21724.89137554314, 21733.0, 21752.456188595293, 19958.20167193314, 20711.896440517816, 21408.92955352234, 21558.0, 22630.54738905225, 4838.346823178878, 6068.969655151718, 6242.656653884034, 6249.468795152417, 6258.687065646723, 6150.0, 6175.6294622322575, 6184.226971628546, 6191.566590338678, 6193.876122477548, 3646.7994260315672, 5933.5549833762425, 6212.347703491136, 6220.253569571658, 6223.906641400383, 6140.232470941132, 6194.349593292684, 6197.504199664016, 6199.4110559497, 6213.099100630406, 5900.881982360372, 6042.5165986721395, 6070.2108725865355, 6081.17904082952, 6090.147379366892, 14101.78847317291, 14359.641008974859, 21739.0, 27225.0, 27254.863725681444, 2168.544605632819, 2249.662550617404, 2422.4186195313173, 2930.9706902931125, 2936.3393236521824, 10090.949545252226, 10167.89832101677, 10396.220283478693, 10474.685759427153, 10836.729081772939, 1810.5292623917744, 1850.380122658911, 1868.5795695968297, 1914.339552854263, 1956.5108722819296, 115094.0, 115548.0, 117776.0, 119026.21460678011, 119729.0, 11678.76642467146, 11738.70653233659, 11746.0, 11792.9927868393, 11798.331880990912, 14012.089214201249, 14508.854911450962, 14568.635784105481, 15444.45944391941, 15492.07047577149, 8795.912040879637, 9140.54297285133, 9184.403013804214, 9272.211861991806, 9303.674371397105, 8308.626111824982, 8824.691135810215, 9233.399829011227, 9254.50128465324, 9302.86045709315, 3920.3923391874305, 4737.549932756383, 4772.472808701252, 4831.9275210871865, 4863.732494712754, 1983.4545499987619, 2034.5523984723336, 2045.3966080006435, 2048.7643920948985, 2069.813716765498, 894.7986702991775, 945.2768631996528, 956.1108169402384, 1029.7899967538112, 1036.383351905615, 20596.691049634268, 20866.0, 21303.78696213049, 21723.13107475683, 21877.453063673536, 1012.9189664826796, 1034.234666346913, 1037.8806437259811, 1039.1063685230695, 1080.4111759091313, 8952.597133129026, 11205.60780372683, 11486.712832179262, 11506.654800356002, 11542.480588373543, 641691.0, 642888.0, 652443.0, 653478.7326063435, 658457.0, 119128.0, 123373.0, 124958.0, 127139.36430317974, 133499.0, 1040.6877936618985, 1103.6027030269258, 1112.8163852964333, 1115.2694984784978, 1117.620009196877, 18973.33593324227, 18988.810111898703, 19103.904480477508, 19791.802081978996, 20057.29799457012, 56608.71695641495, 57377.85244295174, 57463.0, 58384.4161558379, 59478.70260648842, 61938.0, 78279.04302392485, 82760.58619706862, 83099.0, 84230.0, 8204.302634276153, 8412.62143203545, 8424.83150337002, 8545.316374689886, 8734.388592798443, 12540.184887982252, 12822.0, 12917.61247162549, 13142.868571314548, 13153.342332883127, 11163.88836111661, 11378.601748939078, 11494.942525287655, 11547.711307217387, 11613.941930290295, 11257.662270131908, 11351.035162011322, 11405.828912566152, 11469.922123331202, 11498.0, 11222.0, 11340.94329528347, 11459.989003848586, 11640.417979101181, 11951.641450756491, 8251.711190108557, 8356.456830306011, 8515.659373624985, 8535.53054582004, 8713.695020674246, 8016.959915200387, 11413.486393112164, 11423.371714555778, 11635.360055197045, 11804.881951180378], "value": 9877.512506082458, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1508.8717459015984, 1620.3842539834864, 1651.8182999870012, 1902.5433895864987, 2012.2856385982984, 8274.66901323947, 8908.910910890889, 9069.365144439875, 9093.13615206556, 9108.225800806931, 8714.346424018193, 9049.819003619923, 9055.094490550942, 9060.728178154666, 9071.773205669862, 2536.6575512305835, 2562.1032638576535, 2570.241778675286, 2573.240893936293, 2575.1115865026536, 2499.562576549106, 2544.134994102005, 2548.2227920484247, 2553.6041913503345, 2559.5264875997905, 2489.539435204484, 2515.220281712675, 2524.00301880757, 2527.9620805687928, 2533.240027991604, 2099.9160033598637, 2523.3060908250286, 2542.6694529711112, 2556.821022528424, 2567.460833225025, 2489.4647650755173, 2524.0913271222344, 2533.961990570143, 2537.6320433537217, 2543.987280063588, 8760.518171500566, 8920.776980575472, 9124.680636177702, 9126.361154719172, 9213.2168765655, 5589.944100558983, 5760.135979603051, 5807.477327040587, 5819.709014549256, 5820.912686309709, 3282.868685252587, 3534.9469757953652, 3683.557973043252, 3732.7387082904206, 3738.476613274144, 1049.601151562409, 1067.1889364083274, 1085.7991271614776, 1088.542812018954, 1092.1699508373613, 12199.0, 12464.750704985849, 12467.75064498714, 12487.937560312232, 12488.687782805411, 4735.21868891629, 4751.524847515221, 4840.467548569654, 4871.318015477836, 4879.853604391874, 9652.22782177424, 9654.420734755797, 9671.854922176173, 9704.417734935927, 9731.221502279801, 5557.5831812614215, 5584.0, 5603.7478313475995, 5610.915836262459, 5624.184493248456, 4610.561996610317, 4711.52884711533, 5047.848564543069, 5166.199239117943, 5216.035033518811, 3850.403187505941, 3909.0, 3972.2651309507255, 4070.470838790938, 4111.506619205715, 1246.9625911222497, 1280.2638482872385, 1287.414226526928, 1293.8447386313703, 1295.475332490343, 863.9395242333102, 956.0726095687172, 968.9951550242204, 979.8138353712772, 1015.1320620869199, 5959.463648271676, 6123.295820980555, 6149.631022138686, 6162.599431036968, 6208.844778880564, 477.9091972525209, 483.74603333250326, 486.3288661646975, 1027.291169093323, 1037.444966942682, 3454.188265757595, 3902.3561112416132, 4016.136530645925, 4053.4527838741983, 4080.7755573443746, 10676.306040107369, 11102.389368584643, 11132.0, 11135.220534562664, 11142.331460112418, 10708.03627673513, 10990.615328463466, 11097.44512774358, 11097.611583594535, 11126.332420054823, 8550.144985501525, 8617.267532259702, 8727.65089396417, 8758.912410875937, 8784.736457906272, 5145.434002259673, 5911.467967882912, 5959.986802243542, 5986.730597123227, 6008.939910600838, 9510.809783804423, 9604.327697061139, 9788.608455661693, 9973.252006099427, 10268.589256429957, 9878.357906736039, 9900.455474948947, 9927.751806204613, 10070.395776253448, 10101.646442374482, 7551.773446796605, 7600.429967752551, 7636.923630763621, 7737.883931741141, 7768.0, 8390.622421990904, 8433.156684331518, 8499.107593702573, 8500.70247541333, 8502.659893604186, 7485.214052524407, 7512.21121782205, 7658.502197357377, 7660.310572048543, 7847.489913155627, 7381.188069312264, 7485.438592105723, 7495.850082998419, 7595.240475952361, 7625.275598818103, 7110.502264841618, 7134.928650713427, 7163.570185788869, 7184.425245980205, 7190.137183538009, 4564.566366195206, 4759.95281038171, 4870.0, 4912.680675756064, 5094.083065048327, 5089.440161582297, 5144.742762861917, 5156.922646160236, 5208.401033881, 5327.520523152934], "value": 4694.68858381342, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.3174859788835, 334.8208708341038, 338.90849470642934, 346.0621715151938, 348.7680692339594, 6491.0, 6561.409473147416, 6564.081028655992, 6580.572262802914, 6592.835179120524, 6429.935700642992, 6433.067205255235, 6441.516886233528, 6445.90419628663, 6472.385123413268, 4594.517575654559, 4737.242041273397, 4765.404324459442, 4827.734474603895, 4849.393825771778, 4811.350467686852, 4874.97562512187, 4890.24201248807, 4893.902121957559, 4900.58345040672, 4843.273508973647, 4847.175980083377, 4851.490593487668, 4854.499932534747, 4869.245266983606, 3681.355762741523, 4711.222648263032, 4772.926091629391, 4788.4253889533475, 4797.808087676489, 4031.1937612477623, 4140.875773726793, 4140.958590414118, 4144.046869220097, 4148.253314403406, 5549.418415751532, 5688.203651488795, 6093.421124993119, 6191.7926004429155, 6195.2255968004, 5028.673136246132, 5298.443663415363, 5706.914396284059, 5712.371639119693, 5716.0, 6923.619200943946, 6926.099607051102, 6932.445404367639, 6958.547694399847, 6964.651767411609, 4350.129974005212, 4494.640428765723, 4515.706479078882, 4529.139463501924, 4529.932051019237, 7045.436365090781, 7198.0, 7223.638818059076, 7231.855362892766, 7286.635668216621, 4620.699654522446, 4643.071385722869, 4643.582077612963, 4644.628429725613, 4645.628349732014, 4689.882752931136, 4692.366530518337, 4698.083873644675, 4702.57676809082, 4702.965347623517, 5618.747156377973, 5623.690697011703, 5630.71846407678, 5638.633488823213, 5644.74598643062, 6648.96675516629, 6886.586804791728, 6902.344277293649, 6908.896366554506, 6966.0, 1600.3998500562288, 1619.7165496038147, 1630.7635392868206, 1635.5992781768543, 1635.6156303268722, 845.6763688094039, 1013.5236438873718, 1040.0535512683573, 1042.910158883968, 1045.6915210013065, 6409.903851442232, 6619.635920024445, 6657.300983396771, 6689.1972963244725, 6695.531312808057, 7017.754378596725, 7163.820904477429, 7165.641717914188, 7176.246494118147, 7196.820079498055, 6642.368974947372, 6654.201495820435, 6713.932860671429, 6735.057092007123, 6746.662666866637, 3167.160702413862, 3784.848606055782, 3790.3745881929726, 3827.0432391902023, 3832.0419895026243, 7460.142083660448, 7734.690612375442, 7755.844883102306, 7772.961135194288, 7818.960905195438, 7415.3326200642205, 7434.739784107638, 7442.106947166375, 7450.515716478411, 7502.2122677119205, 7750.689972401041, 7753.728619498291, 7766.456348055582, 7773.5724535149975, 7779.8833017504785, 7144.64276786169, 7210.134783825974, 7212.8918066228, 7227.49407541467, 7237.203907570269, 5886.0, 6776.86446271062, 7080.575165490087, 7088.04311417952, 7095.325944035309, 7698.923010770045, 7739.690412383667, 7740.148583655906, 7764.456488045783, 7786.33816125613, 4607.746573938465, 4615.007773328751, 4621.745803980813, 4627.6066534344955, 4630.930536042029, 7163.570185788869, 7179.389751871149, 7186.748463803742, 7209.855802883808, 7213.71145154188, 6692.397684208445, 6920.861582768417, 6953.0, 6962.164540255202, 6968.616726080114, 5603.215549822947, 6909.79270621862, 6922.926946323328, 6944.166699995831, 6946.16646002483, 5492.231087647652, 5554.250176226158, 6779.93220067793, 6787.01588269708, 6799.694013769294, 6921.550099243533, 6935.375816176568, 6941.132358455193, 6943.236244013054, 6958.338957799001, 6489.351064893662, 6585.670716464253, 6822.8635427292165, 6823.249442561413, 6832.965835170792], "value": 5084.9129065699735, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.8023592922123, 711.1643818513246, 753.2542782645183, 768.7347864986577, 819.1439945257204, 15220.315085821137, 15434.768478472832, 15609.92195039026, 15624.218789060544, 15628.531144065682, 14285.0, 14451.638709032279, 14454.638634034129, 14459.855401445982, 14477.63805904853, 798.0901771979948, 811.3022800391658, 956.9712908612736, 964.6334392930677, 971.2763990826844, 988.0613417253602, 991.4497453913075, 992.8312186928204, 993.2600212841443, 997.1574019953129, 1041.9374837509774, 1042.8487869258952, 1043.6242952537082, 1045.430240518919, 1047.4029803012247, 814.2468216899374, 1012.8379459286479, 1036.4092467293647, 1037.7198156497702, 1037.8495118207893, 771.5987686403039, 772.3473664753275, 775.329340120797, 775.4920527054788, 776.3362325211918, 14862.182579958098, 15244.23778811055, 15259.08445493274, 15269.847301527065, 15285.235738213045, 12714.838477458854, 12738.0, 12831.615051548468, 13004.154729942524, 13264.801027984588, 10194.388336699747, 10224.897751022543, 10516.369017858877, 10533.052025317682, 10644.201684873588, 3525.1715846775987, 3564.0, 3568.7323450741037, 3631.94552081719, 3819.0643292393265, 78406.0, 78727.21272787314, 79452.41095178122, 80018.0, 80194.0, 9488.667896623585, 9587.952060239653, 9626.229901607854, 9685.612575496902, 9755.317127801127, 21583.56832863334, 21761.455963601038, 21813.345599632037, 21822.45443863916, 22324.10703571839, 7581.6209189540305, 7582.658780354897, 7722.498037627536, 7785.571793551409, 8004.07953085391, 4202.243596152661, 4215.557366476476, 4221.894452638647, 4251.319788833772, 4263.573642635712, 3719.6466335698065, 3743.6256374362893, 3780.3006443807985, 3785.6592906638534, 3785.716071294609, 580.2051189869906, 686.8385929306609, 689.4553302890661, 703.8592281543712, 727.29089138091, 539.6222644149111, 542.2219115569171, 603.3694788945562, 605.1860247966478, 616.8735409241095, 7734.7679569613, 8008.935219657484, 8122.75631731049, 8262.958685206655, 8434.367422443342, 503.97732102055494, 540.065686362587, 546.4535464535464, 596.0969131765379, 602.5631417222479, 3788.124878185261, 3841.2893614681375, 3860.6911447084167, 3922.3332033554366, 4069.877903662895, 92727.07272927319, 93920.0, 95307.57038644426, 95413.61465963407, 95436.52281738547, 66044.01867943969, 75151.62424187953, 75496.0, 75733.621331893, 77396.61301693456, 64619.0, 70580.6470967642, 71232.0, 71364.28635713784, 72076.0, 7631.3894888407685, 7795.883061754192, 7903.802404939923, 8365.498070115813, 8390.916090839013, 47474.52525474701, 47624.761876190394, 47758.76120619375, 48405.0, 49611.751941240065, 64822.0, 68550.65724671345, 70065.89802305939, 70434.29565704483, 71127.28872711207, 10980.450977451255, 11072.97120907896, 11169.553217871518, 11367.43162841838, 11639.709007274547, 11928.257366253396, 11994.0, 12084.45619947122, 12176.939115304367, 12571.49714011466, 11268.38023908693, 11535.192536522363, 11651.168784820775, 11891.345975971404, 11954.940225298818, 11562.4441487779, 11573.305601663928, 11679.474423651127, 11871.169018168644, 12066.577669781516, 11064.723381915195, 11192.552297908318, 11314.0, 11633.59282425111, 11757.529698812294, 9648.71053868385, 9750.756231093996, 9914.670052537504, 10087.04173103554, 10229.795404092025, 9508.286878484003, 9607.855882161914, 9655.372400794207, 9679.70960871175, 9733.561989710339], "value": 7046.519440787526, "unit": "score"}], "name": "dromaeo_css", "value": 7578.175806713679, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 121.0, 113.0, 112.0, 112.0, 114.0, 114.0, 115.0, 137.0], "value": 116.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 121.0, 143.0, 163.0, 113.0, 139.0, 118.0, 152.0, 159.0, 115.0], "value": 137.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 185.0, 185.0, 186.0, 193.0, 264.0, 210.0, 184.0, 186.0], "value": 196.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 75.0, 102.0, 188.0, 83.0, 55.0, 57.0, 58.0, 130.0, 55.0], "value": 87.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 143.0, 78.0, 77.0, 80.0, 123.0, 80.0, 79.0, 123.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 91.0, 88.0, 90.0, 86.0, 90.0, 88.0, 91.0, 87.0], "value": 88.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 94.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 84.0, 84.0, 83.0, 93.0, 130.0, 133.0, 87.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 62.0, 62.0, 61.0, 62.0, 62.0, 64.0, 78.0, 60.0, 56.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 69.0, 75.0, 74.0, 70.0, 69.0, 68.0, 68.0, 67.0], "value": 68.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 79.0, 79.0, 80.0, 76.0, 80.0, 80.0, 80.0, 84.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 128.0, 124.0, 124.0, 121.0, 126.0, 126.0, 126.0, 147.0, 129.0], "value": 127.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 164.0, 162.0, 167.0, 166.0, 162.0, 214.0, 226.0, 171.0], "value": 176.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 67.0, 66.0, 65.0, 67.0, 66.0, 69.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1494.3999999999999, "alertThreshold": 2.0}]} 15:59:56 INFO - Return code: 0 15:59:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:59:56 ERROR - # TBPL SUCCESS # 15:59:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:59:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:59:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:59:56 INFO - 2016-07-07 15:59:56.709 screenresolution[1689:10117] starting screenresolution argv=screenresolution get 15:59:56 INFO - 2016-07-07 15:59:56.712 screenresolution[1689:10117] Display 0: 1600x1200x32@60 15:59:56 INFO - 2016-07-07 15:59:56.718 screenresolution[1690:10120] starting screenresolution argv=screenresolution list 15:59:56 INFO - Available Modes on Display 0 15:59:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:59:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:59:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:59:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:59:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:59:56 INFO - Intel Iris: 15:59:56 INFO - Chipset Model: Intel Iris 15:59:56 INFO - Type: GPU 15:59:56 INFO - Bus: Built-In 15:59:56 INFO - VRAM (Dynamic, Max): 1536 MB 15:59:56 INFO - Vendor: Intel (0x8086) 15:59:56 INFO - Device ID: 0x0a2e 15:59:56 INFO - Revision ID: 0x0009 15:59:56 INFO - Displays: 15:59:56 INFO - Display: 15:59:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:59:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:59:56 INFO - Display Serial Number: 1600x1200 60 15:59:56 INFO - Main Display: Yes 15:59:56 INFO - Mirror: Off 15:59:56 INFO - Online: Yes 15:59:56 INFO - Rotation: Supported 15:59:56 INFO - Return code: 0 15:59:56 INFO - Running post-action listener: _resource_record_post_action 15:59:56 INFO - Running post-run listener: _resource_record_post_run 15:59:58 INFO - Total resource usage - Wall time: 1196s; CPU: 53.0%; Read bytes: 31706624; Write bytes: 494947840; Read time: 194; Write time: 1508 15:59:58 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 185555456; Write bytes: 186898432; Read time: 17217; Write time: 387 15:59:58 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 30785024; Write bytes: 298096128; Read time: 183; Write time: 1085 15:59:58 INFO - Running post-run listener: _upload_blobber_files 15:59:58 INFO - Blob upload gear active. 15:59:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:59:58 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 15:59:58 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'] 15:59:58 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 15:59:58 INFO - (blobuploader) - INFO - Open directory for files ... 15:59:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:59:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:59:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:59:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:59:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:59:59 INFO - (blobuploader) - INFO - Done attempting. 15:59:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:59:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:59:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:00:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:00 INFO - (blobuploader) - INFO - Done attempting. 16:00:00 INFO - (blobuploader) - INFO - Iteration through files over. 16:00:00 INFO - Return code: 0 16:00:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:00:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:00:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b87b7cde551fe680478f8e7e3ea89edaf5898950272e765acc847e4e8d0a0df15493b584879b15aaa25595ae044b25bcb99a1dbd2141852453a91a9d97bb5423", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e6611c05214e39804d9d0aeecf3b5ae9a545a053bdf85b1152cb2336bd45f80b569273b3a1d8d45ed5558207a26a1713f29aee844fc9272f79a267eb062a8721"} 16:00:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:00:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:00:00 INFO - Contents: 16:00:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b87b7cde551fe680478f8e7e3ea89edaf5898950272e765acc847e4e8d0a0df15493b584879b15aaa25595ae044b25bcb99a1dbd2141852453a91a9d97bb5423", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e6611c05214e39804d9d0aeecf3b5ae9a545a053bdf85b1152cb2336bd45f80b569273b3a1d8d45ed5558207a26a1713f29aee844fc9272f79a267eb062a8721"} 16:00:00 INFO - Running post-run listener: copy_logs_to_upload_dir 16:00:00 INFO - Copying logs to upload dir... 16:00:00 INFO - mkdir: /builds/slave/test/build/upload/logs 16:00:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.404097 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-07 16:00:00.837721) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 16:00:00.841427) ========= 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.w7pQa17GnI/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.LkDeL8tmIi/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b87b7cde551fe680478f8e7e3ea89edaf5898950272e765acc847e4e8d0a0df15493b584879b15aaa25595ae044b25bcb99a1dbd2141852453a91a9d97bb5423", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e6611c05214e39804d9d0aeecf3b5ae9a545a053bdf85b1152cb2336bd45f80b569273b3a1d8d45ed5558207a26a1713f29aee844fc9272f79a267eb062a8721"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011116 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b87b7cde551fe680478f8e7e3ea89edaf5898950272e765acc847e4e8d0a0df15493b584879b15aaa25595ae044b25bcb99a1dbd2141852453a91a9d97bb5423", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e6611c05214e39804d9d0aeecf3b5ae9a545a053bdf85b1152cb2336bd45f80b569273b3a1d8d45ed5558207a26a1713f29aee844fc9272f79a267eb062a8721"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 16:00:00.874441) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 16:00:00.874782) ========= 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.w7pQa17GnI/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.LkDeL8tmIi/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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.004974 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 16:00:00.922936) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 16:00:00.923280) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 16:00:00.923640) ========= ========= Total master_lag: 0.17 =========