builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-035 starttime: 1474632429.45 results: success (0) buildid: 20160923035101 builduid: 37e55f9ffeab43dca78129a05f79ccec revision: 60cc643978c7020926fe4145761e26945fcd5c37 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 05:07:09.449300) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 05:07:09.449700) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 05:07:09.449982) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 05:07:09.465921) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 05:07:09.466640) ========= 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=ed14279e38b05397cf4aa391000001a4-1474632149.339210-1989473087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-23 05:07:09-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-09-23 05:07:09 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080613 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 05:07:09.566472) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 05:07:09.567160) ========= 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=ed14279e38b05397cf4aa391000001a4-1474632149.339210-1989473087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021190 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 05:07:09.621766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 05:07:09.622135) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 60cc643978c7020926fe4145761e26945fcd5c37 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 60cc643978c7020926fe4145761e26945fcd5c37 --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=ed14279e38b05397cf4aa391000001a4-1474632149.339210-1989473087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-23 05:07:09,773 truncating revision to first 12 chars 2016-09-23 05:07:09,773 Setting DEBUG logging. 2016-09-23 05:07:09,773 attempt 1/10 2016-09-23 05:07:09,773 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/60cc643978c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 05:07:10,078 unpacking tar archive at: fx-team-60cc643978c7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.725383 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 05:07:10.362724) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 05:07:10.363165) ========= script_repo_revision: 60cc643978c7020926fe4145761e26945fcd5c37 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 05:07:10.363601) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 05:07:10.363946) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 05:07:10.373810) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-09-23 05:07:10.374134) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=ed14279e38b05397cf4aa391000001a4-1474632149.339210-1989473087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:07:10 INFO - MultiFileLogger online at 20160923 05:07:10 in /builds/slave/test 05:07:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:07:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:07:10 INFO - {'append_to_log': False, 05:07:10 INFO - 'base_work_dir': '/builds/slave/test', 05:07:10 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:07:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:07:10 INFO - 'branch': 'Fx-Team-Non-PGO', 05:07:10 INFO - 'buildbot_json_path': 'buildprops.json', 05:07:10 INFO - 'config_files': ('talos/linux_config.py',), 05:07:10 INFO - 'default_actions': ('clobber', 05:07:10 INFO - 'read-buildbot-config', 05:07:10 INFO - 'download-and-extract', 05:07:10 INFO - 'populate-webroot', 05:07:10 INFO - 'create-virtualenv', 05:07:10 INFO - 'install', 05:07:10 INFO - 'run-tests'), 05:07:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:07:10 INFO - 'download_minidump_stackwalk': True, 05:07:10 INFO - 'download_symbols': 'ondemand', 05:07:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:07:10 INFO - 'tooltool.py': '/tools/tooltool.py', 05:07:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:07:10 INFO - '/tools/misc-python/virtualenv.py')}, 05:07:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:07:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:07:10 INFO - 'installer_path': 'installer.exe', 05:07:10 INFO - 'log_level': 'info', 05:07:10 INFO - 'log_name': 'talos', 05:07:10 INFO - 'log_to_console': True, 05:07:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:07:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:07:10 INFO - 'opt_config_files': (), 05:07:10 INFO - 'pip_index': False, 05:07:10 INFO - 'sps_profile': False, 05:07:10 INFO - 'sps_profile_interval': 0, 05:07:10 INFO - 'suite': 'dromaeojs', 05:07:10 INFO - 'system_bits': '32', 05:07:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:07:10 INFO - 'title': 'talos-linux64-ix-035', 05:07:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:07:10 INFO - 'use_talos_json': True, 05:07:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:07:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:07:10 INFO - 'work_dir': 'build'} 05:07:10 INFO - [mozharness: 2016-09-23 12:07:10.626794Z] Running clobber step. 05:07:10 INFO - Running pre-action listener: _resource_record_pre_action 05:07:10 INFO - Running main action method: clobber 05:07:10 INFO - rmtree: /builds/slave/test/build 05:07:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:07:11 INFO - Running post-action listener: _resource_record_post_action 05:07:11 INFO - [mozharness: 2016-09-23 12:07:11.600899Z] Finished clobber step (success) 05:07:11 INFO - [mozharness: 2016-09-23 12:07:11.600999Z] Running read-buildbot-config step. 05:07:11 INFO - Running pre-action listener: _resource_record_pre_action 05:07:11 INFO - Running main action method: read_buildbot_config 05:07:11 INFO - Using buildbot properties: 05:07:11 INFO - { 05:07:11 INFO - "project": "", 05:07:11 INFO - "product": "firefox", 05:07:11 INFO - "script_repo_revision": "production", 05:07:11 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:07:11 INFO - "repository": "", 05:07:11 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:07:11 INFO - "buildid": "20160923035101", 05:07:11 INFO - "pgo_build": "False", 05:07:11 INFO - "basedir": "/builds/slave/test", 05:07:11 INFO - "buildnumber": 3347, 05:07:11 INFO - "slavename": "talos-linux64-ix-035", 05:07:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:07:11 INFO - "platform": "ubuntu64_hw", 05:07:11 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:07:11 INFO - "branch": "fx-team", 05:07:11 INFO - "repo_path": "integration/fx-team", 05:07:11 INFO - "revision": "60cc643978c7020926fe4145761e26945fcd5c37", 05:07:11 INFO - "stage_platform": "linux64", 05:07:11 INFO - "builduid": "37e55f9ffeab43dca78129a05f79ccec", 05:07:11 INFO - "slavebuilddir": "test" 05:07:11 INFO - } 05:07:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/DSbIMvxKQECotsSBBHiWyQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 05:07:11 INFO - Running post-action listener: _resource_record_post_action 05:07:11 INFO - [mozharness: 2016-09-23 12:07:11.603764Z] Finished read-buildbot-config step (success) 05:07:11 INFO - [mozharness: 2016-09-23 12:07:11.603854Z] Running download-and-extract step. 05:07:11 INFO - Running pre-action listener: _resource_record_pre_action 05:07:11 INFO - Running main action method: download_and_extract 05:07:11 INFO - mkdir: /builds/slave/test/build/tests 05:07:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:11 INFO - trying https://queue.taskcluster.net/v1/task/DSbIMvxKQECotsSBBHiWyQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:07:11 INFO - Downloading https://queue.taskcluster.net/v1/task/DSbIMvxKQECotsSBBHiWyQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:07:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DSbIMvxKQECotsSBBHiWyQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:07:12 INFO - Downloaded 1361 bytes. 05:07:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:07:12 INFO - Using the following test package requirements: 05:07:12 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:07:12 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:07:12 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:07:12 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:12 INFO - u'jsshell-linux-x86_64.zip'], 05:07:12 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:07:12 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:07:12 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:07:12 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:07:12 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:07:12 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:07:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:07:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:07:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DSbIMvxKQECotsSBBHiWyQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:07:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DSbIMvxKQECotsSBBHiWyQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:07:12 INFO - Fetch https://queue.taskcluster.net/v1/task/DSbIMvxKQECotsSBBHiWyQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:07:12 INFO - Expected file size: 20377253 05:07:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:07:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DSbIMvxKQECotsSBBHiWyQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:07:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DSbIMvxKQECotsSBBHiWyQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:07:17 INFO - Fetch https://queue.taskcluster.net/v1/task/DSbIMvxKQECotsSBBHiWyQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:07:17 INFO - Expected file size: 20377253 05:07:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DSbIMvxKQECotsSBBHiWyQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 05:07:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DSbIMvxKQECotsSBBHiWyQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:07:22 INFO - Fetch https://queue.taskcluster.net/v1/task/DSbIMvxKQECotsSBBHiWyQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:07:23 INFO - Expected file size: 14414059 05:07: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')]} 05:07:24 INFO - trying https://queue.taskcluster.net/v1/task/DSbIMvxKQECotsSBBHiWyQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:07:24 INFO - Downloading https://queue.taskcluster.net/v1/task/DSbIMvxKQECotsSBBHiWyQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:07:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DSbIMvxKQECotsSBBHiWyQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:07:25 INFO - Downloaded 55729004 bytes. 05:07:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DSbIMvxKQECotsSBBHiWyQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:07:25 INFO - mkdir: /builds/slave/test/properties 05:07:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:07:25 INFO - Writing to file /builds/slave/test/properties/build_url 05:07:25 INFO - Contents: 05:07:25 INFO - build_url:https://queue.taskcluster.net/v1/task/DSbIMvxKQECotsSBBHiWyQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:07:26 INFO - Running post-action listener: _resource_record_post_action 05:07:26 INFO - Running post-action listener: set_extra_try_arguments 05:07:26 INFO - [mozharness: 2016-09-23 12:07:26.542034Z] Finished download-and-extract step (success) 05:07:26 INFO - [mozharness: 2016-09-23 12:07:26.542264Z] Running populate-webroot step. 05:07:26 INFO - Running pre-action listener: _resource_record_pre_action 05:07:26 INFO - Running main action method: populate_webroot 05:07:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:07:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:07:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:07:26 INFO - '--tppagecycles', 05:07:26 INFO - '7'], 05:07:26 INFO - 'tests': ['tsvgm']}}, 05:07:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:07:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:07:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:07:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:07:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:07:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:07:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:26 INFO - 'talos_options': ['--disable-e10s'], 05:07:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:26 INFO - 'talos_options': ['--disable-e10s'], 05:07:26 INFO - 'tests': ['damp', 'tps']}, 05:07:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:26 INFO - 'tests': ['damp', 'tps']}, 05:07:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:07:26 INFO - 'tests': ['dromaeo_dom']}, 05:07:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:07:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:07:26 INFO - 'tests': ['basic_compositor_video']}, 05:07:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:07:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:07:26 INFO - 'tests': ['a11yr', 05:07:26 INFO - 'ts_paint', 05:07:26 INFO - 'tpaint', 05:07:26 INFO - 'sessionrestore', 05:07:26 INFO - 'sessionrestore_no_auto_restore', 05:07:26 INFO - 'tabpaint']}, 05:07:26 INFO - 'other-e10s': {'tests': ['a11yr', 05:07:26 INFO - 'ts_paint', 05:07:26 INFO - 'tpaint', 05:07:26 INFO - 'sessionrestore', 05:07:26 INFO - 'sessionrestore_no_auto_restore', 05:07:26 INFO - 'tabpaint']}, 05:07:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:07:26 INFO - 'ts_paint', 05:07:26 INFO - 'tpaint', 05:07:26 INFO - 'sessionrestore', 05:07:26 INFO - 'sessionrestore_no_auto_restore', 05:07:26 INFO - 'tabpaint']}, 05:07:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:07:26 INFO - 'ts_paint', 05:07:26 INFO - 'tpaint', 05:07:26 INFO - 'sessionrestore', 05:07:26 INFO - 'sessionrestore_no_auto_restore', 05:07:26 INFO - 'tabpaint']}, 05:07:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:07:26 INFO - 'tests': ['a11yr', 05:07:26 INFO - 'ts_paint', 05:07:26 INFO - 'tpaint', 05:07:26 INFO - 'sessionrestore', 05:07:26 INFO - 'sessionrestore_no_auto_restore', 05:07:26 INFO - 'tabpaint']}, 05:07:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:07:26 INFO - 'tests': ['a11yr', 05:07:26 INFO - 'ts_paint', 05:07:26 INFO - 'tpaint', 05:07:26 INFO - 'sessionrestore', 05:07:26 INFO - 'sessionrestore_no_auto_restore', 05:07:26 INFO - 'tabpaint']}, 05:07:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:07:26 INFO - 'tests': ['tsvgx', 05:07:26 INFO - 'tsvgr_opacity', 05:07:26 INFO - 'tart', 05:07:26 INFO - 'tscrollx', 05:07:26 INFO - 'cart']}, 05:07:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:07:26 INFO - 'tsvgr_opacity', 05:07:26 INFO - 'tart', 05:07:26 INFO - 'tscrollx', 05:07:26 INFO - 'cart']}, 05:07:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:26 INFO - 'talos_options': ['--disable-e10s'], 05:07:26 INFO - 'tests': ['tp5o']}, 05:07:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:26 INFO - 'tests': ['tp5o']}, 05:07:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:26 INFO - 'talos_options': ['--disable-e10s', 05:07:26 INFO - '--xperf_path', 05:07:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:26 INFO - 'tests': ['tp5n']}, 05:07:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:26 INFO - 'talos_options': ['--xperf_path', 05:07:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:26 INFO - 'tests': ['tp5n']}}, 05:07:26 INFO - 'talos.zip': {'path': '', 05:07:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:07:26 INFO - Running post-action listener: _resource_record_post_action 05:07:26 INFO - [mozharness: 2016-09-23 12:07:26.560326Z] Finished populate-webroot step (success) 05:07:26 INFO - [mozharness: 2016-09-23 12:07:26.560415Z] Running create-virtualenv step. 05:07:26 INFO - Running pre-action listener: _resource_record_pre_action 05:07:26 INFO - Running main action method: create_virtualenv 05:07:26 INFO - Creating virtualenv /builds/slave/test/build/venv 05:07:26 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 05:07:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:07:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:07:26 INFO - Using real prefix '/usr' 05:07:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:07:27 INFO - Installing distribute.............................................................................................................................................................................................done. 05:07:29 INFO - Installing pip.................done. 05:07:29 INFO - Return code: 0 05:07:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0783cd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2732f60>, '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 0x2733d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27341d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1474632149.339210-1989473087', '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 05:07:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:07:29 INFO - Using env: {'DISPLAY': ':0', 05:07:29 INFO - 'HOME': '/home/cltbld', 05:07:29 INFO - 'LANG': 'en_US.UTF-8', 05:07:29 INFO - 'LANGUAGE': 'en_US:en', 05:07:29 INFO - 'LOGNAME': 'cltbld', 05:07:29 INFO - 'MAIL': '/var/mail/cltbld', 05:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:29 INFO - 'MOZ_NO_REMOTE': '1', 05:07:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:29 INFO - 'NO_EM_RESTART': '1', 05:07:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:29 INFO - 'PWD': '/builds/slave/test', 05:07:29 INFO - 'SHELL': '/bin/bash', 05:07:29 INFO - 'SHLVL': '1', 05:07:29 INFO - 'TERM': 'linux', 05:07:29 INFO - 'TMOUT': '86400', 05:07:29 INFO - 'USER': 'cltbld', 05:07:29 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1474632149.339210-1989473087', 05:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:29 INFO - '_': '/tools/buildbot/bin/python'} 05:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:29 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 05:07:29 INFO - Cleaning up... 05:07:29 INFO - Return code: 0 05:07:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0783cd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2732f60>, '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 0x2733d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27341d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1474632149.339210-1989473087', '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 05:07:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:07:29 INFO - Using env: {'DISPLAY': ':0', 05:07:29 INFO - 'HOME': '/home/cltbld', 05:07:29 INFO - 'LANG': 'en_US.UTF-8', 05:07:29 INFO - 'LANGUAGE': 'en_US:en', 05:07:29 INFO - 'LOGNAME': 'cltbld', 05:07:29 INFO - 'MAIL': '/var/mail/cltbld', 05:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:29 INFO - 'MOZ_NO_REMOTE': '1', 05:07:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:29 INFO - 'NO_EM_RESTART': '1', 05:07:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:29 INFO - 'PWD': '/builds/slave/test', 05:07:29 INFO - 'SHELL': '/bin/bash', 05:07:29 INFO - 'SHLVL': '1', 05:07:29 INFO - 'TERM': 'linux', 05:07:29 INFO - 'TMOUT': '86400', 05:07:29 INFO - 'USER': 'cltbld', 05:07:29 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1474632149.339210-1989473087', 05:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:29 INFO - '_': '/tools/buildbot/bin/python'} 05:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:29 INFO - Downloading/unpacking psutil>=3.1.1 05:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:07:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:31 INFO - Installing collected packages: psutil 05:07:31 INFO - Running setup.py install for psutil 05:07:31 INFO - building 'psutil._psutil_linux' extension 05:07:31 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 05:07:31 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 05:07:31 INFO - building 'psutil._psutil_posix' extension 05:07:31 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 05:07:31 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 05:07:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:32 INFO - Successfully installed psutil 05:07:32 INFO - Cleaning up... 05:07:32 INFO - Return code: 0 05:07:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:32 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 0x7f0783cd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2732f60>, '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 0x2733d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27341d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1474632149.339210-1989473087', '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 05:07:32 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 05:07:32 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 05:07:32 INFO - Using env: {'DISPLAY': ':0', 05:07:32 INFO - 'HOME': '/home/cltbld', 05:07:32 INFO - 'LANG': 'en_US.UTF-8', 05:07:32 INFO - 'LANGUAGE': 'en_US:en', 05:07:32 INFO - 'LOGNAME': 'cltbld', 05:07:32 INFO - 'MAIL': '/var/mail/cltbld', 05:07:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:32 INFO - 'MOZ_NO_REMOTE': '1', 05:07:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:32 INFO - 'NO_EM_RESTART': '1', 05:07:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:32 INFO - 'PWD': '/builds/slave/test', 05:07:32 INFO - 'SHELL': '/bin/bash', 05:07:32 INFO - 'SHLVL': '1', 05:07:32 INFO - 'TERM': 'linux', 05:07:32 INFO - 'TMOUT': '86400', 05:07:32 INFO - 'USER': 'cltbld', 05:07:32 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1474632149.339210-1989473087', 05:07:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:32 INFO - '_': '/tools/buildbot/bin/python'} 05:07:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:07:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:07:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:07:34 INFO - Installing collected packages: mozsystemmonitor 05:07:34 INFO - Running setup.py install for mozsystemmonitor 05:07:34 INFO - Successfully installed mozsystemmonitor 05:07:34 INFO - Cleaning up... 05:07:34 INFO - Return code: 0 05:07:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:07: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')]} 05:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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')]} 05:07:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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', '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 0x7f0783cd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2732f60>, '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 0x2733d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27341d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1474632149.339210-1989473087', '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 05:07: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:07: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 jsonschema==2.5.1 05:07:34 INFO - Using env: {'DISPLAY': ':0', 05:07:34 INFO - 'HOME': '/home/cltbld', 05:07:34 INFO - 'LANG': 'en_US.UTF-8', 05:07:34 INFO - 'LANGUAGE': 'en_US:en', 05:07:34 INFO - 'LOGNAME': 'cltbld', 05:07:34 INFO - 'MAIL': '/var/mail/cltbld', 05:07:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:34 INFO - 'MOZ_NO_REMOTE': '1', 05:07:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:34 INFO - 'NO_EM_RESTART': '1', 05:07:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:34 INFO - 'PWD': '/builds/slave/test', 05:07:34 INFO - 'SHELL': '/bin/bash', 05:07:34 INFO - 'SHLVL': '1', 05:07:34 INFO - 'TERM': 'linux', 05:07:34 INFO - 'TMOUT': '86400', 05:07:34 INFO - 'USER': 'cltbld', 05:07:34 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1474632149.339210-1989473087', 05:07:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:34 INFO - '_': '/tools/buildbot/bin/python'} 05:07:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:34 INFO - Downloading/unpacking jsonschema==2.5.1 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:07:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07:36 INFO - Downloading functools32-3.2.3-2.tar.gz 05:07:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:07:36 INFO - warning: no files found matching '*.txt' 05:07:36 INFO - no previously-included directories found matching 'build' 05:07:36 INFO - no previously-included directories found matching 'dist' 05:07:36 INFO - no previously-included directories found matching '.git*' 05:07:36 INFO - Installing collected packages: jsonschema, functools32 05:07:36 INFO - Running setup.py install for functools32 05:07:37 INFO - warning: no files found matching '*.txt' 05:07:37 INFO - no previously-included directories found matching 'build' 05:07:37 INFO - no previously-included directories found matching 'dist' 05:07:37 INFO - no previously-included directories found matching '.git*' 05:07:37 INFO - Successfully installed jsonschema functools32 05:07:37 INFO - Cleaning up... 05:07:37 INFO - Return code: 0 05:07:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:07: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')]} 05:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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')]} 05:07:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:37 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 0x7f0783cd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2732f60>, '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 0x2733d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27341d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1474632149.339210-1989473087', '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 05:07:37 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 05:07:37 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 05:07:37 INFO - Using env: {'DISPLAY': ':0', 05:07:37 INFO - 'HOME': '/home/cltbld', 05:07:37 INFO - 'LANG': 'en_US.UTF-8', 05:07:37 INFO - 'LANGUAGE': 'en_US:en', 05:07:37 INFO - 'LOGNAME': 'cltbld', 05:07:37 INFO - 'MAIL': '/var/mail/cltbld', 05:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:37 INFO - 'MOZ_NO_REMOTE': '1', 05:07:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:37 INFO - 'NO_EM_RESTART': '1', 05:07:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:37 INFO - 'PWD': '/builds/slave/test', 05:07:37 INFO - 'SHELL': '/bin/bash', 05:07:37 INFO - 'SHLVL': '1', 05:07:37 INFO - 'TERM': 'linux', 05:07:37 INFO - 'TMOUT': '86400', 05:07:37 INFO - 'USER': 'cltbld', 05:07:37 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1474632149.339210-1989473087', 05:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:37 INFO - '_': '/tools/buildbot/bin/python'} 05:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:07:37 INFO - Cleaning up... 05:07:37 INFO - Return code: 0 05:07:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:07: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')]} 05:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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')]} 05:07:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:37 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 0x7f0783cd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2732f60>, '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 0x2733d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27341d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1474632149.339210-1989473087', '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 05:07:37 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 05:07:37 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 05:07:37 INFO - Using env: {'DISPLAY': ':0', 05:07:37 INFO - 'HOME': '/home/cltbld', 05:07:37 INFO - 'LANG': 'en_US.UTF-8', 05:07:37 INFO - 'LANGUAGE': 'en_US:en', 05:07:37 INFO - 'LOGNAME': 'cltbld', 05:07:37 INFO - 'MAIL': '/var/mail/cltbld', 05:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:37 INFO - 'MOZ_NO_REMOTE': '1', 05:07:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:37 INFO - 'NO_EM_RESTART': '1', 05:07:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:37 INFO - 'PWD': '/builds/slave/test', 05:07:37 INFO - 'SHELL': '/bin/bash', 05:07:37 INFO - 'SHLVL': '1', 05:07:37 INFO - 'TERM': 'linux', 05:07:37 INFO - 'TMOUT': '86400', 05:07:37 INFO - 'USER': 'cltbld', 05:07:37 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1474632149.339210-1989473087', 05:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:37 INFO - '_': '/tools/buildbot/bin/python'} 05:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:37 INFO - Downloading/unpacking blobuploader==1.2.4 05:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:39 INFO - Downloading blobuploader-1.2.4.tar.gz 05:07:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:07:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:07:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:40 INFO - Downloading docopt-0.6.1.tar.gz 05:07:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:07:40 INFO - Installing collected packages: blobuploader, requests, docopt 05:07:40 INFO - Running setup.py install for blobuploader 05:07:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:07:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:07:40 INFO - Running setup.py install for requests 05:07:40 INFO - Running setup.py install for docopt 05:07:40 INFO - Successfully installed blobuploader requests docopt 05:07:40 INFO - Cleaning up... 05:07:40 INFO - Return code: 0 05:07:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07:40 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')]} 05:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:40 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')]} 05:07:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:40 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 0x7f0783cd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2732f60>, '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 0x2733d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27341d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1474632149.339210-1989473087', '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 05:07:40 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 05:07:40 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 05:07:40 INFO - Using env: {'DISPLAY': ':0', 05:07:40 INFO - 'HOME': '/home/cltbld', 05:07:40 INFO - 'LANG': 'en_US.UTF-8', 05:07:40 INFO - 'LANGUAGE': 'en_US:en', 05:07:40 INFO - 'LOGNAME': 'cltbld', 05:07:40 INFO - 'MAIL': '/var/mail/cltbld', 05:07:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:40 INFO - 'MOZ_NO_REMOTE': '1', 05:07:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:40 INFO - 'NO_EM_RESTART': '1', 05:07:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:40 INFO - 'PWD': '/builds/slave/test', 05:07:40 INFO - 'SHELL': '/bin/bash', 05:07:40 INFO - 'SHLVL': '1', 05:07:40 INFO - 'TERM': 'linux', 05:07:40 INFO - 'TMOUT': '86400', 05:07:40 INFO - 'USER': 'cltbld', 05:07:40 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1474632149.339210-1989473087', 05:07:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:40 INFO - '_': '/tools/buildbot/bin/python'} 05:07:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:07:40 INFO - Running setup.py (path:/tmp/pip-PmvlCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:07:41 INFO - Running setup.py (path:/tmp/pip-z0CvQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:07:41 INFO - Running setup.py (path:/tmp/pip-f5mGv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:07:41 INFO - Running setup.py (path:/tmp/pip-XHNMof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:07:41 INFO - Running setup.py (path:/tmp/pip-K4atQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:07:41 INFO - Running setup.py (path:/tmp/pip-CWuwAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:07:41 INFO - Running setup.py (path:/tmp/pip-w1xRRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:07:41 INFO - Running setup.py (path:/tmp/pip-XVDHXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:07:41 INFO - Running setup.py (path:/tmp/pip-vzjXOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:07:41 INFO - Running setup.py (path:/tmp/pip-6NfOLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:07:41 INFO - Running setup.py (path:/tmp/pip-C8WwgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:07:41 INFO - Running setup.py (path:/tmp/pip-SLySTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:07:41 INFO - Running setup.py (path:/tmp/pip-ARXMae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:07:41 INFO - Running setup.py (path:/tmp/pip-Vl9ZrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:41 INFO - Running setup.py (path:/tmp/pip-EeLry1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:07:42 INFO - Running setup.py (path:/tmp/pip-VhaYoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:07:42 INFO - Running setup.py (path:/tmp/pip-jq3l9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:07:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:07:42 INFO - Running setup.py install for manifestparser 05:07:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:07:42 INFO - Running setup.py install for mozcrash 05:07:42 INFO - Running setup.py install for mozdebug 05:07:42 INFO - Running setup.py install for mozdevice 05:07:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:07:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:07:42 INFO - Running setup.py install for mozfile 05:07:42 INFO - Running setup.py install for mozhttpd 05:07:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:07:42 INFO - Running setup.py install for mozinfo 05:07:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:07:42 INFO - Running setup.py install for mozInstall 05:07:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:07:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:07:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:07:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:07:42 INFO - Running setup.py install for mozleak 05:07:43 INFO - Running setup.py install for mozlog 05:07:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:07:43 INFO - Running setup.py install for moznetwork 05:07:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:07:43 INFO - Running setup.py install for mozprocess 05:07:43 INFO - Running setup.py install for mozprofile 05:07:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:07:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:07:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:07:43 INFO - Running setup.py install for mozrunner 05:07:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:07:43 INFO - Running setup.py install for mozscreenshot 05:07:43 INFO - Running setup.py install for moztest 05:07:43 INFO - Running setup.py install for mozversion 05:07:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:07:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:07:43 INFO - Cleaning up... 05:07:43 INFO - Return code: 0 05:07:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:43 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 0x7f0783cd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2732f60>, '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 0x2733d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27341d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1474632149.339210-1989473087', '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 05:07:43 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 05:07:43 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 05:07:43 INFO - Using env: {'DISPLAY': ':0', 05:07:43 INFO - 'HOME': '/home/cltbld', 05:07:43 INFO - 'LANG': 'en_US.UTF-8', 05:07:43 INFO - 'LANGUAGE': 'en_US:en', 05:07:43 INFO - 'LOGNAME': 'cltbld', 05:07:43 INFO - 'MAIL': '/var/mail/cltbld', 05:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:43 INFO - 'MOZ_NO_REMOTE': '1', 05:07:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:43 INFO - 'NO_EM_RESTART': '1', 05:07:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:43 INFO - 'PWD': '/builds/slave/test', 05:07:43 INFO - 'SHELL': '/bin/bash', 05:07:43 INFO - 'SHLVL': '1', 05:07:43 INFO - 'TERM': 'linux', 05:07:43 INFO - 'TMOUT': '86400', 05:07:43 INFO - 'USER': 'cltbld', 05:07:43 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1474632149.339210-1989473087', 05:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:43 INFO - '_': '/tools/buildbot/bin/python'} 05:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:07:44 INFO - Running setup.py (path:/tmp/pip-JjCSQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:07:44 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)) 05:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:07:44 INFO - Running setup.py (path:/tmp/pip-KCWwtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:07:44 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)) 05:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:07:44 INFO - Running setup.py (path:/tmp/pip-8Cv94p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:07:44 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)) 05:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:07:44 INFO - Running setup.py (path:/tmp/pip-IgmM0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:07:44 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)) 05:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:07:44 INFO - Running setup.py (path:/tmp/pip-hvqotw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:07:44 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)) 05:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:07:44 INFO - Running setup.py (path:/tmp/pip-3FCms5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:07:44 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)) 05:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:07:44 INFO - Running setup.py (path:/tmp/pip-qVN1Zp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:07:44 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)) 05:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:07:44 INFO - Running setup.py (path:/tmp/pip-Ip1T59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:07:44 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)) 05:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:07:44 INFO - Running setup.py (path:/tmp/pip-i6mWCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:07:44 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)) 05:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:07:44 INFO - Running setup.py (path:/tmp/pip-6rPTTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:07:44 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)) 05:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:07:44 INFO - Running setup.py (path:/tmp/pip-vCI9a4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:07:44 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)) 05:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:07:44 INFO - Running setup.py (path:/tmp/pip-5GCAar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:07:45 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)) 05:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:07:45 INFO - Running setup.py (path:/tmp/pip-e2s47k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:07:45 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)) 05:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:07:45 INFO - Running setup.py (path:/tmp/pip-BA6j_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:07:45 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)) 05:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:45 INFO - Running setup.py (path:/tmp/pip-bdZDYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:45 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)) 05:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:07:45 INFO - Running setup.py (path:/tmp/pip-nUwyUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:07:45 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)) 05:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:07:45 INFO - Running setup.py (path:/tmp/pip-v3xgj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:07:45 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)) 05:07:45 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)) 05:07:45 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)) 05:07:45 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)) 05:07:45 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)) 05:07:45 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)) 05:07:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:07:45 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 05:07:45 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 05:07:45 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 05:07:45 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 05:07:45 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 05:07:45 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 05:07:47 INFO - Downloading blessings-1.6.tar.gz 05:07:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:07:47 INFO - Installing collected packages: blessings 05:07:47 INFO - Running setup.py install for blessings 05:07:47 INFO - Successfully installed blessings 05:07:47 INFO - Cleaning up... 05:07:47 INFO - Return code: 0 05:07:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:07:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:07:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:07:47 INFO - Reading from file tmpfile_stdout 05:07:47 INFO - Current package versions: 05:07:47 INFO - argparse == 1.2.1 05:07:47 INFO - blessings == 1.6 05:07:47 INFO - blobuploader == 1.2.4 05:07:47 INFO - docopt == 0.6.1 05:07:47 INFO - functools32 == 3.2.3-2 05:07:47 INFO - jsonschema == 2.5.1 05:07:47 INFO - manifestparser == 1.1 05:07:47 INFO - mozInstall == 1.12 05:07:47 INFO - mozcrash == 0.17 05:07:47 INFO - mozdebug == 0.1 05:07:47 INFO - mozdevice == 0.48 05:07:47 INFO - mozfile == 1.2 05:07:47 INFO - mozhttpd == 0.7 05:07:47 INFO - mozinfo == 0.9 05:07:47 INFO - mozleak == 0.1 05:07:47 INFO - mozlog == 3.4 05:07:47 INFO - moznetwork == 0.27 05:07:47 INFO - mozprocess == 0.23 05:07:47 INFO - mozprofile == 0.28 05:07:47 INFO - mozrunner == 6.12 05:07:47 INFO - mozscreenshot == 0.1 05:07:47 INFO - mozsystemmonitor == 0.3 05:07:47 INFO - moztest == 0.7 05:07:47 INFO - mozversion == 1.4 05:07:47 INFO - psutil == 3.1.1 05:07:47 INFO - requests == 1.2.3 05:07:47 INFO - wsgiref == 0.1.2 05:07:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07:47 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')]} 05:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:47 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')]} 05:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:47 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 0x7f0783cd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2732f60>, '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 0x2733d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27341d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1474632149.339210-1989473087', '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 05:07:47 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 05:07:47 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 05:07:47 INFO - Using env: {'DISPLAY': ':0', 05:07:47 INFO - 'HOME': '/home/cltbld', 05:07:47 INFO - 'LANG': 'en_US.UTF-8', 05:07:47 INFO - 'LANGUAGE': 'en_US:en', 05:07:47 INFO - 'LOGNAME': 'cltbld', 05:07:47 INFO - 'MAIL': '/var/mail/cltbld', 05:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:47 INFO - 'MOZ_NO_REMOTE': '1', 05:07:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:47 INFO - 'NO_EM_RESTART': '1', 05:07:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:47 INFO - 'PWD': '/builds/slave/test', 05:07:47 INFO - 'SHELL': '/bin/bash', 05:07:47 INFO - 'SHLVL': '1', 05:07:47 INFO - 'TERM': 'linux', 05:07:47 INFO - 'TMOUT': '86400', 05:07:47 INFO - 'USER': 'cltbld', 05:07:47 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1474632149.339210-1989473087', 05:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:47 INFO - '_': '/tools/buildbot/bin/python'} 05:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:48 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)) 05:07:48 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)) 05:07:48 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)) 05:07:48 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)) 05:07:48 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)) 05:07:48 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)) 05:07:48 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)) 05:07:48 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)) 05:07:48 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)) 05:07:48 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)) 05:07:48 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)) 05:07:48 INFO - Cleaning up... 05:07:48 INFO - Return code: 0 05:07:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:07:48 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')]} 05:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:48 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')]} 05:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:48 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 0x7f0783cd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2735ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2732f60>, '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 0x2733d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27341d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1474632149.339210-1989473087', '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 05:07:48 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 05:07:48 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 05:07:48 INFO - Using env: {'DISPLAY': ':0', 05:07:48 INFO - 'HOME': '/home/cltbld', 05:07:48 INFO - 'LANG': 'en_US.UTF-8', 05:07:48 INFO - 'LANGUAGE': 'en_US:en', 05:07:48 INFO - 'LOGNAME': 'cltbld', 05:07:48 INFO - 'MAIL': '/var/mail/cltbld', 05:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:48 INFO - 'MOZ_NO_REMOTE': '1', 05:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:48 INFO - 'NO_EM_RESTART': '1', 05:07:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:48 INFO - 'PWD': '/builds/slave/test', 05:07:48 INFO - 'SHELL': '/bin/bash', 05:07:48 INFO - 'SHLVL': '1', 05:07:48 INFO - 'TERM': 'linux', 05:07:48 INFO - 'TMOUT': '86400', 05:07:48 INFO - 'USER': 'cltbld', 05:07:48 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1474632149.339210-1989473087', 05:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:48 INFO - '_': '/tools/buildbot/bin/python'} 05:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:07:48 INFO - Cleaning up... 05:07:48 INFO - Return code: 0 05:07:48 INFO - Running post-action listener: _resource_record_post_action 05:07:48 INFO - Running post-action listener: _start_resource_monitoring 05:07:48 INFO - Starting resource monitoring. 05:07:48 INFO - [mozharness: 2016-09-23 12:07:48.276027Z] Finished create-virtualenv step (success) 05:07:48 INFO - [mozharness: 2016-09-23 12:07:48.276474Z] Running install step. 05:07:48 INFO - Running pre-action listener: _resource_record_pre_action 05:07:48 INFO - Running main action method: install 05:07:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:07:48 INFO - Reading from file tmpfile_stdout 05:07:48 INFO - Detecting whether we're running mozinstall >=1.0... 05:07:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:07:48 INFO - Reading from file tmpfile_stdout 05:07:48 INFO - Output received: 05:07:48 INFO - Usage: mozinstall [options] installer 05:07:48 INFO - Options: 05:07:48 INFO - -h, --help show this help message and exit 05:07:48 INFO - -d DEST, --destination=DEST 05:07:48 INFO - Directory to install application into. [default: 05:07:48 INFO - "/builds/slave/test"] 05:07:48 INFO - --app=APP Application being installed. [default: firefox] 05:07:48 INFO - mkdir: /builds/slave/test/build/application 05:07:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:08:05 INFO - Reading from file tmpfile_stdout 05:08:05 INFO - Output received: 05:08:05 INFO - /builds/slave/test/build/application/firefox/firefox 05:08:05 INFO - Running post-action listener: _resource_record_post_action 05:08:05 INFO - [mozharness: 2016-09-23 12:08:05.099878Z] Finished install step (success) 05:08:05 INFO - [mozharness: 2016-09-23 12:08:05.100124Z] Running run-tests step. 05:08:05 INFO - Running pre-action listener: _resource_record_pre_action 05:08:05 INFO - Running main action method: run_tests 05:08:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:08:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:08:05 INFO - Python 2.7.3 05:08:05 INFO - Return code: 0 05:08:05 INFO - grabbing minidump binary from tooltool 05:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:05 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/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 0x2732f60>, '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 0x2733d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27341d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:08:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:08:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:08:05 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 05:08:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:08:05 INFO - Return code: 0 05:08:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:08:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:08:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:08:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:08:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:08:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DSbIMvxKQECotsSBBHiWyQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 05:08:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DSbIMvxKQECotsSBBHiWyQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 05:08:05 INFO - Using env: {'DISPLAY': ':0', 05:08:05 INFO - 'HOME': '/home/cltbld', 05:08:05 INFO - 'LANG': 'en_US.UTF-8', 05:08:05 INFO - 'LANGUAGE': 'en_US:en', 05:08:05 INFO - 'LOGNAME': 'cltbld', 05:08:05 INFO - 'MAIL': '/var/mail/cltbld', 05:08:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:08:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:05 INFO - 'MOZ_NO_REMOTE': '1', 05:08:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:05 INFO - 'NO_EM_RESTART': '1', 05:08:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:05 INFO - 'PWD': '/builds/slave/test', 05:08:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:08:05 INFO - 'SHELL': '/bin/bash', 05:08:05 INFO - 'SHLVL': '1', 05:08:05 INFO - 'TERM': 'linux', 05:08:05 INFO - 'TMOUT': '86400', 05:08:05 INFO - 'USER': 'cltbld', 05:08:05 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1474632149.339210-1989473087', 05:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:05 INFO - '_': '/tools/buildbot/bin/python'} 05:08:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DSbIMvxKQECotsSBBHiWyQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 05:08:05 INFO - mozversion application_buildid: 20160923035101 05:08:05 INFO - mozversion application_changeset: 60cc643978c7020926fe4145761e26945fcd5c37 05:08:05 INFO - mozversion application_display_name: Nightly 05:08:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:08:05 INFO - mozversion application_name: Firefox 05:08:05 INFO - mozversion application_remotingname: firefox 05:08:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:08:05 INFO - mozversion application_vendor: Mozilla 05:08:05 INFO - mozversion application_version: 52.0a1 05:08:05 INFO - mozversion platform_buildid: 20160923035101 05:08:05 INFO - mozversion platform_changeset: 60cc643978c7020926fe4145761e26945fcd5c37 05:08:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:08:05 INFO - mozversion platform_version: 52.0a1 05:08:05 INFO - using testdate: 1474632485 05:08:05 INFO - actual date: 1474632485 05:08:05 INFO - starting webserver on 'localhost:41493' 05:08:05 INFO - SUITE-START | Running 2 tests 05:08:05 INFO - TEST-START | dromaeo_css 05:08:05 INFO - operating with platform_type : linux_ 05:08:05 INFO - Initialising browser for dromaeo_css test... 05:08:05 INFO - TEST-INFO | started process 15186 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCHAgSI/profile http://localhost:41493/getInfo.html) 05:08:09 INFO - PROCESS | 15186 | __metrics Screen width/height:1600/1200 05:08:09 INFO - PROCESS | 15186 | colorDepth:24 05:08:09 INFO - PROCESS | 15186 | Browser inner width/height: 1024/697 05:08:09 INFO - PROCESS | 15186 | __metrics 05:08:10 INFO - PROCESS | 15186 | 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" 05:08:10 INFO - PROCESS | 15186 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:08:10 INFO - PROCESS | 15186 | console.error: PushService: 05:08:10 INFO - PROCESS | 15186 | stateChangeProcessEnqueue: Error transitioning state 05:08:10 INFO - PROCESS | 15186 | UnknownError 05:08:11 INFO - TEST-INFO | 15186: exit 0 05:08:11 INFO - Browser initialized. 05:08:11 INFO - Running cycle 1/1 for dromaeo_css test... 05:08:11 INFO - TEST-INFO | started process 15266 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCHAgSI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:08:23 INFO - PROCESS | 15266 | RSS: Main: 175296512 05:08:23 INFO - PROCESS | 15266 | 05:09:15 INFO - PROCESS | 15266 | 1474632555693 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] 05:11:28 INFO - PROCESS | 15266 | Cycle 1(1): loaded http://localhost:41493/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41493/tests/dromaeo/cssquery-ext.html) 05:11:29 INFO - PROCESS | 15266 | RSS: Main: 255668224 05:11:29 INFO - PROCESS | 15266 | 05:14:32 INFO - PROCESS | 15266 | Cycle 1(1): loaded http://localhost:41493/tests/dromaeo/cssquery-ext.html (next: http://localhost:41493/tests/dromaeo/cssquery-jquery.html) 05:14:32 INFO - PROCESS | 15266 | RSS: Main: 266747904 05:14:32 INFO - PROCESS | 15266 | 05:17:34 INFO - PROCESS | 15266 | Cycle 1(1): loaded http://localhost:41493/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41493/tests/dromaeo/cssquery-mootools.html) 05:17:35 INFO - PROCESS | 15266 | RSS: Main: 255832064 05:17:35 INFO - PROCESS | 15266 | 05:20:37 INFO - PROCESS | 15266 | Cycle 1(1): loaded http://localhost:41493/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41493/tests/dromaeo/cssquery-prototype.html) 05:20:38 INFO - PROCESS | 15266 | RSS: Main: 216375296 05:20:38 INFO - PROCESS | 15266 | 05:23:41 INFO - PROCESS | 15266 | Cycle 1(1): loaded http://localhost:41493/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41493/tests/dromaeo/cssquery-yui.html) 05:23:42 INFO - PROCESS | 15266 | RSS: Main: 214376448 05:23:42 INFO - PROCESS | 15266 | 05:26:45 INFO - PROCESS | 15266 | Cycle 1(1): loaded http://localhost:41493/tests/dromaeo/cssquery-yui.html (next: http://localhost:41493/tests/dromaeo/cssquery-dojo.html) 05:26:45 INFO - PROCESS | 15266 | RSS: Main: 309526528 05:26:45 INFO - PROCESS | 15266 | 05:26:45 INFO - PROCESS | 15266 | __start_tp_report 05:26:45 INFO - PROCESS | 15266 | _x_x_mozilla_page_load 05:26:45 INFO - PROCESS | 15266 | _x_x_mozilla_page_load_details 05:26:45 INFO - PROCESS | 15266 | |i|pagename|runs| 05:26:45 INFO - PROCESS | 15266 | |0;dojo.html;2586.6508021417108;2606.687197536296;2638.6833579970407;2640.947181056379;2654.163938359418;4636.953630463699;4654.883627909304;4692.741899195543;4693.835715749945;4701.835435759749;4699.718016918987;4722.7874745636445;4751.90496190076;4787.162246606838;4838.51614838516;4297.097609502009;4325.070109926365;4355.912881742363;4392.86821395357;4403.82384704613;4404.625606823424;4449.443819522559;4450.599446049855;4457.153140903234;4476.1271552047365;4327.437433133672;4409.426774519324;4417.271150260235;4436.378906953029;4515.187266292066;4362.847300344472;4363.996280855389;4404.361367601712;4420.580044895762;4453.242948698729;4384.473863136413;4386.517483076859;4389.144116897206;4446.488653804821;4456.019675671347;4739.620830333565;4763.547462991045;4796;4811;4872.220444728861;4938.2839488274;4977.527134922213;5009.574186194178;5043.495650434964;5120.871978200537;5091;5100.285959965608;5110.616703747234;5156.355455568054;5157.690538567698;4744.691595046311;4747.501512341223;4749.881252968635;4754.286856971482;4814.975925120352;4989.775460104304;5027.748612569357;5118.667286626357;5205.167173252337;5274.050670879202;4943.752812359367;4979.800807967641;4988.102141614471;5039.168537191395;5053.823116190989;5071.41678706946;5073.061483625467;5073.137566613685;5078.314427552233;5138.537531622172;4865.367502224688;4935.901281974412;5014.247862820534;5018.874528136826;5024.447310795809;4944.431390390151;4990.950090499121;5006.4743201964;5037.697738135724;5082.263071854561;4342;4345.044090300129;4350.456192975878;4395.230834603932;4401.625861801719;3772.4529943158636;3781.9810900945868;3811.5807261201244;3842.1355195080882;3844.0966372902344;4354.107407981356;4361.5856493633055;4379.3430985351815;4399.032212913154;4405.2511073117;5116.130257856174;5118.616103792156;5118.718470484085;5158.819441319536;5184.481551844785;4408.6913916026215;4410.42664453619;4414.381986521889;4470.485894122153;4472.7092738972515;4547.3406356078185;4561.178987782231;4608.377868987711;4628.352030715702;4634.2585186370015;4784.067106914188;4869.220924652181;4888.560029597354;4888.6577939543895;4890.902181956412;5067.341245638191;5070.797168113234;5072.644914855925;5073.11220536412;5157.303763991963;4815.253635686474;4822.734749588806;4825.9758701206265;4827.300041494034;4874.390701162355;4888.437829649636;4902.3872015998;4947.0353281111275;4979.651424400257;5009.924851127309;5109.565686916654;5110.207917772751;5116.360454943132;5116.3860336758335;5165.405978312542;4934.55588996992;4973.129702302155;4976.427710813158;4980.551750342486;5037.823676171316;4809.422869255712;4878.438979517401;4890.975545122394;4941.456439791692;4963.975180124221;4889.682170658896;4921.803127874988;4923.483034281492;4971.105201063843;4991.176455884738;4898.608111351012;4954.405471343462;4955.479674634112;4987.451380348086;5074.695518268915;4796.928046079382;4848.12733707936;4866.902661946812;4879.853604391874;4880.219164933594 05:26:45 INFO - PROCESS | 15266 | |1;ext.html;532.6005495878092;559.1138046196778;561.6826493031436;577.7313549199621;578.7945279425804;27510.174694759164;30829.22926926828;30866.691333086634;30870.69129308709;30889.69110308902;39447;39978.40032399516;40052.799736001354;44508.55491445085;44681.329780053326;7506.474546781714;7639.9236007639765;7643.235676432368;7645.388368930472;7647.464677472579;7314.963425182893;7465.888011679829;7545;7623.199564045779;7624.27569380908;7605.467617266793;7663.961680191591;9595.424274543515;9846.556904939294;9852.359596626196;9666.130048295652;9680.709578712649;9686.176674982635;9737.610495580167;9743.853842192373;9736.075072868067;9800.754981125458;9817.214622830157;9821.852672209923;9823.115919567203;36627.267454650755;37034.07414814624;37222.81388593067;37328;37341.81329093364;3027.9091627250996;3048.283653341463;3050.7864449488543;3094.3811237752316;3121.78147529673;27955;28069.578956315672;28651.856740716164;28838.71161288402;29797.702022979927;3252.642209356969;3273.685256983791;3339.799612023262;3362.0250127463005;3467.6532346765375;241234.7938260315;242379;242548;242637;243002;50994;51753.22370164451;51781.482185177665;51827;51902.48097519052;28764.424711505653;54049.459505405226;54258.45741542534;54278.728606356715;54366.72816635971;13894;14212.644683882985;14229.715405691828;14246;14314;10700.197485188643;10866.565337386573;10882.727931801768;10883.945580272048;10894;17620.20709068095;17848.55378615519;17887.642247154985;17906.462806115578;17960.9101954492;5380.488853558905;6559.934400656028;6713.832154196184;7035.226125126232;7048.224695283515;748.6631016042802;859.5788063848794;878.060475291432;896.7668406214431;938.6057855700485;27063.1881043569;27817.721822781514;28683.28291792722;28749;28837.711622883922;905.8822353094056;922.423485321674;929.9116583924516;933.118203297877;1004.3572113847143;14700.264986750833;14881.627959300888;15123.546293611209;15153.82735628391;15459.690806183813;360243;365956;366063;366565;366673;48986.75506622444;49542.50457495451;49580;49585;49709.50290497049;1071.0895738622264;1104.6741211342674;1140.0708422635525;1147.9942600286945;1159.930404175752;24610.50778984446;28594.57108143338;29366.412671746017;29768.404631907673;29812.254693632833;41703.58296416997;42272.15455690931;42299.57700423079;42324.36513452362;42333.36499952441;238198;239167;239342;240333;242548;23942.401439964142;24554.263372098867;24691.135810246557;24725.50548989046;26227.868860655573;40672.59327406688;40767;41066;41236.79381603073;41868.58131418647;34062.48906266457;34284.48573271353;34434.827825861714;34474.310513790086;34784.82607586946;34678;34837;35048;35459.82270088633;35609.30251159802;34273.657263428046;34962.02822760094;35035;35279.64720352764;35490;29471.852640737518;31673.5248971261;31747.206319841265;31763.20591985219;32126.19684507906;24510.387240319134;25117.24648260555;25147.874260629313;25218.62172067457;25475.235742927744 05:26:45 INFO - PROCESS | 15266 | |2;jquery.html;351.174739362498;368.3130960758187;368.362732472822;372.2313422781955;388.48137736122277;12499.937500312497;15717.214139293032;15998.600034999145;17474.912625436857;17636.64726705465;16423.2609532571;16642.50072497824;17169.313227470888;17298.913505432454;17327.566810829736;4957.876053098684;4958.157113290731;4995.5753760930365;5049.056113396332;5055.31753213317;3720.2373513429684;3890.727649064567;4990.87522811929;5077.136886729265;5636.887262254752;5936.198613187229;6016.458518733313;6023.608465449754;6041.939580604204;6046.304674962392;5755.453231942959;5911.438413350767;5927.02204136317;5937.079752638348;6020.8494787630225;5212.061828870802;5213.087709650796;5224.373075230958;5226.320578324793;5240.3187585614005;19623.803761962485;20243.190272389234;20277.797222027737;20449.386518404324;20533.5893282135;1890.2439024390217;1904.2573396375424;2053.866498677581;2204.922827701039;2278;8861.158189971942;8986.281097512183;9143;9189.770255743593;9396.48319342436;1716.785401824772;1756.4203812741764;1764.80587135415;1793.3633560086112;1828.8994105324202;69751;70098.2990170102;71789.28210717878;72930.63534682292;73870.26129738742;9775.90224097764;9789.265805064648;9919.2560557957;9984;10035.297529172887;13559.254241016839;13559.525416610568;13582.049256551947;13584.45662173502;13584.93207533956;6871.896921546181;6988.44092472601;7015.649217539205;7090.964545177241;7150.9284907151305;6490.772822951174;6493.70778314977;6667.466602671775;6690.063391125246;6714.328567143344;4090.611391917763;4198.202341555095;4263.5736426357735;4281.785910704514;4335.566443355639;1736.1319340329835;1744.9476515704548;1798.379559052125;1801.4955812372557;1811.936582219616;834.7954751086023;847.4025811802665;856.2507805670039;902.4269588811021;935.5836652689624;16435.424760133577;16777.328906843588;17285.13574321304;17574;17669.116544172997;841.5497708725802;843.6161546496329;894.6019021535354;905.9637614495479;925.1118925831278;9078.727638170865;9856.802863942681;9870.851937220947;9887.653932112342;9978.101970822516;122733.38633306955;123057.38471307587;123177.38411307886;123294;125132.37433812955;69065.65467172733;72705;76917.23082769212;77218.22781772223;79935;908.6047569307373;913.5660561233494;955.9474228917337;963.0754475703263;963.1812958984807;15658.686826263638;15694.450694225647;16234;16292.51122466328;16615.66768664644;37995.81002094972;38318.23363532658;38323.42514862335;38576.614233858425;38659.6134038656;46064.7696761514;49154.508454916424;50079.74960125176;53378.73310633422;53544.19683704669;4800.4479484859685;5593.496585307342;6031.517478601789;7136.3220494052985;7696.422768292512;11448.82826757616;11841.23032002917;12126.575569855013;12280.140390172603;12435.44040518197;9956.900430995598;10098.8485172721;10331.84502232452;10386.221033422675;10838.241323107306;9598.32811703202;9747.268954828274;10116.797664046826;10584.259101862795;10612.151027917902;10928.562857485611;11016.394098324668;11069.391183484664;11108.61119860801;11333.489992950503;7175.892361614476;7405.814854628462;7410.555366678017;7489.513181643176;7506.512076714996;9407.43555386679;9460.290478214023;9604.08761167688;9844.950775246078;10218.795624087625 05:26:45 INFO - PROCESS | 15266 | |3;mootools.html;1310.9541166059187;1361.972760544789;1376.2430663135274;1666.4750603559885;1699.728043513038;6985.615791131486;7257.8911316330295;7469.701211951522;8109.189081091895;8125.796855078619;7445.813854653623;7748.457607967444;7756.573388463647;8008.239217274349;8016.318612917909;2153.924612638554;2183.585118827418;2189.1462329691353;2201.1195521791333;2204.867707937529;1852.685043542601;1913.7607799025122;2085.1971990783504;2149.9140034398606;2183.967240491394;2146.7423909130925;2170.077716970289;2171.782821717831;2172.73927128744;2173.7282839645045;2133.1893880325533;2158.643823769084;2162.76209616942;2173.163332117146;2179.3461961411513;2122.9150833966623;2123.713298704686;2136.583366243583;2139.978600214009;2173.6848157017303;7832;7995.520268783892;7996.640151193152;7996.800079997988;8006.319462845665;4679.74261415622;4816.759162041884;4818.662693611449;4824.5899098576665;4826.444958829745;2796.6504186976626;2939.3092623233524;2963.970360296391;2998.1005698290423;3009.458297506448;886.1448702002534;930.4603330068544;937.0442149008041;937.9671711490133;949.9762505937338;10755.300905441121;10777.083947864441;10778.353298802018;10781.191410644155;10785.514651840685;3899;4233.729881035677;4289.656827453796;4346.935410535565;4347.304431290978;9254.907450925539;9260.814783704289;9261.30540209487;9265.768355791159;9279.118483744034;4859.635527335464;4863.708177509361;4865.197242455026;4867.975660121677;4870.805167793319;4383.057642606855;4413.117376524708;4434.290513517822;4441.045175287264;4447.266201076786;3610.494530765695;3679.632036796299;3712.6053695366336;3745.0824547985917;3751.9062023449633;1101.2456467319912;1141.8401423800674;1189.6431070678761;1211.8242854786183;1234.7900856854355;706.9713566760352;791.8574656561759;798.9161138080534;804.3605333759558;804.7143264141263;4995.800167993312;5081.136206844845;5098.541131298127;5114.744262786846;5303.628745987821;830.6137645994521;846.7332790171076;858.5621333120154;865.7965378136133;890.9599068041954;3347.2970676157793;3353.4466812976075;3354.8825791097192;3366.0238530826277;3468.618451970281;9416.246700263962;9624.230061595195;9799.16707079892;9873.35823171506;9873.555689993824;8653.956730216309;9780.462074585825;9787.951060244795;9791.510424478747;9799.951000244953;6518.413342799171;7058.364747172676;7300.4159667226495;7323.523970941872;7483.8503229935095;5141.87145321355;5156.381234251914;5213;5230.320058392537;5409.513143817076;8997.100289971213;9014.86477702848;9026.277897768032;9098.636054557743;9154.954225228832;8638.352123590881;9030.45817250967;9043.909560904307;9159.267258619162;9337.71986840396;6745.089412929192;6803.183617965876;6871.793846184622;6903.689333979883;6914.619695916773;7534.0582427196605;7599;7605.885911711218;7609.277118673717;7609.581473019037;6853.7943861684225;6971.616561088986;7067.187273463617;7106.609136497542;7157.534760240776;6803.9319606805275;6850.417714494324;6858;6868.313168683092;6900.447964162955;6221.471174949999;6236.563440559117;6290.308066112632;6318.210223722035;6336.429721324918;4546.88632784183;4577.725336479822;4641.582257596832;4662;4784.784684689267;4391.912161756811;4467.15124126415;4638.93041604383;4663.976680116578;4667.066586682609 05:26:45 INFO - PROCESS | 15266 | |4;prototype.html;288.58587926325725;292.0464682810623;295.6260330681687;296.35394839250426;298.4523399561803;4890.315355850184;4915.18899381602;4920.53254940781;4927.187014142671;4927.876803079925;4833.661643684944;4857.441394239663;4871.683340582859;4899.853004409864;4936.23488359304;3650.5619325680955;3733.813309334536;3757.3424650686156;3810.3331916914567;3812.294725475782;3797.14564223049;3805.923881522368;3810.790406527654;3815;3823.5220597425323;3771.943420848676;3774.735768496206;3781.432785082246;3783.2811765764554;3806.619338066199;3618.9819050904707;3673.742838001341;3746.83139258734;3757.3424650686293;3820.617938206185;3306.074299196229;3310.817905015223;3319.1204330852343;3320.2031512437084;3349.129226401129;4702.482726900038;4716.7359667359515;4723.48041715411;4745.525447455261;4804.399450068741;4181.979090104561;4335.458067741532;4339.177545430926;4357.891052723708;4390.538993405678;4982.651214414992;4982.975085124551;5041.798328066873;5053.8123540967845;5058.544730974193;3680.852765889388;3686.1337585667347;3693.169036966688;3693.242885208526;3699.72252081095;5163.406208286057;5351.314335984152;5360.865978350534;5367.516923476866;5420.783168673248;3701;3707.5550933887566;3726.6087060858763;3747.414284143932;3750.493683352767;3777.7166712496673;3783.243351329745;3807.8476860925252;3843.846845946205;3850.942235866464;4340.153670034313;4345.9348109778375;4366.271080574641;4374.971881607819;4378.715383500063;4838.612910967185;5062.544371006627;5128.743562821844;5140.511651393112;5159.871003224949;1316.2760481735008;1330.221820235154;1330.7471580399692;1331.9134256273505;1334.2661536155076;822.7408366364576;852.7015544559479;853.4836423963537;864.6757465950269;866.0213958227289;4258.7444753314285;4379.197313719223;4418.889527761768;4510.143072816154;4510.977445112753;5231.319928409359;5238.240455133984;5243.764030618631;5253.763580638881;5263.710495922761;4496.482904466028;4500.572445617661;4500.594946454835;4523.276275795857;4524.909501809945;2645.246104860106;2781.6662000560063;2786.3452088759127;2789.539725945237;2796.9582204990065;4981.455748717836;4991.302956994639;4999.875003124951;5000.3498145982685;5007.749612519359;5129.307543481582;5377.865553361197;5415.160650099241;5417.295751552273;5420.620556561003;4937.975310123498;4977.377827771528;4982.4768399317545;4993.6254780892305;5002.249662550574;5240.868978275574;5259.368875734936;5267.9736601316745;5268.473152684701;5269.894602108013;5004.173476681058;5149.819756308661;5152.089069675621;5166.741662916915;5167.560757335668;4947.901041979212;4958.785097650954;4960.255961605788;4968;4977.9751101244265;3729.1609387887506;3756.9856138841815;3767.9246415072093;3779.7543159694533;3795.7532760370486;5171;5257.868553286198;5308.619758862646;5313.990341835039;5327.440618734977;5047;5061.139606267017;5075.847724568269;5087.219473184504;5133.665247035723;5040.815408379101;5066.873328166826;5096.949030509648;5097.266929244075;5100.438951715382;4785.736784476748;4999.625028122832;5026.798928042837;5034.320366750442;5045.470225626404;4911.312416261655;5071.721055341844;5163.845084647466;5168.767405466839;5178.705323669083;4864.6594738369395;4985.277134815504;5008.298838162587;5014.52362025607;5023.748812559431 05:26:45 INFO - PROCESS | 15266 | |5;yui.html;636.1348565950308;658.8254112660146;688.3598253624131;699.8145491444765;718.7556230881503;12792.424340904658;13714.24571648559;13921.512747053855;14009.159450432968;14041.789373159398;13397.866021339809;13533.796993045113;13560.45758169672;13594.252316122635;13619.25094119823;620.8447888027993;638.0397501759845;758.2720588235301;762.8054846014259;775.9728409505668;772.8377040821406;773.4817672159667;774.1677696476311;774.2760518914805;774.4540099230057;820.9014918209823;821.8438496685641;821.9136990615959;822.0382152881114;822.2271065198725;650.4503694378219;669.6919417068154;673.5958424945043;676.2561182698992;814.8044469327378;489.168413696717;585.6866576381616;597.9312379076418;602.3133627664466;602.6956387024568;12282.938585307016;12302.261864288172;12318.938405307916;12323.137380383378;12324.32216228107;12253.264804111692;12425.254484730945;12832.550860719923;13199.999999999904;13365;11836.467358968866;12141.878581214252;12210.389480526028;12451.190672606343;12908.225506469642;4228.260054490483;4241.681873859473;4277.572242775697;4323.351497275403;4423.668224883147;69930;70336.6483167591;70734.29265707328;70811;71997;9223.308251881135;9436.669716559887;9652.179564736936;9652.469114198646;9786.314957953018;18473.907630461763;18481.630367392845;18486.168122434523;18508.65046714021;18541.907290463463;6812.659367031629;6975.128108986377;6979.616121113388;6991.265917078736;7006.964965175243;3934.5868683788362;3935.58676338986;3978.2441336146617;4026.8187931543152;4107.342825147962;2926.268432891777;3030.4242193983514;3030.712082352173;3034.5599888016113;3037.7569794416395;503.896701176258;507.3303239723603;510.46656244224874;517.2551525802832;533.216172226826;517.6376536424442;523.9502247286501;572.9627574207664;612.7242740766584;615.3385111005687;8433.662653493915;8661.826763464822;8673.826523469495;8683.739487815375;8709.216170544682;620.227816368624;624.4442446222865;627.8524546731514;640.3532432243375;649.0945131541473;3895.9610403896163;3998.960010399917;4007.2987227235117;4047.736897101679;4251.702380833312;54361;55044.724776375864;95647;106302;107463;74712;76817;79905.20568765892;80102.19897801064;81912;68749;69696.30303697;70941;73667.63166184242;75476;8416;8730.126987301219;8883.955580222317;8930.285577153942;9050.547472626211;38420.231595367375;39026.804865975486;41203.7939810299;42968.15343843956;44249.55750442583;54578.45058592835;63940;64620.676896615216;64842.67578662076;65065;11252.83120753173;11354.205205635526;11432;11685.707857303636;11796.29222246668;12839.550615728405;13072.803907941197;13145.277009764555;13578;14028.509002184874;12283.263004219776;12386;13030.934845325713;13300.933495332461;13430.0598958072;10891.782164356828;11258.943705281421;11646.76706465849;11987.40062996864;12013.099017573892;11843;12371.814422783846;12411.255324680547;12539.247645140957;12919.741605168032;9788.412695238023;10108.39349639024;10356.482175891024;10609.575616975235;10638.41488718097;9018.594163262538;9858.112769850748;10054.447005414773;10659.25385223058;10838.349699017768 05:26:45 INFO - PROCESS | 15266 | __end_tp_report 05:26:45 INFO - PROCESS | 15266 | __start_cc_report 05:26:45 INFO - PROCESS | 15266 | _x_x_mozilla_cycle_collect,820 05:26:45 INFO - PROCESS | 15266 | __end_cc_report 05:26:45 INFO - PROCESS | 15266 | __startTimestamp1474633605310__endTimestamp 05:26:45 INFO - PROCESS | 15266 | 05:26:45 INFO - PROCESS | 15266 | ------- Summary: start ------- 05:26:45 INFO - PROCESS | 15266 | Number of tests: 6 05:26:45 INFO - PROCESS | 15266 | 05:26:45 INFO - PROCESS | 15266 | [#0] dojo.html Cycles:165 Average:4703.68 Median:4865.37 stddev:483.59 (9.9%) stddev-sans-first:455.67 05:26:45 INFO - PROCESS | 15266 | Values: 2586.7 2606.7 2638.7 2640.9 2654.2 4637.0 4654.9 4692.7 4693.8 4701.8 4699.7 4722.8 4751.9 4787.2 4838.5 4297.1 4325.1 4355.9 4392.9 4403.8 4404.6 4449.4 4450.6 4457.2 4476.1 4327.4 4409.4 4417.3 4436.4 4515.2 4362.8 4364.0 4404.4 4420.6 4453.2 4384.5 4386.5 4389.1 4446.5 4456.0 4739.6 4763.5 4796.0 4811.0 4872.2 4938.3 4977.5 5009.6 5043.5 5120.9 5091.0 5100.3 5110.6 5156.4 5157.7 4744.7 4747.5 4749.9 4754.3 4815.0 4989.8 5027.7 5118.7 5205.2 5274.1 4943.8 4979.8 4988.1 5039.2 5053.8 5071.4 5073.1 5073.1 5078.3 5138.5 4865.4 4935.9 5014.2 5018.9 5024.4 4944.4 4991.0 5006.5 5037.7 5082.3 4342.0 4345.0 4350.5 4395.2 4401.6 3772.5 3782.0 3811.6 3842.1 3844.1 4354.1 4361.6 4379.3 4399.0 4405.3 5116.1 5118.6 5118.7 5158.8 5184.5 4408.7 4410.4 4414.4 4470.5 4472.7 4547.3 4561.2 4608.4 4628.4 4634.3 4784.1 4869.2 4888.6 4888.7 4890.9 5067.3 5070.8 5072.6 5073.1 5157.3 4815.3 4822.7 4826.0 4827.3 4874.4 4888.4 4902.4 4947.0 4979.7 5009.9 5109.6 5110.2 5116.4 5116.4 5165.4 4934.6 4973.1 4976.4 4980.6 5037.8 4809.4 4878.4 4891.0 4941.5 4964.0 4889.7 4921.8 4923.5 4971.1 4991.2 4898.6 4954.4 4955.5 4987.5 5074.7 4796.9 4848.1 4866.9 4879.9 4880.2 05:26:45 INFO - PROCESS | 15266 | 05:26:45 INFO - PROCESS | 15266 | [#1] ext.html Cycles:180 Average:43863.06 Median:34998.51 stddev:75692.23 (216.3%) stddev-sans-first:75834.64 05:26:45 INFO - PROCESS | 15266 | Values: 532.6 559.1 561.7 577.7 578.8 27510.2 30829.2 30866.7 30870.7 30889.7 39447.0 39978.4 40052.8 44508.6 44681.3 7506.5 7639.9 7643.2 7645.4 7647.5 7315.0 7465.9 7545.0 7623.2 7624.3 7605.5 7664.0 9595.4 9846.6 9852.4 9666.1 9680.7 9686.2 9737.6 9743.9 9736.1 9800.8 9817.2 9821.9 9823.1 36627.3 37034.1 37222.8 37328.0 37341.8 3027.9 3048.3 3050.8 3094.4 3121.8 27955.0 28069.6 28651.9 28838.7 29797.7 3252.6 3273.7 3339.8 3362.0 3467.7 241234.8 242379.0 242548.0 242637.0 243002.0 50994.0 51753.2 51781.5 51827.0 51902.5 28764.4 54049.5 54258.5 54278.7 54366.7 13894.0 14212.6 14229.7 14246.0 14314.0 10700.2 10866.6 10882.7 10883.9 10894.0 17620.2 17848.6 17887.6 17906.5 17960.9 5380.5 6559.9 6713.8 7035.2 7048.2 748.7 859.6 878.1 896.8 938.6 27063.2 27817.7 28683.3 28749.0 28837.7 905.9 922.4 929.9 933.1 1004.4 14700.3 14881.6 15123.5 15153.8 15459.7 360243.0 365956.0 366063.0 366565.0 366673.0 48986.8 49542.5 49580.0 49585.0 49709.5 1071.1 1104.7 1140.1 1148.0 1159.9 24610.5 28594.6 29366.4 29768.4 29812.3 41703.6 42272.2 42299.6 42324.4 42333.4 238198.0 239167.0 239342.0 240333.0 242548.0 23942.4 24554.3 24691.1 24725.5 26227.9 40672.6 40767.0 41066.0 41236.8 41868.6 34062.5 34284.5 34434.8 34474.3 34784.8 34678.0 34837.0 35048.0 35459.8 35609.3 34273.7 34962.0 35035.0 35279.6 35490.0 29471.9 31673.5 31747.2 31763.2 32126.2 24510.4 25117.2 25147.9 25218.6 25475.2 05:26:45 INFO - PROCESS | 15266 | 05:26:45 INFO - PROCESS | 15266 | [#2] jquery.html Cycles:180 Average:16891.23 Median:4974.52 stddev:25186.98 (506.3%) stddev-sans-first:25227.02 05:26:45 INFO - PROCESS | 15266 | Values: 351.2 368.3 368.4 372.2 388.5 12499.9 15717.2 15998.6 17474.9 17636.6 16423.3 16642.5 17169.3 17298.9 17327.6 4957.9 4958.2 4995.6 5049.1 5055.3 3720.2 3890.7 4990.9 5077.1 5636.9 5936.2 6016.5 6023.6 6041.9 6046.3 5755.5 5911.4 5927.0 5937.1 6020.8 5212.1 5213.1 5224.4 5226.3 5240.3 19623.8 20243.2 20277.8 20449.4 20533.6 1890.2 1904.3 2053.9 2204.9 2278.0 8861.2 8986.3 9143.0 9189.8 9396.5 1716.8 1756.4 1764.8 1793.4 1828.9 69751.0 70098.3 71789.3 72930.6 73870.3 9775.9 9789.3 9919.3 9984.0 10035.3 13559.3 13559.5 13582.0 13584.5 13584.9 6871.9 6988.4 7015.6 7091.0 7150.9 6490.8 6493.7 6667.5 6690.1 6714.3 4090.6 4198.2 4263.6 4281.8 4335.6 1736.1 1744.9 1798.4 1801.5 1811.9 834.8 847.4 856.3 902.4 935.6 16435.4 16777.3 17285.1 17574.0 17669.1 841.5 843.6 894.6 906.0 925.1 9078.7 9856.8 9870.9 9887.7 9978.1 122733.4 123057.4 123177.4 123294.0 125132.4 69065.7 72705.0 76917.2 77218.2 79935.0 908.6 913.6 955.9 963.1 963.2 15658.7 15694.5 16234.0 16292.5 16615.7 37995.8 38318.2 38323.4 38576.6 38659.6 46064.8 49154.5 50079.7 53378.7 53544.2 4800.4 5593.5 6031.5 7136.3 7696.4 11448.8 11841.2 12126.6 12280.1 12435.4 9956.9 10098.8 10331.8 10386.2 10838.2 9598.3 9747.3 10116.8 10584.3 10612.2 10928.6 11016.4 11069.4 11108.6 11333.5 7175.9 7405.8 7410.6 7489.5 7506.5 9407.4 9460.3 9604.1 9845.0 10218.8 05:26:45 INFO - PROCESS | 15266 | 05:26:45 INFO - PROCESS | 15266 | [#3] mootools.html Cycles:180 Average:5175.45 Median:5184.69 stddev:2912.93 (56.2%) stddev-sans-first:2906.63 05:26:45 INFO - PROCESS | 15266 | Values: 1311.0 1362.0 1376.2 1666.5 1699.7 6985.6 7257.9 7469.7 8109.2 8125.8 7445.8 7748.5 7756.6 8008.2 8016.3 2153.9 2183.6 2189.1 2201.1 2204.9 1852.7 1913.8 2085.2 2149.9 2184.0 2146.7 2170.1 2171.8 2172.7 2173.7 2133.2 2158.6 2162.8 2173.2 2179.3 2122.9 2123.7 2136.6 2140.0 2173.7 7832.0 7995.5 7996.6 7996.8 8006.3 4679.7 4816.8 4818.7 4824.6 4826.4 2796.7 2939.3 2964.0 2998.1 3009.5 886.1 930.5 937.0 938.0 950.0 10755.3 10777.1 10778.4 10781.2 10785.5 3899.0 4233.7 4289.7 4346.9 4347.3 9254.9 9260.8 9261.3 9265.8 9279.1 4859.6 4863.7 4865.2 4868.0 4870.8 4383.1 4413.1 4434.3 4441.0 4447.3 3610.5 3679.6 3712.6 3745.1 3751.9 1101.2 1141.8 1189.6 1211.8 1234.8 707.0 791.9 798.9 804.4 804.7 4995.8 5081.1 5098.5 5114.7 5303.6 830.6 846.7 858.6 865.8 891.0 3347.3 3353.4 3354.9 3366.0 3468.6 9416.2 9624.2 9799.2 9873.4 9873.6 8654.0 9780.5 9788.0 9791.5 9800.0 6518.4 7058.4 7300.4 7323.5 7483.9 5141.9 5156.4 5213.0 5230.3 5409.5 8997.1 9014.9 9026.3 9098.6 9155.0 8638.4 9030.5 9043.9 9159.3 9337.7 6745.1 6803.2 6871.8 6903.7 6914.6 7534.1 7599.0 7605.9 7609.3 7609.6 6853.8 6971.6 7067.2 7106.6 7157.5 6803.9 6850.4 6858.0 6868.3 6900.4 6221.5 6236.6 6290.3 6318.2 6336.4 4546.9 4577.7 4641.6 4662.0 4784.8 4391.9 4467.2 4638.9 4664.0 4667.1 05:26:45 INFO - PROCESS | 15266 | 05:26:45 INFO - PROCESS | 15266 | [#4] prototype.html Cycles:180 Average:4239.04 Median:4881.00 stddev:1231.52 (25.2%) stddev-sans-first:1198.74 05:26:45 INFO - PROCESS | 15266 | Values: 288.6 292.0 295.6 296.4 298.5 4890.3 4915.2 4920.5 4927.2 4927.9 4833.7 4857.4 4871.7 4899.9 4936.2 3650.6 3733.8 3757.3 3810.3 3812.3 3797.1 3805.9 3810.8 3815.0 3823.5 3771.9 3774.7 3781.4 3783.3 3806.6 3619.0 3673.7 3746.8 3757.3 3820.6 3306.1 3310.8 3319.1 3320.2 3349.1 4702.5 4716.7 4723.5 4745.5 4804.4 4182.0 4335.5 4339.2 4357.9 4390.5 4982.7 4983.0 5041.8 5053.8 5058.5 3680.9 3686.1 3693.2 3693.2 3699.7 5163.4 5351.3 5360.9 5367.5 5420.8 3701.0 3707.6 3726.6 3747.4 3750.5 3777.7 3783.2 3807.8 3843.8 3850.9 4340.2 4345.9 4366.3 4375.0 4378.7 4838.6 5062.5 5128.7 5140.5 5159.9 1316.3 1330.2 1330.7 1331.9 1334.3 822.7 852.7 853.5 864.7 866.0 4258.7 4379.2 4418.9 4510.1 4511.0 5231.3 5238.2 5243.8 5253.8 5263.7 4496.5 4500.6 4500.6 4523.3 4524.9 2645.2 2781.7 2786.3 2789.5 2797.0 4981.5 4991.3 4999.9 5000.3 5007.7 5129.3 5377.9 5415.2 5417.3 5420.6 4938.0 4977.4 4982.5 4993.6 5002.2 5240.9 5259.4 5268.0 5268.5 5269.9 5004.2 5149.8 5152.1 5166.7 5167.6 4947.9 4958.8 4960.3 4968.0 4978.0 3729.2 3757.0 3767.9 3779.8 3795.8 5171.0 5257.9 5308.6 5314.0 5327.4 5047.0 5061.1 5075.8 5087.2 5133.7 5040.8 5066.9 5096.9 5097.3 5100.4 4785.7 4999.6 5026.8 5034.3 5045.5 4911.3 5071.7 5163.8 5168.8 5178.7 4864.7 4985.3 5008.3 5014.5 5023.7 05:26:45 INFO - PROCESS | 15266 | 05:26:45 INFO - PROCESS | 15266 | [#5] yui.html Cycles:180 Average:17478.37 Median:505.61 stddev:24276.75 (4801.4%) stddev-sans-first:24311.91 05:26:45 INFO - PROCESS | 15266 | Values: 636.1 658.8 688.4 699.8 718.8 12792.4 13714.2 13921.5 14009.2 14041.8 13397.9 13533.8 13560.5 13594.3 13619.3 620.8 638.0 758.3 762.8 776.0 772.8 773.5 774.2 774.3 774.5 820.9 821.8 821.9 822.0 822.2 650.5 669.7 673.6 676.3 814.8 489.2 585.7 597.9 602.3 602.7 12282.9 12302.3 12318.9 12323.1 12324.3 12253.3 12425.3 12832.6 13200.0 13365.0 11836.5 12141.9 12210.4 12451.2 12908.2 4228.3 4241.7 4277.6 4323.4 4423.7 69930.0 70336.6 70734.3 70811.0 71997.0 9223.3 9436.7 9652.2 9652.5 9786.3 18473.9 18481.6 18486.2 18508.7 18541.9 6812.7 6975.1 6979.6 6991.3 7007.0 3934.6 3935.6 3978.2 4026.8 4107.3 2926.3 3030.4 3030.7 3034.6 3037.8 503.9 507.3 510.5 517.3 533.2 517.6 524.0 573.0 612.7 615.3 8433.7 8661.8 8673.8 8683.7 8709.2 620.2 624.4 627.9 640.4 649.1 3896.0 3999.0 4007.3 4047.7 4251.7 54361.0 55044.7 95647.0 106302.0 107463.0 74712.0 76817.0 79905.2 80102.2 81912.0 68749.0 69696.3 70941.0 73667.6 75476.0 8416.0 8730.1 8884.0 8930.3 9050.5 38420.2 39026.8 41203.8 42968.2 44249.6 54578.5 63940.0 64620.7 64842.7 65065.0 11252.8 11354.2 11432.0 11685.7 11796.3 12839.6 13072.8 13145.3 13578.0 14028.5 12283.3 12386.0 13030.9 13300.9 13430.1 10891.8 11258.9 11646.8 11987.4 12013.1 11843.0 12371.8 12411.3 12539.2 12919.7 9788.4 10108.4 10356.5 10609.6 10638.4 9018.6 9858.1 10054.4 10659.3 10838.3 05:26:45 INFO - PROCESS | 15266 | -------- Summary: end -------- 05:26:45 INFO - PROCESS | 15266 | 05:26:46 INFO - TEST-INFO | 15266: exit 0 05:26:46 INFO - TEST-OK | dromaeo_css | took 1120926ms 05:26:46 INFO - TEST-START | kraken 05:26:46 INFO - operating with platform_type : linux_ 05:26:46 INFO - Initialising browser for kraken test... 05:26:46 INFO - TEST-INFO | started process 15578 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO_I5vt/profile http://localhost:41493/getInfo.html) 05:26:50 INFO - PROCESS | 15578 | __metrics Screen width/height:1600/1200 05:26:50 INFO - PROCESS | 15578 | colorDepth:24 05:26:50 INFO - PROCESS | 15578 | Browser inner width/height: 1024/697 05:26:50 INFO - PROCESS | 15578 | __metrics 05:26:51 INFO - PROCESS | 15578 | 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" 05:26:51 INFO - PROCESS | 15578 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:26:51 INFO - PROCESS | 15578 | console.error: PushService: 05:26:51 INFO - PROCESS | 15578 | stateChangeProcessEnqueue: Error transitioning state 05:26:51 INFO - PROCESS | 15578 | UnknownError 05:26:52 INFO - TEST-INFO | 15578: exit 0 05:26:52 INFO - Browser initialized. 05:26:52 INFO - Running cycle 1/1 for kraken test... 05:26:52 INFO - TEST-INFO | started process 15661 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO_I5vt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:27:04 INFO - PROCESS | 15661 | RSS: Main: 175669248 05:27:04 INFO - PROCESS | 15661 | 05:27:07 INFO - PROCESS | 15661 | Cycle 1(1): loaded http://localhost:41493/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41493/tests/kraken/driver.html?testName=audio-beat-detection) 05:27:08 INFO - PROCESS | 15661 | RSS: Main: 243286016 05:27:08 INFO - PROCESS | 15661 | 05:27:11 INFO - PROCESS | 15661 | Cycle 1(1): loaded http://localhost:41493/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41493/tests/kraken/driver.html?testName=audio-dft) 05:27:11 INFO - PROCESS | 15661 | RSS: Main: 218329088 05:27:11 INFO - PROCESS | 15661 | 05:27:15 INFO - PROCESS | 15661 | Cycle 1(1): loaded http://localhost:41493/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41493/tests/kraken/driver.html?testName=audio-fft) 05:27:15 INFO - PROCESS | 15661 | RSS: Main: 300625920 05:27:15 INFO - PROCESS | 15661 | 05:27:17 INFO - PROCESS | 15661 | Cycle 1(1): loaded http://localhost:41493/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41493/tests/kraken/driver.html?testName=audio-oscillator) 05:27:18 INFO - PROCESS | 15661 | RSS: Main: 209682432 05:27:18 INFO - PROCESS | 15661 | 05:27:20 INFO - PROCESS | 15661 | Cycle 1(1): loaded http://localhost:41493/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41493/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:27:21 INFO - PROCESS | 15661 | RSS: Main: 214036480 05:27:21 INFO - PROCESS | 15661 | 05:27:24 INFO - PROCESS | 15661 | Cycle 1(1): loaded http://localhost:41493/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41493/tests/kraken/driver.html?testName=imaging-darkroom) 05:27:25 INFO - PROCESS | 15661 | RSS: Main: 250826752 05:27:25 INFO - PROCESS | 15661 | 05:27:28 INFO - PROCESS | 15661 | Cycle 1(1): loaded http://localhost:41493/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41493/tests/kraken/driver.html?testName=imaging-desaturate) 05:27:29 INFO - PROCESS | 15661 | RSS: Main: 245551104 05:27:29 INFO - PROCESS | 15661 | 05:27:32 INFO - PROCESS | 15661 | Cycle 1(1): loaded http://localhost:41493/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41493/tests/kraken/driver.html?testName=json-parse-financial) 05:27:32 INFO - PROCESS | 15661 | RSS: Main: 247492608 05:27:32 INFO - PROCESS | 15661 | 05:27:34 INFO - PROCESS | 15661 | Cycle 1(1): loaded http://localhost:41493/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41493/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:27:35 INFO - PROCESS | 15661 | RSS: Main: 211419136 05:27:35 INFO - PROCESS | 15661 | 05:27:36 INFO - PROCESS | 15661 | Cycle 1(1): loaded http://localhost:41493/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41493/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:27:37 INFO - PROCESS | 15661 | RSS: Main: 218206208 05:27:37 INFO - PROCESS | 15661 | 05:27:39 INFO - PROCESS | 15661 | Cycle 1(1): loaded http://localhost:41493/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41493/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:27:40 INFO - PROCESS | 15661 | RSS: Main: 223256576 05:27:40 INFO - PROCESS | 15661 | 05:27:43 INFO - PROCESS | 15661 | Cycle 1(1): loaded http://localhost:41493/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41493/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:27:43 INFO - PROCESS | 15661 | RSS: Main: 223850496 05:27:43 INFO - PROCESS | 15661 | 05:27:46 INFO - PROCESS | 15661 | Cycle 1(1): loaded http://localhost:41493/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41493/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:27:47 INFO - PROCESS | 15661 | RSS: Main: 222531584 05:27:47 INFO - PROCESS | 15661 | 05:27:49 INFO - PROCESS | 15661 | Cycle 1(1): loaded http://localhost:41493/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41493/tests/kraken/driver.html?testName=ai-astar) 05:27:49 INFO - PROCESS | 15661 | RSS: Main: 273371136 05:27:49 INFO - PROCESS | 15661 | 05:27:49 INFO - PROCESS | 15661 | __start_tp_report 05:27:49 INFO - PROCESS | 15661 | _x_x_mozilla_page_load 05:27:49 INFO - PROCESS | 15661 | _x_x_mozilla_page_load_details 05:27:49 INFO - PROCESS | 15661 | |i|pagename|runs| 05:27:49 INFO - PROCESS | 15661 | |0;ai-astar;110;114;113;114;114;114;115;115;114;114 05:27:49 INFO - PROCESS | 15661 | |1;audio-beat-detection;158;130;127;169;124;127;125;126;167;128 05:27:49 INFO - PROCESS | 15661 | |2;audio-dft;161;161;161;163;162;161;162;162;161;161 05:27:49 INFO - PROCESS | 15661 | |3;audio-fft;76;76;76;107;78;76;80;79;97;76 05:27:49 INFO - PROCESS | 15661 | |4;audio-oscillator;86;84;111;83;84;84;105;85;84;111 05:27:49 INFO - PROCESS | 15661 | |5;imaging-gaussian-blur;118;117;117;117;116;116;117;117;116;116 05:27:49 INFO - PROCESS | 15661 | |6;imaging-darkroom;147;146;148;148;147;147;146;146;146;146 05:27:49 INFO - PROCESS | 15661 | |7;imaging-desaturate;95;96;95;96;96;96;96;96;95;95 05:27:49 INFO - PROCESS | 15661 | |8;json-parse-financial;64;63;63;63;64;65;64;63;63;64 05:27:49 INFO - PROCESS | 15661 | |9;json-stringify-tinderbox;66;66;66;66;66;66;67;66;67;67 05:27:49 INFO - PROCESS | 15661 | |10;stanford-crypto-aes;84;83;83;83;89;83;84;83;89;85 05:27:49 INFO - PROCESS | 15661 | |11;stanford-crypto-ccm;153;134;136;139;134;140;134;140;178;134 05:27:49 INFO - PROCESS | 15661 | |12;stanford-crypto-pbkdf2;180;176;177;171;173;172;171;173;174;175 05:27:49 INFO - PROCESS | 15661 | |13;stanford-crypto-sha256-iterative;70;69;69;69;70;73;69;74;68;69 05:27:49 INFO - PROCESS | 15661 | __end_tp_report 05:27:49 INFO - PROCESS | 15661 | __start_cc_report 05:27:49 INFO - PROCESS | 15661 | _x_x_mozilla_cycle_collect,1923 05:27:49 INFO - PROCESS | 15661 | __end_cc_report 05:27:49 INFO - PROCESS | 15661 | __startTimestamp1474633669555__endTimestamp 05:27:49 INFO - PROCESS | 15661 | 05:27:49 INFO - PROCESS | 15661 | ------- Summary: start ------- 05:27:49 INFO - PROCESS | 15661 | Number of tests: 14 05:27:49 INFO - PROCESS | 15661 | 05:27:49 INFO - PROCESS | 15661 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:1.42 (1.2%) stddev-sans-first:0.60 05:27:49 INFO - PROCESS | 15661 | Values: 110.0 114.0 113.0 114.0 114.0 114.0 115.0 115.0 114.0 114.0 05:27:49 INFO - PROCESS | 15661 | 05:27:49 INFO - PROCESS | 15661 | [#1] audio-beat-detection Cycles:10 Average:138.10 Median:129.00 stddev:18.61 (14.4%) stddev-sans-first:18.29 05:27:49 INFO - PROCESS | 15661 | Values: 158.0 130.0 127.0 169.0 124.0 127.0 125.0 126.0 167.0 128.0 05:27:49 INFO - PROCESS | 15661 | 05:27:49 INFO - PROCESS | 15661 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 05:27:49 INFO - PROCESS | 15661 | Values: 161.0 161.0 161.0 163.0 162.0 161.0 162.0 162.0 161.0 161.0 05:27:49 INFO - PROCESS | 15661 | 05:27:49 INFO - PROCESS | 15661 | [#3] audio-fft Cycles:10 Average:82.10 Median:77.00 stddev:10.85 (14.1%) stddev-sans-first:11.28 05:27:49 INFO - PROCESS | 15661 | Values: 76.0 76.0 76.0 107.0 78.0 76.0 80.0 79.0 97.0 76.0 05:27:49 INFO - PROCESS | 15661 | 05:27:49 INFO - PROCESS | 15661 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:84.00 stddev:12.07 (14.4%) stddev-sans-first:12.63 05:27:49 INFO - PROCESS | 15661 | Values: 86.0 84.0 111.0 83.0 84.0 84.0 105.0 85.0 84.0 111.0 05:27:49 INFO - PROCESS | 15661 | 05:27:49 INFO - PROCESS | 15661 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.53 05:27:49 INFO - PROCESS | 15661 | Values: 118.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 116.0 05:27:49 INFO - PROCESS | 15661 | 05:27:49 INFO - PROCESS | 15661 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 05:27:49 INFO - PROCESS | 15661 | Values: 147.0 146.0 148.0 148.0 147.0 147.0 146.0 146.0 146.0 146.0 05:27:49 INFO - PROCESS | 15661 | 05:27:49 INFO - PROCESS | 15661 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 05:27:49 INFO - PROCESS | 15661 | Values: 95.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 05:27:49 INFO - PROCESS | 15661 | 05:27:49 INFO - PROCESS | 15661 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:64.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 05:27:49 INFO - PROCESS | 15661 | Values: 64.0 63.0 63.0 63.0 64.0 65.0 64.0 63.0 63.0 64.0 05:27:49 INFO - PROCESS | 15661 | 05:27:49 INFO - PROCESS | 15661 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 05:27:49 INFO - PROCESS | 15661 | Values: 66.0 66.0 66.0 66.0 66.0 66.0 67.0 66.0 67.0 67.0 05:27:49 INFO - PROCESS | 15661 | 05:27:49 INFO - PROCESS | 15661 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.00 stddev:2.41 (2.9%) stddev-sans-first:2.55 05:27:49 INFO - PROCESS | 15661 | Values: 84.0 83.0 83.0 83.0 89.0 83.0 84.0 83.0 89.0 85.0 05:27:49 INFO - PROCESS | 15661 | 05:27:49 INFO - PROCESS | 15661 | [#11] stanford-crypto-ccm Cycles:10 Average:142.20 Median:139.50 stddev:13.85 (9.9%) stddev-sans-first:14.12 05:27:49 INFO - PROCESS | 15661 | Values: 153.0 134.0 136.0 139.0 134.0 140.0 134.0 140.0 178.0 134.0 05:27:49 INFO - PROCESS | 15661 | 05:27:49 INFO - PROCESS | 15661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:174.50 stddev:2.86 (1.6%) stddev-sans-first:2.13 05:27:49 INFO - PROCESS | 15661 | Values: 180.0 176.0 177.0 171.0 173.0 172.0 171.0 173.0 174.0 175.0 05:27:49 INFO - PROCESS | 15661 | 05:27:49 INFO - PROCESS | 15661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:69.50 stddev:1.94 (2.8%) stddev-sans-first:2.06 05:27:49 INFO - PROCESS | 15661 | Values: 70.0 69.0 69.0 69.0 70.0 73.0 69.0 74.0 68.0 69.0 05:27:49 INFO - PROCESS | 15661 | -------- Summary: end -------- 05:27:49 INFO - PROCESS | 15661 | 05:27:50 INFO - TEST-INFO | 15661: exit 0 05:27:50 INFO - TEST-OK | kraken | took 64558ms 05:27:50 INFO - SUITE-END | took 1185s 05:27:51 INFO - Completed test suite (00:19:45) 05:27:51 INFO - javascript benchmark 05:27:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2586.6508021417108, 2606.687197536296, 2638.6833579970407, 2640.947181056379, 2654.163938359418, 4636.953630463699, 4654.883627909304, 4692.741899195543, 4693.835715749945, 4701.835435759749, 4699.718016918987, 4722.7874745636445, 4751.90496190076, 4787.162246606838, 4838.51614838516, 4297.097609502009, 4325.070109926365, 4355.912881742363, 4392.86821395357, 4403.82384704613, 4404.625606823424, 4449.443819522559, 4450.599446049855, 4457.153140903234, 4476.1271552047365, 4327.437433133672, 4409.426774519324, 4417.271150260235, 4436.378906953029, 4515.187266292066, 4362.847300344472, 4363.996280855389, 4404.361367601712, 4420.580044895762, 4453.242948698729, 4384.473863136413, 4386.517483076859, 4389.144116897206, 4446.488653804821, 4456.019675671347, 4739.620830333565, 4763.547462991045, 4796.0, 4811.0, 4872.220444728861, 4938.2839488274, 4977.527134922213, 5009.574186194178, 5043.495650434964, 5120.871978200537, 5091.0, 5100.285959965608, 5110.616703747234, 5156.355455568054, 5157.690538567698, 4744.691595046311, 4747.501512341223, 4749.881252968635, 4754.286856971482, 4814.975925120352, 4989.775460104304, 5027.748612569357, 5118.667286626357, 5205.167173252337, 5274.050670879202, 4943.752812359367, 4979.800807967641, 4988.102141614471, 5039.168537191395, 5053.823116190989, 5071.41678706946, 5073.061483625467, 5073.137566613685, 5078.314427552233, 5138.537531622172, 4865.367502224688, 4935.901281974412, 5014.247862820534, 5018.874528136826, 5024.447310795809, 4944.431390390151, 4990.950090499121, 5006.4743201964, 5037.697738135724, 5082.263071854561, 4342.0, 4345.044090300129, 4350.456192975878, 4395.230834603932, 4401.625861801719, 3772.4529943158636, 3781.9810900945868, 3811.5807261201244, 3842.1355195080882, 3844.0966372902344, 4354.107407981356, 4361.5856493633055, 4379.3430985351815, 4399.032212913154, 4405.2511073117, 5116.130257856174, 5118.616103792156, 5118.718470484085, 5158.819441319536, 5184.481551844785, 4408.6913916026215, 4410.42664453619, 4414.381986521889, 4470.485894122153, 4472.7092738972515, 4547.3406356078185, 4561.178987782231, 4608.377868987711, 4628.352030715702, 4634.2585186370015, 4784.067106914188, 4869.220924652181, 4888.560029597354, 4888.6577939543895, 4890.902181956412, 5067.341245638191, 5070.797168113234, 5072.644914855925, 5073.11220536412, 5157.303763991963, 4815.253635686474, 4822.734749588806, 4825.9758701206265, 4827.300041494034, 4874.390701162355, 4888.437829649636, 4902.3872015998, 4947.0353281111275, 4979.651424400257, 5009.924851127309, 5109.565686916654, 5110.207917772751, 5116.360454943132, 5116.3860336758335, 5165.405978312542, 4934.55588996992, 4973.129702302155, 4976.427710813158, 4980.551750342486, 5037.823676171316, 4809.422869255712, 4878.438979517401, 4890.975545122394, 4941.456439791692, 4963.975180124221, 4889.682170658896, 4921.803127874988, 4923.483034281492, 4971.105201063843, 4991.176455884738, 4898.608111351012, 4954.405471343462, 4955.479674634112, 4987.451380348086, 5074.695518268915, 4796.928046079382, 4848.12733707936, 4866.902661946812, 4879.853604391874, 4880.219164933594], "value": 4672.8236348922155, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [532.6005495878092, 559.1138046196778, 561.6826493031436, 577.7313549199621, 578.7945279425804, 27510.174694759164, 30829.22926926828, 30866.691333086634, 30870.69129308709, 30889.69110308902, 39447.0, 39978.40032399516, 40052.799736001354, 44508.55491445085, 44681.329780053326, 7506.474546781714, 7639.9236007639765, 7643.235676432368, 7645.388368930472, 7647.464677472579, 7314.963425182893, 7465.888011679829, 7545.0, 7623.199564045779, 7624.27569380908, 7605.467617266793, 7663.961680191591, 9595.424274543515, 9846.556904939294, 9852.359596626196, 9666.130048295652, 9680.709578712649, 9686.176674982635, 9737.610495580167, 9743.853842192373, 9736.075072868067, 9800.754981125458, 9817.214622830157, 9821.852672209923, 9823.115919567203, 36627.267454650755, 37034.07414814624, 37222.81388593067, 37328.0, 37341.81329093364, 3027.9091627250996, 3048.283653341463, 3050.7864449488543, 3094.3811237752316, 3121.78147529673, 27955.0, 28069.578956315672, 28651.856740716164, 28838.71161288402, 29797.702022979927, 3252.642209356969, 3273.685256983791, 3339.799612023262, 3362.0250127463005, 3467.6532346765375, 241234.7938260315, 242379.0, 242548.0, 242637.0, 243002.0, 50994.0, 51753.22370164451, 51781.482185177665, 51827.0, 51902.48097519052, 28764.424711505653, 54049.459505405226, 54258.45741542534, 54278.728606356715, 54366.72816635971, 13894.0, 14212.644683882985, 14229.715405691828, 14246.0, 14314.0, 10700.197485188643, 10866.565337386573, 10882.727931801768, 10883.945580272048, 10894.0, 17620.20709068095, 17848.55378615519, 17887.642247154985, 17906.462806115578, 17960.9101954492, 5380.488853558905, 6559.934400656028, 6713.832154196184, 7035.226125126232, 7048.224695283515, 748.6631016042802, 859.5788063848794, 878.060475291432, 896.7668406214431, 938.6057855700485, 27063.1881043569, 27817.721822781514, 28683.28291792722, 28749.0, 28837.711622883922, 905.8822353094056, 922.423485321674, 929.9116583924516, 933.118203297877, 1004.3572113847143, 14700.264986750833, 14881.627959300888, 15123.546293611209, 15153.82735628391, 15459.690806183813, 360243.0, 365956.0, 366063.0, 366565.0, 366673.0, 48986.75506622444, 49542.50457495451, 49580.0, 49585.0, 49709.50290497049, 1071.0895738622264, 1104.6741211342674, 1140.0708422635525, 1147.9942600286945, 1159.930404175752, 24610.50778984446, 28594.57108143338, 29366.412671746017, 29768.404631907673, 29812.254693632833, 41703.58296416997, 42272.15455690931, 42299.57700423079, 42324.36513452362, 42333.36499952441, 238198.0, 239167.0, 239342.0, 240333.0, 242548.0, 23942.401439964142, 24554.263372098867, 24691.135810246557, 24725.50548989046, 26227.868860655573, 40672.59327406688, 40767.0, 41066.0, 41236.79381603073, 41868.58131418647, 34062.48906266457, 34284.48573271353, 34434.827825861714, 34474.310513790086, 34784.82607586946, 34678.0, 34837.0, 35048.0, 35459.82270088633, 35609.30251159802, 34273.657263428046, 34962.02822760094, 35035.0, 35279.64720352764, 35490.0, 29471.852640737518, 31673.5248971261, 31747.206319841265, 31763.20591985219, 32126.19684507906, 24510.387240319134, 25117.24648260555, 25147.874260629313, 25218.62172067457, 25475.235742927744], "value": 17173.95143844144, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.174739362498, 368.3130960758187, 368.362732472822, 372.2313422781955, 388.48137736122277, 12499.937500312497, 15717.214139293032, 15998.600034999145, 17474.912625436857, 17636.64726705465, 16423.2609532571, 16642.50072497824, 17169.313227470888, 17298.913505432454, 17327.566810829736, 4957.876053098684, 4958.157113290731, 4995.5753760930365, 5049.056113396332, 5055.31753213317, 3720.2373513429684, 3890.727649064567, 4990.87522811929, 5077.136886729265, 5636.887262254752, 5936.198613187229, 6016.458518733313, 6023.608465449754, 6041.939580604204, 6046.304674962392, 5755.453231942959, 5911.438413350767, 5927.02204136317, 5937.079752638348, 6020.8494787630225, 5212.061828870802, 5213.087709650796, 5224.373075230958, 5226.320578324793, 5240.3187585614005, 19623.803761962485, 20243.190272389234, 20277.797222027737, 20449.386518404324, 20533.5893282135, 1890.2439024390217, 1904.2573396375424, 2053.866498677581, 2204.922827701039, 2278.0, 8861.158189971942, 8986.281097512183, 9143.0, 9189.770255743593, 9396.48319342436, 1716.785401824772, 1756.4203812741764, 1764.80587135415, 1793.3633560086112, 1828.8994105324202, 69751.0, 70098.2990170102, 71789.28210717878, 72930.63534682292, 73870.26129738742, 9775.90224097764, 9789.265805064648, 9919.2560557957, 9984.0, 10035.297529172887, 13559.254241016839, 13559.525416610568, 13582.049256551947, 13584.45662173502, 13584.93207533956, 6871.896921546181, 6988.44092472601, 7015.649217539205, 7090.964545177241, 7150.9284907151305, 6490.772822951174, 6493.70778314977, 6667.466602671775, 6690.063391125246, 6714.328567143344, 4090.611391917763, 4198.202341555095, 4263.5736426357735, 4281.785910704514, 4335.566443355639, 1736.1319340329835, 1744.9476515704548, 1798.379559052125, 1801.4955812372557, 1811.936582219616, 834.7954751086023, 847.4025811802665, 856.2507805670039, 902.4269588811021, 935.5836652689624, 16435.424760133577, 16777.328906843588, 17285.13574321304, 17574.0, 17669.116544172997, 841.5497708725802, 843.6161546496329, 894.6019021535354, 905.9637614495479, 925.1118925831278, 9078.727638170865, 9856.802863942681, 9870.851937220947, 9887.653932112342, 9978.101970822516, 122733.38633306955, 123057.38471307587, 123177.38411307886, 123294.0, 125132.37433812955, 69065.65467172733, 72705.0, 76917.23082769212, 77218.22781772223, 79935.0, 908.6047569307373, 913.5660561233494, 955.9474228917337, 963.0754475703263, 963.1812958984807, 15658.686826263638, 15694.450694225647, 16234.0, 16292.51122466328, 16615.66768664644, 37995.81002094972, 38318.23363532658, 38323.42514862335, 38576.614233858425, 38659.6134038656, 46064.7696761514, 49154.508454916424, 50079.74960125176, 53378.73310633422, 53544.19683704669, 4800.4479484859685, 5593.496585307342, 6031.517478601789, 7136.3220494052985, 7696.422768292512, 11448.82826757616, 11841.23032002917, 12126.575569855013, 12280.140390172603, 12435.44040518197, 9956.900430995598, 10098.8485172721, 10331.84502232452, 10386.221033422675, 10838.241323107306, 9598.32811703202, 9747.268954828274, 10116.797664046826, 10584.259101862795, 10612.151027917902, 10928.562857485611, 11016.394098324668, 11069.391183484664, 11108.61119860801, 11333.489992950503, 7175.892361614476, 7405.814854628462, 7410.555366678017, 7489.513181643176, 7506.512076714996, 9407.43555386679, 9460.290478214023, 9604.08761167688, 9844.950775246078, 10218.795624087625], "value": 7910.786091263232, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.9541166059187, 1361.972760544789, 1376.2430663135274, 1666.4750603559885, 1699.728043513038, 6985.615791131486, 7257.8911316330295, 7469.701211951522, 8109.189081091895, 8125.796855078619, 7445.813854653623, 7748.457607967444, 7756.573388463647, 8008.239217274349, 8016.318612917909, 2153.924612638554, 2183.585118827418, 2189.1462329691353, 2201.1195521791333, 2204.867707937529, 1852.685043542601, 1913.7607799025122, 2085.1971990783504, 2149.9140034398606, 2183.967240491394, 2146.7423909130925, 2170.077716970289, 2171.782821717831, 2172.73927128744, 2173.7282839645045, 2133.1893880325533, 2158.643823769084, 2162.76209616942, 2173.163332117146, 2179.3461961411513, 2122.9150833966623, 2123.713298704686, 2136.583366243583, 2139.978600214009, 2173.6848157017303, 7832.0, 7995.520268783892, 7996.640151193152, 7996.800079997988, 8006.319462845665, 4679.74261415622, 4816.759162041884, 4818.662693611449, 4824.5899098576665, 4826.444958829745, 2796.6504186976626, 2939.3092623233524, 2963.970360296391, 2998.1005698290423, 3009.458297506448, 886.1448702002534, 930.4603330068544, 937.0442149008041, 937.9671711490133, 949.9762505937338, 10755.300905441121, 10777.083947864441, 10778.353298802018, 10781.191410644155, 10785.514651840685, 3899.0, 4233.729881035677, 4289.656827453796, 4346.935410535565, 4347.304431290978, 9254.907450925539, 9260.814783704289, 9261.30540209487, 9265.768355791159, 9279.118483744034, 4859.635527335464, 4863.708177509361, 4865.197242455026, 4867.975660121677, 4870.805167793319, 4383.057642606855, 4413.117376524708, 4434.290513517822, 4441.045175287264, 4447.266201076786, 3610.494530765695, 3679.632036796299, 3712.6053695366336, 3745.0824547985917, 3751.9062023449633, 1101.2456467319912, 1141.8401423800674, 1189.6431070678761, 1211.8242854786183, 1234.7900856854355, 706.9713566760352, 791.8574656561759, 798.9161138080534, 804.3605333759558, 804.7143264141263, 4995.800167993312, 5081.136206844845, 5098.541131298127, 5114.744262786846, 5303.628745987821, 830.6137645994521, 846.7332790171076, 858.5621333120154, 865.7965378136133, 890.9599068041954, 3347.2970676157793, 3353.4466812976075, 3354.8825791097192, 3366.0238530826277, 3468.618451970281, 9416.246700263962, 9624.230061595195, 9799.16707079892, 9873.35823171506, 9873.555689993824, 8653.956730216309, 9780.462074585825, 9787.951060244795, 9791.510424478747, 9799.951000244953, 6518.413342799171, 7058.364747172676, 7300.4159667226495, 7323.523970941872, 7483.8503229935095, 5141.87145321355, 5156.381234251914, 5213.0, 5230.320058392537, 5409.513143817076, 8997.100289971213, 9014.86477702848, 9026.277897768032, 9098.636054557743, 9154.954225228832, 8638.352123590881, 9030.45817250967, 9043.909560904307, 9159.267258619162, 9337.71986840396, 6745.089412929192, 6803.183617965876, 6871.793846184622, 6903.689333979883, 6914.619695916773, 7534.0582427196605, 7599.0, 7605.885911711218, 7609.277118673717, 7609.581473019037, 6853.7943861684225, 6971.616561088986, 7067.187273463617, 7106.609136497542, 7157.534760240776, 6803.9319606805275, 6850.417714494324, 6858.0, 6868.313168683092, 6900.447964162955, 6221.471174949999, 6236.563440559117, 6290.308066112632, 6318.210223722035, 6336.429721324918, 4546.88632784183, 4577.725336479822, 4641.582257596832, 4662.0, 4784.784684689267, 4391.912161756811, 4467.15124126415, 4638.93041604383, 4663.976680116578, 4667.066586682609], "value": 4150.050563139745, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.58587926325725, 292.0464682810623, 295.6260330681687, 296.35394839250426, 298.4523399561803, 4890.315355850184, 4915.18899381602, 4920.53254940781, 4927.187014142671, 4927.876803079925, 4833.661643684944, 4857.441394239663, 4871.683340582859, 4899.853004409864, 4936.23488359304, 3650.5619325680955, 3733.813309334536, 3757.3424650686156, 3810.3331916914567, 3812.294725475782, 3797.14564223049, 3805.923881522368, 3810.790406527654, 3815.0, 3823.5220597425323, 3771.943420848676, 3774.735768496206, 3781.432785082246, 3783.2811765764554, 3806.619338066199, 3618.9819050904707, 3673.742838001341, 3746.83139258734, 3757.3424650686293, 3820.617938206185, 3306.074299196229, 3310.817905015223, 3319.1204330852343, 3320.2031512437084, 3349.129226401129, 4702.482726900038, 4716.7359667359515, 4723.48041715411, 4745.525447455261, 4804.399450068741, 4181.979090104561, 4335.458067741532, 4339.177545430926, 4357.891052723708, 4390.538993405678, 4982.651214414992, 4982.975085124551, 5041.798328066873, 5053.8123540967845, 5058.544730974193, 3680.852765889388, 3686.1337585667347, 3693.169036966688, 3693.242885208526, 3699.72252081095, 5163.406208286057, 5351.314335984152, 5360.865978350534, 5367.516923476866, 5420.783168673248, 3701.0, 3707.5550933887566, 3726.6087060858763, 3747.414284143932, 3750.493683352767, 3777.7166712496673, 3783.243351329745, 3807.8476860925252, 3843.846845946205, 3850.942235866464, 4340.153670034313, 4345.9348109778375, 4366.271080574641, 4374.971881607819, 4378.715383500063, 4838.612910967185, 5062.544371006627, 5128.743562821844, 5140.511651393112, 5159.871003224949, 1316.2760481735008, 1330.221820235154, 1330.7471580399692, 1331.9134256273505, 1334.2661536155076, 822.7408366364576, 852.7015544559479, 853.4836423963537, 864.6757465950269, 866.0213958227289, 4258.7444753314285, 4379.197313719223, 4418.889527761768, 4510.143072816154, 4510.977445112753, 5231.319928409359, 5238.240455133984, 5243.764030618631, 5253.763580638881, 5263.710495922761, 4496.482904466028, 4500.572445617661, 4500.594946454835, 4523.276275795857, 4524.909501809945, 2645.246104860106, 2781.6662000560063, 2786.3452088759127, 2789.539725945237, 2796.9582204990065, 4981.455748717836, 4991.302956994639, 4999.875003124951, 5000.3498145982685, 5007.749612519359, 5129.307543481582, 5377.865553361197, 5415.160650099241, 5417.295751552273, 5420.620556561003, 4937.975310123498, 4977.377827771528, 4982.4768399317545, 4993.6254780892305, 5002.249662550574, 5240.868978275574, 5259.368875734936, 5267.9736601316745, 5268.473152684701, 5269.894602108013, 5004.173476681058, 5149.819756308661, 5152.089069675621, 5166.741662916915, 5167.560757335668, 4947.901041979212, 4958.785097650954, 4960.255961605788, 4968.0, 4977.9751101244265, 3729.1609387887506, 3756.9856138841815, 3767.9246415072093, 3779.7543159694533, 3795.7532760370486, 5171.0, 5257.868553286198, 5308.619758862646, 5313.990341835039, 5327.440618734977, 5047.0, 5061.139606267017, 5075.847724568269, 5087.219473184504, 5133.665247035723, 5040.815408379101, 5066.873328166826, 5096.949030509648, 5097.266929244075, 5100.438951715382, 4785.736784476748, 4999.625028122832, 5026.798928042837, 5034.320366750442, 5045.470225626404, 4911.312416261655, 5071.721055341844, 5163.845084647466, 5168.767405466839, 5178.705323669083, 4864.6594738369395, 4985.277134815504, 5008.298838162587, 5014.52362025607, 5023.748812559431], "value": 3844.7437134044103, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.1348565950308, 658.8254112660146, 688.3598253624131, 699.8145491444765, 718.7556230881503, 12792.424340904658, 13714.24571648559, 13921.512747053855, 14009.159450432968, 14041.789373159398, 13397.866021339809, 13533.796993045113, 13560.45758169672, 13594.252316122635, 13619.25094119823, 620.8447888027993, 638.0397501759845, 758.2720588235301, 762.8054846014259, 775.9728409505668, 772.8377040821406, 773.4817672159667, 774.1677696476311, 774.2760518914805, 774.4540099230057, 820.9014918209823, 821.8438496685641, 821.9136990615959, 822.0382152881114, 822.2271065198725, 650.4503694378219, 669.6919417068154, 673.5958424945043, 676.2561182698992, 814.8044469327378, 489.168413696717, 585.6866576381616, 597.9312379076418, 602.3133627664466, 602.6956387024568, 12282.938585307016, 12302.261864288172, 12318.938405307916, 12323.137380383378, 12324.32216228107, 12253.264804111692, 12425.254484730945, 12832.550860719923, 13199.999999999904, 13365.0, 11836.467358968866, 12141.878581214252, 12210.389480526028, 12451.190672606343, 12908.225506469642, 4228.260054490483, 4241.681873859473, 4277.572242775697, 4323.351497275403, 4423.668224883147, 69930.0, 70336.6483167591, 70734.29265707328, 70811.0, 71997.0, 9223.308251881135, 9436.669716559887, 9652.179564736936, 9652.469114198646, 9786.314957953018, 18473.907630461763, 18481.630367392845, 18486.168122434523, 18508.65046714021, 18541.907290463463, 6812.659367031629, 6975.128108986377, 6979.616121113388, 6991.265917078736, 7006.964965175243, 3934.5868683788362, 3935.58676338986, 3978.2441336146617, 4026.8187931543152, 4107.342825147962, 2926.268432891777, 3030.4242193983514, 3030.712082352173, 3034.5599888016113, 3037.7569794416395, 503.896701176258, 507.3303239723603, 510.46656244224874, 517.2551525802832, 533.216172226826, 517.6376536424442, 523.9502247286501, 572.9627574207664, 612.7242740766584, 615.3385111005687, 8433.662653493915, 8661.826763464822, 8673.826523469495, 8683.739487815375, 8709.216170544682, 620.227816368624, 624.4442446222865, 627.8524546731514, 640.3532432243375, 649.0945131541473, 3895.9610403896163, 3998.960010399917, 4007.2987227235117, 4047.736897101679, 4251.702380833312, 54361.0, 55044.724776375864, 95647.0, 106302.0, 107463.0, 74712.0, 76817.0, 79905.20568765892, 80102.19897801064, 81912.0, 68749.0, 69696.30303697, 70941.0, 73667.63166184242, 75476.0, 8416.0, 8730.126987301219, 8883.955580222317, 8930.285577153942, 9050.547472626211, 38420.231595367375, 39026.804865975486, 41203.7939810299, 42968.15343843956, 44249.55750442583, 54578.45058592835, 63940.0, 64620.676896615216, 64842.67578662076, 65065.0, 11252.83120753173, 11354.205205635526, 11432.0, 11685.707857303636, 11796.29222246668, 12839.550615728405, 13072.803907941197, 13145.277009764555, 13578.0, 14028.509002184874, 12283.263004219776, 12386.0, 13030.934845325713, 13300.933495332461, 13430.0598958072, 10891.782164356828, 11258.943705281421, 11646.76706465849, 11987.40062996864, 12013.099017573892, 11843.0, 12371.814422783846, 12411.255324680547, 12539.247645140957, 12919.741605168032, 9788.412695238023, 10108.39349639024, 10356.482175891024, 10609.575616975235, 10638.41488718097, 9018.594163262538, 9858.112769850748, 10054.447005414773, 10659.25385223058, 10838.349699017768], "value": 6647.275092172655, "unit": "score"}], "name": "dromaeo_css", "value": 6378.4262306706505, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 113.0, 114.0, 114.0, 114.0, 115.0, 115.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 130.0, 127.0, 169.0, 124.0, 127.0, 125.0, 126.0, 167.0, 128.0], "value": 138.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 163.0, 162.0, 161.0, 162.0, 162.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 107.0, 78.0, 76.0, 80.0, 79.0, 97.0, 76.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 111.0, 83.0, 84.0, 84.0, 105.0, 85.0, 84.0, 111.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 148.0, 148.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 64.0, 65.0, 64.0, 63.0, 63.0, 64.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 67.0, 67.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 83.0, 83.0, 89.0, 83.0, 84.0, 83.0, 89.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 134.0, 136.0, 139.0, 134.0, 140.0, 134.0, 140.0, 178.0, 134.0], "value": 142.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 176.0, 177.0, 171.0, 173.0, 172.0, 171.0, 173.0, 174.0, 175.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 69.0, 70.0, 73.0, 69.0, 74.0, 68.0, 69.0], "value": 70.0, "unit": "score"}], "name": "kraken", "value": 1547.0, "alertThreshold": 2.0}]} 05:27:51 INFO - Return code: 0 05:27:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:27:51 INFO - # TBPL SUCCESS # 05:27:51 INFO - Running post-action listener: _resource_record_post_action 05:27:51 INFO - [mozharness: 2016-09-23 12:27:51.335244Z] Finished run-tests step (success) 05:27:51 INFO - Running post-run listener: _resource_record_post_run 05:27:51 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 12288; Write bytes: 409878528; Read time: 20; Write time: 272060 05:27:51 INFO - TinderboxPrint: CPU usage
13.0% 05:27:51 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 20 05:27:51 INFO - TinderboxPrint: I/O write bytes / time
409,878,528 / 272,060 05:27:51 INFO - TinderboxPrint: CPU idle
8,347.9 (87.0%) 05:27:51 INFO - TinderboxPrint: CPU user
1,202.2 (12.5%) 05:27:51 INFO - TinderboxPrint: Swap in / out
0 / 0 05:27:51 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 116449280; Read time: 0; Write time: 81164 05:27:51 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 12288; Write bytes: 292524032; Read time: 20; Write time: 190872 05:27:51 INFO - Running post-run listener: _upload_blobber_files 05:27:51 INFO - Blob upload gear active. 05:27:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:27:51 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 05:27:51 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:27:51 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:27:52 INFO - (blobuploader) - INFO - Open directory for files ... 05:27:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:27:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:27:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:53 INFO - (blobuploader) - INFO - Done attempting. 05:27:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:27:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:27:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:57 INFO - (blobuploader) - INFO - Done attempting. 05:27:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:27:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:27:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:58 INFO - (blobuploader) - INFO - Done attempting. 05:27:58 INFO - (blobuploader) - INFO - Iteration through files over. 05:27:58 INFO - Return code: 0 05:27:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:27:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:27:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/90d5f491a25763bc48cb2e53fd0fa91656c8686797f822afc1b1d07e81b7f2f135c67f105db9c05c7ad31cab11bd469b247d820413f371c1ebea8369c0e87f86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/775e1843f058e6dc4f8cd77cf7fa0a80859c97d860901ae72eea0d74f326c09056bb03e23fa2a0b1f9425f2e0831f2da67dc5abb9cd6b4c9e5577e167eafa8d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cec7599909c3ad31120324891661e8367ffdbf0bed03c3d74c10c81deb8884dd02186558ddd5e582e51dc6eaeb84da08275cc8ab3515feaca2e300c9bf334236"} 05:27:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:27:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:27:58 INFO - Contents: 05:27:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/90d5f491a25763bc48cb2e53fd0fa91656c8686797f822afc1b1d07e81b7f2f135c67f105db9c05c7ad31cab11bd469b247d820413f371c1ebea8369c0e87f86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/775e1843f058e6dc4f8cd77cf7fa0a80859c97d860901ae72eea0d74f326c09056bb03e23fa2a0b1f9425f2e0831f2da67dc5abb9cd6b4c9e5577e167eafa8d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cec7599909c3ad31120324891661e8367ffdbf0bed03c3d74c10c81deb8884dd02186558ddd5e582e51dc6eaeb84da08275cc8ab3515feaca2e300c9bf334236"} 05:27:58 INFO - Running post-run listener: copy_logs_to_upload_dir 05:27:58 INFO - Copying logs to upload dir... 05:27:58 INFO - mkdir: /builds/slave/test/build/upload/logs 05:27:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.735164 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-09-23 05:27:58.138539) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 05:27:58.142111) ========= 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=ed14279e38b05397cf4aa391000001a4-1474632149.339210-1989473087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/90d5f491a25763bc48cb2e53fd0fa91656c8686797f822afc1b1d07e81b7f2f135c67f105db9c05c7ad31cab11bd469b247d820413f371c1ebea8369c0e87f86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/775e1843f058e6dc4f8cd77cf7fa0a80859c97d860901ae72eea0d74f326c09056bb03e23fa2a0b1f9425f2e0831f2da67dc5abb9cd6b4c9e5577e167eafa8d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cec7599909c3ad31120324891661e8367ffdbf0bed03c3d74c10c81deb8884dd02186558ddd5e582e51dc6eaeb84da08275cc8ab3515feaca2e300c9bf334236"} build_url:https://queue.taskcluster.net/v1/task/DSbIMvxKQECotsSBBHiWyQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011351 build_url: 'https://queue.taskcluster.net/v1/task/DSbIMvxKQECotsSBBHiWyQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/90d5f491a25763bc48cb2e53fd0fa91656c8686797f822afc1b1d07e81b7f2f135c67f105db9c05c7ad31cab11bd469b247d820413f371c1ebea8369c0e87f86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/775e1843f058e6dc4f8cd77cf7fa0a80859c97d860901ae72eea0d74f326c09056bb03e23fa2a0b1f9425f2e0831f2da67dc5abb9cd6b4c9e5577e167eafa8d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cec7599909c3ad31120324891661e8367ffdbf0bed03c3d74c10c81deb8884dd02186558ddd5e582e51dc6eaeb84da08275cc8ab3515feaca2e300c9bf334236"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 05:27:58.168123) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 05:27:58.168463) ========= 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=ed14279e38b05397cf4aa391000001a4-1474632149.339210-1989473087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 05:27:58.251605) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 05:27:58.252055) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 05:27:58.252437) ========= ========= Total master_lag: 0.19 =========