builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-058 starttime: 1480428964.33 results: success (0) buildid: 20161129030527 builduid: 1be287e02bc841eb8560ba3cc9f4181a revision: 6f79cece26e953c7d7d5f8b09241b7b3cdd71602 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 06:16:04.332504) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 06:16:04.332912) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 06:16:04.333181) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 06:16:04.384648) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 06:16:04.385028) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1480428738.166064-180361810 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-29 06:16:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.7M=0s 2016-11-29 06:16:04 (35.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.141433 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 06:16:04.575294) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 06:16:04.575664) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1480428738.166064-180361810 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015731 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 06:16:04.625442) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 06:16:04.625845) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6f79cece26e953c7d7d5f8b09241b7b3cdd71602 --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 6f79cece26e953c7d7d5f8b09241b7b3cdd71602 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1480428738.166064-180361810 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-29 06:16:04,914 truncating revision to first 12 chars 2016-11-29 06:16:04,914 Setting DEBUG logging. 2016-11-29 06:16:04,914 attempt 1/10 2016-11-29 06:16:04,914 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6f79cece26e9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-29 06:16:05,209 unpacking tar archive at: mozilla-beta-6f79cece26e9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.694963 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 06:16:05.334437) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 06:16:05.334787) ========= script_repo_revision: 6f79cece26e953c7d7d5f8b09241b7b3cdd71602 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 06:16:05.335183) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 06:16:05.335453) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 06:16:05.344543) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-29 06:16:05.344856) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_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/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1480428738.166064-180361810 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:16:05 INFO - MultiFileLogger online at 20161129 06:16:05 in /builds/slave/test 06:16:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 06:16:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:16:05 INFO - {'append_to_log': False, 06:16:05 INFO - 'base_work_dir': '/builds/slave/test', 06:16:05 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:16:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:16:05 INFO - 'branch': 'Mozilla-Beta', 06:16:05 INFO - 'buildbot_json_path': 'buildprops.json', 06:16:05 INFO - 'config_files': ('talos/linux_config.py',), 06:16:05 INFO - 'default_actions': ('clobber', 06:16:05 INFO - 'read-buildbot-config', 06:16:05 INFO - 'download-and-extract', 06:16:05 INFO - 'populate-webroot', 06:16:05 INFO - 'create-virtualenv', 06:16:05 INFO - 'install', 06:16:05 INFO - 'run-tests'), 06:16:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:16:05 INFO - 'download_minidump_stackwalk': True, 06:16:05 INFO - 'download_symbols': 'ondemand', 06:16:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:16:05 INFO - 'tooltool.py': '/tools/tooltool.py', 06:16:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:16:05 INFO - '/tools/misc-python/virtualenv.py')}, 06:16:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:16:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:16:05 INFO - 'installer_path': 'installer.exe', 06:16:05 INFO - 'log_level': 'info', 06:16:05 INFO - 'log_name': 'talos', 06:16:05 INFO - 'log_to_console': True, 06:16:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:16:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:16:05 INFO - 'opt_config_files': (), 06:16:05 INFO - 'pip_index': False, 06:16:05 INFO - 'sps_profile': False, 06:16:05 INFO - 'sps_profile_interval': 0, 06:16:05 INFO - 'suite': 'dromaeojs', 06:16:05 INFO - 'system_bits': '32', 06:16:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:16:05 INFO - 'title': 'talos-linux64-ix-058', 06:16:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:16:05 INFO - 'use_talos_json': True, 06:16:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:16:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:16:05 INFO - 'work_dir': 'build'} 06:16:05 INFO - [mozharness: 2016-11-29 14:16:05.834406Z] Running clobber step. 06:16:05 INFO - Running pre-action listener: _resource_record_pre_action 06:16:05 INFO - Running main action method: clobber 06:16:05 INFO - rmtree: /builds/slave/test/build 06:16:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:16:06 INFO - Running post-action listener: _resource_record_post_action 06:16:06 INFO - [mozharness: 2016-11-29 14:16:06.255925Z] Finished clobber step (success) 06:16:06 INFO - [mozharness: 2016-11-29 14:16:06.256027Z] Running read-buildbot-config step. 06:16:06 INFO - Running pre-action listener: _resource_record_pre_action 06:16:06 INFO - Running main action method: read_buildbot_config 06:16:06 INFO - Using buildbot properties: 06:16:06 INFO - { 06:16:06 INFO - "project": "", 06:16:06 INFO - "product": "firefox", 06:16:06 INFO - "script_repo_revision": "production", 06:16:06 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 06:16:06 INFO - "repository": "", 06:16:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 06:16:06 INFO - "buildid": "20161129030527", 06:16:06 INFO - "pgo_build": "True", 06:16:06 INFO - "basedir": "/builds/slave/test", 06:16:06 INFO - "buildnumber": 481, 06:16:06 INFO - "slavename": "talos-linux64-ix-058", 06:16:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:16:06 INFO - "platform": "ubuntu64_hw", 06:16:06 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 06:16:06 INFO - "branch": "mozilla-beta", 06:16:06 INFO - "repo_path": "releases/mozilla-beta", 06:16:06 INFO - "revision": "6f79cece26e953c7d7d5f8b09241b7b3cdd71602", 06:16:06 INFO - "stage_platform": "linux64-pgo", 06:16:06 INFO - "builduid": "1be287e02bc841eb8560ba3cc9f4181a", 06:16:06 INFO - "slavebuilddir": "test" 06:16:06 INFO - } 06:16:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/CBWTwKIgSb-Wfyo8iik6Mw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2. 06:16:06 INFO - Running post-action listener: _resource_record_post_action 06:16:06 INFO - [mozharness: 2016-11-29 14:16:06.258492Z] Finished read-buildbot-config step (success) 06:16:06 INFO - [mozharness: 2016-11-29 14:16:06.258581Z] Running download-and-extract step. 06:16:06 INFO - Running pre-action listener: _resource_record_pre_action 06:16:06 INFO - Running main action method: download_and_extract 06:16:06 INFO - mkdir: /builds/slave/test/build/tests 06:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:06 INFO - trying https://queue.taskcluster.net/v1/task/CBWTwKIgSb-Wfyo8iik6Mw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 06:16:06 INFO - Downloading https://queue.taskcluster.net/v1/task/CBWTwKIgSb-Wfyo8iik6Mw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 06:16:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CBWTwKIgSb-Wfyo8iik6Mw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:16:06 INFO - Downloaded 1327 bytes. 06:16:06 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.test_packages.json 06:16:06 INFO - Using the following test package requirements: 06:16:06 INFO - {u'common': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 06:16:06 INFO - u'cppunittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 06:16:06 INFO - u'firefox-51.0.en-US.linux-x86_64.cppunittest.tests.zip'], 06:16:06 INFO - u'gtest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 06:16:06 INFO - u'firefox-51.0.en-US.linux-x86_64.gtest.tests.zip'], 06:16:06 INFO - u'jittest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 06:16:06 INFO - u'jsshell-linux-x86_64.zip'], 06:16:06 INFO - u'mochitest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 06:16:06 INFO - u'firefox-51.0.en-US.linux-x86_64.mochitest.tests.zip'], 06:16:06 INFO - u'mozbase': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'], 06:16:06 INFO - u'reftest': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 06:16:06 INFO - u'firefox-51.0.en-US.linux-x86_64.reftest.tests.zip'], 06:16:06 INFO - u'talos': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 06:16:06 INFO - u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'], 06:16:06 INFO - u'web-platform': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 06:16:06 INFO - u'firefox-51.0.en-US.linux-x86_64.web-platform.tests.zip'], 06:16:06 INFO - u'xpcshell': [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', 06:16:06 INFO - u'firefox-51.0.en-US.linux-x86_64.xpcshell.tests.zip']} 06:16:06 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:16:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CBWTwKIgSb-Wfyo8iik6Mw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 06:16:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CBWTwKIgSb-Wfyo8iik6Mw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:16:06 INFO - Fetch https://queue.taskcluster.net/v1/task/CBWTwKIgSb-Wfyo8iik6Mw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 06:16:07 INFO - Expected file size: 21963808 06:16:11 INFO - Downloading packages: [u'firefox-51.0.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:16:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CBWTwKIgSb-Wfyo8iik6Mw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip 06:16:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CBWTwKIgSb-Wfyo8iik6Mw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:16:11 INFO - Fetch https://queue.taskcluster.net/v1/task/CBWTwKIgSb-Wfyo8iik6Mw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.common.tests.zip into memory 06:16:12 INFO - Expected file size: 21963808 06:16:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CBWTwKIgSb-Wfyo8iik6Mw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip 06:16:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CBWTwKIgSb-Wfyo8iik6Mw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:16:17 INFO - Fetch https://queue.taskcluster.net/v1/task/CBWTwKIgSb-Wfyo8iik6Mw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.talos.tests.zip into memory 06:16:18 INFO - Expected file size: 14414089 06:16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:18 INFO - trying https://queue.taskcluster.net/v1/task/CBWTwKIgSb-Wfyo8iik6Mw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 06:16:18 INFO - Downloading https://queue.taskcluster.net/v1/task/CBWTwKIgSb-Wfyo8iik6Mw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 06:16:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CBWTwKIgSb-Wfyo8iik6Mw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:16:19 INFO - Downloaded 56957142 bytes. 06:16:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CBWTwKIgSb-Wfyo8iik6Mw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 06:16:19 INFO - mkdir: /builds/slave/test/properties 06:16:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:16:19 INFO - Writing to file /builds/slave/test/properties/build_url 06:16:19 INFO - Contents: 06:16:19 INFO - build_url:https://queue.taskcluster.net/v1/task/CBWTwKIgSb-Wfyo8iik6Mw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 06:16:20 INFO - Running post-action listener: _resource_record_post_action 06:16:20 INFO - Running post-action listener: set_extra_try_arguments 06:16:20 INFO - [mozharness: 2016-11-29 14:16:20.841476Z] Finished download-and-extract step (success) 06:16:20 INFO - [mozharness: 2016-11-29 14:16:20.841709Z] Running populate-webroot step. 06:16:20 INFO - Running pre-action listener: _resource_record_pre_action 06:16:20 INFO - Running main action method: populate_webroot 06:16:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:16:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:16:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:16:20 INFO - '--tppagecycles', 06:16:20 INFO - '7'], 06:16:20 INFO - 'tests': ['tsvgm']}}, 06:16:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:16:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:16:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:16:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:16:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:16:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:16:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:16:20 INFO - 'talos_options': ['--disable-e10s'], 06:16:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:16:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:16:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:16:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:16:20 INFO - 'talos_options': ['--disable-e10s'], 06:16:20 INFO - 'tests': ['damp', 'tps']}, 06:16:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:16:20 INFO - 'tests': ['damp', 'tps']}, 06:16:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:16:20 INFO - 'tests': ['dromaeo_dom']}, 06:16:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:16:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:16:20 INFO - 'tests': ['basic_compositor_video']}, 06:16:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:16:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:16:20 INFO - 'tests': ['a11yr', 06:16:20 INFO - 'ts_paint', 06:16:20 INFO - 'tpaint', 06:16:20 INFO - 'sessionrestore', 06:16:20 INFO - 'sessionrestore_no_auto_restore', 06:16:20 INFO - 'tabpaint']}, 06:16:20 INFO - 'other-e10s': {'tests': ['a11yr', 06:16:20 INFO - 'ts_paint', 06:16:20 INFO - 'tpaint', 06:16:20 INFO - 'sessionrestore', 06:16:20 INFO - 'sessionrestore_no_auto_restore', 06:16:20 INFO - 'tabpaint']}, 06:16:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:16:20 INFO - 'ts_paint', 06:16:20 INFO - 'tpaint', 06:16:20 INFO - 'sessionrestore', 06:16:20 INFO - 'sessionrestore_no_auto_restore', 06:16:20 INFO - 'tabpaint']}, 06:16:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:16:20 INFO - 'ts_paint', 06:16:20 INFO - 'tpaint', 06:16:20 INFO - 'sessionrestore', 06:16:20 INFO - 'sessionrestore_no_auto_restore', 06:16:20 INFO - 'tabpaint']}, 06:16:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:16:20 INFO - 'tests': ['a11yr', 06:16:20 INFO - 'ts_paint', 06:16:20 INFO - 'tpaint', 06:16:20 INFO - 'sessionrestore', 06:16:20 INFO - 'sessionrestore_no_auto_restore', 06:16:20 INFO - 'tabpaint']}, 06:16:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:16:20 INFO - 'tests': ['a11yr', 06:16:20 INFO - 'ts_paint', 06:16:20 INFO - 'tpaint', 06:16:20 INFO - 'sessionrestore', 06:16:20 INFO - 'sessionrestore_no_auto_restore', 06:16:20 INFO - 'tabpaint']}, 06:16:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:16:20 INFO - 'tests': ['tsvgx', 06:16:20 INFO - 'tsvgr_opacity', 06:16:20 INFO - 'tart', 06:16:20 INFO - 'tscrollx', 06:16:20 INFO - 'cart']}, 06:16:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:16:20 INFO - 'tsvgr_opacity', 06:16:20 INFO - 'tart', 06:16:20 INFO - 'tscrollx', 06:16:20 INFO - 'cart']}, 06:16:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:16:20 INFO - 'talos_options': ['--disable-e10s'], 06:16:20 INFO - 'tests': ['tp5o']}, 06:16:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:16:20 INFO - 'tests': ['tp5o']}, 06:16:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:16:20 INFO - 'talos_options': ['--disable-e10s', 06:16:20 INFO - '--xperf_path', 06:16:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:16:20 INFO - 'tests': ['tp5n']}, 06:16:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:16:20 INFO - 'talos_options': ['--xperf_path', 06:16:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:16:20 INFO - 'tests': ['tp5n']}}, 06:16:20 INFO - 'talos.zip': {'path': '', 06:16:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:16:20 INFO - Running post-action listener: _resource_record_post_action 06:16:20 INFO - [mozharness: 2016-11-29 14:16:20.862551Z] Finished populate-webroot step (success) 06:16:20 INFO - [mozharness: 2016-11-29 14:16:20.862645Z] Running create-virtualenv step. 06:16:20 INFO - Running pre-action listener: _resource_record_pre_action 06:16:20 INFO - Running main action method: create_virtualenv 06:16:20 INFO - Creating virtualenv /builds/slave/test/build/venv 06:16:20 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 06:16:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:16:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:16:21 INFO - Using real prefix '/usr' 06:16:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:16:21 INFO - Installing distribute.............................................................................................................................................................................................done. 06:16:23 INFO - Installing pip.................done. 06:16:23 INFO - Return code: 0 06:16:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f037d4c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeef60>, '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 0xeefd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef01d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480428738.166064-180361810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:16:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:16:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:16:23 INFO - Using env: {'DISPLAY': ':0', 06:16:23 INFO - 'HOME': '/home/cltbld', 06:16:23 INFO - 'LANG': 'en_US.UTF-8', 06:16:23 INFO - 'LANGUAGE': 'en_US:en', 06:16:23 INFO - 'LOGNAME': 'cltbld', 06:16:23 INFO - 'MAIL': '/var/mail/cltbld', 06:16:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:23 INFO - 'MOZ_NO_REMOTE': '1', 06:16:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:23 INFO - 'NO_EM_RESTART': '1', 06:16:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:23 INFO - 'PWD': '/builds/slave/test', 06:16:23 INFO - 'SHELL': '/bin/bash', 06:16:23 INFO - 'SHLVL': '1', 06:16:23 INFO - 'TERM': 'linux', 06:16:23 INFO - 'TMOUT': '86400', 06:16:23 INFO - 'USER': 'cltbld', 06:16:23 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480428738.166064-180361810', 06:16:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:23 INFO - '_': '/tools/buildbot/bin/python'} 06:16:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:24 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 06:16:24 INFO - Cleaning up... 06:16:24 INFO - Return code: 0 06:16:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f037d4c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeef60>, '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 0xeefd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef01d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480428738.166064-180361810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:16:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:16:24 INFO - Using env: {'DISPLAY': ':0', 06:16:24 INFO - 'HOME': '/home/cltbld', 06:16:24 INFO - 'LANG': 'en_US.UTF-8', 06:16:24 INFO - 'LANGUAGE': 'en_US:en', 06:16:24 INFO - 'LOGNAME': 'cltbld', 06:16:24 INFO - 'MAIL': '/var/mail/cltbld', 06:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:24 INFO - 'MOZ_NO_REMOTE': '1', 06:16:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:24 INFO - 'NO_EM_RESTART': '1', 06:16:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:24 INFO - 'PWD': '/builds/slave/test', 06:16:24 INFO - 'SHELL': '/bin/bash', 06:16:24 INFO - 'SHLVL': '1', 06:16:24 INFO - 'TERM': 'linux', 06:16:24 INFO - 'TMOUT': '86400', 06:16:24 INFO - 'USER': 'cltbld', 06:16:24 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480428738.166064-180361810', 06:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:24 INFO - '_': '/tools/buildbot/bin/python'} 06:16:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:24 INFO - Downloading/unpacking psutil>=3.1.1 06:16:24 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 06:16:24 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 06:16:24 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 06:16:24 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 06:16:24 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 06:16:24 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 06:16:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:16:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:16:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:16:26 INFO - Installing collected packages: psutil 06:16:26 INFO - Running setup.py install for psutil 06:16:26 INFO - building 'psutil._psutil_linux' extension 06:16:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:16:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:16:27 INFO - building 'psutil._psutil_posix' extension 06:16:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:16:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:16:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:16:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:16:27 INFO - Successfully installed psutil 06:16:27 INFO - Cleaning up... 06:16:27 INFO - Return code: 0 06:16:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f037d4c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeef60>, '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 0xeefd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef01d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480428738.166064-180361810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:16:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:16:27 INFO - Using env: {'DISPLAY': ':0', 06:16:27 INFO - 'HOME': '/home/cltbld', 06:16:27 INFO - 'LANG': 'en_US.UTF-8', 06:16:27 INFO - 'LANGUAGE': 'en_US:en', 06:16:27 INFO - 'LOGNAME': 'cltbld', 06:16:27 INFO - 'MAIL': '/var/mail/cltbld', 06:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:27 INFO - 'MOZ_NO_REMOTE': '1', 06:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:27 INFO - 'NO_EM_RESTART': '1', 06:16:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:27 INFO - 'PWD': '/builds/slave/test', 06:16:27 INFO - 'SHELL': '/bin/bash', 06:16:27 INFO - 'SHLVL': '1', 06:16:27 INFO - 'TERM': 'linux', 06:16:27 INFO - 'TMOUT': '86400', 06:16:27 INFO - 'USER': 'cltbld', 06:16:27 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480428738.166064-180361810', 06:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:27 INFO - '_': '/tools/buildbot/bin/python'} 06:16:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:16: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 06:16: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 06:16: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 06:16: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 06:16: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 06:16: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 06:16:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:16:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:16:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:16:30 INFO - Installing collected packages: mozsystemmonitor 06:16:30 INFO - Running setup.py install for mozsystemmonitor 06:16:30 INFO - Successfully installed mozsystemmonitor 06:16:30 INFO - Cleaning up... 06:16:30 INFO - Return code: 0 06:16:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f037d4c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeef60>, '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 0xeefd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef01d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480428738.166064-180361810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:16:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:16:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:16:30 INFO - Using env: {'DISPLAY': ':0', 06:16:30 INFO - 'HOME': '/home/cltbld', 06:16:30 INFO - 'LANG': 'en_US.UTF-8', 06:16:30 INFO - 'LANGUAGE': 'en_US:en', 06:16:30 INFO - 'LOGNAME': 'cltbld', 06:16:30 INFO - 'MAIL': '/var/mail/cltbld', 06:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:30 INFO - 'MOZ_NO_REMOTE': '1', 06:16:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:30 INFO - 'NO_EM_RESTART': '1', 06:16:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:30 INFO - 'PWD': '/builds/slave/test', 06:16:30 INFO - 'SHELL': '/bin/bash', 06:16:30 INFO - 'SHLVL': '1', 06:16:30 INFO - 'TERM': 'linux', 06:16:30 INFO - 'TMOUT': '86400', 06:16:30 INFO - 'USER': 'cltbld', 06:16:30 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480428738.166064-180361810', 06:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:30 INFO - '_': '/tools/buildbot/bin/python'} 06:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:30 INFO - Downloading/unpacking jsonschema==2.5.1 06:16:30 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 06:16:30 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 06:16:30 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 06:16:30 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 06:16:30 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 06:16:30 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 06:16:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:16:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:16:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:16:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:16:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:16:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:16:33 INFO - Downloading functools32-3.2.3-2.tar.gz 06:16:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:16:33 INFO - warning: no files found matching '*.txt' 06:16:33 INFO - no previously-included directories found matching 'build' 06:16:33 INFO - no previously-included directories found matching 'dist' 06:16:33 INFO - no previously-included directories found matching '.git*' 06:16:33 INFO - Installing collected packages: jsonschema, functools32 06:16:33 INFO - Running setup.py install for functools32 06:16:33 INFO - warning: no files found matching '*.txt' 06:16:33 INFO - no previously-included directories found matching 'build' 06:16:33 INFO - no previously-included directories found matching 'dist' 06:16:33 INFO - no previously-included directories found matching '.git*' 06:16:33 INFO - Successfully installed jsonschema functools32 06:16:33 INFO - Cleaning up... 06:16:34 INFO - Return code: 0 06:16:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f037d4c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeef60>, '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 0xeefd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef01d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480428738.166064-180361810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:16:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:16:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:16:34 INFO - Using env: {'DISPLAY': ':0', 06:16:34 INFO - 'HOME': '/home/cltbld', 06:16:34 INFO - 'LANG': 'en_US.UTF-8', 06:16:34 INFO - 'LANGUAGE': 'en_US:en', 06:16:34 INFO - 'LOGNAME': 'cltbld', 06:16:34 INFO - 'MAIL': '/var/mail/cltbld', 06:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:34 INFO - 'MOZ_NO_REMOTE': '1', 06:16:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:34 INFO - 'NO_EM_RESTART': '1', 06:16:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:34 INFO - 'PWD': '/builds/slave/test', 06:16:34 INFO - 'SHELL': '/bin/bash', 06:16:34 INFO - 'SHLVL': '1', 06:16:34 INFO - 'TERM': 'linux', 06:16:34 INFO - 'TMOUT': '86400', 06:16:34 INFO - 'USER': 'cltbld', 06:16:34 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480428738.166064-180361810', 06:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:34 INFO - '_': '/tools/buildbot/bin/python'} 06:16:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:16:34 INFO - Cleaning up... 06:16:34 INFO - Return code: 0 06:16:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:34 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 0x7f037d4c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeef60>, '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 0xeefd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef01d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480428738.166064-180361810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:16:34 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 06:16:34 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 06:16:34 INFO - Using env: {'DISPLAY': ':0', 06:16:34 INFO - 'HOME': '/home/cltbld', 06:16:34 INFO - 'LANG': 'en_US.UTF-8', 06:16:34 INFO - 'LANGUAGE': 'en_US:en', 06:16:34 INFO - 'LOGNAME': 'cltbld', 06:16:34 INFO - 'MAIL': '/var/mail/cltbld', 06:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:34 INFO - 'MOZ_NO_REMOTE': '1', 06:16:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:34 INFO - 'NO_EM_RESTART': '1', 06:16:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:34 INFO - 'PWD': '/builds/slave/test', 06:16:34 INFO - 'SHELL': '/bin/bash', 06:16:34 INFO - 'SHLVL': '1', 06:16:34 INFO - 'TERM': 'linux', 06:16:34 INFO - 'TMOUT': '86400', 06:16:34 INFO - 'USER': 'cltbld', 06:16:34 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480428738.166064-180361810', 06:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:34 INFO - '_': '/tools/buildbot/bin/python'} 06:16:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:34 INFO - Downloading/unpacking blobuploader==1.2.4 06:16: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 06:16: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 06:16: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 06:16: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 06:16: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 06:16: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 06:16:36 INFO - Downloading blobuploader-1.2.4.tar.gz 06:16:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:16:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:16:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:16:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:16:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:16:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:16:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:16:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:16:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:16:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:16:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:16:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:16:37 INFO - Downloading docopt-0.6.1.tar.gz 06:16:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:16:37 INFO - Installing collected packages: blobuploader, requests, docopt 06:16:37 INFO - Running setup.py install for blobuploader 06:16:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:16:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:16:37 INFO - Running setup.py install for requests 06:16:37 INFO - Running setup.py install for docopt 06:16:37 INFO - Successfully installed blobuploader requests docopt 06:16:37 INFO - Cleaning up... 06:16:37 INFO - Return code: 0 06:16:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:37 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 0x7f037d4c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeef60>, '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 0xeefd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef01d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480428738.166064-180361810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:16:37 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 06:16:37 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 06:16:37 INFO - Using env: {'DISPLAY': ':0', 06:16:37 INFO - 'HOME': '/home/cltbld', 06:16:37 INFO - 'LANG': 'en_US.UTF-8', 06:16:37 INFO - 'LANGUAGE': 'en_US:en', 06:16:37 INFO - 'LOGNAME': 'cltbld', 06:16:37 INFO - 'MAIL': '/var/mail/cltbld', 06:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:37 INFO - 'MOZ_NO_REMOTE': '1', 06:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:37 INFO - 'NO_EM_RESTART': '1', 06:16:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:37 INFO - 'PWD': '/builds/slave/test', 06:16:37 INFO - 'SHELL': '/bin/bash', 06:16:37 INFO - 'SHLVL': '1', 06:16:37 INFO - 'TERM': 'linux', 06:16:37 INFO - 'TMOUT': '86400', 06:16:37 INFO - 'USER': 'cltbld', 06:16:37 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480428738.166064-180361810', 06:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:37 INFO - '_': '/tools/buildbot/bin/python'} 06:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:16:38 INFO - Running setup.py (path:/tmp/pip-TkK5hC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:16:38 INFO - Running setup.py (path:/tmp/pip-CmYjs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:16:38 INFO - Running setup.py (path:/tmp/pip-RdjwXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:16:38 INFO - Running setup.py (path:/tmp/pip-DbIswm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:16:38 INFO - Running setup.py (path:/tmp/pip-yd3uH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:16:38 INFO - Running setup.py (path:/tmp/pip-l1lr0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:16:38 INFO - Running setup.py (path:/tmp/pip-tNemqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:16:38 INFO - Running setup.py (path:/tmp/pip-TtWaJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:16:38 INFO - Running setup.py (path:/tmp/pip-TxJtSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:16:38 INFO - Running setup.py (path:/tmp/pip-swNeKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:16:38 INFO - Running setup.py (path:/tmp/pip-eoxnjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:16:38 INFO - Running setup.py (path:/tmp/pip-wzoAla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:16:39 INFO - Running setup.py (path:/tmp/pip-ij7UQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:16:39 INFO - Running setup.py (path:/tmp/pip-EmP81o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:16:39 INFO - Running setup.py (path:/tmp/pip-PFTqlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:16:39 INFO - Running setup.py (path:/tmp/pip-cT_MOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:16:39 INFO - Running setup.py (path:/tmp/pip-AZoF2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:16:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:16:39 INFO - Running setup.py install for manifestparser 06:16:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:16:39 INFO - Running setup.py install for mozcrash 06:16:39 INFO - Running setup.py install for mozdebug 06:16:39 INFO - Running setup.py install for mozdevice 06:16:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:16:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:16:39 INFO - Running setup.py install for mozfile 06:16:39 INFO - Running setup.py install for mozhttpd 06:16:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:16:40 INFO - Running setup.py install for mozinfo 06:16:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:16:40 INFO - Running setup.py install for mozInstall 06:16:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:16:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:16:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:16:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:16:40 INFO - Running setup.py install for mozleak 06:16:40 INFO - Running setup.py install for mozlog 06:16:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:16:40 INFO - Running setup.py install for moznetwork 06:16:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:16:40 INFO - Running setup.py install for mozprocess 06:16:40 INFO - Running setup.py install for mozprofile 06:16:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:16:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:16:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:16:40 INFO - Running setup.py install for mozrunner 06:16:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:16:40 INFO - Running setup.py install for mozscreenshot 06:16:40 INFO - Running setup.py install for moztest 06:16:41 INFO - Running setup.py install for mozversion 06:16:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:16:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:16:41 INFO - Cleaning up... 06:16:41 INFO - Return code: 0 06:16:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:41 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 0x7f037d4c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeef60>, '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 0xeefd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef01d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480428738.166064-180361810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:16:41 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 06:16:41 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 06:16:41 INFO - Using env: {'DISPLAY': ':0', 06:16:41 INFO - 'HOME': '/home/cltbld', 06:16:41 INFO - 'LANG': 'en_US.UTF-8', 06:16:41 INFO - 'LANGUAGE': 'en_US:en', 06:16:41 INFO - 'LOGNAME': 'cltbld', 06:16:41 INFO - 'MAIL': '/var/mail/cltbld', 06:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:41 INFO - 'MOZ_NO_REMOTE': '1', 06:16:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:41 INFO - 'NO_EM_RESTART': '1', 06:16:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:41 INFO - 'PWD': '/builds/slave/test', 06:16:41 INFO - 'SHELL': '/bin/bash', 06:16:41 INFO - 'SHLVL': '1', 06:16:41 INFO - 'TERM': 'linux', 06:16:41 INFO - 'TMOUT': '86400', 06:16:41 INFO - 'USER': 'cltbld', 06:16:41 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480428738.166064-180361810', 06:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:41 INFO - '_': '/tools/buildbot/bin/python'} 06:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:16:41 INFO - Running setup.py (path:/tmp/pip-4bajXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:16:41 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)) 06:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:16:41 INFO - Running setup.py (path:/tmp/pip-VN8GEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:16:41 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)) 06:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:16:41 INFO - Running setup.py (path:/tmp/pip-646c2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:16:41 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)) 06:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:16:41 INFO - Running setup.py (path:/tmp/pip-gvMe9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:16:41 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)) 06:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:16:41 INFO - Running setup.py (path:/tmp/pip-GbpyLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:16:41 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)) 06:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:16:41 INFO - Running setup.py (path:/tmp/pip-phVipj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:16:41 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)) 06:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:16:41 INFO - Running setup.py (path:/tmp/pip-wh97PY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:16:41 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)) 06:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:16:41 INFO - Running setup.py (path:/tmp/pip-WSU6Mk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:16:41 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)) 06:16:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:16:41 INFO - Running setup.py (path:/tmp/pip-YsHQDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:16:42 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)) 06:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:16:42 INFO - Running setup.py (path:/tmp/pip-qqfg9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:16:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:16:42 INFO - Running setup.py (path:/tmp/pip-g5KCtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:16:42 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)) 06:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:16:42 INFO - Running setup.py (path:/tmp/pip-3q6glw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:16:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 06:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:16:42 INFO - Running setup.py (path:/tmp/pip-erMUb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:16:42 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)) 06:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:16:42 INFO - Running setup.py (path:/tmp/pip-bH0gAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:16:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 06:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:16:42 INFO - Running setup.py (path:/tmp/pip-baJ7lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:16:42 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)) 06:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:16:42 INFO - Running setup.py (path:/tmp/pip-2x_MsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:16:42 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)) 06:16:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:16:42 INFO - Running setup.py (path:/tmp/pip-67IQM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:16:42 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)) 06:16:42 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)) 06:16:42 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)) 06:16:42 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)) 06:16:42 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)) 06:16:42 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)) 06:16:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:16:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:16:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:16:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:16:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:16:44 INFO - Downloading blessings-1.6.tar.gz 06:16:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:16:44 INFO - Installing collected packages: blessings 06:16:44 INFO - Running setup.py install for blessings 06:16:44 INFO - Successfully installed blessings 06:16:44 INFO - Cleaning up... 06:16:44 INFO - Return code: 0 06:16:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:16:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:16:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:16:45 INFO - Reading from file tmpfile_stdout 06:16:45 INFO - Current package versions: 06:16:45 INFO - argparse == 1.2.1 06:16:45 INFO - blessings == 1.6 06:16:45 INFO - blobuploader == 1.2.4 06:16:45 INFO - docopt == 0.6.1 06:16:45 INFO - functools32 == 3.2.3-2 06:16:45 INFO - jsonschema == 2.5.1 06:16:45 INFO - manifestparser == 1.1 06:16:45 INFO - mozInstall == 1.12 06:16:45 INFO - mozcrash == 0.17 06:16:45 INFO - mozdebug == 0.1 06:16:45 INFO - mozdevice == 0.48 06:16:45 INFO - mozfile == 1.2 06:16:45 INFO - mozhttpd == 0.7 06:16:45 INFO - mozinfo == 0.9 06:16:45 INFO - mozleak == 0.1 06:16:45 INFO - mozlog == 3.4 06:16:45 INFO - moznetwork == 0.27 06:16:45 INFO - mozprocess == 0.23 06:16:45 INFO - mozprofile == 0.28 06:16:45 INFO - mozrunner == 6.12 06:16:45 INFO - mozscreenshot == 0.1 06:16:45 INFO - mozsystemmonitor == 0.3 06:16:45 INFO - moztest == 0.7 06:16:45 INFO - mozversion == 1.4 06:16:45 INFO - psutil == 3.1.1 06:16:45 INFO - requests == 1.2.3 06:16:45 INFO - wsgiref == 0.1.2 06:16:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:16:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:45 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 0x7f037d4c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeef60>, '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 0xeefd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef01d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480428738.166064-180361810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:16:45 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 06:16:45 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 06:16:45 INFO - Using env: {'DISPLAY': ':0', 06:16:45 INFO - 'HOME': '/home/cltbld', 06:16:45 INFO - 'LANG': 'en_US.UTF-8', 06:16:45 INFO - 'LANGUAGE': 'en_US:en', 06:16:45 INFO - 'LOGNAME': 'cltbld', 06:16:45 INFO - 'MAIL': '/var/mail/cltbld', 06:16:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:45 INFO - 'MOZ_NO_REMOTE': '1', 06:16:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:45 INFO - 'NO_EM_RESTART': '1', 06:16:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:45 INFO - 'PWD': '/builds/slave/test', 06:16:45 INFO - 'SHELL': '/bin/bash', 06:16:45 INFO - 'SHLVL': '1', 06:16:45 INFO - 'TERM': 'linux', 06:16:45 INFO - 'TMOUT': '86400', 06:16:45 INFO - 'USER': 'cltbld', 06:16:45 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480428738.166064-180361810', 06:16:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:45 INFO - '_': '/tools/buildbot/bin/python'} 06:16:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:45 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)) 06:16:45 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)) 06:16:45 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)) 06:16:45 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)) 06:16:45 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)) 06:16:45 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)) 06:16:45 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)) 06:16:45 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)) 06:16:45 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)) 06:16:45 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)) 06:16:45 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)) 06:16:45 INFO - Cleaning up... 06:16:45 INFO - Return code: 0 06:16:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:16:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:16:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:16:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:16:45 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 0x7f037d4c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xef1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeef60>, '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 0xeefd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef01d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480428738.166064-180361810', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:16:45 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 06:16:45 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 06:16:45 INFO - Using env: {'DISPLAY': ':0', 06:16:45 INFO - 'HOME': '/home/cltbld', 06:16:45 INFO - 'LANG': 'en_US.UTF-8', 06:16:45 INFO - 'LANGUAGE': 'en_US:en', 06:16:45 INFO - 'LOGNAME': 'cltbld', 06:16:45 INFO - 'MAIL': '/var/mail/cltbld', 06:16:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:45 INFO - 'MOZ_NO_REMOTE': '1', 06:16:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:45 INFO - 'NO_EM_RESTART': '1', 06:16:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:45 INFO - 'PWD': '/builds/slave/test', 06:16:45 INFO - 'SHELL': '/bin/bash', 06:16:45 INFO - 'SHLVL': '1', 06:16:45 INFO - 'TERM': 'linux', 06:16:45 INFO - 'TMOUT': '86400', 06:16:45 INFO - 'USER': 'cltbld', 06:16:45 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480428738.166064-180361810', 06:16:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:45 INFO - '_': '/tools/buildbot/bin/python'} 06:16:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:16:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:16:45 INFO - Cleaning up... 06:16:45 INFO - Return code: 0 06:16:45 INFO - Running post-action listener: _resource_record_post_action 06:16:45 INFO - Running post-action listener: _start_resource_monitoring 06:16:45 INFO - Starting resource monitoring. 06:16:45 INFO - [mozharness: 2016-11-29 14:16:45.627889Z] Finished create-virtualenv step (success) 06:16:45 INFO - [mozharness: 2016-11-29 14:16:45.628849Z] Running install step. 06:16:45 INFO - Running pre-action listener: _resource_record_pre_action 06:16:45 INFO - Running main action method: install 06:16:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:16:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:16:45 INFO - Reading from file tmpfile_stdout 06:16:45 INFO - Detecting whether we're running mozinstall >=1.0... 06:16:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:16:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:16:45 INFO - Reading from file tmpfile_stdout 06:16:45 INFO - Output received: 06:16:45 INFO - Usage: mozinstall [options] installer 06:16:45 INFO - Options: 06:16:45 INFO - -h, --help show this help message and exit 06:16:45 INFO - -d DEST, --destination=DEST 06:16:45 INFO - Directory to install application into. [default: 06:16:45 INFO - "/builds/slave/test"] 06:16:45 INFO - --app=APP Application being installed. [default: firefox] 06:16:45 INFO - mkdir: /builds/slave/test/build/application 06:16:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:16:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:16:59 INFO - Reading from file tmpfile_stdout 06:16:59 INFO - Output received: 06:16:59 INFO - /builds/slave/test/build/application/firefox/firefox 06:16:59 INFO - Running post-action listener: _resource_record_post_action 06:16:59 INFO - [mozharness: 2016-11-29 14:16:59.422674Z] Finished install step (success) 06:16:59 INFO - [mozharness: 2016-11-29 14:16:59.422920Z] Running run-tests step. 06:16:59 INFO - Running pre-action listener: _resource_record_pre_action 06:16:59 INFO - Running main action method: run_tests 06:16:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:16:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:16:59 INFO - Python 2.7.3 06:16:59 INFO - Return code: 0 06:16:59 INFO - grabbing minidump binary from tooltool 06:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:16:59 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeeef60>, '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 0xeefd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xef01d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:16:59 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:16:59 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/linux64/releng.manifest -o -c /builds/tooltool_cache 06:16:59 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:16:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:16:59 INFO - Return code: 0 06:16:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:16:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:16:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:16:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:16:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:16:59 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/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CBWTwKIgSb-Wfyo8iik6Mw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 06:16:59 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/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CBWTwKIgSb-Wfyo8iik6Mw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 06:16:59 INFO - Using env: {'DISPLAY': ':0', 06:16:59 INFO - 'HOME': '/home/cltbld', 06:16:59 INFO - 'LANG': 'en_US.UTF-8', 06:16:59 INFO - 'LANGUAGE': 'en_US:en', 06:16:59 INFO - 'LOGNAME': 'cltbld', 06:16:59 INFO - 'MAIL': '/var/mail/cltbld', 06:16:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:16:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:16:59 INFO - 'MOZ_NO_REMOTE': '1', 06:16:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:16:59 INFO - 'NO_EM_RESTART': '1', 06:16:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:16:59 INFO - 'PWD': '/builds/slave/test', 06:16:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:16:59 INFO - 'SHELL': '/bin/bash', 06:16:59 INFO - 'SHLVL': '1', 06:16:59 INFO - 'TERM': 'linux', 06:16:59 INFO - 'TMOUT': '86400', 06:16:59 INFO - 'USER': 'cltbld', 06:16:59 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480428738.166064-180361810', 06:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:16:59 INFO - '_': '/tools/buildbot/bin/python'} 06:16:59 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/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CBWTwKIgSb-Wfyo8iik6Mw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 06:16:59 INFO - mozversion application_buildid: 20161129030527 06:16:59 INFO - mozversion application_changeset: 6f79cece26e953c7d7d5f8b09241b7b3cdd71602 06:16:59 INFO - mozversion application_display_name: Firefox 06:16:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:16:59 INFO - mozversion application_name: Firefox 06:16:59 INFO - mozversion application_remotingname: firefox 06:16:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:16:59 INFO - mozversion application_vendor: Mozilla 06:16:59 INFO - mozversion application_version: 51.0 06:16:59 INFO - mozversion platform_buildid: 20161129030527 06:16:59 INFO - mozversion platform_changeset: 6f79cece26e953c7d7d5f8b09241b7b3cdd71602 06:16:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:16:59 INFO - mozversion platform_version: 51.0 06:16:59 INFO - using testdate: 1480429019 06:16:59 INFO - actual date: 1480429019 06:16:59 INFO - starting webserver on 'localhost:58597' 06:16:59 INFO - SUITE-START | Running 2 tests 06:16:59 INFO - TEST-START | dromaeo_css 06:16:59 INFO - operating with platform_type : linux_ 06:16:59 INFO - Initialising browser for dromaeo_css test... 06:16:59 INFO - TEST-INFO | started process 3335 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpANrL5B/profile http://localhost:58597/getInfo.html) 06:17:06 INFO - PROCESS | 3335 | __metrics Screen width/height:1600/1200 06:17:06 INFO - PROCESS | 3335 | colorDepth:24 06:17:06 INFO - PROCESS | 3335 | Browser inner width/height: 1024/697 06:17:06 INFO - PROCESS | 3335 | __metrics 06:17:06 INFO - PROCESS | 3335 | 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" 06:17:06 INFO - PROCESS | 3335 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:17:07 INFO - PROCESS | 3335 | console.error: PushService: 06:17:07 INFO - PROCESS | 3335 | stateChangeProcessEnqueue: Error transitioning state 06:17:07 INFO - PROCESS | 3335 | UnknownError 06:17:07 INFO - TEST-INFO | 3335: exit 0 06:17:07 INFO - Browser initialized. 06:17:07 INFO - Running cycle 1/1 for dromaeo_css test... 06:17:07 INFO - TEST-INFO | started process 3434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpANrL5B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:17:19 INFO - PROCESS | 3434 | RSS: Main: 143126528 06:17:19 INFO - PROCESS | 3434 | 06:18:10 INFO - PROCESS | 3434 | 1480429090841 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] 06:20:20 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:58597/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58597/tests/dromaeo/cssquery-ext.html) 06:20:21 INFO - PROCESS | 3434 | RSS: Main: 244813824 06:20:21 INFO - PROCESS | 3434 | 06:23:23 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:58597/tests/dromaeo/cssquery-ext.html (next: http://localhost:58597/tests/dromaeo/cssquery-jquery.html) 06:23:24 INFO - PROCESS | 3434 | RSS: Main: 235565056 06:23:24 INFO - PROCESS | 3434 | 06:26:25 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:58597/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58597/tests/dromaeo/cssquery-mootools.html) 06:26:26 INFO - PROCESS | 3434 | RSS: Main: 210898944 06:26:26 INFO - PROCESS | 3434 | 06:29:28 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:58597/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58597/tests/dromaeo/cssquery-prototype.html) 06:29:28 INFO - PROCESS | 3434 | RSS: Main: 232337408 06:29:28 INFO - PROCESS | 3434 | 06:32:31 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:58597/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58597/tests/dromaeo/cssquery-yui.html) 06:32:32 INFO - PROCESS | 3434 | RSS: Main: 174014464 06:32:32 INFO - PROCESS | 3434 | 06:35:34 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:58597/tests/dromaeo/cssquery-yui.html (next: http://localhost:58597/tests/dromaeo/cssquery-dojo.html) 06:35:34 INFO - PROCESS | 3434 | RSS: Main: 259043328 06:35:34 INFO - PROCESS | 3434 | 06:35:34 INFO - PROCESS | 3434 | __start_tp_report 06:35:34 INFO - PROCESS | 3434 | _x_x_mozilla_page_load 06:35:34 INFO - PROCESS | 3434 | _x_x_mozilla_page_load_details 06:35:34 INFO - PROCESS | 3434 | |i|pagename|runs| 06:35:34 INFO - PROCESS | 3434 | |0;dojo.html;3148.6536480987093;3182.0453863840844;3194.329190869917;3211.5022171563387;3225.5645487859133;5736.024875771119;5824.068149096145;5827.679477628729;5832.56255780816;5859.414058594133;5726.026575482168;5776.162456443813;5783.5084017858535;5794.130880367947;5794.217780599618;5173.09470842602;5196.29849970253;5200.401953775327;5264.894702105956;5266.710330931797;5132.204508301201;5270.841874743764;5272.209168624699;5281.5774738021055;5288.206768984644;5083.6441449098575;5101.693898366091;5132.28148059272;5145.0481660892665;5223.947760522403;5258.13240815265;5285.418603953562;5291.603129765244;5304.36347638282;5327.3074500314715;5198.116320225571;5230.267762513251;5294.338207724035;5312.6281160318795;5315.309009828737;5556.222128901957;5602.859928501779;5646.971765141189;5683.431656834325;5732.398098199671;6109.755609775648;6112.877742445171;6190.3190649028575;6196.318404975449;6205.627662340229;6198.907016394758;6252.218472690914;6260.655663938482;6261.5929964552615;6263.843403914893;5537.833864984057;5608.270924779793;5626.774929002835;5744.965906136852;5745.2818397700285;6334.904976425358;6335.239771227482;6339.809805705836;6369.9681501592195;6370.458511026522;6096.786612468631;6098.207233059674;6108.664023478751;6109.419605137505;6110.725017374229;5994.730237139252;6009.519238460913;6016.458518733335;6096.908546371808;6109.602875813058;6093.512518998469;6096.756129754849;6110.969445152746;6115.205023346936;6138.938610613926;6082.482988945989;6121.234845644294;6145.96927015371;6156.78451254204;6163.476104531075;4601.217792975135;4641.350210970467;4654.045920586272;4696.1546921554445;4705.035467729107;4178.373244013423;4179.310413781753;4192.245395828719;4201.957980420218;4220.978895105505;5961.076033214858;5967;5970.104484327386;5971.223740913741;5971.313298970587;5962.2249107615735;5971.79098731551;6093.11649810775;6291.433770960635;6305.558610897285;5856.355800861902;5953.553483488756;5980.252468441445;5984.371640977722;5985.191999080069;5175.7153356564995;5207.062728708869;5229.712365819916;5231.136862417735;5249.08141075318;6124.938750612437;6403.1996000499;6404.391582799627;6410.102585638015;6474.352564743488;5995.520358371233;6002.669853158118;6146.815595532141;6165.784197553064;6239.407256310825;6475.967620161869;6477.4494167996245;6478.125453063776;6483.967580162258;6487.253965793805;5853.765849366148;6123.84690382744;6141;6142.447179753844;6156.1381406604005;6069.089636554552;6078;6128.533679014772;6129.601575897553;6188.350223226496;6067.474934260021;6069.36271691466;6071.089336599545;6078.6048906820915;6111.633302001894;6060.090986352083;6064.878702426015;6076.33160352352;6078;6079.787207447718;5805.970970145122;5936.5844390892225;6016.2479690038745;6104.603200791934;6120.204373431426;6155.753769849156;6182.536309776695;6217.813465596039;6218.81343559694;6221.47117495018;5728.054870946247;6051.939480605138;6066.3023752269055;6071.2714474263375;6082.2701275847185 06:35:34 INFO - PROCESS | 3434 | |1;ext.html;588.2441063233742;635.3487675132989;653.7973228299226;664.8470851704105;671.8689855478184;34002.65997340029;34607.65392346079;37292.254154916955;37327.81336093322;37394.252114957686;37993.81003094988;46422;47628;47641.761791191086;51353.74323128379;9272.814543709123;9405;9405;9415.340926135174;9423.492241241403;8477.957610211972;8692.956535217316;9272.16550510454;9377.296702747288;9388.155066044055;11016.614418495354;11329.773404531905;11339.546418143264;11669.299842009465;11723.7069073273;11210.383428911407;11241.83137252946;11295.661130166109;11305.321680699184;11325.263857849213;11102.500387482583;11163.944180279128;11167.720806979809;11177.273477223955;11177.944110279477;44163.55836441627;44486;44528.77735611301;44700;44748.3287750684;3749.8312575934146;3930.5872883347124;4007.83968641254;4314.892127696801;4542.523035081335;33971.15072123192;34207.486887696454;34213.48679769805;34433;35891.820540897126;4675.859724208245;4696.577308042259;4697.4832768395445;4714.269288260325;4815.133276010317;376203;377587;377748;377918;378094;39216.803915980236;63108;63257;63311.36688633055;63339.683301583194;41669.58330416718;41696.583034169875;41918.790406048385;41921;41948.3707744378;16224.918875405547;16292.67414651724;16296.755548666779;16305;16312.347506099622;13495.797563036562;13505.527306544223;13509.797353039712;13515.729685406237;13516.662083447993;8946.105389461001;9178.54107294646;9250.259979201648;9591.280653950982;9608.13526782593;3637.4543818427446;3649.8905032849057;3650.2881938021833;3664.0839790052487;3743.128435782109;1071.1002757683584;1083.3012706804225;1096.6655170173174;1118.994405027986;1178.6994316449423;34083.31833363369;34846.477302840474;35207;35272.470912936325;35318.47022294668;1127.9266847654876;1146.4325159046325;1151.501242304202;1185.152615879633;1261.9305938173488;17251.3962011329;17426.47720568385;17426.738598921027;17650.470485885446;17729.911350443166;624271;627250;629548;630276;630527;59249.40750592525;59636.701816491506;59963.400365996655;60080.39919600835;60213.39786602078;1426.2259904485675;1464.392277204948;1472.3300898091343;1477.2613693153423;1489.7244009858211;29992.550111748777;32583.511247330836;32791.18022049468;32958;33106.66893331036;53207;53958.73020635029;54073.45926540684;54076;54104.72947635237;534263;535587;537376;537637;538147;26882.462350753267;27603.86198068997;30158;30900.69099309068;31222;48954.26568601545;49139.262911055645;49199.75400122976;49895.251571227185;49900.75049624874;42017.78991105147;42655.09466411278;42676;43265.783671081444;44056.339154913345;42395.5760442404;42465;42869.78565107154;43820.78089609532;43961.34057989197;42104.78947605242;42643.78678106589;43303.78348108365;43626.34560481532;43674;35991.46012809758;38394.80802595969;38731;38745;39112.6088739109;28238.294042649097;28943.42113157767;29061.12816615505;29072.854635726686;29104.126876193746 06:35:34 INFO - PROCESS | 3434 | |2;jquery.html;428.3375458138165;429.43314824431764;437.84675363622733;438.956104389561;447.6687251433938;19093.522661933443;20469.385918422453;20943.16227350906;21067.47331316718;21372.57254854902;18242.5439364016;20682.586348273024;20790.58418831626;20820.8958955205;21053;5790.623609465392;6087.2999605045325;6088.939110608903;6096.725647345858;6104.542159338067;5780.9710951445395;5944.524438044968;5965.433283838029;5973.044312909935;5981.850453738648;5893.764249430018;5930.466258036776;5937.198478205431;5940.88118237635;5940.940590594082;5732.856678583027;5879.853003674921;5901.852453688649;5905.6751878646655;5911.970440147793;5271.841844744664;5284.973575132138;5292.603054770908;5292.867678308035;5344.465553444663;24097.277081687578;24166.637500437508;24335.14826981065;24577.385565361008;24716.382090447703;2553.221267513408;2750.972490275092;3113.8443077846246;3218.372417378612;3258.9408442256126;15223.391064357413;15283.617909552238;15402.075875447508;15490.30293636789;15848.207589620473;1902.0584810518744;1932.884026958387;1966.459223713476;2014.5366565689826;2022.592577860866;49604.25593616099;62959;78431;79521.20478795195;88614.670779939;11090.334579925231;11316.71708207285;11352.886471135183;11502.07983361329;11775.764484710258;16564.171791410383;16582.170891455622;16609.252583633766;16628.750568741478;16629.50111496633;8229;8536.573171341408;8538.188872057144;8609.139086091342;8664.523451210118;8196.467229630054;8259.628316725762;8268.049174344907;8422.957885210535;8567;6957.373836354753;7011.544249623758;7104.3961263293195;7121.572705637678;7196.640167991684;2027.6350256953594;2068.9379318620163;2070.513429344103;2080.989595052015;2083;999.4503023337281;1006.7483129217695;1041.5417216424748;1083.0469187115445;1108.8115020446544;20280.89859550693;20648.690269645966;20935.581288374146;21120;21346.252881149398;1038.2732087538752;1066.4347895615335;1098.2531878322818;1106.1427393769893;1214.1622280626339;11502.53989840397;11858.110641701907;11947.581834635746;11970.76058478843;12057;498251;502376;510248;515748;517385;88091;88785;88822.55588722145;88865;89017.55491222502;1104.2711810205226;1109.2512554026;1132.3319241647469;1140.5380820767602;1163.8079716846794;17464.912675436542;17982.640347193246;18058.819411805714;18255.54361140982;18792.906035469736;40665.39001914914;41123.58876411198;42128;42908;43259.35110973275;61003.69498152481;61270.69364653148;61787.69106154441;61858.69070654798;62097.689511552155;6245.843853903507;8485.95757021211;8771.429857059271;8924.196822286025;8941;10877.564897404016;14132.434702612192;14198.574042778733;14233.288335583387;14449.205293708947;11532.59635912739;12117.394130293625;12387.69030774238;12446.751064978469;12842.101052926206;12144.39278036077;12416.503339866304;12652.810207847073;12717.173383730027;12983.28591927453;12986.415611297703;12995.62882477832;13199;13330.533431329857;13681.521146759816;9367.250619950251;9385.953070234878;9408.623655053721;9634.293342365609;9786;9813;12556.87443125557;12963.287019213656;13082.672933176747;13250.204987700768 06:35:34 INFO - PROCESS | 3434 | |3;mootools.html;1315.8947284217263;1556.81318241811;1560.2666746629084;1761.8942863428194;1880.539267879369;8408.117147699495;9215.58529866156;9581.377210481314;9582.089701478366;9993.800123997516;9721.125098741111;9777.7555561111;9822;9846.901530984687;9862.16171625411;2509.9874500627516;2531.4810463854865;2555.4122551813093;2571.8199726019093;2576.8325058871205;2494.3140636325065;2578.3811885147525;2583.341247981762;2589.029114082219;2589.507993481242;2520.6471094046756;2526.3178941685733;2543.796496280293;2548.439343344461;2553.731858154895;2385.940351491218;2406.4344878953434;2408.614621660535;2431.222008957134;2443.401366665161;2439.658447817307;2462.347477918353;2470.641756945233;2487.1916627096266;2487.514934587756;9329.953350233272;9610.519474026341;9654.951725241399;9727.854082188773;9763.755906102404;5749;5975.043992961148;6001.729922153513;6002.339742628307;6009.519238460913;3487.2502411981545;3547.5742910850604;3551.449525323579;3563.073600863794;3590.0127464947086;1164.7612239490884;1175.4416652090274;1178.1458442629112;1204.5302332090491;2318.084356679119;13070.281134537596;13519.797203041962;13528.985326100581;13639.113457625223;13708.24604646734;5005.049040682259;5049.01544198885;5062.493750624982;5062.7468626568525;5126.38483381989;10706.946465267623;10755.193360497993;10759.246852720391;10766.73083172927;10812.35125892449;5743.85640358986;5805.7387417566315;5809.82570522885;5812.505936995402;5814.680192589363;4609.331646911179;4903;4911.87720306988;5243.659162154524;5428.321459817523;4238.894027649333;4254.723442976197;4319.6976211665515;4353.1293741251875;4367.10474352757;1256.5036810459817;1258.9559365422167;1280.8847203751707;1283.140296001681;1286.6976260578756;941.5762906691879;945.621751299472;986.1223511075149;1006.3609607899036;1020.0360659177155;5971.2834459864225;6124.816255512342;6242.43818056368;6315.652639104894;6404.679766011681;472.5723220485466;473.7086691684589;483.2123638469343;490.6467343512665;490.75707524775464;4378.846740364135;4452.777361131931;4457.621102206349;4471.6646251531265;4555.5899969002285;12013.939930300292;12609.495620175274;12613.054020948466;12632;12646.430910609044;12214.57248996281;12282.201656892274;12324.582672992541;12483.687907802196;12523.185992910432;9053.275737940949;9058.761418083659;9084.591193396182;9146.359754817098;9149.451032938045;6324.335944725922;6351.650659213788;6454.870902581828;6468.902966455413;6537.771178008747;11195.104391648485;11356.772864542829;11445.942770286096;11543.8268425972;11547.826782598437;9923.454210018519;11007.174461915549;11251.718707032389;11342.20604557706;11589.130815189063;7975.481593696391;8059.838803223785;8069.7175598853755;8129.512229266263;8181.509109453452;9301.534923253945;9372.625094996123;9401.388909720847;9401.858972115288;9402.905970940477;8342.332613390792;8425.241728244488;8472.788180295542;8480.95759521223;8656.610452529525;8363.540005299767;8394.70618528373;8461.196186362286;8517.701880434155;8612.827743445221;7483.550986940801;7634.618269086634;7733.651985660546;7891.329237014918;7918.2477664621765;5541.33503979525;5584.413636568264;5591.776328946959;5606.411326810626;5816.941830581809;5540.501354878081;5544.306961629796;5587.552995760248;5705.030144875464;5736.053551164011 06:35:34 INFO - PROCESS | 3434 | |4;prototype.html;351.78013741411615;356.07953440356675;361.6347489036074;371.13895761832526;371.9944200836988;5449.64577302475;5573.637713548616;5592.972035139829;5635.408282130379;5662.716864156796;5362.747645988685;5413.729313534327;5453.918191227135;5486.698231597261;5518.779248830052;4330.285502892019;4336.21948049351;4355.455568053993;4355.782210889459;4367.235733746589;4156.459660244164;4345.826626810759;4346.239408103585;4347.78261086946;4399.824007039714;4317.819501151914;4318.762468064255;4329.696921215516;4331.891702707442;4334.1765064637775;4303.956960430418;4314.935275970863;4317.611414972636;4317.69776115672;4329.502107257674;3687.391580389259;3833.386658134685;3840.9450943744964;3851.8844434667003;3857.6720978716844;5391.865203369908;5391.919121213185;5397.514223719845;5404.189596485182;5405.891882162374;5004.674696144739;5008.373953255843;5009.799608015712;5009.924851127236;5010.674306170087;5567.526760225385;5754.482096611325;5790.536757059425;5808.796692115756;5809.477147056785;4232.9153416931795;4234.929675984887;4243.766592837393;4244.575542445762;4253.659707223445;5771.50942169916;5956.106584012433;5966.254218222723;5989.670568118751;6002.429769171922;4283.201055556674;4333.328334108218;4333.479982402132;4335.609795118455;4346.695731298779;4375.606195442426;4392.494863090722;4398.098389830141;4404.273294906305;4407.427034485497;4964.776585053682;4980.701157930535;4982.750862456863;4984.277279794482;4988.10452028227;5538.695371754592;5580.832575022756;5771.797987070517;5781.161731548986;5845.473907348359;1451.6153219396867;1471.8528147185195;1506.623344163959;1514.863662270401;1521.1025494957807;1013.533774463755;1038.787048655024;1049.8057859296055;1051.5478344311866;1057.539970112988;5676.205331253628;5695.772169113272;5710.2862142232225;5724.16999535065;5724.513416359656;5969.2240008799445;5978;5979.664743061333;5980.654352770592;5987.520998320124;5527.585431092684;5665.971670141623;5691.459311365414;5693.259876216065;5719.313682358061;2739.315171207198;2749.463854548384;2751.55975043992;2773.7503624673877;2788.9581656275172;5226.3205783248695;5256.39551451588;5280.630355875129;5284.097724819062;5341.65279256847;5867.911981320198;6181.660008699475;6188.907166392508;6203.2556093268195;6215.471684906834;6211.937880621226;6242.843928901723;6246.906296405557;6255.812325630239;6258.468030217483;5933.703314834327;5978.624916269369;6047.213862197887;6061.636301821904;6083.6045657032155;5972.611780234271;5974.446643872538;5985.730642121202;5990.221271234712;6013.308469525886;6027.939720602738;6112.8777424452155;6140.2368933979;6174.591909155343;6180.567360284737;4331.328644060176;4382.255016647114;4384.693071484965;4388.912221755483;4393.165298593257;5725.770969161354;5904.704764761831;6015.72929218195;6029.728662210124;6058.242719660043;5784.421557844182;5874.765009399576;5877.94122058774;5882.676452795137;5906.497947674324;5890.911636325544;5899.17411562373;5907.970460147843;5917.437843404869;5948.39393363798;5668.688222147822;5843.357230704534;5865.94134058654;5875.941240587539;5877.382874798084;5835.44563266489;5843.035899076604;5871.178035075179;5875.531117220695;5883.676397798162;5463.945360546344;5753.84923015407;5776.566757493289;5778.930897783924;5782.335031471266 06:35:34 INFO - PROCESS | 3434 | |5;yui.html;675.5102550650782;694.9652517374133;785.7917651822268;822.3133683374383;827.710301394512;15705.52883413498;17226.569335766613;17257.39599114031;17334.30662773489;17344.479665610037;14318.997670163093;15833;16096.356145754185;16485.093319867403;16577.502674919742;863.089440640126;889.1020069729587;889.5730049576207;889.8976617688952;891.4027601506973;894.8657701344786;896.4755617963499;896.7578753736487;896.8834051573319;896.995515022424;947.0198344713223;948.7248697877607;948.9572969216401;949.3070058857038;949.7578117580008;943.5329511891589;944.7968686732352;945.026622578745;945.1163162443138;945.2013048973606;697.7801992372387;700.7337211859511;701.0710808179132;701.3092104277283;701.4073108223542;14572.70854582913;14611.561653150422;14668.266586670623;15131.319090640947;15405.845941540552;13462.528811491551;13507.86492135076;13723.45106195751;13802.65493362664;14140.15159090458;12231.143819932608;12472.438740256619;12478.313692746895;12632.810507842298;12721.618351449471;4068.837246510136;4121.5878412158545;4134.462519872397;4201.495820501559;4257.531671516131;53116.051049151225;58551.70724146352;66796.66601666961;79525;87067;11921.523139074514;12041.337726424956;12081.21472104328;12249.938750306192;12447.93776031114;22341.441463963205;22624.660630090562;22638;22640;22640.094396224296;9214.308926830381;9304.767380815398;9365.953170234105;9504.524773761423;9684.322097453252;5171.560417364491;5342.679439233659;5366.114591092426;5440.374356949002;5466.207399926989;3556.41319182332;3677.191017976041;3679.7424180307657;3693.1505753676806;3695.6858667013066;597.2951916738203;603.0953569645532;643.240975648739;645.0743183531647;673.4309508465338;668.8061809669813;722.3390597603134;727.3272223193525;728.8141523911474;766.3792328214164;8942.105789421135;9004.815088609581;9492;9526.809463810685;9778.755531111638;650.1547987616175;658.4798009572385;697.6790676288863;753.88691696246;754.2683596910988;4527.683062185615;4715.905681886412;4957.132501812169;5020.59835213182;5024.84925452237;130306;134081;135005;136338.81967082006;136453.3177334127;72238.74925628254;97014.51492742632;113289;113605;115364.42317788526;80364;96516.51741741247;97348;99590;100728.99271007342;10135.341202821794;10426.232456819718;10582.259241852997;10708.196885233483;10731.946340268249;39793.40309895296;51971.48028519817;54183;55567.722161388934;56246;78101.60949195217;83494.58252708941;84135;85258.57370713107;88704.55647721721;13450.730985380042;13941.930290348484;13964.441422342992;14063.648408789863;14201.857981420053;15459.381624734884;15620.182409516436;15725.528234152993;15805.209739513208;16015.919920400323;14116.153030818185;14177.929110354382;14283;14327.928360358132;14524.636884077983;14734.26328683583;14837.480688175861;14940.551783446514;14946.327415266556;15639.609009774847;13930.373133209232;14221.71556568842;14381.352839122474;14826.629334266298;14829.851701483278;11679.941600291944;11685.65180090162;11739.647810565697;11938.462769175234;12239.938800306298;11996;12143.271403715453;12179.878201217874;12427.192232504858;12471.251724896536 06:35:34 INFO - PROCESS | 3434 | __end_tp_report 06:35:34 INFO - PROCESS | 3434 | __start_cc_report 06:35:34 INFO - PROCESS | 3434 | _x_x_mozilla_cycle_collect,894 06:35:34 INFO - PROCESS | 3434 | __end_cc_report 06:35:34 INFO - PROCESS | 3434 | __startTimestamp1480430134833__endTimestamp 06:35:34 INFO - PROCESS | 3434 | 06:35:34 INFO - PROCESS | 3434 | ------- Summary: start ------- 06:35:34 INFO - PROCESS | 3434 | Number of tests: 6 06:35:34 INFO - PROCESS | 3434 | 06:35:34 INFO - PROCESS | 3434 | [#0] dojo.html Cycles:165 Average:5728.10 Median:5995.52 stddev:681.61 (11.4%) stddev-sans-first:652.97 06:35:34 INFO - PROCESS | 3434 | Values: 3148.7 3182.0 3194.3 3211.5 3225.6 5736.0 5824.1 5827.7 5832.6 5859.4 5726.0 5776.2 5783.5 5794.1 5794.2 5173.1 5196.3 5200.4 5264.9 5266.7 5132.2 5270.8 5272.2 5281.6 5288.2 5083.6 5101.7 5132.3 5145.0 5223.9 5258.1 5285.4 5291.6 5304.4 5327.3 5198.1 5230.3 5294.3 5312.6 5315.3 5556.2 5602.9 5647.0 5683.4 5732.4 6109.8 6112.9 6190.3 6196.3 6205.6 6198.9 6252.2 6260.7 6261.6 6263.8 5537.8 5608.3 5626.8 5745.0 5745.3 6334.9 6335.2 6339.8 6370.0 6370.5 6096.8 6098.2 6108.7 6109.4 6110.7 5994.7 6009.5 6016.5 6096.9 6109.6 6093.5 6096.8 6111.0 6115.2 6138.9 6082.5 6121.2 6146.0 6156.8 6163.5 4601.2 4641.4 4654.0 4696.2 4705.0 4178.4 4179.3 4192.2 4202.0 4221.0 5961.1 5967.0 5970.1 5971.2 5971.3 5962.2 5971.8 6093.1 6291.4 6305.6 5856.4 5953.6 5980.3 5984.4 5985.2 5175.7 5207.1 5229.7 5231.1 5249.1 6124.9 6403.2 6404.4 6410.1 6474.4 5995.5 6002.7 6146.8 6165.8 6239.4 6476.0 6477.4 6478.1 6484.0 6487.3 5853.8 6123.8 6141.0 6142.4 6156.1 6069.1 6078.0 6128.5 6129.6 6188.4 6067.5 6069.4 6071.1 6078.6 6111.6 6060.1 6064.9 6076.3 6078.0 6079.8 5806.0 5936.6 6016.2 6104.6 6120.2 6155.8 6182.5 6217.8 6218.8 6221.5 5728.1 6051.9 6066.3 6071.3 6082.3 06:35:34 INFO - PROCESS | 3434 | 06:35:34 INFO - PROCESS | 3434 | [#1] ext.html Cycles:180 Average:66273.35 Median:38928.80 stddev:139877.74 (359.3%) stddev-sans-first:140183.19 06:35:34 INFO - PROCESS | 3434 | Values: 588.2 635.3 653.8 664.8 671.9 34002.7 34607.7 37292.3 37327.8 37394.3 37993.8 46422.0 47628.0 47641.8 51353.7 9272.8 9405.0 9405.0 9415.3 9423.5 8478.0 8693.0 9272.2 9377.3 9388.2 11016.6 11329.8 11339.5 11669.3 11723.7 11210.4 11241.8 11295.7 11305.3 11325.3 11102.5 11163.9 11167.7 11177.3 11177.9 44163.6 44486.0 44528.8 44700.0 44748.3 3749.8 3930.6 4007.8 4314.9 4542.5 33971.2 34207.5 34213.5 34433.0 35891.8 4675.9 4696.6 4697.5 4714.3 4815.1 376203.0 377587.0 377748.0 377918.0 378094.0 39216.8 63108.0 63257.0 63311.4 63339.7 41669.6 41696.6 41918.8 41921.0 41948.4 16224.9 16292.7 16296.8 16305.0 16312.3 13495.8 13505.5 13509.8 13515.7 13516.7 8946.1 9178.5 9250.3 9591.3 9608.1 3637.5 3649.9 3650.3 3664.1 3743.1 1071.1 1083.3 1096.7 1119.0 1178.7 34083.3 34846.5 35207.0 35272.5 35318.5 1127.9 1146.4 1151.5 1185.2 1261.9 17251.4 17426.5 17426.7 17650.5 17729.9 624271.0 627250.0 629548.0 630276.0 630527.0 59249.4 59636.7 59963.4 60080.4 60213.4 1426.2 1464.4 1472.3 1477.3 1489.7 29992.6 32583.5 32791.2 32958.0 33106.7 53207.0 53958.7 54073.5 54076.0 54104.7 534263.0 535587.0 537376.0 537637.0 538147.0 26882.5 27603.9 30158.0 30900.7 31222.0 48954.3 49139.3 49199.8 49895.3 49900.8 42017.8 42655.1 42676.0 43265.8 44056.3 42395.6 42465.0 42869.8 43820.8 43961.3 42104.8 42643.8 43303.8 43626.3 43674.0 35991.5 38394.8 38731.0 38745.0 39112.6 28238.3 28943.4 29061.1 29072.9 29104.1 06:35:34 INFO - PROCESS | 3434 | 06:35:34 INFO - PROCESS | 3434 | [#2] jquery.html Cycles:180 Average:29946.29 Median:24456.27 stddev:83529.30 (341.5%) stddev-sans-first:83734.22 06:35:34 INFO - PROCESS | 3434 | Values: 428.3 429.4 437.8 439.0 447.7 19093.5 20469.4 20943.2 21067.5 21372.6 18242.5 20682.6 20790.6 20820.9 21053.0 5790.6 6087.3 6088.9 6096.7 6104.5 5781.0 5944.5 5965.4 5973.0 5981.9 5893.8 5930.5 5937.2 5940.9 5940.9 5732.9 5879.9 5901.9 5905.7 5912.0 5271.8 5285.0 5292.6 5292.9 5344.5 24097.3 24166.6 24335.1 24577.4 24716.4 2553.2 2751.0 3113.8 3218.4 3258.9 15223.4 15283.6 15402.1 15490.3 15848.2 1902.1 1932.9 1966.5 2014.5 2022.6 49604.3 62959.0 78431.0 79521.2 88614.7 11090.3 11316.7 11352.9 11502.1 11775.8 16564.2 16582.2 16609.3 16628.8 16629.5 8229.0 8536.6 8538.2 8609.1 8664.5 8196.5 8259.6 8268.0 8423.0 8567.0 6957.4 7011.5 7104.4 7121.6 7196.6 2027.6 2068.9 2070.5 2081.0 2083.0 999.5 1006.7 1041.5 1083.0 1108.8 20280.9 20648.7 20935.6 21120.0 21346.3 1038.3 1066.4 1098.3 1106.1 1214.2 11502.5 11858.1 11947.6 11970.8 12057.0 498251.0 502376.0 510248.0 515748.0 517385.0 88091.0 88785.0 88822.6 88865.0 89017.6 1104.3 1109.3 1132.3 1140.5 1163.8 17464.9 17982.6 18058.8 18255.5 18792.9 40665.4 41123.6 42128.0 42908.0 43259.4 61003.7 61270.7 61787.7 61858.7 62097.7 6245.8 8486.0 8771.4 8924.2 8941.0 10877.6 14132.4 14198.6 14233.3 14449.2 11532.6 12117.4 12387.7 12446.8 12842.1 12144.4 12416.5 12652.8 12717.2 12983.3 12986.4 12995.6 13199.0 13330.5 13681.5 9367.3 9386.0 9408.6 9634.3 9786.0 9813.0 12556.9 12963.3 13082.7 13250.2 06:35:34 INFO - PROCESS | 3434 | 06:35:34 INFO - PROCESS | 3434 | [#3] mootools.html Cycles:180 Average:6330.80 Median:490.70 stddev:3683.85 (750.7%) stddev-sans-first:3674.91 06:35:34 INFO - PROCESS | 3434 | Values: 1315.9 1556.8 1560.3 1761.9 1880.5 8408.1 9215.6 9581.4 9582.1 9993.8 9721.1 9777.8 9822.0 9846.9 9862.2 2510.0 2531.5 2555.4 2571.8 2576.8 2494.3 2578.4 2583.3 2589.0 2589.5 2520.6 2526.3 2543.8 2548.4 2553.7 2385.9 2406.4 2408.6 2431.2 2443.4 2439.7 2462.3 2470.6 2487.2 2487.5 9330.0 9610.5 9655.0 9727.9 9763.8 5749.0 5975.0 6001.7 6002.3 6009.5 3487.3 3547.6 3551.4 3563.1 3590.0 1164.8 1175.4 1178.1 1204.5 2318.1 13070.3 13519.8 13529.0 13639.1 13708.2 5005.0 5049.0 5062.5 5062.7 5126.4 10706.9 10755.2 10759.2 10766.7 10812.4 5743.9 5805.7 5809.8 5812.5 5814.7 4609.3 4903.0 4911.9 5243.7 5428.3 4238.9 4254.7 4319.7 4353.1 4367.1 1256.5 1259.0 1280.9 1283.1 1286.7 941.6 945.6 986.1 1006.4 1020.0 5971.3 6124.8 6242.4 6315.7 6404.7 472.6 473.7 483.2 490.6 490.8 4378.8 4452.8 4457.6 4471.7 4555.6 12013.9 12609.5 12613.1 12632.0 12646.4 12214.6 12282.2 12324.6 12483.7 12523.2 9053.3 9058.8 9084.6 9146.4 9149.5 6324.3 6351.7 6454.9 6468.9 6537.8 11195.1 11356.8 11445.9 11543.8 11547.8 9923.5 11007.2 11251.7 11342.2 11589.1 7975.5 8059.8 8069.7 8129.5 8181.5 9301.5 9372.6 9401.4 9401.9 9402.9 8342.3 8425.2 8472.8 8481.0 8656.6 8363.5 8394.7 8461.2 8517.7 8612.8 7483.6 7634.6 7733.7 7891.3 7918.2 5541.3 5584.4 5591.8 5606.4 5816.9 5540.5 5544.3 5587.6 5705.0 5736.1 06:35:34 INFO - PROCESS | 3434 | 06:35:34 INFO - PROCESS | 3434 | [#4] prototype.html Cycles:180 Average:4894.03 Median:5502.74 stddev:1440.81 (26.2%) stddev-sans-first:1403.94 06:35:34 INFO - PROCESS | 3434 | Values: 351.8 356.1 361.6 371.1 372.0 5449.6 5573.6 5593.0 5635.4 5662.7 5362.7 5413.7 5453.9 5486.7 5518.8 4330.3 4336.2 4355.5 4355.8 4367.2 4156.5 4345.8 4346.2 4347.8 4399.8 4317.8 4318.8 4329.7 4331.9 4334.2 4304.0 4314.9 4317.6 4317.7 4329.5 3687.4 3833.4 3840.9 3851.9 3857.7 5391.9 5391.9 5397.5 5404.2 5405.9 5004.7 5008.4 5009.8 5009.9 5010.7 5567.5 5754.5 5790.5 5808.8 5809.5 4232.9 4234.9 4243.8 4244.6 4253.7 5771.5 5956.1 5966.3 5989.7 6002.4 4283.2 4333.3 4333.5 4335.6 4346.7 4375.6 4392.5 4398.1 4404.3 4407.4 4964.8 4980.7 4982.8 4984.3 4988.1 5538.7 5580.8 5771.8 5781.2 5845.5 1451.6 1471.9 1506.6 1514.9 1521.1 1013.5 1038.8 1049.8 1051.5 1057.5 5676.2 5695.8 5710.3 5724.2 5724.5 5969.2 5978.0 5979.7 5980.7 5987.5 5527.6 5666.0 5691.5 5693.3 5719.3 2739.3 2749.5 2751.6 2773.8 2789.0 5226.3 5256.4 5280.6 5284.1 5341.7 5867.9 6181.7 6188.9 6203.3 6215.5 6211.9 6242.8 6246.9 6255.8 6258.5 5933.7 5978.6 6047.2 6061.6 6083.6 5972.6 5974.4 5985.7 5990.2 6013.3 6027.9 6112.9 6140.2 6174.6 6180.6 4331.3 4382.3 4384.7 4388.9 4393.2 5725.8 5904.7 6015.7 6029.7 6058.2 5784.4 5874.8 5877.9 5882.7 5906.5 5890.9 5899.2 5908.0 5917.4 5948.4 5668.7 5843.4 5865.9 5875.9 5877.4 5835.4 5843.0 5871.2 5875.5 5883.7 5463.9 5753.8 5776.6 5778.9 5782.3 06:35:34 INFO - PROCESS | 3434 | 06:35:34 INFO - PROCESS | 3434 | [#5] yui.html Cycles:180 Average:22133.80 Median:4095.21 stddev:32762.11 (800.0%) stddev-sans-first:32814.40 06:35:34 INFO - PROCESS | 3434 | Values: 675.5 695.0 785.8 822.3 827.7 15705.5 17226.6 17257.4 17334.3 17344.5 14319.0 15833.0 16096.4 16485.1 16577.5 863.1 889.1 889.6 889.9 891.4 894.9 896.5 896.8 896.9 897.0 947.0 948.7 949.0 949.3 949.8 943.5 944.8 945.0 945.1 945.2 697.8 700.7 701.1 701.3 701.4 14572.7 14611.6 14668.3 15131.3 15405.8 13462.5 13507.9 13723.5 13802.7 14140.2 12231.1 12472.4 12478.3 12632.8 12721.6 4068.8 4121.6 4134.5 4201.5 4257.5 53116.1 58551.7 66796.7 79525.0 87067.0 11921.5 12041.3 12081.2 12249.9 12447.9 22341.4 22624.7 22638.0 22640.0 22640.1 9214.3 9304.8 9366.0 9504.5 9684.3 5171.6 5342.7 5366.1 5440.4 5466.2 3556.4 3677.2 3679.7 3693.2 3695.7 597.3 603.1 643.2 645.1 673.4 668.8 722.3 727.3 728.8 766.4 8942.1 9004.8 9492.0 9526.8 9778.8 650.2 658.5 697.7 753.9 754.3 4527.7 4715.9 4957.1 5020.6 5024.8 130306.0 134081.0 135005.0 136338.8 136453.3 72238.7 97014.5 113289.0 113605.0 115364.4 80364.0 96516.5 97348.0 99590.0 100729.0 10135.3 10426.2 10582.3 10708.2 10731.9 39793.4 51971.5 54183.0 55567.7 56246.0 78101.6 83494.6 84135.0 85258.6 88704.6 13450.7 13941.9 13964.4 14063.6 14201.9 15459.4 15620.2 15725.5 15805.2 16015.9 14116.2 14177.9 14283.0 14327.9 14524.6 14734.3 14837.5 14940.6 14946.3 15639.6 13930.4 14221.7 14381.4 14826.6 14829.9 11679.9 11685.7 11739.6 11938.5 12239.9 11996.0 12143.3 12179.9 12427.2 12471.3 06:35:34 INFO - PROCESS | 3434 | -------- Summary: end -------- 06:35:34 INFO - PROCESS | 3434 | 06:35:35 INFO - TEST-INFO | 3434: exit 0 06:35:35 INFO - TEST-OK | dromaeo_css | took 1115796ms 06:35:35 INFO - TEST-START | kraken 06:35:35 INFO - operating with platform_type : linux_ 06:35:35 INFO - Initialising browser for kraken test... 06:35:35 INFO - TEST-INFO | started process 3742 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTTrs3u/profile http://localhost:58597/getInfo.html) 06:35:39 INFO - PROCESS | 3742 | __metrics Screen width/height:1600/1200 06:35:39 INFO - PROCESS | 3742 | colorDepth:24 06:35:39 INFO - PROCESS | 3742 | Browser inner width/height: 1024/697 06:35:39 INFO - PROCESS | 3742 | __metrics 06:35:40 INFO - PROCESS | 3742 | 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" 06:35:40 INFO - PROCESS | 3742 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:35:40 INFO - PROCESS | 3742 | console.error: PushService: 06:35:40 INFO - PROCESS | 3742 | stateChangeProcessEnqueue: Error transitioning state 06:35:40 INFO - PROCESS | 3742 | UnknownError 06:35:41 INFO - TEST-INFO | 3742: exit 0 06:35:41 INFO - Browser initialized. 06:35:41 INFO - Running cycle 1/1 for kraken test... 06:35:41 INFO - TEST-INFO | started process 3837 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTTrs3u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:35:52 INFO - PROCESS | 3837 | RSS: Main: 143396864 06:35:52 INFO - PROCESS | 3837 | 06:35:55 INFO - PROCESS | 3837 | Cycle 1(1): loaded http://localhost:58597/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58597/tests/kraken/driver.html?testName=audio-beat-detection) 06:35:56 INFO - PROCESS | 3837 | RSS: Main: 186245120 06:35:56 INFO - PROCESS | 3837 | 06:35:58 INFO - PROCESS | 3837 | Cycle 1(1): loaded http://localhost:58597/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58597/tests/kraken/driver.html?testName=audio-dft) 06:35:59 INFO - PROCESS | 3837 | RSS: Main: 173518848 06:35:59 INFO - PROCESS | 3837 | 06:36:02 INFO - PROCESS | 3837 | Cycle 1(1): loaded http://localhost:58597/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58597/tests/kraken/driver.html?testName=audio-fft) 06:36:02 INFO - PROCESS | 3837 | RSS: Main: 265646080 06:36:02 INFO - PROCESS | 3837 | 06:36:04 INFO - PROCESS | 3837 | Cycle 1(1): loaded http://localhost:58597/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58597/tests/kraken/driver.html?testName=audio-oscillator) 06:36:05 INFO - PROCESS | 3837 | RSS: Main: 172560384 06:36:05 INFO - PROCESS | 3837 | 06:36:07 INFO - PROCESS | 3837 | Cycle 1(1): loaded http://localhost:58597/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58597/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:36:08 INFO - PROCESS | 3837 | RSS: Main: 174706688 06:36:08 INFO - PROCESS | 3837 | 06:36:11 INFO - PROCESS | 3837 | Cycle 1(1): loaded http://localhost:58597/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58597/tests/kraken/driver.html?testName=imaging-darkroom) 06:36:11 INFO - PROCESS | 3837 | RSS: Main: 209686528 06:36:11 INFO - PROCESS | 3837 | 06:36:14 INFO - PROCESS | 3837 | Cycle 1(1): loaded http://localhost:58597/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58597/tests/kraken/driver.html?testName=imaging-desaturate) 06:36:15 INFO - PROCESS | 3837 | RSS: Main: 208896000 06:36:15 INFO - PROCESS | 3837 | 06:36:18 INFO - PROCESS | 3837 | Cycle 1(1): loaded http://localhost:58597/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58597/tests/kraken/driver.html?testName=json-parse-financial) 06:36:18 INFO - PROCESS | 3837 | RSS: Main: 208224256 06:36:18 INFO - PROCESS | 3837 | 06:36:20 INFO - PROCESS | 3837 | Cycle 1(1): loaded http://localhost:58597/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58597/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:36:20 INFO - PROCESS | 3837 | RSS: Main: 170631168 06:36:20 INFO - PROCESS | 3837 | 06:36:22 INFO - PROCESS | 3837 | Cycle 1(1): loaded http://localhost:58597/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58597/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:36:23 INFO - PROCESS | 3837 | RSS: Main: 178626560 06:36:23 INFO - PROCESS | 3837 | 06:36:25 INFO - PROCESS | 3837 | Cycle 1(1): loaded http://localhost:58597/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58597/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:36:25 INFO - PROCESS | 3837 | RSS: Main: 187736064 06:36:25 INFO - PROCESS | 3837 | 06:36:28 INFO - PROCESS | 3837 | Cycle 1(1): loaded http://localhost:58597/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58597/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:36:29 INFO - PROCESS | 3837 | RSS: Main: 196562944 06:36:29 INFO - PROCESS | 3837 | 06:36:31 INFO - PROCESS | 3837 | Cycle 1(1): loaded http://localhost:58597/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58597/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:36:32 INFO - PROCESS | 3837 | RSS: Main: 192626688 06:36:32 INFO - PROCESS | 3837 | 06:36:33 INFO - PROCESS | 3837 | Cycle 1(1): loaded http://localhost:58597/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58597/tests/kraken/driver.html?testName=ai-astar) 06:36:34 INFO - PROCESS | 3837 | RSS: Main: 244531200 06:36:34 INFO - PROCESS | 3837 | 06:36:34 INFO - PROCESS | 3837 | __start_tp_report 06:36:34 INFO - PROCESS | 3837 | _x_x_mozilla_page_load 06:36:34 INFO - PROCESS | 3837 | _x_x_mozilla_page_load_details 06:36:34 INFO - PROCESS | 3837 | |i|pagename|runs| 06:36:34 INFO - PROCESS | 3837 | |0;ai-astar;111;113;111;110;110;110;111;111;111;111 06:36:34 INFO - PROCESS | 3837 | |1;audio-beat-detection;143;122;115;163;123;119;116;121;158;117 06:36:34 INFO - PROCESS | 3837 | |2;audio-dft;158;160;159;161;160;159;162;161;161;161 06:36:34 INFO - PROCESS | 3837 | |3;audio-fft;75;75;75;113;75;76;75;77;101;75 06:36:34 INFO - PROCESS | 3837 | |4;audio-oscillator;82;83;126;82;82;81;115;81;82;110 06:36:34 INFO - PROCESS | 3837 | |5;imaging-gaussian-blur;117;117;117;116;116;117;116;117;116;117 06:36:34 INFO - PROCESS | 3837 | |6;imaging-darkroom;148;146;146;146;146;146;145;145;145;145 06:36:34 INFO - PROCESS | 3837 | |7;imaging-desaturate;95;96;95;96;95;94;95;94;95;94 06:36:34 INFO - PROCESS | 3837 | |8;json-parse-financial;54;52;51;49;50;51;54;51;48;49 06:36:34 INFO - PROCESS | 3837 | |9;json-stringify-tinderbox;56;58;57;57;57;56;56;56;56;58 06:36:34 INFO - PROCESS | 3837 | |10;stanford-crypto-aes;79;73;73;74;74;73;73;74;74;72 06:36:34 INFO - PROCESS | 3837 | |11;stanford-crypto-ccm;126;130;129;118;119;119;127;126;162;120 06:36:34 INFO - PROCESS | 3837 | |12;stanford-crypto-pbkdf2;153;152;154;150;152;153;156;154;150;160 06:36:34 INFO - PROCESS | 3837 | |13;stanford-crypto-sha256-iterative;66;72;63;64;65;62;63;63;62;62 06:36:34 INFO - PROCESS | 3837 | __end_tp_report 06:36:34 INFO - PROCESS | 3837 | __start_cc_report 06:36:34 INFO - PROCESS | 3837 | _x_x_mozilla_cycle_collect,1595 06:36:34 INFO - PROCESS | 3837 | __end_cc_report 06:36:34 INFO - PROCESS | 3837 | __startTimestamp1480430194099__endTimestamp 06:36:34 INFO - PROCESS | 3837 | 06:36:34 INFO - PROCESS | 3837 | ------- Summary: start ------- 06:36:34 INFO - PROCESS | 3837 | Number of tests: 14 06:36:34 INFO - PROCESS | 3837 | 06:36:34 INFO - PROCESS | 3837 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:0.88 (0.8%) stddev-sans-first:0.93 06:36:34 INFO - PROCESS | 3837 | Values: 111.0 113.0 111.0 110.0 110.0 110.0 111.0 111.0 111.0 111.0 06:36:34 INFO - PROCESS | 3837 | 06:36:34 INFO - PROCESS | 3837 | [#1] audio-beat-detection Cycles:10 Average:129.70 Median:122.50 stddev:18.09 (14.8%) stddev-sans-first:18.54 06:36:34 INFO - PROCESS | 3837 | Values: 143.0 122.0 115.0 163.0 123.0 119.0 116.0 121.0 158.0 117.0 06:36:34 INFO - PROCESS | 3837 | 06:36:34 INFO - PROCESS | 3837 | [#2] audio-dft Cycles:10 Average:160.20 Median:161.00 stddev:1.23 (0.8%) stddev-sans-first:1.01 06:36:34 INFO - PROCESS | 3837 | Values: 158.0 160.0 159.0 161.0 160.0 159.0 162.0 161.0 161.0 161.0 06:36:34 INFO - PROCESS | 3837 | 06:36:34 INFO - PROCESS | 3837 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.00 stddev:13.65 (18.2%) stddev-sans-first:14.26 06:36:34 INFO - PROCESS | 3837 | Values: 75.0 75.0 75.0 113.0 75.0 76.0 75.0 77.0 101.0 75.0 06:36:34 INFO - PROCESS | 3837 | 06:36:34 INFO - PROCESS | 3837 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:82.00 stddev:17.42 (21.2%) stddev-sans-first:18.06 06:36:34 INFO - PROCESS | 3837 | Values: 82.0 83.0 126.0 82.0 82.0 81.0 115.0 81.0 82.0 110.0 06:36:34 INFO - PROCESS | 3837 | 06:36:34 INFO - PROCESS | 3837 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:36:34 INFO - PROCESS | 3837 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 116.0 117.0 116.0 117.0 06:36:34 INFO - PROCESS | 3837 | 06:36:34 INFO - PROCESS | 3837 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.53 06:36:34 INFO - PROCESS | 3837 | Values: 148.0 146.0 146.0 146.0 146.0 146.0 145.0 145.0 145.0 145.0 06:36:34 INFO - PROCESS | 3837 | 06:36:34 INFO - PROCESS | 3837 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 06:36:34 INFO - PROCESS | 3837 | Values: 95.0 96.0 95.0 96.0 95.0 94.0 95.0 94.0 95.0 94.0 06:36:34 INFO - PROCESS | 3837 | 06:36:34 INFO - PROCESS | 3837 | [#8] json-parse-financial Cycles:10 Average:50.90 Median:51.00 stddev:2.02 (4.0%) stddev-sans-first:1.81 06:36:34 INFO - PROCESS | 3837 | Values: 54.0 52.0 51.0 49.0 50.0 51.0 54.0 51.0 48.0 49.0 06:36:34 INFO - PROCESS | 3837 | 06:36:34 INFO - PROCESS | 3837 | [#9] json-stringify-tinderbox Cycles:10 Average:56.70 Median:57.00 stddev:0.82 (1.4%) stddev-sans-first:0.83 06:36:34 INFO - PROCESS | 3837 | Values: 56.0 58.0 57.0 57.0 57.0 56.0 56.0 56.0 56.0 58.0 06:36:34 INFO - PROCESS | 3837 | 06:36:34 INFO - PROCESS | 3837 | [#10] stanford-crypto-aes Cycles:10 Average:73.90 Median:74.00 stddev:1.91 (2.6%) stddev-sans-first:0.71 06:36:34 INFO - PROCESS | 3837 | Values: 79.0 73.0 73.0 74.0 74.0 73.0 73.0 74.0 74.0 72.0 06:36:34 INFO - PROCESS | 3837 | 06:36:34 INFO - PROCESS | 3837 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:126.50 stddev:12.89 (10.2%) stddev-sans-first:13.65 06:36:34 INFO - PROCESS | 3837 | Values: 126.0 130.0 129.0 118.0 119.0 119.0 127.0 126.0 162.0 120.0 06:36:34 INFO - PROCESS | 3837 | 06:36:34 INFO - PROCESS | 3837 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.40 Median:153.50 stddev:2.95 (1.9%) stddev-sans-first:3.13 06:36:34 INFO - PROCESS | 3837 | Values: 153.0 152.0 154.0 150.0 152.0 153.0 156.0 154.0 150.0 160.0 06:36:34 INFO - PROCESS | 3837 | 06:36:34 INFO - PROCESS | 3837 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:63.50 stddev:3.05 (4.8%) stddev-sans-first:3.16 06:36:34 INFO - PROCESS | 3837 | Values: 66.0 72.0 63.0 64.0 65.0 62.0 63.0 63.0 62.0 62.0 06:36:34 INFO - PROCESS | 3837 | -------- Summary: end -------- 06:36:34 INFO - PROCESS | 3837 | 06:36:35 INFO - TEST-INFO | 3837: exit 0 06:36:35 INFO - TEST-OK | kraken | took 59454ms 06:36:35 INFO - SUITE-END | took 1175s 06:36:35 INFO - Completed test suite (00:19:35) 06:36:35 INFO - javascript benchmark 06:36:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3148.6536480987093, 3182.0453863840844, 3194.329190869917, 3211.5022171563387, 3225.5645487859133, 5736.024875771119, 5824.068149096145, 5827.679477628729, 5832.56255780816, 5859.414058594133, 5726.026575482168, 5776.162456443813, 5783.5084017858535, 5794.130880367947, 5794.217780599618, 5173.09470842602, 5196.29849970253, 5200.401953775327, 5264.894702105956, 5266.710330931797, 5132.204508301201, 5270.841874743764, 5272.209168624699, 5281.5774738021055, 5288.206768984644, 5083.6441449098575, 5101.693898366091, 5132.28148059272, 5145.0481660892665, 5223.947760522403, 5258.13240815265, 5285.418603953562, 5291.603129765244, 5304.36347638282, 5327.3074500314715, 5198.116320225571, 5230.267762513251, 5294.338207724035, 5312.6281160318795, 5315.309009828737, 5556.222128901957, 5602.859928501779, 5646.971765141189, 5683.431656834325, 5732.398098199671, 6109.755609775648, 6112.877742445171, 6190.3190649028575, 6196.318404975449, 6205.627662340229, 6198.907016394758, 6252.218472690914, 6260.655663938482, 6261.5929964552615, 6263.843403914893, 5537.833864984057, 5608.270924779793, 5626.774929002835, 5744.965906136852, 5745.2818397700285, 6334.904976425358, 6335.239771227482, 6339.809805705836, 6369.9681501592195, 6370.458511026522, 6096.786612468631, 6098.207233059674, 6108.664023478751, 6109.419605137505, 6110.725017374229, 5994.730237139252, 6009.519238460913, 6016.458518733335, 6096.908546371808, 6109.602875813058, 6093.512518998469, 6096.756129754849, 6110.969445152746, 6115.205023346936, 6138.938610613926, 6082.482988945989, 6121.234845644294, 6145.96927015371, 6156.78451254204, 6163.476104531075, 4601.217792975135, 4641.350210970467, 4654.045920586272, 4696.1546921554445, 4705.035467729107, 4178.373244013423, 4179.310413781753, 4192.245395828719, 4201.957980420218, 4220.978895105505, 5961.076033214858, 5967.0, 5970.104484327386, 5971.223740913741, 5971.313298970587, 5962.2249107615735, 5971.79098731551, 6093.11649810775, 6291.433770960635, 6305.558610897285, 5856.355800861902, 5953.553483488756, 5980.252468441445, 5984.371640977722, 5985.191999080069, 5175.7153356564995, 5207.062728708869, 5229.712365819916, 5231.136862417735, 5249.08141075318, 6124.938750612437, 6403.1996000499, 6404.391582799627, 6410.102585638015, 6474.352564743488, 5995.520358371233, 6002.669853158118, 6146.815595532141, 6165.784197553064, 6239.407256310825, 6475.967620161869, 6477.4494167996245, 6478.125453063776, 6483.967580162258, 6487.253965793805, 5853.765849366148, 6123.84690382744, 6141.0, 6142.447179753844, 6156.1381406604005, 6069.089636554552, 6078.0, 6128.533679014772, 6129.601575897553, 6188.350223226496, 6067.474934260021, 6069.36271691466, 6071.089336599545, 6078.6048906820915, 6111.633302001894, 6060.090986352083, 6064.878702426015, 6076.33160352352, 6078.0, 6079.787207447718, 5805.970970145122, 5936.5844390892225, 6016.2479690038745, 6104.603200791934, 6120.204373431426, 6155.753769849156, 6182.536309776695, 6217.813465596039, 6218.81343559694, 6221.47117495018, 5728.054870946247, 6051.939480605138, 6066.3023752269055, 6071.2714474263375, 6082.2701275847185], "value": 5679.166129687579, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.2441063233742, 635.3487675132989, 653.7973228299226, 664.8470851704105, 671.8689855478184, 34002.65997340029, 34607.65392346079, 37292.254154916955, 37327.81336093322, 37394.252114957686, 37993.81003094988, 46422.0, 47628.0, 47641.761791191086, 51353.74323128379, 9272.814543709123, 9405.0, 9405.0, 9415.340926135174, 9423.492241241403, 8477.957610211972, 8692.956535217316, 9272.16550510454, 9377.296702747288, 9388.155066044055, 11016.614418495354, 11329.773404531905, 11339.546418143264, 11669.299842009465, 11723.7069073273, 11210.383428911407, 11241.83137252946, 11295.661130166109, 11305.321680699184, 11325.263857849213, 11102.500387482583, 11163.944180279128, 11167.720806979809, 11177.273477223955, 11177.944110279477, 44163.55836441627, 44486.0, 44528.77735611301, 44700.0, 44748.3287750684, 3749.8312575934146, 3930.5872883347124, 4007.83968641254, 4314.892127696801, 4542.523035081335, 33971.15072123192, 34207.486887696454, 34213.48679769805, 34433.0, 35891.820540897126, 4675.859724208245, 4696.577308042259, 4697.4832768395445, 4714.269288260325, 4815.133276010317, 376203.0, 377587.0, 377748.0, 377918.0, 378094.0, 39216.803915980236, 63108.0, 63257.0, 63311.36688633055, 63339.683301583194, 41669.58330416718, 41696.583034169875, 41918.790406048385, 41921.0, 41948.3707744378, 16224.918875405547, 16292.67414651724, 16296.755548666779, 16305.0, 16312.347506099622, 13495.797563036562, 13505.527306544223, 13509.797353039712, 13515.729685406237, 13516.662083447993, 8946.105389461001, 9178.54107294646, 9250.259979201648, 9591.280653950982, 9608.13526782593, 3637.4543818427446, 3649.8905032849057, 3650.2881938021833, 3664.0839790052487, 3743.128435782109, 1071.1002757683584, 1083.3012706804225, 1096.6655170173174, 1118.994405027986, 1178.6994316449423, 34083.31833363369, 34846.477302840474, 35207.0, 35272.470912936325, 35318.47022294668, 1127.9266847654876, 1146.4325159046325, 1151.501242304202, 1185.152615879633, 1261.9305938173488, 17251.3962011329, 17426.47720568385, 17426.738598921027, 17650.470485885446, 17729.911350443166, 624271.0, 627250.0, 629548.0, 630276.0, 630527.0, 59249.40750592525, 59636.701816491506, 59963.400365996655, 60080.39919600835, 60213.39786602078, 1426.2259904485675, 1464.392277204948, 1472.3300898091343, 1477.2613693153423, 1489.7244009858211, 29992.550111748777, 32583.511247330836, 32791.18022049468, 32958.0, 33106.66893331036, 53207.0, 53958.73020635029, 54073.45926540684, 54076.0, 54104.72947635237, 534263.0, 535587.0, 537376.0, 537637.0, 538147.0, 26882.462350753267, 27603.86198068997, 30158.0, 30900.69099309068, 31222.0, 48954.26568601545, 49139.262911055645, 49199.75400122976, 49895.251571227185, 49900.75049624874, 42017.78991105147, 42655.09466411278, 42676.0, 43265.783671081444, 44056.339154913345, 42395.5760442404, 42465.0, 42869.78565107154, 43820.78089609532, 43961.34057989197, 42104.78947605242, 42643.78678106589, 43303.78348108365, 43626.34560481532, 43674.0, 35991.46012809758, 38394.80802595969, 38731.0, 38745.0, 39112.6088739109, 28238.294042649097, 28943.42113157767, 29061.12816615505, 29072.854635726686, 29104.126876193746], "value": 20408.040597326384, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.3375458138165, 429.43314824431764, 437.84675363622733, 438.956104389561, 447.6687251433938, 19093.522661933443, 20469.385918422453, 20943.16227350906, 21067.47331316718, 21372.57254854902, 18242.5439364016, 20682.586348273024, 20790.58418831626, 20820.8958955205, 21053.0, 5790.623609465392, 6087.2999605045325, 6088.939110608903, 6096.725647345858, 6104.542159338067, 5780.9710951445395, 5944.524438044968, 5965.433283838029, 5973.044312909935, 5981.850453738648, 5893.764249430018, 5930.466258036776, 5937.198478205431, 5940.88118237635, 5940.940590594082, 5732.856678583027, 5879.853003674921, 5901.852453688649, 5905.6751878646655, 5911.970440147793, 5271.841844744664, 5284.973575132138, 5292.603054770908, 5292.867678308035, 5344.465553444663, 24097.277081687578, 24166.637500437508, 24335.14826981065, 24577.385565361008, 24716.382090447703, 2553.221267513408, 2750.972490275092, 3113.8443077846246, 3218.372417378612, 3258.9408442256126, 15223.391064357413, 15283.617909552238, 15402.075875447508, 15490.30293636789, 15848.207589620473, 1902.0584810518744, 1932.884026958387, 1966.459223713476, 2014.5366565689826, 2022.592577860866, 49604.25593616099, 62959.0, 78431.0, 79521.20478795195, 88614.670779939, 11090.334579925231, 11316.71708207285, 11352.886471135183, 11502.07983361329, 11775.764484710258, 16564.171791410383, 16582.170891455622, 16609.252583633766, 16628.750568741478, 16629.50111496633, 8229.0, 8536.573171341408, 8538.188872057144, 8609.139086091342, 8664.523451210118, 8196.467229630054, 8259.628316725762, 8268.049174344907, 8422.957885210535, 8567.0, 6957.373836354753, 7011.544249623758, 7104.3961263293195, 7121.572705637678, 7196.640167991684, 2027.6350256953594, 2068.9379318620163, 2070.513429344103, 2080.989595052015, 2083.0, 999.4503023337281, 1006.7483129217695, 1041.5417216424748, 1083.0469187115445, 1108.8115020446544, 20280.89859550693, 20648.690269645966, 20935.581288374146, 21120.0, 21346.252881149398, 1038.2732087538752, 1066.4347895615335, 1098.2531878322818, 1106.1427393769893, 1214.1622280626339, 11502.53989840397, 11858.110641701907, 11947.581834635746, 11970.76058478843, 12057.0, 498251.0, 502376.0, 510248.0, 515748.0, 517385.0, 88091.0, 88785.0, 88822.55588722145, 88865.0, 89017.55491222502, 1104.2711810205226, 1109.2512554026, 1132.3319241647469, 1140.5380820767602, 1163.8079716846794, 17464.912675436542, 17982.640347193246, 18058.819411805714, 18255.54361140982, 18792.906035469736, 40665.39001914914, 41123.58876411198, 42128.0, 42908.0, 43259.35110973275, 61003.69498152481, 61270.69364653148, 61787.69106154441, 61858.69070654798, 62097.689511552155, 6245.843853903507, 8485.95757021211, 8771.429857059271, 8924.196822286025, 8941.0, 10877.564897404016, 14132.434702612192, 14198.574042778733, 14233.288335583387, 14449.205293708947, 11532.59635912739, 12117.394130293625, 12387.69030774238, 12446.751064978469, 12842.101052926206, 12144.39278036077, 12416.503339866304, 12652.810207847073, 12717.173383730027, 12983.28591927453, 12986.415611297703, 12995.62882477832, 13199.0, 13330.533431329857, 13681.521146759816, 9367.250619950251, 9385.953070234878, 9408.623655053721, 9634.293342365609, 9786.0, 9813.0, 12556.87443125557, 12963.287019213656, 13082.672933176747, 13250.204987700768], "value": 9900.254009782095, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1315.8947284217263, 1556.81318241811, 1560.2666746629084, 1761.8942863428194, 1880.539267879369, 8408.117147699495, 9215.58529866156, 9581.377210481314, 9582.089701478366, 9993.800123997516, 9721.125098741111, 9777.7555561111, 9822.0, 9846.901530984687, 9862.16171625411, 2509.9874500627516, 2531.4810463854865, 2555.4122551813093, 2571.8199726019093, 2576.8325058871205, 2494.3140636325065, 2578.3811885147525, 2583.341247981762, 2589.029114082219, 2589.507993481242, 2520.6471094046756, 2526.3178941685733, 2543.796496280293, 2548.439343344461, 2553.731858154895, 2385.940351491218, 2406.4344878953434, 2408.614621660535, 2431.222008957134, 2443.401366665161, 2439.658447817307, 2462.347477918353, 2470.641756945233, 2487.1916627096266, 2487.514934587756, 9329.953350233272, 9610.519474026341, 9654.951725241399, 9727.854082188773, 9763.755906102404, 5749.0, 5975.043992961148, 6001.729922153513, 6002.339742628307, 6009.519238460913, 3487.2502411981545, 3547.5742910850604, 3551.449525323579, 3563.073600863794, 3590.0127464947086, 1164.7612239490884, 1175.4416652090274, 1178.1458442629112, 1204.5302332090491, 2318.084356679119, 13070.281134537596, 13519.797203041962, 13528.985326100581, 13639.113457625223, 13708.24604646734, 5005.049040682259, 5049.01544198885, 5062.493750624982, 5062.7468626568525, 5126.38483381989, 10706.946465267623, 10755.193360497993, 10759.246852720391, 10766.73083172927, 10812.35125892449, 5743.85640358986, 5805.7387417566315, 5809.82570522885, 5812.505936995402, 5814.680192589363, 4609.331646911179, 4903.0, 4911.87720306988, 5243.659162154524, 5428.321459817523, 4238.894027649333, 4254.723442976197, 4319.6976211665515, 4353.1293741251875, 4367.10474352757, 1256.5036810459817, 1258.9559365422167, 1280.8847203751707, 1283.140296001681, 1286.6976260578756, 941.5762906691879, 945.621751299472, 986.1223511075149, 1006.3609607899036, 1020.0360659177155, 5971.2834459864225, 6124.816255512342, 6242.43818056368, 6315.652639104894, 6404.679766011681, 472.5723220485466, 473.7086691684589, 483.2123638469343, 490.6467343512665, 490.75707524775464, 4378.846740364135, 4452.777361131931, 4457.621102206349, 4471.6646251531265, 4555.5899969002285, 12013.939930300292, 12609.495620175274, 12613.054020948466, 12632.0, 12646.430910609044, 12214.57248996281, 12282.201656892274, 12324.582672992541, 12483.687907802196, 12523.185992910432, 9053.275737940949, 9058.761418083659, 9084.591193396182, 9146.359754817098, 9149.451032938045, 6324.335944725922, 6351.650659213788, 6454.870902581828, 6468.902966455413, 6537.771178008747, 11195.104391648485, 11356.772864542829, 11445.942770286096, 11543.8268425972, 11547.826782598437, 9923.454210018519, 11007.174461915549, 11251.718707032389, 11342.20604557706, 11589.130815189063, 7975.481593696391, 8059.838803223785, 8069.7175598853755, 8129.512229266263, 8181.509109453452, 9301.534923253945, 9372.625094996123, 9401.388909720847, 9401.858972115288, 9402.905970940477, 8342.332613390792, 8425.241728244488, 8472.788180295542, 8480.95759521223, 8656.610452529525, 8363.540005299767, 8394.70618528373, 8461.196186362286, 8517.701880434155, 8612.827743445221, 7483.550986940801, 7634.618269086634, 7733.651985660546, 7891.329237014918, 7918.2477664621765, 5541.33503979525, 5584.413636568264, 5591.776328946959, 5606.411326810626, 5816.941830581809, 5540.501354878081, 5544.306961629796, 5587.552995760248, 5705.030144875464, 5736.053551164011], "value": 4945.346455225515, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.78013741411615, 356.07953440356675, 361.6347489036074, 371.13895761832526, 371.9944200836988, 5449.64577302475, 5573.637713548616, 5592.972035139829, 5635.408282130379, 5662.716864156796, 5362.747645988685, 5413.729313534327, 5453.918191227135, 5486.698231597261, 5518.779248830052, 4330.285502892019, 4336.21948049351, 4355.455568053993, 4355.782210889459, 4367.235733746589, 4156.459660244164, 4345.826626810759, 4346.239408103585, 4347.78261086946, 4399.824007039714, 4317.819501151914, 4318.762468064255, 4329.696921215516, 4331.891702707442, 4334.1765064637775, 4303.956960430418, 4314.935275970863, 4317.611414972636, 4317.69776115672, 4329.502107257674, 3687.391580389259, 3833.386658134685, 3840.9450943744964, 3851.8844434667003, 3857.6720978716844, 5391.865203369908, 5391.919121213185, 5397.514223719845, 5404.189596485182, 5405.891882162374, 5004.674696144739, 5008.373953255843, 5009.799608015712, 5009.924851127236, 5010.674306170087, 5567.526760225385, 5754.482096611325, 5790.536757059425, 5808.796692115756, 5809.477147056785, 4232.9153416931795, 4234.929675984887, 4243.766592837393, 4244.575542445762, 4253.659707223445, 5771.50942169916, 5956.106584012433, 5966.254218222723, 5989.670568118751, 6002.429769171922, 4283.201055556674, 4333.328334108218, 4333.479982402132, 4335.609795118455, 4346.695731298779, 4375.606195442426, 4392.494863090722, 4398.098389830141, 4404.273294906305, 4407.427034485497, 4964.776585053682, 4980.701157930535, 4982.750862456863, 4984.277279794482, 4988.10452028227, 5538.695371754592, 5580.832575022756, 5771.797987070517, 5781.161731548986, 5845.473907348359, 1451.6153219396867, 1471.8528147185195, 1506.623344163959, 1514.863662270401, 1521.1025494957807, 1013.533774463755, 1038.787048655024, 1049.8057859296055, 1051.5478344311866, 1057.539970112988, 5676.205331253628, 5695.772169113272, 5710.2862142232225, 5724.16999535065, 5724.513416359656, 5969.2240008799445, 5978.0, 5979.664743061333, 5980.654352770592, 5987.520998320124, 5527.585431092684, 5665.971670141623, 5691.459311365414, 5693.259876216065, 5719.313682358061, 2739.315171207198, 2749.463854548384, 2751.55975043992, 2773.7503624673877, 2788.9581656275172, 5226.3205783248695, 5256.39551451588, 5280.630355875129, 5284.097724819062, 5341.65279256847, 5867.911981320198, 6181.660008699475, 6188.907166392508, 6203.2556093268195, 6215.471684906834, 6211.937880621226, 6242.843928901723, 6246.906296405557, 6255.812325630239, 6258.468030217483, 5933.703314834327, 5978.624916269369, 6047.213862197887, 6061.636301821904, 6083.6045657032155, 5972.611780234271, 5974.446643872538, 5985.730642121202, 5990.221271234712, 6013.308469525886, 6027.939720602738, 6112.8777424452155, 6140.2368933979, 6174.591909155343, 6180.567360284737, 4331.328644060176, 4382.255016647114, 4384.693071484965, 4388.912221755483, 4393.165298593257, 5725.770969161354, 5904.704764761831, 6015.72929218195, 6029.728662210124, 6058.242719660043, 5784.421557844182, 5874.765009399576, 5877.94122058774, 5882.676452795137, 5906.497947674324, 5890.911636325544, 5899.17411562373, 5907.970460147843, 5917.437843404869, 5948.39393363798, 5668.688222147822, 5843.357230704534, 5865.94134058654, 5875.941240587539, 5877.382874798084, 5835.44563266489, 5843.035899076604, 5871.178035075179, 5875.531117220695, 5883.676397798162, 5463.945360546344, 5753.84923015407, 5776.566757493289, 5778.930897783924, 5782.335031471266], "value": 4440.949820761084, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.5102550650782, 694.9652517374133, 785.7917651822268, 822.3133683374383, 827.710301394512, 15705.52883413498, 17226.569335766613, 17257.39599114031, 17334.30662773489, 17344.479665610037, 14318.997670163093, 15833.0, 16096.356145754185, 16485.093319867403, 16577.502674919742, 863.089440640126, 889.1020069729587, 889.5730049576207, 889.8976617688952, 891.4027601506973, 894.8657701344786, 896.4755617963499, 896.7578753736487, 896.8834051573319, 896.995515022424, 947.0198344713223, 948.7248697877607, 948.9572969216401, 949.3070058857038, 949.7578117580008, 943.5329511891589, 944.7968686732352, 945.026622578745, 945.1163162443138, 945.2013048973606, 697.7801992372387, 700.7337211859511, 701.0710808179132, 701.3092104277283, 701.4073108223542, 14572.70854582913, 14611.561653150422, 14668.266586670623, 15131.319090640947, 15405.845941540552, 13462.528811491551, 13507.86492135076, 13723.45106195751, 13802.65493362664, 14140.15159090458, 12231.143819932608, 12472.438740256619, 12478.313692746895, 12632.810507842298, 12721.618351449471, 4068.837246510136, 4121.5878412158545, 4134.462519872397, 4201.495820501559, 4257.531671516131, 53116.051049151225, 58551.70724146352, 66796.66601666961, 79525.0, 87067.0, 11921.523139074514, 12041.337726424956, 12081.21472104328, 12249.938750306192, 12447.93776031114, 22341.441463963205, 22624.660630090562, 22638.0, 22640.0, 22640.094396224296, 9214.308926830381, 9304.767380815398, 9365.953170234105, 9504.524773761423, 9684.322097453252, 5171.560417364491, 5342.679439233659, 5366.114591092426, 5440.374356949002, 5466.207399926989, 3556.41319182332, 3677.191017976041, 3679.7424180307657, 3693.1505753676806, 3695.6858667013066, 597.2951916738203, 603.0953569645532, 643.240975648739, 645.0743183531647, 673.4309508465338, 668.8061809669813, 722.3390597603134, 727.3272223193525, 728.8141523911474, 766.3792328214164, 8942.105789421135, 9004.815088609581, 9492.0, 9526.809463810685, 9778.755531111638, 650.1547987616175, 658.4798009572385, 697.6790676288863, 753.88691696246, 754.2683596910988, 4527.683062185615, 4715.905681886412, 4957.132501812169, 5020.59835213182, 5024.84925452237, 130306.0, 134081.0, 135005.0, 136338.81967082006, 136453.3177334127, 72238.74925628254, 97014.51492742632, 113289.0, 113605.0, 115364.42317788526, 80364.0, 96516.51741741247, 97348.0, 99590.0, 100728.99271007342, 10135.341202821794, 10426.232456819718, 10582.259241852997, 10708.196885233483, 10731.946340268249, 39793.40309895296, 51971.48028519817, 54183.0, 55567.722161388934, 56246.0, 78101.60949195217, 83494.58252708941, 84135.0, 85258.57370713107, 88704.55647721721, 13450.730985380042, 13941.930290348484, 13964.441422342992, 14063.648408789863, 14201.857981420053, 15459.381624734884, 15620.182409516436, 15725.528234152993, 15805.209739513208, 16015.919920400323, 14116.153030818185, 14177.929110354382, 14283.0, 14327.928360358132, 14524.636884077983, 14734.26328683583, 14837.480688175861, 14940.551783446514, 14946.327415266556, 15639.609009774847, 13930.373133209232, 14221.71556568842, 14381.352839122474, 14826.629334266298, 14829.851701483278, 11679.941600291944, 11685.65180090162, 11739.647810565697, 11938.462769175234, 12239.938800306298, 11996.0, 12143.271403715453, 12179.878201217874, 12427.192232504858, 12471.251724896536], "value": 8000.7347571699975, "unit": "score"}], "name": "dromaeo_css", "value": 7657.658302365251, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 111.0, 110.0, 110.0, 110.0, 111.0, 111.0, 111.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 122.0, 115.0, 163.0, 123.0, 119.0, 116.0, 121.0, 158.0, 117.0], "value": 129.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 160.0, 159.0, 161.0, 160.0, 159.0, 162.0, 161.0, 161.0, 161.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 113.0, 75.0, 76.0, 75.0, 77.0, 101.0, 75.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 126.0, 82.0, 82.0, 81.0, 115.0, 81.0, 82.0, 110.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 51.0, 49.0, 50.0, 51.0, 54.0, 51.0, 48.0, 49.0], "value": 50.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 57.0, 57.0, 57.0, 56.0, 56.0, 56.0, 56.0, 58.0], "value": 56.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 73.0, 73.0, 74.0, 74.0, 73.0, 73.0, 74.0, 74.0, 72.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 130.0, 129.0, 118.0, 119.0, 119.0, 127.0, 126.0, 162.0, 120.0], "value": 127.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 152.0, 154.0, 150.0, 152.0, 153.0, 156.0, 154.0, 150.0, 160.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 72.0, 63.0, 64.0, 65.0, 62.0, 63.0, 63.0, 62.0, 62.0], "value": 64.2, "unit": "score"}], "name": "kraken", "value": 1458.9, "alertThreshold": 2.0}]} 06:36:35 INFO - Return code: 0 06:36:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:36:35 INFO - # TBPL SUCCESS # 06:36:35 INFO - Running post-action listener: _resource_record_post_action 06:36:35 INFO - [mozharness: 2016-11-29 14:36:35.428059Z] Finished run-tests step (success) 06:36:35 INFO - Running post-run listener: _resource_record_post_run 06:36:35 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 7639040; Write bytes: 348717056; Read time: 1828; Write time: 290340 06:36:35 INFO - TinderboxPrint: CPU usage
12.9% 06:36:35 INFO - TinderboxPrint: I/O read bytes / time
7,639,040 / 1,828 06:36:35 INFO - TinderboxPrint: I/O write bytes / time
348,717,056 / 290,340 06:36:35 INFO - TinderboxPrint: CPU idle
8,264.2 (87.1%) 06:36:35 INFO - TinderboxPrint: CPU user
1,180.6 (12.4%) 06:36:35 INFO - TinderboxPrint: Swap in / out
0 / 0 06:36:35 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 696320; Read time: 0; Write time: 36 06:36:35 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 5787648; Write bytes: 347348992; Read time: 1740; Write time: 290060 06:36:36 INFO - Running post-run listener: _upload_blobber_files 06:36:36 INFO - Blob upload gear active. 06:36:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:36:36 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 06:36:36 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'] 06:36:36 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 06:36:36 INFO - (blobuploader) - INFO - Open directory for files ... 06:36:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:36:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:36:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:36:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:36:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:36:37 INFO - (blobuploader) - INFO - Done attempting. 06:36:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:36:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:36:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:36:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:36:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:36:38 INFO - (blobuploader) - INFO - Done attempting. 06:36:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:36:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:36:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:36:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:36:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:36:41 INFO - (blobuploader) - INFO - Done attempting. 06:36:41 INFO - (blobuploader) - INFO - Iteration through files over. 06:36:41 INFO - Return code: 0 06:36:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:36:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:36:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf9f1805dd746037772d977dc12eeb5c1e15294a2fa8f88416cde9d0aa6481901a544f11a670a6144c6cca482f9f10051a988be84f26b1f5d622ae150d962831", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ea00a88bf118b7605253cb2a76a391c7f6a7a6364072300975d6a3470b97e94b3c0d5946bea534a8b6b18c2749584e82aac7dc177e06df3242ca1fc0ad73fa7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/42d0bb0d8cf137ee2c8d6dd338e8d22e259b6d2cdbb46e42bf7b11b6876001c6bd37eb6cd29cdae28a341369ea060dcfa63a4c5a340c04ef27f33d73b30a4034"} 06:36:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:36:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:36:41 INFO - Contents: 06:36:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf9f1805dd746037772d977dc12eeb5c1e15294a2fa8f88416cde9d0aa6481901a544f11a670a6144c6cca482f9f10051a988be84f26b1f5d622ae150d962831", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ea00a88bf118b7605253cb2a76a391c7f6a7a6364072300975d6a3470b97e94b3c0d5946bea534a8b6b18c2749584e82aac7dc177e06df3242ca1fc0ad73fa7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/42d0bb0d8cf137ee2c8d6dd338e8d22e259b6d2cdbb46e42bf7b11b6876001c6bd37eb6cd29cdae28a341369ea060dcfa63a4c5a340c04ef27f33d73b30a4034"} 06:36:41 INFO - Running post-run listener: copy_logs_to_upload_dir 06:36:41 INFO - Copying logs to upload dir... 06:36:41 INFO - mkdir: /builds/slave/test/build/upload/logs 06:36:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.762183 ========= master_lag: 0.30 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-29 06:36:41.406482) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 06:36:41.410120) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1480428738.166064-180361810 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf9f1805dd746037772d977dc12eeb5c1e15294a2fa8f88416cde9d0aa6481901a544f11a670a6144c6cca482f9f10051a988be84f26b1f5d622ae150d962831", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ea00a88bf118b7605253cb2a76a391c7f6a7a6364072300975d6a3470b97e94b3c0d5946bea534a8b6b18c2749584e82aac7dc177e06df3242ca1fc0ad73fa7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/42d0bb0d8cf137ee2c8d6dd338e8d22e259b6d2cdbb46e42bf7b11b6876001c6bd37eb6cd29cdae28a341369ea060dcfa63a4c5a340c04ef27f33d73b30a4034"} build_url:https://queue.taskcluster.net/v1/task/CBWTwKIgSb-Wfyo8iik6Mw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011122 build_url: 'https://queue.taskcluster.net/v1/task/CBWTwKIgSb-Wfyo8iik6Mw/artifacts/public/build/firefox-51.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf9f1805dd746037772d977dc12eeb5c1e15294a2fa8f88416cde9d0aa6481901a544f11a670a6144c6cca482f9f10051a988be84f26b1f5d622ae150d962831", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ea00a88bf118b7605253cb2a76a391c7f6a7a6364072300975d6a3470b97e94b3c0d5946bea534a8b6b18c2749584e82aac7dc177e06df3242ca1fc0ad73fa7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/42d0bb0d8cf137ee2c8d6dd338e8d22e259b6d2cdbb46e42bf7b11b6876001c6bd37eb6cd29cdae28a341369ea060dcfa63a4c5a340c04ef27f33d73b30a4034"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 06:36:41.438483) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 06:36:41.438825) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1480428738.166064-180361810 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004377 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 06:36:41.521404) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 06:36:41.521745) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 06:36:41.522067) ========= ========= Total master_lag: 0.49 =========