builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-067 starttime: 1473780969.3 results: success (0) buildid: 20160913071707 builduid: 2b7c3ff29448415991da5c5e929511f1 revision: a569d019fd4a1e2a7be700555f9e81322e40e846 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-13 08:36:09.295686) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-13 08:36:09.296071) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-13 08:36:09.296344) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-13 08:36:09.312494) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 08:36:09.313193) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1473780638.400966-1998685341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-13 08:36:10-- 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% 222M=0s 2016-09-13 08:36:10 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.152232 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 08:36:09.481269) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 08:36:09.481764) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1473780638.400966-1998685341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018166 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 08:36:09.533829) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 08:36:09.534191) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev a569d019fd4a1e2a7be700555f9e81322e40e846 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev a569d019fd4a1e2a7be700555f9e81322e40e846 --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=e0e61f6f900f4dc42e3e8956000001ad-1473780638.400966-1998685341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-13 08:36:10,465 truncating revision to first 12 chars 2016-09-13 08:36:10,465 Setting DEBUG logging. 2016-09-13 08:36:10,465 attempt 1/10 2016-09-13 08:36:10,465 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/a569d019fd4a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-13 08:36:10,897 unpacking tar archive at: autoland-a569d019fd4a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.760559 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 08:36:10.312844) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-13 08:36:10.313181) ========= script_repo_revision: a569d019fd4a1e2a7be700555f9e81322e40e846 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-13 08:36:10.313602) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-13 08:36:10.313921) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-13 08:36:10.325057) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-09-13 08:36:10.325368) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-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=e0e61f6f900f4dc42e3e8956000001ad-1473780638.400966-1998685341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:36:11 INFO - MultiFileLogger online at 20160913 08:36:11 in /builds/slave/test 08:36:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 08:36:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:36:11 INFO - {'append_to_log': False, 08:36:11 INFO - 'base_work_dir': '/builds/slave/test', 08:36:11 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 08:36:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:36:11 INFO - 'branch': 'Autoland-Non-PGO', 08:36:11 INFO - 'buildbot_json_path': 'buildprops.json', 08:36:11 INFO - 'config_files': ('talos/linux_config.py',), 08:36:11 INFO - 'default_actions': ('clobber', 08:36:11 INFO - 'read-buildbot-config', 08:36:11 INFO - 'download-and-extract', 08:36:11 INFO - 'populate-webroot', 08:36:11 INFO - 'create-virtualenv', 08:36:11 INFO - 'install', 08:36:11 INFO - 'run-tests'), 08:36:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:36:11 INFO - 'download_minidump_stackwalk': True, 08:36:11 INFO - 'download_symbols': 'ondemand', 08:36:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:36:11 INFO - 'tooltool.py': '/tools/tooltool.py', 08:36:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:36:11 INFO - '/tools/misc-python/virtualenv.py')}, 08:36:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:36:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:36:11 INFO - 'installer_path': 'installer.exe', 08:36:11 INFO - 'log_level': 'info', 08:36:11 INFO - 'log_name': 'talos', 08:36:11 INFO - 'log_to_console': True, 08:36:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:36:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:36:11 INFO - 'opt_config_files': (), 08:36:11 INFO - 'pip_index': False, 08:36:11 INFO - 'sps_profile': False, 08:36:11 INFO - 'sps_profile_interval': 0, 08:36:11 INFO - 'suite': 'dromaeojs', 08:36:11 INFO - 'system_bits': '32', 08:36:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:36:11 INFO - 'title': 'talos-linux64-ix-067', 08:36:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:36:11 INFO - 'use_talos_json': True, 08:36:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:36:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:36:11 INFO - 'work_dir': 'build'} 08:36:11 INFO - [mozharness: 2016-09-13 15:36:11.354039Z] Running clobber step. 08:36:11 INFO - Running pre-action listener: _resource_record_pre_action 08:36:11 INFO - Running main action method: clobber 08:36:11 INFO - rmtree: /builds/slave/test/build 08:36:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:36:12 INFO - Running post-action listener: _resource_record_post_action 08:36:12 INFO - [mozharness: 2016-09-13 15:36:12.338162Z] Finished clobber step (success) 08:36:12 INFO - [mozharness: 2016-09-13 15:36:12.338262Z] Running read-buildbot-config step. 08:36:12 INFO - Running pre-action listener: _resource_record_pre_action 08:36:12 INFO - Running main action method: read_buildbot_config 08:36:12 INFO - Using buildbot properties: 08:36:12 INFO - { 08:36:12 INFO - "project": "", 08:36:12 INFO - "product": "firefox", 08:36:12 INFO - "script_repo_revision": "production", 08:36:12 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 08:36:12 INFO - "repository": "", 08:36:12 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 08:36:12 INFO - "buildid": "20160913071707", 08:36:12 INFO - "pgo_build": "False", 08:36:12 INFO - "basedir": "/builds/slave/test", 08:36:12 INFO - "buildnumber": 531, 08:36:12 INFO - "slavename": "talos-linux64-ix-067", 08:36:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:36:12 INFO - "platform": "ubuntu64_hw", 08:36:12 INFO - "scheduler": "tests-autoland-linux64-talos", 08:36:12 INFO - "branch": "autoland", 08:36:12 INFO - "repo_path": "integration/autoland", 08:36:12 INFO - "revision": "a569d019fd4a1e2a7be700555f9e81322e40e846", 08:36:12 INFO - "stage_platform": "linux64", 08:36:12 INFO - "builduid": "2b7c3ff29448415991da5c5e929511f1", 08:36:12 INFO - "slavebuilddir": "test" 08:36:12 INFO - } 08:36:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/eDB_si_OTW6T4BQTqjv_Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:36:12 INFO - Running post-action listener: _resource_record_post_action 08:36:12 INFO - [mozharness: 2016-09-13 15:36:12.340761Z] Finished read-buildbot-config step (success) 08:36:12 INFO - [mozharness: 2016-09-13 15:36:12.340850Z] Running download-and-extract step. 08:36:12 INFO - Running pre-action listener: _resource_record_pre_action 08:36:12 INFO - Running main action method: download_and_extract 08:36:12 INFO - mkdir: /builds/slave/test/build/tests 08:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:12 INFO - trying https://queue.taskcluster.net/v1/task/eDB_si_OTW6T4BQTqjv_Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:36:12 INFO - Downloading https://queue.taskcluster.net/v1/task/eDB_si_OTW6T4BQTqjv_Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:36:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eDB_si_OTW6T4BQTqjv_Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:36:12 INFO - Downloaded 1361 bytes. 08:36:12 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:36:12 INFO - Using the following test package requirements: 08:36:12 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:36:12 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:36:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:36:12 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:36:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:36:12 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:36:12 INFO - u'jsshell-linux-x86_64.zip'], 08:36:12 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:36:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:36:12 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:36:12 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:36:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:36:12 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:36:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:36:12 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:36:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:36:12 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:36:12 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:36:12 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:36:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eDB_si_OTW6T4BQTqjv_Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:36:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eDB_si_OTW6T4BQTqjv_Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:36:12 INFO - Fetch https://queue.taskcluster.net/v1/task/eDB_si_OTW6T4BQTqjv_Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:36:13 INFO - Expected file size: 20362044 08:36:18 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:36:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eDB_si_OTW6T4BQTqjv_Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:36:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eDB_si_OTW6T4BQTqjv_Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:36:18 INFO - Fetch https://queue.taskcluster.net/v1/task/eDB_si_OTW6T4BQTqjv_Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:36:18 INFO - Expected file size: 20362044 08:36:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eDB_si_OTW6T4BQTqjv_Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:36:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eDB_si_OTW6T4BQTqjv_Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:36:23 INFO - Fetch https://queue.taskcluster.net/v1/task/eDB_si_OTW6T4BQTqjv_Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:36:24 INFO - Expected file size: 14414048 08:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:25 INFO - trying https://queue.taskcluster.net/v1/task/eDB_si_OTW6T4BQTqjv_Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:36:25 INFO - Downloading https://queue.taskcluster.net/v1/task/eDB_si_OTW6T4BQTqjv_Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:36:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eDB_si_OTW6T4BQTqjv_Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:36:27 INFO - Downloaded 55611687 bytes. 08:36:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eDB_si_OTW6T4BQTqjv_Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:36:27 INFO - mkdir: /builds/slave/test/properties 08:36:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:36:27 INFO - Writing to file /builds/slave/test/properties/build_url 08:36:27 INFO - Contents: 08:36:27 INFO - build_url:https://queue.taskcluster.net/v1/task/eDB_si_OTW6T4BQTqjv_Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:36:27 INFO - Running post-action listener: _resource_record_post_action 08:36:27 INFO - Running post-action listener: set_extra_try_arguments 08:36:27 INFO - [mozharness: 2016-09-13 15:36:27.962514Z] Finished download-and-extract step (success) 08:36:27 INFO - [mozharness: 2016-09-13 15:36:27.962836Z] Running populate-webroot step. 08:36:27 INFO - Running pre-action listener: _resource_record_pre_action 08:36:27 INFO - Running main action method: populate_webroot 08:36:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:36:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:36:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:36:27 INFO - '--tppagecycles', 08:36:27 INFO - '7'], 08:36:27 INFO - 'tests': ['tsvgm']}}, 08:36:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:36:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:36:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:36:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:36:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:36:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:36:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:27 INFO - 'talos_options': ['--disable-e10s'], 08:36:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:36:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:36:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:27 INFO - 'talos_options': ['--disable-e10s'], 08:36:27 INFO - 'tests': ['damp', 'tps']}, 08:36:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:27 INFO - 'tests': ['damp', 'tps']}, 08:36:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:36:27 INFO - 'tests': ['dromaeo_dom']}, 08:36:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:36:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:36:27 INFO - 'tests': ['basic_compositor_video']}, 08:36:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:36:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:36:27 INFO - 'tests': ['a11yr', 08:36:27 INFO - 'ts_paint', 08:36:27 INFO - 'tpaint', 08:36:27 INFO - 'sessionrestore', 08:36:27 INFO - 'sessionrestore_no_auto_restore', 08:36:27 INFO - 'tabpaint']}, 08:36:27 INFO - 'other-e10s': {'tests': ['a11yr', 08:36:27 INFO - 'ts_paint', 08:36:27 INFO - 'tpaint', 08:36:27 INFO - 'sessionrestore', 08:36:27 INFO - 'sessionrestore_no_auto_restore', 08:36:27 INFO - 'tabpaint']}, 08:36:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:36:27 INFO - 'ts_paint', 08:36:27 INFO - 'tpaint', 08:36:27 INFO - 'sessionrestore', 08:36:27 INFO - 'sessionrestore_no_auto_restore', 08:36:27 INFO - 'tabpaint']}, 08:36:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:36:27 INFO - 'ts_paint', 08:36:27 INFO - 'tpaint', 08:36:27 INFO - 'sessionrestore', 08:36:27 INFO - 'sessionrestore_no_auto_restore', 08:36:27 INFO - 'tabpaint']}, 08:36:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:36:27 INFO - 'tests': ['a11yr', 08:36:27 INFO - 'ts_paint', 08:36:27 INFO - 'tpaint', 08:36:27 INFO - 'sessionrestore', 08:36:27 INFO - 'sessionrestore_no_auto_restore', 08:36:27 INFO - 'tabpaint']}, 08:36:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:36:27 INFO - 'tests': ['a11yr', 08:36:27 INFO - 'ts_paint', 08:36:27 INFO - 'tpaint', 08:36:27 INFO - 'sessionrestore', 08:36:27 INFO - 'sessionrestore_no_auto_restore', 08:36:27 INFO - 'tabpaint']}, 08:36:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:36:27 INFO - 'tests': ['tsvgx', 08:36:27 INFO - 'tsvgr_opacity', 08:36:27 INFO - 'tart', 08:36:27 INFO - 'tscrollx', 08:36:27 INFO - 'cart']}, 08:36:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:36:27 INFO - 'tsvgr_opacity', 08:36:27 INFO - 'tart', 08:36:27 INFO - 'tscrollx', 08:36:27 INFO - 'cart']}, 08:36:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:27 INFO - 'talos_options': ['--disable-e10s'], 08:36:27 INFO - 'tests': ['tp5o']}, 08:36:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:27 INFO - 'tests': ['tp5o']}, 08:36:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:27 INFO - 'talos_options': ['--disable-e10s', 08:36:27 INFO - '--xperf_path', 08:36:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:36:27 INFO - 'tests': ['tp5n']}, 08:36:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:36:27 INFO - 'talos_options': ['--xperf_path', 08:36:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:36:27 INFO - 'tests': ['tp5n']}}, 08:36:27 INFO - 'talos.zip': {'path': '', 08:36:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:36:27 INFO - Running post-action listener: _resource_record_post_action 08:36:27 INFO - [mozharness: 2016-09-13 15:36:27.982018Z] Finished populate-webroot step (success) 08:36:27 INFO - [mozharness: 2016-09-13 15:36:27.982109Z] Running create-virtualenv step. 08:36:27 INFO - Running pre-action listener: _resource_record_pre_action 08:36:27 INFO - Running main action method: create_virtualenv 08:36:27 INFO - Creating virtualenv /builds/slave/test/build/venv 08:36:27 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 08:36:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:36:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:36:28 INFO - Using real prefix '/usr' 08:36:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:36:28 INFO - Installing distribute.............................................................................................................................................................................................done. 08:36:30 INFO - Installing pip.................done. 08:36:30 INFO - Return code: 0 08:36:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1cce613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188af60>, '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 0x188bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188c1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1473780638.400966-1998685341', '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 08:36:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:36:30 INFO - Using env: {'DISPLAY': ':0', 08:36:30 INFO - 'HOME': '/home/cltbld', 08:36:30 INFO - 'LANG': 'en_US.UTF-8', 08:36:30 INFO - 'LANGUAGE': 'en_US:en', 08:36:30 INFO - 'LOGNAME': 'cltbld', 08:36:30 INFO - 'MAIL': '/var/mail/cltbld', 08:36:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:30 INFO - 'MOZ_NO_REMOTE': '1', 08:36:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:30 INFO - 'NO_EM_RESTART': '1', 08:36:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:30 INFO - 'PWD': '/builds/slave/test', 08:36:30 INFO - 'SHELL': '/bin/bash', 08:36:30 INFO - 'SHLVL': '1', 08:36:30 INFO - 'TERM': 'linux', 08:36:30 INFO - 'TMOUT': '86400', 08:36:30 INFO - 'USER': 'cltbld', 08:36:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1473780638.400966-1998685341', 08:36:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:30 INFO - '_': '/tools/buildbot/bin/python'} 08:36:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:30 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 08:36:30 INFO - Cleaning up... 08:36:30 INFO - Return code: 0 08:36:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1cce613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188af60>, '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 0x188bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188c1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1473780638.400966-1998685341', '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 08:36:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:36:30 INFO - Using env: {'DISPLAY': ':0', 08:36:30 INFO - 'HOME': '/home/cltbld', 08:36:30 INFO - 'LANG': 'en_US.UTF-8', 08:36:30 INFO - 'LANGUAGE': 'en_US:en', 08:36:30 INFO - 'LOGNAME': 'cltbld', 08:36:30 INFO - 'MAIL': '/var/mail/cltbld', 08:36:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:30 INFO - 'MOZ_NO_REMOTE': '1', 08:36:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:30 INFO - 'NO_EM_RESTART': '1', 08:36:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:30 INFO - 'PWD': '/builds/slave/test', 08:36:30 INFO - 'SHELL': '/bin/bash', 08:36:30 INFO - 'SHLVL': '1', 08:36:30 INFO - 'TERM': 'linux', 08:36:30 INFO - 'TMOUT': '86400', 08:36:30 INFO - 'USER': 'cltbld', 08:36:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1473780638.400966-1998685341', 08:36:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:30 INFO - '_': '/tools/buildbot/bin/python'} 08:36:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:30 INFO - Downloading/unpacking psutil>=3.1.1 08:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:36:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:36:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:36:32 INFO - Installing collected packages: psutil 08:36:32 INFO - Running setup.py install for psutil 08:36:33 INFO - building 'psutil._psutil_linux' extension 08:36:33 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 08:36:33 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 08:36:33 INFO - building 'psutil._psutil_posix' extension 08:36:33 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 08:36:33 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 08:36:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:36:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:36:33 INFO - Successfully installed psutil 08:36:33 INFO - Cleaning up... 08:36:33 INFO - Return code: 0 08:36:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:36:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1cce613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188af60>, '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 0x188bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188c1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1473780638.400966-1998685341', '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 08:36:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:36:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:36:33 INFO - Using env: {'DISPLAY': ':0', 08:36:33 INFO - 'HOME': '/home/cltbld', 08:36:33 INFO - 'LANG': 'en_US.UTF-8', 08:36:33 INFO - 'LANGUAGE': 'en_US:en', 08:36:33 INFO - 'LOGNAME': 'cltbld', 08:36:33 INFO - 'MAIL': '/var/mail/cltbld', 08:36:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:33 INFO - 'MOZ_NO_REMOTE': '1', 08:36:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:33 INFO - 'NO_EM_RESTART': '1', 08:36:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:33 INFO - 'PWD': '/builds/slave/test', 08:36:33 INFO - 'SHELL': '/bin/bash', 08:36:33 INFO - 'SHLVL': '1', 08:36:33 INFO - 'TERM': 'linux', 08:36:33 INFO - 'TMOUT': '86400', 08:36:33 INFO - 'USER': 'cltbld', 08:36:33 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1473780638.400966-1998685341', 08:36:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:33 INFO - '_': '/tools/buildbot/bin/python'} 08:36:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:36:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:36:35 INFO - Installing collected packages: mozsystemmonitor 08:36:35 INFO - Running setup.py install for mozsystemmonitor 08:36:35 INFO - Successfully installed mozsystemmonitor 08:36:35 INFO - Cleaning up... 08:36:35 INFO - Return code: 0 08:36:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1cce613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188af60>, '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 0x188bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188c1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1473780638.400966-1998685341', '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 08:36:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:36:35 INFO - Using env: {'DISPLAY': ':0', 08:36:35 INFO - 'HOME': '/home/cltbld', 08:36:35 INFO - 'LANG': 'en_US.UTF-8', 08:36:35 INFO - 'LANGUAGE': 'en_US:en', 08:36:35 INFO - 'LOGNAME': 'cltbld', 08:36:35 INFO - 'MAIL': '/var/mail/cltbld', 08:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:35 INFO - 'MOZ_NO_REMOTE': '1', 08:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:35 INFO - 'NO_EM_RESTART': '1', 08:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:35 INFO - 'PWD': '/builds/slave/test', 08:36:35 INFO - 'SHELL': '/bin/bash', 08:36:35 INFO - 'SHLVL': '1', 08:36:35 INFO - 'TERM': 'linux', 08:36:35 INFO - 'TMOUT': '86400', 08:36:35 INFO - 'USER': 'cltbld', 08:36:35 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1473780638.400966-1998685341', 08:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:35 INFO - '_': '/tools/buildbot/bin/python'} 08:36:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:36 INFO - Downloading/unpacking jsonschema==2.5.1 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36: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 08:36:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:36:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:38 INFO - Downloading functools32-3.2.3-2.tar.gz 08:36:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:36:38 INFO - warning: no files found matching '*.txt' 08:36:38 INFO - no previously-included directories found matching 'build' 08:36:38 INFO - no previously-included directories found matching 'dist' 08:36:38 INFO - no previously-included directories found matching '.git*' 08:36:38 INFO - Installing collected packages: jsonschema, functools32 08:36:38 INFO - Running setup.py install for functools32 08:36:38 INFO - warning: no files found matching '*.txt' 08:36:38 INFO - no previously-included directories found matching 'build' 08:36:38 INFO - no previously-included directories found matching 'dist' 08:36:38 INFO - no previously-included directories found matching '.git*' 08:36:38 INFO - Successfully installed jsonschema functools32 08:36:38 INFO - Cleaning up... 08:36:38 INFO - Return code: 0 08:36:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1cce613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188af60>, '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 0x188bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188c1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1473780638.400966-1998685341', '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 08:36:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:36:38 INFO - Using env: {'DISPLAY': ':0', 08:36:38 INFO - 'HOME': '/home/cltbld', 08:36:38 INFO - 'LANG': 'en_US.UTF-8', 08:36:38 INFO - 'LANGUAGE': 'en_US:en', 08:36:38 INFO - 'LOGNAME': 'cltbld', 08:36:38 INFO - 'MAIL': '/var/mail/cltbld', 08:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:38 INFO - 'MOZ_NO_REMOTE': '1', 08:36:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:38 INFO - 'NO_EM_RESTART': '1', 08:36:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:38 INFO - 'PWD': '/builds/slave/test', 08:36:38 INFO - 'SHELL': '/bin/bash', 08:36:38 INFO - 'SHLVL': '1', 08:36:38 INFO - 'TERM': 'linux', 08:36:38 INFO - 'TMOUT': '86400', 08:36:38 INFO - 'USER': 'cltbld', 08:36:38 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1473780638.400966-1998685341', 08:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:38 INFO - '_': '/tools/buildbot/bin/python'} 08:36:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:36:38 INFO - Cleaning up... 08:36:38 INFO - Return code: 0 08:36:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1cce613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188af60>, '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 0x188bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188c1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1473780638.400966-1998685341', '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 08:36:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:36:38 INFO - Using env: {'DISPLAY': ':0', 08:36:38 INFO - 'HOME': '/home/cltbld', 08:36:38 INFO - 'LANG': 'en_US.UTF-8', 08:36:38 INFO - 'LANGUAGE': 'en_US:en', 08:36:38 INFO - 'LOGNAME': 'cltbld', 08:36:38 INFO - 'MAIL': '/var/mail/cltbld', 08:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:38 INFO - 'MOZ_NO_REMOTE': '1', 08:36:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:38 INFO - 'NO_EM_RESTART': '1', 08:36:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:38 INFO - 'PWD': '/builds/slave/test', 08:36:38 INFO - 'SHELL': '/bin/bash', 08:36:38 INFO - 'SHLVL': '1', 08:36:38 INFO - 'TERM': 'linux', 08:36:38 INFO - 'TMOUT': '86400', 08:36:38 INFO - 'USER': 'cltbld', 08:36:38 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1473780638.400966-1998685341', 08:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:38 INFO - '_': '/tools/buildbot/bin/python'} 08:36:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:38 INFO - Downloading/unpacking blobuploader==1.2.4 08:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:40 INFO - Downloading blobuploader-1.2.4.tar.gz 08:36:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:36:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:36:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:41 INFO - Downloading docopt-0.6.1.tar.gz 08:36:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:36:41 INFO - Installing collected packages: blobuploader, requests, docopt 08:36:41 INFO - Running setup.py install for blobuploader 08:36:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:36:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:36:41 INFO - Running setup.py install for requests 08:36:41 INFO - Running setup.py install for docopt 08:36:42 INFO - Successfully installed blobuploader requests docopt 08:36:42 INFO - Cleaning up... 08:36:42 INFO - Return code: 0 08:36:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36:42 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')]} 08:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:42 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')]} 08:36:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:42 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 0x7f1cce613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188af60>, '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 0x188bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188c1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1473780638.400966-1998685341', '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 08:36:42 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 08:36:42 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 08:36:42 INFO - Using env: {'DISPLAY': ':0', 08:36:42 INFO - 'HOME': '/home/cltbld', 08:36:42 INFO - 'LANG': 'en_US.UTF-8', 08:36:42 INFO - 'LANGUAGE': 'en_US:en', 08:36:42 INFO - 'LOGNAME': 'cltbld', 08:36:42 INFO - 'MAIL': '/var/mail/cltbld', 08:36:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:42 INFO - 'MOZ_NO_REMOTE': '1', 08:36:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:42 INFO - 'NO_EM_RESTART': '1', 08:36:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:42 INFO - 'PWD': '/builds/slave/test', 08:36:42 INFO - 'SHELL': '/bin/bash', 08:36:42 INFO - 'SHLVL': '1', 08:36:42 INFO - 'TERM': 'linux', 08:36:42 INFO - 'TMOUT': '86400', 08:36:42 INFO - 'USER': 'cltbld', 08:36:42 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1473780638.400966-1998685341', 08:36:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:42 INFO - '_': '/tools/buildbot/bin/python'} 08:36:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:36:42 INFO - Running setup.py (path:/tmp/pip-B8qBI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:36:42 INFO - Running setup.py (path:/tmp/pip-uQ61jJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:36:42 INFO - Running setup.py (path:/tmp/pip-WvCsG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:36:42 INFO - Running setup.py (path:/tmp/pip-UsknJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:36:42 INFO - Running setup.py (path:/tmp/pip-nj2whG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:36:42 INFO - Running setup.py (path:/tmp/pip-nf_wKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:36:42 INFO - Running setup.py (path:/tmp/pip-5trqQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:36:42 INFO - Running setup.py (path:/tmp/pip-zN7M6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:36:42 INFO - Running setup.py (path:/tmp/pip-AYAYn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:36:42 INFO - Running setup.py (path:/tmp/pip-J7FiqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:36:43 INFO - Running setup.py (path:/tmp/pip-B34F21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:36:43 INFO - Running setup.py (path:/tmp/pip-tdWIdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:36:43 INFO - Running setup.py (path:/tmp/pip-w3z_Ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:36:43 INFO - Running setup.py (path:/tmp/pip-VrOxj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:43 INFO - Running setup.py (path:/tmp/pip-Zmwpdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:36:43 INFO - Running setup.py (path:/tmp/pip-mnrHlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:36:43 INFO - Running setup.py (path:/tmp/pip-8asm4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:36:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:36:43 INFO - Running setup.py install for manifestparser 08:36:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:36:43 INFO - Running setup.py install for mozcrash 08:36:43 INFO - Running setup.py install for mozdebug 08:36:43 INFO - Running setup.py install for mozdevice 08:36:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:36:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:36:43 INFO - Running setup.py install for mozfile 08:36:44 INFO - Running setup.py install for mozhttpd 08:36:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:36:44 INFO - Running setup.py install for mozinfo 08:36:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:36:44 INFO - Running setup.py install for mozInstall 08:36:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:36:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:36:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:36:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:36:44 INFO - Running setup.py install for mozleak 08:36:44 INFO - Running setup.py install for mozlog 08:36:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:36:44 INFO - Running setup.py install for moznetwork 08:36:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:36:44 INFO - Running setup.py install for mozprocess 08:36:44 INFO - Running setup.py install for mozprofile 08:36:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:36:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:36:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:36:44 INFO - Running setup.py install for mozrunner 08:36:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:36:45 INFO - Running setup.py install for mozscreenshot 08:36:45 INFO - Running setup.py install for moztest 08:36:45 INFO - Running setup.py install for mozversion 08:36:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:36:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:36:45 INFO - Cleaning up... 08:36:45 INFO - Return code: 0 08:36:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:45 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 0x7f1cce613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188af60>, '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 0x188bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188c1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1473780638.400966-1998685341', '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 08:36:45 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 08:36:45 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 08:36:45 INFO - Using env: {'DISPLAY': ':0', 08:36:45 INFO - 'HOME': '/home/cltbld', 08:36:45 INFO - 'LANG': 'en_US.UTF-8', 08:36:45 INFO - 'LANGUAGE': 'en_US:en', 08:36:45 INFO - 'LOGNAME': 'cltbld', 08:36:45 INFO - 'MAIL': '/var/mail/cltbld', 08:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:45 INFO - 'MOZ_NO_REMOTE': '1', 08:36:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:45 INFO - 'NO_EM_RESTART': '1', 08:36:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:45 INFO - 'PWD': '/builds/slave/test', 08:36:45 INFO - 'SHELL': '/bin/bash', 08:36:45 INFO - 'SHLVL': '1', 08:36:45 INFO - 'TERM': 'linux', 08:36:45 INFO - 'TMOUT': '86400', 08:36:45 INFO - 'USER': 'cltbld', 08:36:45 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1473780638.400966-1998685341', 08:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:45 INFO - '_': '/tools/buildbot/bin/python'} 08:36:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:36:45 INFO - Running setup.py (path:/tmp/pip-1mMM2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:36:45 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)) 08:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:36:45 INFO - Running setup.py (path:/tmp/pip-u5ck_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:36:45 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)) 08:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:36:45 INFO - Running setup.py (path:/tmp/pip-r1rg_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:36:45 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)) 08:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:36:45 INFO - Running setup.py (path:/tmp/pip-qUfrXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:36:45 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)) 08:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:36:45 INFO - Running setup.py (path:/tmp/pip-QsDOFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:36:45 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)) 08:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:36:45 INFO - Running setup.py (path:/tmp/pip-Bntp97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:36:46 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)) 08:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:36:46 INFO - Running setup.py (path:/tmp/pip-PsqpUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:36:46 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)) 08:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:36:46 INFO - Running setup.py (path:/tmp/pip-FbnmU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:36:46 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)) 08:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:36:46 INFO - Running setup.py (path:/tmp/pip-FLk4pO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:36:46 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)) 08:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:36:46 INFO - Running setup.py (path:/tmp/pip-MzByJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:36:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 08:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:36:46 INFO - Running setup.py (path:/tmp/pip-XZ_p58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:36:46 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)) 08:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:36:46 INFO - Running setup.py (path:/tmp/pip-peJs8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:36:46 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)) 08:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:36:46 INFO - Running setup.py (path:/tmp/pip-ggm5ek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:36:46 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)) 08:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:36:46 INFO - Running setup.py (path:/tmp/pip-GDxLSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:36:46 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)) 08:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:46 INFO - Running setup.py (path:/tmp/pip-_yk4KD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:36:46 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)) 08:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:36:46 INFO - Running setup.py (path:/tmp/pip-Jz6VBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:36:46 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)) 08:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:36:46 INFO - Running setup.py (path:/tmp/pip-Jjx6hv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:36:46 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)) 08:36:46 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)) 08:36:46 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)) 08:36:46 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)) 08:36:46 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)) 08:36:46 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)) 08:36:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:36:48 INFO - Downloading blessings-1.6.tar.gz 08:36:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:36:48 INFO - Installing collected packages: blessings 08:36:48 INFO - Running setup.py install for blessings 08:36:48 INFO - Successfully installed blessings 08:36:48 INFO - Cleaning up... 08:36:48 INFO - Return code: 0 08:36:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:36:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:36:49 INFO - Reading from file tmpfile_stdout 08:36:49 INFO - Current package versions: 08:36:49 INFO - argparse == 1.2.1 08:36:49 INFO - blessings == 1.6 08:36:49 INFO - blobuploader == 1.2.4 08:36:49 INFO - docopt == 0.6.1 08:36:49 INFO - functools32 == 3.2.3-2 08:36:49 INFO - jsonschema == 2.5.1 08:36:49 INFO - manifestparser == 1.1 08:36:49 INFO - mozInstall == 1.12 08:36:49 INFO - mozcrash == 0.17 08:36:49 INFO - mozdebug == 0.1 08:36:49 INFO - mozdevice == 0.48 08:36:49 INFO - mozfile == 1.2 08:36:49 INFO - mozhttpd == 0.7 08:36:49 INFO - mozinfo == 0.9 08:36:49 INFO - mozleak == 0.1 08:36:49 INFO - mozlog == 3.3 08:36:49 INFO - moznetwork == 0.27 08:36:49 INFO - mozprocess == 0.23 08:36:49 INFO - mozprofile == 0.28 08:36:49 INFO - mozrunner == 6.12 08:36:49 INFO - mozscreenshot == 0.1 08:36:49 INFO - mozsystemmonitor == 0.3 08:36:49 INFO - moztest == 0.7 08:36:49 INFO - mozversion == 1.4 08:36:49 INFO - psutil == 3.1.1 08:36:49 INFO - requests == 1.2.3 08:36:49 INFO - wsgiref == 0.1.2 08:36:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:36:49 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')]} 08:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:49 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')]} 08:36:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:49 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 0x7f1cce613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188af60>, '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 0x188bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188c1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1473780638.400966-1998685341', '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 08:36:49 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 08:36:49 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 08:36:49 INFO - Using env: {'DISPLAY': ':0', 08:36:49 INFO - 'HOME': '/home/cltbld', 08:36:49 INFO - 'LANG': 'en_US.UTF-8', 08:36:49 INFO - 'LANGUAGE': 'en_US:en', 08:36:49 INFO - 'LOGNAME': 'cltbld', 08:36:49 INFO - 'MAIL': '/var/mail/cltbld', 08:36:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:49 INFO - 'MOZ_NO_REMOTE': '1', 08:36:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:49 INFO - 'NO_EM_RESTART': '1', 08:36:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:49 INFO - 'PWD': '/builds/slave/test', 08:36:49 INFO - 'SHELL': '/bin/bash', 08:36:49 INFO - 'SHLVL': '1', 08:36:49 INFO - 'TERM': 'linux', 08:36:49 INFO - 'TMOUT': '86400', 08:36:49 INFO - 'USER': 'cltbld', 08:36:49 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1473780638.400966-1998685341', 08:36:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:49 INFO - '_': '/tools/buildbot/bin/python'} 08:36:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:49 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)) 08:36:49 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)) 08:36:49 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)) 08:36:49 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)) 08:36:49 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)) 08:36:49 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)) 08:36:49 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)) 08:36:49 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)) 08:36:49 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)) 08:36:49 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)) 08:36:49 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)) 08:36:49 INFO - Cleaning up... 08:36:49 INFO - Return code: 0 08:36:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:36:49 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')]} 08:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:36:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:49 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')]} 08:36:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:36:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:36:49 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 0x7f1cce613f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x188dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188af60>, '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 0x188bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188c1d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1473780638.400966-1998685341', '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 08:36:49 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 08:36:49 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 08:36:49 INFO - Using env: {'DISPLAY': ':0', 08:36:49 INFO - 'HOME': '/home/cltbld', 08:36:49 INFO - 'LANG': 'en_US.UTF-8', 08:36:49 INFO - 'LANGUAGE': 'en_US:en', 08:36:49 INFO - 'LOGNAME': 'cltbld', 08:36:49 INFO - 'MAIL': '/var/mail/cltbld', 08:36:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:49 INFO - 'MOZ_NO_REMOTE': '1', 08:36:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:36:49 INFO - 'NO_EM_RESTART': '1', 08:36:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:36:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:49 INFO - 'PWD': '/builds/slave/test', 08:36:49 INFO - 'SHELL': '/bin/bash', 08:36:49 INFO - 'SHLVL': '1', 08:36:49 INFO - 'TERM': 'linux', 08:36:49 INFO - 'TMOUT': '86400', 08:36:49 INFO - 'USER': 'cltbld', 08:36:49 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1473780638.400966-1998685341', 08:36:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:49 INFO - '_': '/tools/buildbot/bin/python'} 08:36:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:36:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:36:49 INFO - Cleaning up... 08:36:49 INFO - Return code: 0 08:36:49 INFO - Running post-action listener: _resource_record_post_action 08:36:49 INFO - Running post-action listener: _start_resource_monitoring 08:36:49 INFO - Starting resource monitoring. 08:36:49 INFO - [mozharness: 2016-09-13 15:36:49.625320Z] Finished create-virtualenv step (success) 08:36:49 INFO - [mozharness: 2016-09-13 15:36:49.625773Z] Running install step. 08:36:49 INFO - Running pre-action listener: _resource_record_pre_action 08:36:49 INFO - Running main action method: install 08:36:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:36:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:36:49 INFO - Reading from file tmpfile_stdout 08:36:49 INFO - Detecting whether we're running mozinstall >=1.0... 08:36:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:36:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:36:49 INFO - Reading from file tmpfile_stdout 08:36:49 INFO - Output received: 08:36:49 INFO - Usage: mozinstall [options] installer 08:36:49 INFO - Options: 08:36:49 INFO - -h, --help show this help message and exit 08:36:49 INFO - -d DEST, --destination=DEST 08:36:49 INFO - Directory to install application into. [default: 08:36:49 INFO - "/builds/slave/test"] 08:36:49 INFO - --app=APP Application being installed. [default: firefox] 08:36:49 INFO - mkdir: /builds/slave/test/build/application 08:36:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:36:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:37:06 INFO - Reading from file tmpfile_stdout 08:37:06 INFO - Output received: 08:37:06 INFO - /builds/slave/test/build/application/firefox/firefox 08:37:06 INFO - Running post-action listener: _resource_record_post_action 08:37:06 INFO - [mozharness: 2016-09-13 15:37:06.004314Z] Finished install step (success) 08:37:06 INFO - [mozharness: 2016-09-13 15:37:06.004560Z] Running run-tests step. 08:37:06 INFO - Running pre-action listener: _resource_record_pre_action 08:37:06 INFO - Running main action method: run_tests 08:37:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:37:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:37:06 INFO - Python 2.7.3 08:37:06 INFO - Return code: 0 08:37:06 INFO - grabbing minidump binary from tooltool 08:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:06 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 0x188af60>, '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 0x188bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188c1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:37:06 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 08:37:06 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 08:37:06 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 08:37:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:37:06 INFO - Return code: 0 08:37:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:37:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:37:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:37:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:37:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:37:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eDB_si_OTW6T4BQTqjv_Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 08:37:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eDB_si_OTW6T4BQTqjv_Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 08:37:06 INFO - Using env: {'DISPLAY': ':0', 08:37:06 INFO - 'HOME': '/home/cltbld', 08:37:06 INFO - 'LANG': 'en_US.UTF-8', 08:37:06 INFO - 'LANGUAGE': 'en_US:en', 08:37:06 INFO - 'LOGNAME': 'cltbld', 08:37:06 INFO - 'MAIL': '/var/mail/cltbld', 08:37:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:37:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:06 INFO - 'MOZ_NO_REMOTE': '1', 08:37:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:37:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:37:06 INFO - 'NO_EM_RESTART': '1', 08:37:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:06 INFO - 'PWD': '/builds/slave/test', 08:37:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:37:06 INFO - 'SHELL': '/bin/bash', 08:37:06 INFO - 'SHLVL': '1', 08:37:06 INFO - 'TERM': 'linux', 08:37:06 INFO - 'TMOUT': '86400', 08:37:06 INFO - 'USER': 'cltbld', 08:37:06 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1473780638.400966-1998685341', 08:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:06 INFO - '_': '/tools/buildbot/bin/python'} 08:37:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eDB_si_OTW6T4BQTqjv_Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 08:37:06 INFO - mozversion application_buildid: 20160913071707 08:37:06 INFO - mozversion application_changeset: a569d019fd4a1e2a7be700555f9e81322e40e846 08:37:06 INFO - mozversion application_display_name: Nightly 08:37:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:37:06 INFO - mozversion application_name: Firefox 08:37:06 INFO - mozversion application_remotingname: firefox 08:37:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 08:37:06 INFO - mozversion application_vendor: Mozilla 08:37:06 INFO - mozversion application_version: 51.0a1 08:37:06 INFO - mozversion platform_buildid: 20160913071707 08:37:06 INFO - mozversion platform_changeset: a569d019fd4a1e2a7be700555f9e81322e40e846 08:37:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 08:37:06 INFO - mozversion platform_version: 51.0a1 08:37:06 INFO - using testdate: 1473781026 08:37:06 INFO - actual date: 1473781026 08:37:06 INFO - starting webserver on 'localhost:40366' 08:37:06 INFO - SUITE-START | Running 2 tests 08:37:06 INFO - TEST-START | dromaeo_css 08:37:06 INFO - operating with platform_type : linux_ 08:37:06 INFO - Initialising browser for dromaeo_css test... 08:37:06 INFO - TEST-INFO | started process 31786 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp25FTCZ/profile http://localhost:40366/getInfo.html) 08:37:10 INFO - PROCESS | 31786 | __metrics Screen width/height:1600/1200 08:37:10 INFO - PROCESS | 31786 | colorDepth:24 08:37:10 INFO - PROCESS | 31786 | Browser inner width/height: 1024/697 08:37:10 INFO - PROCESS | 31786 | __metrics 08:37:11 INFO - PROCESS | 31786 | 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" 08:37:11 INFO - PROCESS | 31786 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:37:11 INFO - PROCESS | 31786 | console.error: PushService: 08:37:11 INFO - PROCESS | 31786 | stateChangeProcessEnqueue: Error transitioning state 08:37:11 INFO - PROCESS | 31786 | UnknownError 08:37:12 INFO - TEST-INFO | 31786: exit 0 08:37:12 INFO - Browser initialized. 08:37:12 INFO - Running cycle 1/1 for dromaeo_css test... 08:37:12 INFO - TEST-INFO | started process 31868 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp25FTCZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:37:24 INFO - PROCESS | 31868 | RSS: Main: 175812608 08:37:24 INFO - PROCESS | 31868 | 08:38:16 INFO - PROCESS | 31868 | 1473781096266 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] 08:40:28 INFO - PROCESS | 31868 | Cycle 1(1): loaded http://localhost:40366/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40366/tests/dromaeo/cssquery-ext.html) 08:40:29 INFO - PROCESS | 31868 | RSS: Main: 305979392 08:40:29 INFO - PROCESS | 31868 | 08:43:32 INFO - PROCESS | 31868 | Cycle 1(1): loaded http://localhost:40366/tests/dromaeo/cssquery-ext.html (next: http://localhost:40366/tests/dromaeo/cssquery-jquery.html) 08:43:33 INFO - PROCESS | 31868 | RSS: Main: 269447168 08:43:33 INFO - PROCESS | 31868 | 08:46:35 INFO - PROCESS | 31868 | Cycle 1(1): loaded http://localhost:40366/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40366/tests/dromaeo/cssquery-mootools.html) 08:46:36 INFO - PROCESS | 31868 | RSS: Main: 219312128 08:46:36 INFO - PROCESS | 31868 | 08:49:38 INFO - PROCESS | 31868 | Cycle 1(1): loaded http://localhost:40366/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40366/tests/dromaeo/cssquery-prototype.html) 08:49:38 INFO - PROCESS | 31868 | RSS: Main: 255627264 08:49:38 INFO - PROCESS | 31868 | 08:52:42 INFO - PROCESS | 31868 | Cycle 1(1): loaded http://localhost:40366/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40366/tests/dromaeo/cssquery-yui.html) 08:52:42 INFO - PROCESS | 31868 | RSS: Main: 218738688 08:52:42 INFO - PROCESS | 31868 | 08:55:45 INFO - PROCESS | 31868 | Cycle 1(1): loaded http://localhost:40366/tests/dromaeo/cssquery-yui.html (next: http://localhost:40366/tests/dromaeo/cssquery-dojo.html) 08:55:46 INFO - PROCESS | 31868 | RSS: Main: 310427648 08:55:46 INFO - PROCESS | 31868 | 08:55:46 INFO - PROCESS | 31868 | __start_tp_report 08:55:46 INFO - PROCESS | 31868 | _x_x_mozilla_page_load 08:55:46 INFO - PROCESS | 31868 | _x_x_mozilla_page_load_details 08:55:46 INFO - PROCESS | 31868 | |i|pagename|runs| 08:55:46 INFO - PROCESS | 31868 | |0;dojo.html;2580.6258092576577;2602.4664943686535;2602.557565213914;2618.9738102618967;2647.0602935957736;4453.087117140986;4510.323451482271;4564.360989461478;4659.114768194045;4700.459447163582;4536.750478723677;4551.385562949001;4555.157295900261;4594.173048851206;4629.6064834489025;4202.348635961431;4230.682698797587;4246.065865509583;4273.978630106861;4325.848595299165;4288.228118938589;4335.371371151181;4337.240982828008;4342.717723347972;4381.364702118207;4161.292580261363;4192.161567686475;4283.507396649363;4327.026419055719;4333.349997500369;4182.079942412664;4219.662427005832;4239.215745087138;4249.87250382489;4274.636655884254;4214.473190851144;4220.936685949713;4271.188474189894;4280.978595107035;4303.677224208197;4539.671179499395;4553.476350219734;4570.885727856797;4579.061292435043;4639.884002899955;4799.7360145192;4816.44610869751;4870.09903167915;4884;4884.340614017097;4866.124097662419;4896.069746748142;4907;4952.405711314629;4964.429090654548;4572.268437050056;4579.816807327737;4583.610393116555;4588.197065513588;4638.1883170445035;4882.804687812519;4949.7030178189425;4995.975020124876;5001.049800537886;5055.671381360274;4733.384659994179;4735.455422626374;4763.809447622126;4778.092162489116;4781.856544303677;4808.374911261513;4819.807207711652;4878.0975519529;4887.266909963534;4956.925646115311;4690.179218636725;4822.71063736177;4836.661433699677;4901.975490122598;4903.33804936329;4711.7879695413785;4778.95221047792;4782.952170478251;4804.783784729696;4862.124817532878;4044.7775372354213;4059.167870586523;4064;4117.341225403921;4122.175564887035;3537.7169826413824;3604.9279014419567;3617.3127105849803;3632.9273414531563;3670.8164591770305;4228.090960443519;4249.660027197817;4296.441462609903;4301.462317210348;4348.934765978513;4899.338589290472;4904.779284932187;4923.630727695438;4946.183879659816;4974.950250497449;4271.850485233002;4286.678499112579;4303.763293018914;4311.2239796836875;4344.23975804233;4310.43964284641;4333.046729719456;4335.2196604610845;4346.804393802223;4354.521002689701;4595.494495605414;4622.699524530894;4627.120847039052;4665.6734028617675;4693.859184224479;4870.391201099863;4877.829275975324;4888.804447822189;4897.3878265216845;4947.77735001933;4473.418455600751;4517.028838799673;4613.19269127908;4614.630829533562;4617.145828021827;4855.854324370274;4856.562909338177;4869.391326084239;4896.143174944442;4911.607071434205;4918.286848407032;4919.065377578248;4928.852134435972;4938.678985865908;4960.355153829979;4638.6752927294765;4669.509701481295;4683;4798.928016079832;4833.202521583899;4681.133990211822;4701.5298470154075;4707.835225767219;4761.047790441995;4777.808887644455;4649.070185962889;4666.673332866667;4674.158651442637;4675.32207829856;4711.764411779329;4722.598579120813;4771.260454629538;4776.9761151194025;4781.019890922422;4845.927311090407;4676.041411510564;4739.099571081483;4740.502247263988;4752.025834703808;4755.120302744003 08:55:46 INFO - PROCESS | 31868 | |1;ext.html;557.66818742848;570.3697414357138;574.0327548081483;577.8757567123067;583.8423625621083;27566;38026.809865950665;39439.40840887385;39483;42784;39801;40114;40117.59882401175;40515;40536.391954120714;7183.353498185163;7481.513701609405;7626.694932202705;7627.389808815282;7627.817688258328;7139.286071392845;7359.043324367824;7363.521371110887;7363.9631801840915;9559.95220023899;9565;9928.205743540499;9934;9942.801143977116;9961.40231586107;9719.514024298827;9725.708228753148;9771.657991970282;9789.706308810675;9790.55942482583;9622.230221582327;9688.903110968871;9690.37012594179;9693.612255509772;9694.418334899929;37006.62993370059;37287;37290.81354593237;37300.44049339262;37350;2822.7177282271814;2823.2095013396283;2831.6460442444695;2881.899133530337;2896.898608548691;27372.726272737415;27550;27713;28114.437711245864;28351.43297134046;3379.548963250878;3467.063892748969;3537.398642230827;3553.8400771965325;3592.0660628236587;252417;253701;254126;254256.99999999814;254567;49572.75213623981;49782.253266201034;49898.25152622713;49906.750466248166;49907.25139122916;31709.682903171135;32517.67482325194;32773.50839737406;34286;34305.142371440415;13771.724565508634;13919.373628186755;13932.651683707989;13936.303184840717;13941.512047078506;10247.9487602563;10325.48372581368;10339.224558158168;10339.793204135874;10343;15170.544883653509;15466.9226653866;17025.31898724062;17063.48809535691;17688.292468301122;6398.392152745481;6547.541672082908;6730.528862979544;6778.491613129035;6835.658217089126;683.2416018219772;725.6879541797078;833.8749187621784;840.2269911681145;912.1653686876566;26855.328616784736;27346;27378.45243095127;27519.58720619192;27595;850.0649285785587;901.4951627088851;927.3091546797544;947.1475671895349;979.686500319905;14113.506027288995;14177.14937103777;14198.728203487393;14221.28893555318;14293.714125717428;381546.09226953686;385712;386863;387219;388149;48444;48487.75756121197;48578;48666.27000594994;48744.26883596749;1046.9738256543494;1064.2390690656218;1119.8544189255344;1165.5221359242669;1166.5275563396838;24142.189335800238;27922.72077279201;28062.719372806827;28953.919676868092;29258.561121583618;40118.799406002785;40672.98317542085;40730.592694073865;40731;40766.79616601898;292545;293801;294919;295136;295492;24233.151839685528;25302.367440814127;25383.492330152923;26344.209673709818;26420.735792642598;41014.58985410227;41265.58734412617;41735.79132104442;42248.78875605603;42679.3598096035;34864.65135348614;34944.65055349414;35294.64705353016;35467.82266088653;35836.462453063745;34850.30299393947;34903.650963491054;35120.297594047464;35140.64859351476;35184.472232916014;34785.47821782625;35311.29377412386;35409.82295088508;35428.29143417169;36260.27479450449;29744.810207591454;32166.19584510406;32427.351452970335;32693.346133076728;32902.50646240356;24936.37659058538;25061.749382505943;25213.369665758502;25222.84846304457;25613.615795762707 08:55:46 INFO - PROCESS | 31868 | |2;jquery.html;327.0760102709845;342.33022004115884;351.4675266970539;352.8165354015912;373.72904644133007;12024.879751202485;16101.436449724262;16230.594235144128;16994.405195818148;18131.909340453312;16967.57581060471;17072;17277.654446911056;17311.653766924686;17569.91215043926;4920.384951881015;4992.92510612342;5067.8479645610505;5099.974500127512;5100.107481190796;3609.097725568608;3793.7154713396467;4959.330490383788;5042.974785126069;5639.746211420475;5870.11948207768;5977.312609049972;5985.521158307325;5991.281046274453;5993.370696076914;5711.114777209518;5880.000399931979;5903.49820265278;5907.852303692399;5956.791512297071;5173.844784656466;5177.352830896138;5178.792848286064;5184.585233181337;5191.143461328877;20534.383968480968;20977.790222097738;21144.2599509018;21235.893820530797;21264.468388290417;1934.3229869545687;2358.9974260939034;2449.081594402099;2469.9506009879883;2543.249741326313;13297.53458628953;13336;13381.66545836352;13393.397297121654;14011.789823152661;1674.7236705943506;1721.5868191634042;1733.2633630707026;1760.1727188221516;1771.9557011074696;69587;69879.65060174717;71096.49166658318;76090.85863712104;77434;15608.921955390151;15893.920530397274;16250.431234906722;16395.344186232654;16645.167741613113;29123.854380728386;29309.85345073261;29313.706862931525;29350.11949641514;29487.705122948926;8328.750137495885;8553.529555874487;8564.61459234336;8602.78493037679;9009.459432434074;6776.898346524806;6863.10779598659;6999.965000175069;7016.438684905195;7043.823904402431;8320.750377488685;8424.620892059873;8530.914690853137;8550.273226775793;8600.311975041981;3324.7173990211104;3338.2322065924973;3392.692968781203;3401.7618766686587;3461.732565169818;733.5232099135604;853.3301358433599;899.0065977095346;924.0851556958563;944.4946953379908;16185.271662775203;16745.581360465843;16964.321427142775;17050;17852.732209016875;768.5196752029981;782.9138794732575;823.4606332851992;880.3705350674298;880.5245167609547;8911.2425443838;9575.760605984906;9625.32622716403;9696.903030969741;9891.653792117242;348895;353155;371213;372838;373499;74718;75666.62166689131;76864.61567692125;79087.60456197683;79629.60185199037;673.1787219592188;676.668432468097;685.6366125953252;686.1114856261154;687.0450074396692;14907.732842708492;15038.172900490577;15353.385864565293;15562.844371556139;15741.370345186064;35721.82139089288;36068.27863442664;36790.26419471649;36953.26093478169;37712.245755084194;49496.75251623719;49800;50349.496505035946;50494.49505504898;52399.21401178909;7010.824729381806;7400.851982960203;8822.691205807765;9044.547772611475;9141.085891410805;7185;7291.927080729125;7340.669669864762;7485.737999170003;7488.5506869588;6116.908246376397;6269;6562.34376562359;6669.533132680665;6928.930710692828;6677.332266773284;6924.757633482804;7034.788956331318;7072.858542829012;7244.985702001619;6587.901181482377;6786.898196526958;6833.826693356299;7023.192332881579;7172.964135179291;9460.763480913032;9481.819181588135;9685;9805.21558275322;10102.545385457819;5663.603547751618;7288.870225115115;8524.531150786766;8695.52174630376;8930.642774289216 08:55:46 INFO - PROCESS | 31868 | |3;mootools.html;1218.8842060004308;1317.822094017308;1363.7477066742651;1384.5292600515822;1690.7379356199785;6767.695453704583;7457;7757.922420775804;7769.883451748221;7962.522248665085;7821.296083352498;7889.5266284023;7901.525908445497;7906.2884340409355;7908.644111015004;2135.711678923345;2158.4495953531828;2159.4385459780415;2160.6326924422888;2164.9025793839237;2129.606022885763;2183.268605017321;2185.7704940981207;2188.7592364839857;2191.2002119226527;2104.389726979174;2140.9250676226334;2153.3217036633487;2162.664786958024;2165.6426689596196;2103.705481232621;2111.5882402931434;2112.6091673040537;2112.6619740841393;2114.154338264691;2010.7084472751515;2082.073477302601;2086.7182930304366;2092.843036772233;2093.047663313189;7751.8449631007625;7761.262680045386;7840.49036812611;7940.722074727357;7950.681972721084;4537.115262523809;4727.409073865767;4728.290756386536;4731.432228132611;4745.074710431467;2863.0981240909255;2967.421352836198;3008.2178633555213;3029.969700302991;3040.5135178371356;949.7625593601599;956.206348730552;974.4202199691173;976.4287891583432;979.6130528441225;10729.248952573324;10810.945945270301;10826.945865270702;10828;10841.241113122085;4001.5998400160333;4112.3420252759415;4169.437125988014;4278.187144442546;4328.350747387854;8457;8540.957295213608;8556.358273129415;8571.742847714579;8578.785530361665;4619.722816631013;4629.375034370384;4632.374629425052;4634.328022436795;4638.466576343763;3565.5008298838184;3746.3069332173636;3754.267917756066;4311.676624253194;4315;3404.6084700259294;3488.6162522122545;3568.072301201706;3591.06632275605;3599.3881040223223;1065.8294672852307;1066.2056767707952;1078.2937176149635;1078.6925726168004;1088.9727756805985;730.1639622632057;778.2489897249181;786.8937693411431;790.8177274973835;794.4200733464603;4723.338732577442;4868.634852386085;4891.364122664102;4932.950670493321;4948.925766113512;395.88717215593994;412.59359530862076;412.8286760994214;414.97925103744694;415.56158253043327;3150.2754366495833;3334.7832390895;3340.3319336132386;3361.9327613447595;3415.6072051713872;9371.531423428938;9476.384035037701;9732.2214222862;9836.06557377048;9919.950400248097;9738.513074346254;9743.561539730728;9748.61005559784;9761.609535618638;9771.21830253578;7400.370968467741;7406.333429991434;7414.814629634195;7461.70153193877;7473.476856619985;4893.7063776173545;4987.077390682735;5007.499250074963;5033.924491132562;5037.5214354636255;8654.437461564978;8681.609327580149;8890.911090889009;8906.376553641183;8946.597403117006;8970.820583588422;9069.863952040592;9111.772205694646;9157.221636161;9176.587053582738;6261.68691565429;6317.6209427434505;6325.240971083499;6327.683615819098;6328.778492752732;7371;7451.031365922396;7520;7532.359749421142;7560.243975602396;6614.768483103068;6641.535092543476;6675.23234828001;6692.130023096966;6706.161729783777;6596.30738772422;6642.867142657024;6662.800115996528;6671.332866713484;6695.497837662292;6060.848478788065;6061.060535616986;6106.847328816815;6108.75564977396;6132.08018797184;4385.671074669349;4456.3761073449095;4484.103179364205;4493.146302202571;4641.443026836801;4321.935170972375;4368.563143685606;4415.227335216388;4418.7127836690515;4591.104734576726 08:55:46 INFO - PROCESS | 31868 | |4;prototype.html;277.8944001279512;292.26203835315823;296.5803388205689;298.15175824778527;300.6947947832949;4774.976125119374;4790.425148982127;4806.543378379057;4816.518348165182;4843.176659967805;4505.639548836093;4614.953850461495;4616.630669546436;4633.582977532022;4777.832775852846;3584.946225806615;3705.240425712736;3716.5725941516803;3750.287445385368;3762.0970966967866;3752.1370084880496;3766.41620548814;3773.5471743390694;3787.16682329887;3803.50554427924;3648.434492653643;3738.8130593470355;3738.869139580115;3745.6441638044344;3747.2692824899154;3716.163863130801;3718.925621487555;3735.62643735627;3754.812259387047;3759.248150369937;3297.5383446317533;3299.15871452778;3312.933741325184;3322.1528510229978;3332.96667033329;4591.943852913815;4630.953690463086;4631.397918270603;4636.420447444069;4640.466346370177;4176.874693759192;4241.791089539466;4253.595908388729;4268.740721487169;4274.252005898955;4868.563773686771;4870.415550133971;4881.194602890519;4887.3890763654545;4905.362302900636;3605.2068544920076;3615.6079909234873;3616.3671357512594;3625.3111908737255;3629.6370362963494;4969.503049695001;5121.718305493197;5155.510226528474;5191.195364718475;5203.505666961632;3685.1339935115225;3689.94465083024;3707.1288247261873;3711.832967516468;3712.1647629283193;3759.642833930772;3777.7544459610035;3782.243551289698;3782.924341513154;3785;4256.169846965834;4273.166732487135;4274.1451709658195;4275.551067137906;4280.422143010716;4730.101280756645;4869.954619060003;4890.486498917634;4943.975280123648;4980.228064649985;1279.1365828066018;1284.4091717809724;1288.7035981724068;1295.4559085184246;1297.3448408553809;847.9067302596709;856.2678909532385;883.8674198870092;884.9601767920459;889.2930120554175;4308.763018034038;4320.891977700583;4349.26062569364;4423.668224883147;4482.686211965131;5073.315102461121;5100.132977393852;5100.285959965608;5103.209002604603;5106.15748401517;4341.9131617367475;4446.3108218226225;4448.243798554254;4451.354553589711;4482.7758612069265;2663.4007348346468;2696.44722831819;2699.379142797168;2731.8634068296506;2733.8633068346503;4857.1742803723455;4866.659333846596;4871.2206047032305;4900.656954013185;4924.3105965164905;5108.310378098983;5187.1989125871605;5234.398044224963;5247.134222853187;5290.259363689087;4855.247436647254;4857.077155340474;4887.313876712528;4900.705957642553;4905.166121759309;5106.438291787975;5147.562457191031;5150.175971844487;5159.948400516097;5174.97412512935;4744.525547445228;4938.728369939544;4971.477994810492;5006.799728010838;5016.297718319365;4807.735574543433;4813.350197723263;4823.324734537237;4824.962633033914;4827.637927155548;3656.1956369598647;3677.816109194583;3681.263747250614;3682.0978860179425;3698.2603479304785;4883.511648835088;5109.744512774272;5115.820946266863;5127.692338459704;5141.38303403594;4969.602431805519;4974.452810190804;4976.30331753562;4980.601551875769;4981.637394758596;4956.603471722182;4957.231629097496;4959.677620954626;4963.677360971526;4964.975175124101;4783.95216047835;4868.95131048685;4902.166631672553;4902.7058376497525;4911.877203069809;4722.504137065559;4871.780769865435;4906.509349065208;5000.924616284201;5005.77474013663;4886.853394398174;4893.7797799099835;4897.918384686565;4901.975490122527;4922.286268490977 08:55:46 INFO - PROCESS | 31868 | |5;yui.html;602.2177539766279;613.5459759777766;632.4971647540207;639.3670266436229;671.2482020137444;12754.808677869827;13770.655733606665;13803.51687690931;13804.79292810606;13808.792868106986;13190.802137967914;13690.315484225799;13932.651683707913;14428;14441.422343106264;736.5249414127884;761.5811303782925;766.5783818899611;767.3860911270989;767.57399643198;598.8263403612947;612.6660969771463;737.5021860244341;777.510168593788;780.2782426255719;786.8347646994138;796.2236819101358;797.9680812767511;798.7843282313772;799.6961154761183;787.4566549081115;788.03072221168;788.0346575445092;788.2708494642433;791.0902462168494;462.235001073221;469.3663554201834;560.330405165827;583.0612713531211;583.3670467542721;12433.316167610777;13067.803982940264;13105.2136871788;13106.60680179596;13107.606771796862;12195.207311524811;12430.378481076;12576.056795740356;12621.305828179446;12726.363681815872;11745.882541174564;11918.582849600309;12101.213421127686;12212.511499540007;12383.133180677356;3921.1961547882615;3936.212757448493;3973.602639736032;4027;4071;64493.35506644921;65320.3467965319;65835.3416465834;66611.66694166498;68839;10051.447170405698;10441.582336706599;10501.159907207406;10539.84190237147;10664.306820056672;18024.639507209784;18069.367572134914;18080.457586272434;18136.63726725458;18273.17770700322;6189.97756170531;6343.788910771286;6487.643179625166;6571.145751052428;6631.27056023837;3551.5027896094566;3567.928641427157;3572.8570857165423;3573.7498375114014;3711.740178187555;2757.26932362924;2843.1754791110347;2853.9143825685264;2864.6992065832787;2865.885364585435;496.6862648295239;500.06487867687656;507.50011238929625;515.8194631878812;527.385595780911;416.3837520469722;435.9607635312837;444.44444444444446;447.05447977527297;518.6317714422727;6902.689378977958;7179.282071792779;7319.133620926629;7406.518576292524;7543.094828620491;447.98432054877924;457.17708125374196;482.55363788495504;506.1471420656206;521.3743507790666;3378.5945686517775;3445.8277086145595;3567.7324200685052;3664.2671465706967;3735.495708079429;102032.48983755182;102438.122091076;102462.48768756108;104196;105064;51434.228486572734;89675.55162224147;90089.54955225313;90500.54749726209;91743.56872194396;76153;78064.60967695239;78819.66491843003;80297.99999999884;81777.18222817934;6699.464042876656;6821.249662537018;6858.245592984668;6937.549059311129;7116.715331386687;48276.5172348272;48795.75602121967;49031.509684902696;49058.848820873296;51111;39721;40781.59218407778;41312.38031429471;69930.30069699441;70843;10199.602677222261;10407.895921040692;10520.263581549218;10736.141108711441;10860.294080884718;10718.464076795974;10833.241673082808;11032.779344412906;11489.82765258505;11936.940315298369;9616.374935629161;9624.470654114091;9673.613055477983;10101.242406819665;10738;9238.187557477586;9317.906820931705;10061.496925153859;10156.187504999434;10835.891641083803;9860.901390985999;9954.502274886372;10659.840102398626;10670.253082284165;10673.57305707763;8722.52026138543;9010.234130099016;9121.315901307562;9313.953430232805;9606;7746.264104910025;8119.30985866208;8416.326693864354;8555.786105347415;8607.569621519024 08:55:46 INFO - PROCESS | 31868 | __end_tp_report 08:55:46 INFO - PROCESS | 31868 | __start_cc_report 08:55:46 INFO - PROCESS | 31868 | _x_x_mozilla_cycle_collect,1086 08:55:46 INFO - PROCESS | 31868 | __end_cc_report 08:55:46 INFO - PROCESS | 31868 | __startTimestamp1473782146054__endTimestamp 08:55:46 INFO - PROCESS | 31868 | 08:55:46 INFO - PROCESS | 31868 | ------- Summary: start ------- 08:55:46 INFO - PROCESS | 31868 | Number of tests: 6 08:55:46 INFO - PROCESS | 31868 | 08:55:46 INFO - PROCESS | 31868 | [#0] dojo.html Cycles:165 Average:4526.32 Median:4649.07 stddev:457.51 (9.8%) stddev-sans-first:432.71 08:55:46 INFO - PROCESS | 31868 | Values: 2580.6 2602.5 2602.6 2619.0 2647.1 4453.1 4510.3 4564.4 4659.1 4700.5 4536.8 4551.4 4555.2 4594.2 4629.6 4202.3 4230.7 4246.1 4274.0 4325.8 4288.2 4335.4 4337.2 4342.7 4381.4 4161.3 4192.2 4283.5 4327.0 4333.3 4182.1 4219.7 4239.2 4249.9 4274.6 4214.5 4220.9 4271.2 4281.0 4303.7 4539.7 4553.5 4570.9 4579.1 4639.9 4799.7 4816.4 4870.1 4884.0 4884.3 4866.1 4896.1 4907.0 4952.4 4964.4 4572.3 4579.8 4583.6 4588.2 4638.2 4882.8 4949.7 4996.0 5001.0 5055.7 4733.4 4735.5 4763.8 4778.1 4781.9 4808.4 4819.8 4878.1 4887.3 4956.9 4690.2 4822.7 4836.7 4902.0 4903.3 4711.8 4779.0 4783.0 4804.8 4862.1 4044.8 4059.2 4064.0 4117.3 4122.2 3537.7 3604.9 3617.3 3632.9 3670.8 4228.1 4249.7 4296.4 4301.5 4348.9 4899.3 4904.8 4923.6 4946.2 4975.0 4271.9 4286.7 4303.8 4311.2 4344.2 4310.4 4333.0 4335.2 4346.8 4354.5 4595.5 4622.7 4627.1 4665.7 4693.9 4870.4 4877.8 4888.8 4897.4 4947.8 4473.4 4517.0 4613.2 4614.6 4617.1 4855.9 4856.6 4869.4 4896.1 4911.6 4918.3 4919.1 4928.9 4938.7 4960.4 4638.7 4669.5 4683.0 4798.9 4833.2 4681.1 4701.5 4707.8 4761.0 4777.8 4649.1 4666.7 4674.2 4675.3 4711.8 4722.6 4771.3 4777.0 4781.0 4845.9 4676.0 4739.1 4740.5 4752.0 4755.1 08:55:46 INFO - PROCESS | 31868 | 08:55:46 INFO - PROCESS | 31868 | [#1] ext.html Cycles:180 Average:45837.16 Median:35448.06 stddev:83182.93 (234.7%) stddev-sans-first:83346.81 08:55:46 INFO - PROCESS | 31868 | Values: 557.7 570.4 574.0 577.9 583.8 27566.0 38026.8 39439.4 39483.0 42784.0 39801.0 40114.0 40117.6 40515.0 40536.4 7183.4 7481.5 7626.7 7627.4 7627.8 7139.3 7359.0 7363.5 7364.0 9560.0 9565.0 9928.2 9934.0 9942.8 9961.4 9719.5 9725.7 9771.7 9789.7 9790.6 9622.2 9688.9 9690.4 9693.6 9694.4 37006.6 37287.0 37290.8 37300.4 37350.0 2822.7 2823.2 2831.6 2881.9 2896.9 27372.7 27550.0 27713.0 28114.4 28351.4 3379.5 3467.1 3537.4 3553.8 3592.1 252417.0 253701.0 254126.0 254257.0 254567.0 49572.8 49782.3 49898.3 49906.8 49907.3 31709.7 32517.7 32773.5 34286.0 34305.1 13771.7 13919.4 13932.7 13936.3 13941.5 10247.9 10325.5 10339.2 10339.8 10343.0 15170.5 15466.9 17025.3 17063.5 17688.3 6398.4 6547.5 6730.5 6778.5 6835.7 683.2 725.7 833.9 840.2 912.2 26855.3 27346.0 27378.5 27519.6 27595.0 850.1 901.5 927.3 947.1 979.7 14113.5 14177.1 14198.7 14221.3 14293.7 381546.1 385712.0 386863.0 387219.0 388149.0 48444.0 48487.8 48578.0 48666.3 48744.3 1047.0 1064.2 1119.9 1165.5 1166.5 24142.2 27922.7 28062.7 28953.9 29258.6 40118.8 40673.0 40730.6 40731.0 40766.8 292545.0 293801.0 294919.0 295136.0 295492.0 24233.2 25302.4 25383.5 26344.2 26420.7 41014.6 41265.6 41735.8 42248.8 42679.4 34864.7 34944.7 35294.6 35467.8 35836.5 34850.3 34903.7 35120.3 35140.6 35184.5 34785.5 35311.3 35409.8 35428.3 36260.3 29744.8 32166.2 32427.4 32693.3 32902.5 24936.4 25061.7 25213.4 25222.8 25613.6 08:55:46 INFO - PROCESS | 31868 | 08:55:46 INFO - PROCESS | 31868 | [#2] jquery.html Cycles:180 Average:24180.08 Median:5651.67 stddev:60345.14 (1067.7%) stddev-sans-first:60487.84 08:55:46 INFO - PROCESS | 31868 | Values: 327.1 342.3 351.5 352.8 373.7 12024.9 16101.4 16230.6 16994.4 18131.9 16967.6 17072.0 17277.7 17311.7 17569.9 4920.4 4992.9 5067.8 5100.0 5100.1 3609.1 3793.7 4959.3 5043.0 5639.7 5870.1 5977.3 5985.5 5991.3 5993.4 5711.1 5880.0 5903.5 5907.9 5956.8 5173.8 5177.4 5178.8 5184.6 5191.1 20534.4 20977.8 21144.3 21235.9 21264.5 1934.3 2359.0 2449.1 2470.0 2543.2 13297.5 13336.0 13381.7 13393.4 14011.8 1674.7 1721.6 1733.3 1760.2 1772.0 69587.0 69879.7 71096.5 76090.9 77434.0 15608.9 15893.9 16250.4 16395.3 16645.2 29123.9 29309.9 29313.7 29350.1 29487.7 8328.8 8553.5 8564.6 8602.8 9009.5 6776.9 6863.1 7000.0 7016.4 7043.8 8320.8 8424.6 8530.9 8550.3 8600.3 3324.7 3338.2 3392.7 3401.8 3461.7 733.5 853.3 899.0 924.1 944.5 16185.3 16745.6 16964.3 17050.0 17852.7 768.5 782.9 823.5 880.4 880.5 8911.2 9575.8 9625.3 9696.9 9891.7 348895.0 353155.0 371213.0 372838.0 373499.0 74718.0 75666.6 76864.6 79087.6 79629.6 673.2 676.7 685.6 686.1 687.0 14907.7 15038.2 15353.4 15562.8 15741.4 35721.8 36068.3 36790.3 36953.3 37712.2 49496.8 49800.0 50349.5 50494.5 52399.2 7010.8 7400.9 8822.7 9044.5 9141.1 7185.0 7291.9 7340.7 7485.7 7488.6 6116.9 6269.0 6562.3 6669.5 6928.9 6677.3 6924.8 7034.8 7072.9 7245.0 6587.9 6786.9 6833.8 7023.2 7173.0 9460.8 9481.8 9685.0 9805.2 10102.5 5663.6 7288.9 8524.5 8695.5 8930.6 08:55:46 INFO - PROCESS | 31868 | 08:55:46 INFO - PROCESS | 31868 | [#3] mootools.html Cycles:180 Average:5053.96 Median:4806.85 stddev:2905.15 (60.4%) stddev-sans-first:2899.01 08:55:46 INFO - PROCESS | 31868 | Values: 1218.9 1317.8 1363.7 1384.5 1690.7 6767.7 7457.0 7757.9 7769.9 7962.5 7821.3 7889.5 7901.5 7906.3 7908.6 2135.7 2158.4 2159.4 2160.6 2164.9 2129.6 2183.3 2185.8 2188.8 2191.2 2104.4 2140.9 2153.3 2162.7 2165.6 2103.7 2111.6 2112.6 2112.7 2114.2 2010.7 2082.1 2086.7 2092.8 2093.0 7751.8 7761.3 7840.5 7940.7 7950.7 4537.1 4727.4 4728.3 4731.4 4745.1 2863.1 2967.4 3008.2 3030.0 3040.5 949.8 956.2 974.4 976.4 979.6 10729.2 10810.9 10826.9 10828.0 10841.2 4001.6 4112.3 4169.4 4278.2 4328.4 8457.0 8541.0 8556.4 8571.7 8578.8 4619.7 4629.4 4632.4 4634.3 4638.5 3565.5 3746.3 3754.3 4311.7 4315.0 3404.6 3488.6 3568.1 3591.1 3599.4 1065.8 1066.2 1078.3 1078.7 1089.0 730.2 778.2 786.9 790.8 794.4 4723.3 4868.6 4891.4 4933.0 4948.9 395.9 412.6 412.8 415.0 415.6 3150.3 3334.8 3340.3 3361.9 3415.6 9371.5 9476.4 9732.2 9836.1 9920.0 9738.5 9743.6 9748.6 9761.6 9771.2 7400.4 7406.3 7414.8 7461.7 7473.5 4893.7 4987.1 5007.5 5033.9 5037.5 8654.4 8681.6 8890.9 8906.4 8946.6 8970.8 9069.9 9111.8 9157.2 9176.6 6261.7 6317.6 6325.2 6327.7 6328.8 7371.0 7451.0 7520.0 7532.4 7560.2 6614.8 6641.5 6675.2 6692.1 6706.2 6596.3 6642.9 6662.8 6671.3 6695.5 6060.8 6061.1 6106.8 6108.8 6132.1 4385.7 4456.4 4484.1 4493.1 4641.4 4321.9 4368.6 4415.2 4418.7 4591.1 08:55:46 INFO - PROCESS | 31868 | 08:55:46 INFO - PROCESS | 31868 | [#4] prototype.html Cycles:180 Average:4142.74 Median:4737.31 stddev:1185.18 (25.0%) stddev-sans-first:1152.46 08:55:46 INFO - PROCESS | 31868 | Values: 277.9 292.3 296.6 298.2 300.7 4775.0 4790.4 4806.5 4816.5 4843.2 4505.6 4615.0 4616.6 4633.6 4777.8 3584.9 3705.2 3716.6 3750.3 3762.1 3752.1 3766.4 3773.5 3787.2 3803.5 3648.4 3738.8 3738.9 3745.6 3747.3 3716.2 3718.9 3735.6 3754.8 3759.2 3297.5 3299.2 3312.9 3322.2 3333.0 4591.9 4631.0 4631.4 4636.4 4640.5 4176.9 4241.8 4253.6 4268.7 4274.3 4868.6 4870.4 4881.2 4887.4 4905.4 3605.2 3615.6 3616.4 3625.3 3629.6 4969.5 5121.7 5155.5 5191.2 5203.5 3685.1 3689.9 3707.1 3711.8 3712.2 3759.6 3777.8 3782.2 3782.9 3785.0 4256.2 4273.2 4274.1 4275.6 4280.4 4730.1 4870.0 4890.5 4944.0 4980.2 1279.1 1284.4 1288.7 1295.5 1297.3 847.9 856.3 883.9 885.0 889.3 4308.8 4320.9 4349.3 4423.7 4482.7 5073.3 5100.1 5100.3 5103.2 5106.2 4341.9 4446.3 4448.2 4451.4 4482.8 2663.4 2696.4 2699.4 2731.9 2733.9 4857.2 4866.7 4871.2 4900.7 4924.3 5108.3 5187.2 5234.4 5247.1 5290.3 4855.2 4857.1 4887.3 4900.7 4905.2 5106.4 5147.6 5150.2 5159.9 5175.0 4744.5 4938.7 4971.5 5006.8 5016.3 4807.7 4813.4 4823.3 4825.0 4827.6 3656.2 3677.8 3681.3 3682.1 3698.3 4883.5 5109.7 5115.8 5127.7 5141.4 4969.6 4974.5 4976.3 4980.6 4981.6 4956.6 4957.2 4959.7 4963.7 4965.0 4784.0 4869.0 4902.2 4902.7 4911.9 4722.5 4871.8 4906.5 5000.9 5005.8 4886.9 4893.8 4897.9 4902.0 4922.3 08:55:46 INFO - PROCESS | 31868 | 08:55:46 INFO - PROCESS | 31868 | [#5] yui.html Cycles:180 Average:17673.06 Median:48536.14 stddev:26271.43 (54.1%) stddev-sans-first:26313.86 08:55:46 INFO - PROCESS | 31868 | Values: 602.2 613.5 632.5 639.4 671.2 12754.8 13770.7 13803.5 13804.8 13808.8 13190.8 13690.3 13932.7 14428.0 14441.4 736.5 761.6 766.6 767.4 767.6 598.8 612.7 737.5 777.5 780.3 786.8 796.2 798.0 798.8 799.7 787.5 788.0 788.0 788.3 791.1 462.2 469.4 560.3 583.1 583.4 12433.3 13067.8 13105.2 13106.6 13107.6 12195.2 12430.4 12576.1 12621.3 12726.4 11745.9 11918.6 12101.2 12212.5 12383.1 3921.2 3936.2 3973.6 4027.0 4071.0 64493.4 65320.3 65835.3 66611.7 68839.0 10051.4 10441.6 10501.2 10539.8 10664.3 18024.6 18069.4 18080.5 18136.6 18273.2 6190.0 6343.8 6487.6 6571.1 6631.3 3551.5 3567.9 3572.9 3573.7 3711.7 2757.3 2843.2 2853.9 2864.7 2865.9 496.7 500.1 507.5 515.8 527.4 416.4 436.0 444.4 447.1 518.6 6902.7 7179.3 7319.1 7406.5 7543.1 448.0 457.2 482.6 506.1 521.4 3378.6 3445.8 3567.7 3664.3 3735.5 102032.5 102438.1 102462.5 104196.0 105064.0 51434.2 89675.6 90089.5 90500.5 91743.6 76153.0 78064.6 78819.7 80298.0 81777.2 6699.5 6821.2 6858.2 6937.5 7116.7 48276.5 48795.8 49031.5 49058.8 51111.0 39721.0 40781.6 41312.4 69930.3 70843.0 10199.6 10407.9 10520.3 10736.1 10860.3 10718.5 10833.2 11032.8 11489.8 11936.9 9616.4 9624.5 9673.6 10101.2 10738.0 9238.2 9317.9 10061.5 10156.2 10835.9 9860.9 9954.5 10659.8 10670.3 10673.6 8722.5 9010.2 9121.3 9314.0 9606.0 7746.3 8119.3 8416.3 8555.8 8607.6 08:55:46 INFO - PROCESS | 31868 | -------- Summary: end -------- 08:55:46 INFO - PROCESS | 31868 | 08:55:47 INFO - TEST-INFO | 31868: exit 0 08:55:47 INFO - TEST-OK | dromaeo_css | took 1120766ms 08:55:47 INFO - TEST-START | kraken 08:55:47 INFO - operating with platform_type : linux_ 08:55:47 INFO - Initialising browser for kraken test... 08:55:47 INFO - TEST-INFO | started process 32173 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRlFukG/profile http://localhost:40366/getInfo.html) 08:55:51 INFO - PROCESS | 32173 | __metrics Screen width/height:1600/1200 08:55:51 INFO - PROCESS | 32173 | colorDepth:24 08:55:51 INFO - PROCESS | 32173 | Browser inner width/height: 1024/697 08:55:51 INFO - PROCESS | 32173 | __metrics 08:55:51 INFO - PROCESS | 32173 | 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" 08:55:51 INFO - PROCESS | 32173 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:55:52 INFO - PROCESS | 32173 | console.error: PushService: 08:55:52 INFO - PROCESS | 32173 | stateChangeProcessEnqueue: Error transitioning state 08:55:52 INFO - PROCESS | 32173 | UnknownError 08:55:52 INFO - TEST-INFO | 32173: exit 0 08:55:52 INFO - Browser initialized. 08:55:52 INFO - Running cycle 1/1 for kraken test... 08:55:52 INFO - TEST-INFO | started process 32252 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRlFukG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:56:05 INFO - PROCESS | 32252 | RSS: Main: 175484928 08:56:05 INFO - PROCESS | 32252 | 08:56:07 INFO - PROCESS | 32252 | Cycle 1(1): loaded http://localhost:40366/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40366/tests/kraken/driver.html?testName=audio-beat-detection) 08:56:08 INFO - PROCESS | 32252 | RSS: Main: 233574400 08:56:08 INFO - PROCESS | 32252 | 08:56:11 INFO - PROCESS | 32252 | Cycle 1(1): loaded http://localhost:40366/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40366/tests/kraken/driver.html?testName=audio-dft) 08:56:12 INFO - PROCESS | 32252 | RSS: Main: 218124288 08:56:12 INFO - PROCESS | 32252 | 08:56:15 INFO - PROCESS | 32252 | Cycle 1(1): loaded http://localhost:40366/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40366/tests/kraken/driver.html?testName=audio-fft) 08:56:16 INFO - PROCESS | 32252 | RSS: Main: 301166592 08:56:16 INFO - PROCESS | 32252 | 08:56:18 INFO - PROCESS | 32252 | Cycle 1(1): loaded http://localhost:40366/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40366/tests/kraken/driver.html?testName=audio-oscillator) 08:56:19 INFO - PROCESS | 32252 | RSS: Main: 210432000 08:56:19 INFO - PROCESS | 32252 | 08:56:21 INFO - PROCESS | 32252 | Cycle 1(1): loaded http://localhost:40366/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40366/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:56:21 INFO - PROCESS | 32252 | RSS: Main: 214286336 08:56:21 INFO - PROCESS | 32252 | 08:56:25 INFO - PROCESS | 32252 | Cycle 1(1): loaded http://localhost:40366/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40366/tests/kraken/driver.html?testName=imaging-darkroom) 08:56:25 INFO - PROCESS | 32252 | RSS: Main: 250556416 08:56:25 INFO - PROCESS | 32252 | 08:56:29 INFO - PROCESS | 32252 | Cycle 1(1): loaded http://localhost:40366/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40366/tests/kraken/driver.html?testName=imaging-desaturate) 08:56:29 INFO - PROCESS | 32252 | RSS: Main: 244436992 08:56:29 INFO - PROCESS | 32252 | 08:56:32 INFO - PROCESS | 32252 | Cycle 1(1): loaded http://localhost:40366/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40366/tests/kraken/driver.html?testName=json-parse-financial) 08:56:33 INFO - PROCESS | 32252 | RSS: Main: 247529472 08:56:33 INFO - PROCESS | 32252 | 08:56:35 INFO - PROCESS | 32252 | Cycle 1(1): loaded http://localhost:40366/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40366/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:56:35 INFO - PROCESS | 32252 | RSS: Main: 211169280 08:56:35 INFO - PROCESS | 32252 | 08:56:37 INFO - PROCESS | 32252 | Cycle 1(1): loaded http://localhost:40366/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40366/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:56:38 INFO - PROCESS | 32252 | RSS: Main: 218460160 08:56:38 INFO - PROCESS | 32252 | 08:56:40 INFO - PROCESS | 32252 | Cycle 1(1): loaded http://localhost:40366/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40366/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:56:41 INFO - PROCESS | 32252 | RSS: Main: 221396992 08:56:41 INFO - PROCESS | 32252 | 08:56:43 INFO - PROCESS | 32252 | Cycle 1(1): loaded http://localhost:40366/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40366/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:56:44 INFO - PROCESS | 32252 | RSS: Main: 223985664 08:56:44 INFO - PROCESS | 32252 | 08:56:47 INFO - PROCESS | 32252 | Cycle 1(1): loaded http://localhost:40366/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40366/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:56:48 INFO - PROCESS | 32252 | RSS: Main: 221921280 08:56:48 INFO - PROCESS | 32252 | 08:56:49 INFO - PROCESS | 32252 | Cycle 1(1): loaded http://localhost:40366/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40366/tests/kraken/driver.html?testName=ai-astar) 08:56:50 INFO - PROCESS | 32252 | RSS: Main: 272789504 08:56:50 INFO - PROCESS | 32252 | 08:56:50 INFO - PROCESS | 32252 | __start_tp_report 08:56:50 INFO - PROCESS | 32252 | _x_x_mozilla_page_load 08:56:50 INFO - PROCESS | 32252 | _x_x_mozilla_page_load_details 08:56:50 INFO - PROCESS | 32252 | |i|pagename|runs| 08:56:50 INFO - PROCESS | 32252 | |0;ai-astar;113;114;116;115;114;114;113;114;114;113 08:56:50 INFO - PROCESS | 32252 | |1;audio-beat-detection;159;123;124;166;140;125;125;135;157;130 08:56:50 INFO - PROCESS | 32252 | |2;audio-dft;161;161;162;162;162;162;163;162;160;161 08:56:50 INFO - PROCESS | 32252 | |3;audio-fft;76;77;76;110;79;78;78;77;99;77 08:56:50 INFO - PROCESS | 32252 | |4;audio-oscillator;85;84;114;84;84;85;108;84;84;114 08:56:50 INFO - PROCESS | 32252 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;116;118;117 08:56:50 INFO - PROCESS | 32252 | |6;imaging-darkroom;149;148;147;146;147;146;147;147;147;146 08:56:50 INFO - PROCESS | 32252 | |7;imaging-desaturate;95;94;95;95;95;96;94;95;95;96 08:56:50 INFO - PROCESS | 32252 | |8;json-parse-financial;65;63;64;62;63;64;64;64;65;64 08:56:50 INFO - PROCESS | 32252 | |9;json-stringify-tinderbox;65;66;65;66;65;66;66;65;66;66 08:56:50 INFO - PROCESS | 32252 | |10;stanford-crypto-aes;91;85;83;82;83;82;82;82;82;90 08:56:50 INFO - PROCESS | 32252 | |11;stanford-crypto-ccm;133;130;131;135;130;136;131;140;179;148 08:56:50 INFO - PROCESS | 32252 | |12;stanford-crypto-pbkdf2;176;176;175;172;173;174;174;174;175;182 08:56:50 INFO - PROCESS | 32252 | |13;stanford-crypto-sha256-iterative;69;69;68;69;69;67;69;69;67;69 08:56:50 INFO - PROCESS | 32252 | __end_tp_report 08:56:50 INFO - PROCESS | 32252 | __start_cc_report 08:56:50 INFO - PROCESS | 32252 | _x_x_mozilla_cycle_collect,1979 08:56:50 INFO - PROCESS | 32252 | __end_cc_report 08:56:50 INFO - PROCESS | 32252 | __startTimestamp1473782210145__endTimestamp 08:56:50 INFO - PROCESS | 32252 | 08:56:50 INFO - PROCESS | 32252 | ------- Summary: start ------- 08:56:50 INFO - PROCESS | 32252 | Number of tests: 14 08:56:50 INFO - PROCESS | 32252 | 08:56:50 INFO - PROCESS | 32252 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:0.94 (0.8%) stddev-sans-first:0.93 08:56:50 INFO - PROCESS | 32252 | Values: 113.0 114.0 116.0 115.0 114.0 114.0 113.0 114.0 114.0 113.0 08:56:50 INFO - PROCESS | 32252 | 08:56:50 INFO - PROCESS | 32252 | [#1] audio-beat-detection Cycles:10 Average:138.40 Median:137.50 stddev:16.40 (11.9%) stddev-sans-first:15.61 08:56:50 INFO - PROCESS | 32252 | Values: 159.0 123.0 124.0 166.0 140.0 125.0 125.0 135.0 157.0 130.0 08:56:50 INFO - PROCESS | 32252 | 08:56:50 INFO - PROCESS | 32252 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.84 (0.5%) stddev-sans-first:0.87 08:56:50 INFO - PROCESS | 32252 | Values: 161.0 161.0 162.0 162.0 162.0 162.0 163.0 162.0 160.0 161.0 08:56:50 INFO - PROCESS | 32252 | 08:56:50 INFO - PROCESS | 32252 | [#3] audio-fft Cycles:10 Average:82.70 Median:77.50 stddev:11.81 (15.2%) stddev-sans-first:12.28 08:56:50 INFO - PROCESS | 32252 | Values: 76.0 77.0 76.0 110.0 79.0 78.0 78.0 77.0 99.0 77.0 08:56:50 INFO - PROCESS | 32252 | 08:56:50 INFO - PROCESS | 32252 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:84.00 stddev:13.49 (16.1%) stddev-sans-first:14.03 08:56:50 INFO - PROCESS | 32252 | Values: 85.0 84.0 114.0 84.0 84.0 85.0 108.0 84.0 84.0 114.0 08:56:50 INFO - PROCESS | 32252 | 08:56:50 INFO - PROCESS | 32252 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 08:56:50 INFO - PROCESS | 32252 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 118.0 117.0 08:56:50 INFO - PROCESS | 32252 | 08:56:50 INFO - PROCESS | 32252 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.94 (0.6%) stddev-sans-first:0.67 08:56:50 INFO - PROCESS | 32252 | Values: 149.0 148.0 147.0 146.0 147.0 146.0 147.0 147.0 147.0 146.0 08:56:50 INFO - PROCESS | 32252 | 08:56:50 INFO - PROCESS | 32252 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 08:56:50 INFO - PROCESS | 32252 | Values: 95.0 94.0 95.0 95.0 95.0 96.0 94.0 95.0 95.0 96.0 08:56:50 INFO - PROCESS | 32252 | 08:56:50 INFO - PROCESS | 32252 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:0.92 (1.4%) stddev-sans-first:0.87 08:56:50 INFO - PROCESS | 32252 | Values: 65.0 63.0 64.0 62.0 63.0 64.0 64.0 64.0 65.0 64.0 08:56:50 INFO - PROCESS | 32252 | 08:56:50 INFO - PROCESS | 32252 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 08:56:50 INFO - PROCESS | 32252 | Values: 65.0 66.0 65.0 66.0 65.0 66.0 66.0 65.0 66.0 66.0 08:56:50 INFO - PROCESS | 32252 | 08:56:50 INFO - PROCESS | 32252 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:83.00 stddev:3.46 (4.2%) stddev-sans-first:2.65 08:56:50 INFO - PROCESS | 32252 | Values: 91.0 85.0 83.0 82.0 83.0 82.0 82.0 82.0 82.0 90.0 08:56:50 INFO - PROCESS | 32252 | 08:56:50 INFO - PROCESS | 32252 | [#11] stanford-crypto-ccm Cycles:10 Average:139.30 Median:135.50 stddev:15.03 (11.1%) stddev-sans-first:15.76 08:56:50 INFO - PROCESS | 32252 | Values: 133.0 130.0 131.0 135.0 130.0 136.0 131.0 140.0 179.0 148.0 08:56:50 INFO - PROCESS | 32252 | 08:56:50 INFO - PROCESS | 32252 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.10 Median:175.00 stddev:2.73 (1.6%) stddev-sans-first:2.87 08:56:50 INFO - PROCESS | 32252 | Values: 176.0 176.0 175.0 172.0 173.0 174.0 174.0 174.0 175.0 182.0 08:56:50 INFO - PROCESS | 32252 | 08:56:50 INFO - PROCESS | 32252 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 08:56:50 INFO - PROCESS | 32252 | Values: 69.0 69.0 68.0 69.0 69.0 67.0 69.0 69.0 67.0 69.0 08:56:50 INFO - PROCESS | 32252 | -------- Summary: end -------- 08:56:50 INFO - PROCESS | 32252 | 08:56:51 INFO - TEST-INFO | 32252: exit 0 08:56:51 INFO - TEST-OK | kraken | took 64404ms 08:56:51 INFO - SUITE-END | took 1185s 08:56:51 INFO - Completed test suite (00:19:45) 08:56:51 INFO - javascript benchmark 08:56:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2580.6258092576577, 2602.4664943686535, 2602.557565213914, 2618.9738102618967, 2647.0602935957736, 4453.087117140986, 4510.323451482271, 4564.360989461478, 4659.114768194045, 4700.459447163582, 4536.750478723677, 4551.385562949001, 4555.157295900261, 4594.173048851206, 4629.6064834489025, 4202.348635961431, 4230.682698797587, 4246.065865509583, 4273.978630106861, 4325.848595299165, 4288.228118938589, 4335.371371151181, 4337.240982828008, 4342.717723347972, 4381.364702118207, 4161.292580261363, 4192.161567686475, 4283.507396649363, 4327.026419055719, 4333.349997500369, 4182.079942412664, 4219.662427005832, 4239.215745087138, 4249.87250382489, 4274.636655884254, 4214.473190851144, 4220.936685949713, 4271.188474189894, 4280.978595107035, 4303.677224208197, 4539.671179499395, 4553.476350219734, 4570.885727856797, 4579.061292435043, 4639.884002899955, 4799.7360145192, 4816.44610869751, 4870.09903167915, 4884.0, 4884.340614017097, 4866.124097662419, 4896.069746748142, 4907.0, 4952.405711314629, 4964.429090654548, 4572.268437050056, 4579.816807327737, 4583.610393116555, 4588.197065513588, 4638.1883170445035, 4882.804687812519, 4949.7030178189425, 4995.975020124876, 5001.049800537886, 5055.671381360274, 4733.384659994179, 4735.455422626374, 4763.809447622126, 4778.092162489116, 4781.856544303677, 4808.374911261513, 4819.807207711652, 4878.0975519529, 4887.266909963534, 4956.925646115311, 4690.179218636725, 4822.71063736177, 4836.661433699677, 4901.975490122598, 4903.33804936329, 4711.7879695413785, 4778.95221047792, 4782.952170478251, 4804.783784729696, 4862.124817532878, 4044.7775372354213, 4059.167870586523, 4064.0, 4117.341225403921, 4122.175564887035, 3537.7169826413824, 3604.9279014419567, 3617.3127105849803, 3632.9273414531563, 3670.8164591770305, 4228.090960443519, 4249.660027197817, 4296.441462609903, 4301.462317210348, 4348.934765978513, 4899.338589290472, 4904.779284932187, 4923.630727695438, 4946.183879659816, 4974.950250497449, 4271.850485233002, 4286.678499112579, 4303.763293018914, 4311.2239796836875, 4344.23975804233, 4310.43964284641, 4333.046729719456, 4335.2196604610845, 4346.804393802223, 4354.521002689701, 4595.494495605414, 4622.699524530894, 4627.120847039052, 4665.6734028617675, 4693.859184224479, 4870.391201099863, 4877.829275975324, 4888.804447822189, 4897.3878265216845, 4947.77735001933, 4473.418455600751, 4517.028838799673, 4613.19269127908, 4614.630829533562, 4617.145828021827, 4855.854324370274, 4856.562909338177, 4869.391326084239, 4896.143174944442, 4911.607071434205, 4918.286848407032, 4919.065377578248, 4928.852134435972, 4938.678985865908, 4960.355153829979, 4638.6752927294765, 4669.509701481295, 4683.0, 4798.928016079832, 4833.202521583899, 4681.133990211822, 4701.5298470154075, 4707.835225767219, 4761.047790441995, 4777.808887644455, 4649.070185962889, 4666.673332866667, 4674.158651442637, 4675.32207829856, 4711.764411779329, 4722.598579120813, 4771.260454629538, 4776.9761151194025, 4781.019890922422, 4845.927311090407, 4676.041411510564, 4739.099571081483, 4740.502247263988, 4752.025834703808, 4755.120302744003], "value": 4498.200581781478, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.66818742848, 570.3697414357138, 574.0327548081483, 577.8757567123067, 583.8423625621083, 27566.0, 38026.809865950665, 39439.40840887385, 39483.0, 42784.0, 39801.0, 40114.0, 40117.59882401175, 40515.0, 40536.391954120714, 7183.353498185163, 7481.513701609405, 7626.694932202705, 7627.389808815282, 7627.817688258328, 7139.286071392845, 7359.043324367824, 7363.521371110887, 7363.9631801840915, 9559.95220023899, 9565.0, 9928.205743540499, 9934.0, 9942.801143977116, 9961.40231586107, 9719.514024298827, 9725.708228753148, 9771.657991970282, 9789.706308810675, 9790.55942482583, 9622.230221582327, 9688.903110968871, 9690.37012594179, 9693.612255509772, 9694.418334899929, 37006.62993370059, 37287.0, 37290.81354593237, 37300.44049339262, 37350.0, 2822.7177282271814, 2823.2095013396283, 2831.6460442444695, 2881.899133530337, 2896.898608548691, 27372.726272737415, 27550.0, 27713.0, 28114.437711245864, 28351.43297134046, 3379.548963250878, 3467.063892748969, 3537.398642230827, 3553.8400771965325, 3592.0660628236587, 252417.0, 253701.0, 254126.0, 254256.99999999814, 254567.0, 49572.75213623981, 49782.253266201034, 49898.25152622713, 49906.750466248166, 49907.25139122916, 31709.682903171135, 32517.67482325194, 32773.50839737406, 34286.0, 34305.142371440415, 13771.724565508634, 13919.373628186755, 13932.651683707989, 13936.303184840717, 13941.512047078506, 10247.9487602563, 10325.48372581368, 10339.224558158168, 10339.793204135874, 10343.0, 15170.544883653509, 15466.9226653866, 17025.31898724062, 17063.48809535691, 17688.292468301122, 6398.392152745481, 6547.541672082908, 6730.528862979544, 6778.491613129035, 6835.658217089126, 683.2416018219772, 725.6879541797078, 833.8749187621784, 840.2269911681145, 912.1653686876566, 26855.328616784736, 27346.0, 27378.45243095127, 27519.58720619192, 27595.0, 850.0649285785587, 901.4951627088851, 927.3091546797544, 947.1475671895349, 979.686500319905, 14113.506027288995, 14177.14937103777, 14198.728203487393, 14221.28893555318, 14293.714125717428, 381546.09226953686, 385712.0, 386863.0, 387219.0, 388149.0, 48444.0, 48487.75756121197, 48578.0, 48666.27000594994, 48744.26883596749, 1046.9738256543494, 1064.2390690656218, 1119.8544189255344, 1165.5221359242669, 1166.5275563396838, 24142.189335800238, 27922.72077279201, 28062.719372806827, 28953.919676868092, 29258.561121583618, 40118.799406002785, 40672.98317542085, 40730.592694073865, 40731.0, 40766.79616601898, 292545.0, 293801.0, 294919.0, 295136.0, 295492.0, 24233.151839685528, 25302.367440814127, 25383.492330152923, 26344.209673709818, 26420.735792642598, 41014.58985410227, 41265.58734412617, 41735.79132104442, 42248.78875605603, 42679.3598096035, 34864.65135348614, 34944.65055349414, 35294.64705353016, 35467.82266088653, 35836.462453063745, 34850.30299393947, 34903.650963491054, 35120.297594047464, 35140.64859351476, 35184.472232916014, 34785.47821782625, 35311.29377412386, 35409.82295088508, 35428.29143417169, 36260.27479450449, 29744.810207591454, 32166.19584510406, 32427.351452970335, 32693.346133076728, 32902.50646240356, 24936.37659058538, 25061.749382505943, 25213.369665758502, 25222.84846304457, 25613.615795762707], "value": 17089.433901601606, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.0760102709845, 342.33022004115884, 351.4675266970539, 352.8165354015912, 373.72904644133007, 12024.879751202485, 16101.436449724262, 16230.594235144128, 16994.405195818148, 18131.909340453312, 16967.57581060471, 17072.0, 17277.654446911056, 17311.653766924686, 17569.91215043926, 4920.384951881015, 4992.92510612342, 5067.8479645610505, 5099.974500127512, 5100.107481190796, 3609.097725568608, 3793.7154713396467, 4959.330490383788, 5042.974785126069, 5639.746211420475, 5870.11948207768, 5977.312609049972, 5985.521158307325, 5991.281046274453, 5993.370696076914, 5711.114777209518, 5880.000399931979, 5903.49820265278, 5907.852303692399, 5956.791512297071, 5173.844784656466, 5177.352830896138, 5178.792848286064, 5184.585233181337, 5191.143461328877, 20534.383968480968, 20977.790222097738, 21144.2599509018, 21235.893820530797, 21264.468388290417, 1934.3229869545687, 2358.9974260939034, 2449.081594402099, 2469.9506009879883, 2543.249741326313, 13297.53458628953, 13336.0, 13381.66545836352, 13393.397297121654, 14011.789823152661, 1674.7236705943506, 1721.5868191634042, 1733.2633630707026, 1760.1727188221516, 1771.9557011074696, 69587.0, 69879.65060174717, 71096.49166658318, 76090.85863712104, 77434.0, 15608.921955390151, 15893.920530397274, 16250.431234906722, 16395.344186232654, 16645.167741613113, 29123.854380728386, 29309.85345073261, 29313.706862931525, 29350.11949641514, 29487.705122948926, 8328.750137495885, 8553.529555874487, 8564.61459234336, 8602.78493037679, 9009.459432434074, 6776.898346524806, 6863.10779598659, 6999.965000175069, 7016.438684905195, 7043.823904402431, 8320.750377488685, 8424.620892059873, 8530.914690853137, 8550.273226775793, 8600.311975041981, 3324.7173990211104, 3338.2322065924973, 3392.692968781203, 3401.7618766686587, 3461.732565169818, 733.5232099135604, 853.3301358433599, 899.0065977095346, 924.0851556958563, 944.4946953379908, 16185.271662775203, 16745.581360465843, 16964.321427142775, 17050.0, 17852.732209016875, 768.5196752029981, 782.9138794732575, 823.4606332851992, 880.3705350674298, 880.5245167609547, 8911.2425443838, 9575.760605984906, 9625.32622716403, 9696.903030969741, 9891.653792117242, 348895.0, 353155.0, 371213.0, 372838.0, 373499.0, 74718.0, 75666.62166689131, 76864.61567692125, 79087.60456197683, 79629.60185199037, 673.1787219592188, 676.668432468097, 685.6366125953252, 686.1114856261154, 687.0450074396692, 14907.732842708492, 15038.172900490577, 15353.385864565293, 15562.844371556139, 15741.370345186064, 35721.82139089288, 36068.27863442664, 36790.26419471649, 36953.26093478169, 37712.245755084194, 49496.75251623719, 49800.0, 50349.496505035946, 50494.49505504898, 52399.21401178909, 7010.824729381806, 7400.851982960203, 8822.691205807765, 9044.547772611475, 9141.085891410805, 7185.0, 7291.927080729125, 7340.669669864762, 7485.737999170003, 7488.5506869588, 6116.908246376397, 6269.0, 6562.34376562359, 6669.533132680665, 6928.930710692828, 6677.332266773284, 6924.757633482804, 7034.788956331318, 7072.858542829012, 7244.985702001619, 6587.901181482377, 6786.898196526958, 6833.826693356299, 7023.192332881579, 7172.964135179291, 9460.763480913032, 9481.819181588135, 9685.0, 9805.21558275322, 10102.545385457819, 5663.603547751618, 7288.870225115115, 8524.531150786766, 8695.52174630376, 8930.642774289216], "value": 8471.163297430583, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1218.8842060004308, 1317.822094017308, 1363.7477066742651, 1384.5292600515822, 1690.7379356199785, 6767.695453704583, 7457.0, 7757.922420775804, 7769.883451748221, 7962.522248665085, 7821.296083352498, 7889.5266284023, 7901.525908445497, 7906.2884340409355, 7908.644111015004, 2135.711678923345, 2158.4495953531828, 2159.4385459780415, 2160.6326924422888, 2164.9025793839237, 2129.606022885763, 2183.268605017321, 2185.7704940981207, 2188.7592364839857, 2191.2002119226527, 2104.389726979174, 2140.9250676226334, 2153.3217036633487, 2162.664786958024, 2165.6426689596196, 2103.705481232621, 2111.5882402931434, 2112.6091673040537, 2112.6619740841393, 2114.154338264691, 2010.7084472751515, 2082.073477302601, 2086.7182930304366, 2092.843036772233, 2093.047663313189, 7751.8449631007625, 7761.262680045386, 7840.49036812611, 7940.722074727357, 7950.681972721084, 4537.115262523809, 4727.409073865767, 4728.290756386536, 4731.432228132611, 4745.074710431467, 2863.0981240909255, 2967.421352836198, 3008.2178633555213, 3029.969700302991, 3040.5135178371356, 949.7625593601599, 956.206348730552, 974.4202199691173, 976.4287891583432, 979.6130528441225, 10729.248952573324, 10810.945945270301, 10826.945865270702, 10828.0, 10841.241113122085, 4001.5998400160333, 4112.3420252759415, 4169.437125988014, 4278.187144442546, 4328.350747387854, 8457.0, 8540.957295213608, 8556.358273129415, 8571.742847714579, 8578.785530361665, 4619.722816631013, 4629.375034370384, 4632.374629425052, 4634.328022436795, 4638.466576343763, 3565.5008298838184, 3746.3069332173636, 3754.267917756066, 4311.676624253194, 4315.0, 3404.6084700259294, 3488.6162522122545, 3568.072301201706, 3591.06632275605, 3599.3881040223223, 1065.8294672852307, 1066.2056767707952, 1078.2937176149635, 1078.6925726168004, 1088.9727756805985, 730.1639622632057, 778.2489897249181, 786.8937693411431, 790.8177274973835, 794.4200733464603, 4723.338732577442, 4868.634852386085, 4891.364122664102, 4932.950670493321, 4948.925766113512, 395.88717215593994, 412.59359530862076, 412.8286760994214, 414.97925103744694, 415.56158253043327, 3150.2754366495833, 3334.7832390895, 3340.3319336132386, 3361.9327613447595, 3415.6072051713872, 9371.531423428938, 9476.384035037701, 9732.2214222862, 9836.06557377048, 9919.950400248097, 9738.513074346254, 9743.561539730728, 9748.61005559784, 9761.609535618638, 9771.21830253578, 7400.370968467741, 7406.333429991434, 7414.814629634195, 7461.70153193877, 7473.476856619985, 4893.7063776173545, 4987.077390682735, 5007.499250074963, 5033.924491132562, 5037.5214354636255, 8654.437461564978, 8681.609327580149, 8890.911090889009, 8906.376553641183, 8946.597403117006, 8970.820583588422, 9069.863952040592, 9111.772205694646, 9157.221636161, 9176.587053582738, 6261.68691565429, 6317.6209427434505, 6325.240971083499, 6327.683615819098, 6328.778492752732, 7371.0, 7451.031365922396, 7520.0, 7532.359749421142, 7560.243975602396, 6614.768483103068, 6641.535092543476, 6675.23234828001, 6692.130023096966, 6706.161729783777, 6596.30738772422, 6642.867142657024, 6662.800115996528, 6671.332866713484, 6695.497837662292, 6060.848478788065, 6061.060535616986, 6106.847328816815, 6108.75564977396, 6132.08018797184, 4385.671074669349, 4456.3761073449095, 4484.103179364205, 4493.146302202571, 4641.443026836801, 4321.935170972375, 4368.563143685606, 4415.227335216388, 4418.7127836690515, 4591.104734576726], "value": 3976.5591372407152, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [277.8944001279512, 292.26203835315823, 296.5803388205689, 298.15175824778527, 300.6947947832949, 4774.976125119374, 4790.425148982127, 4806.543378379057, 4816.518348165182, 4843.176659967805, 4505.639548836093, 4614.953850461495, 4616.630669546436, 4633.582977532022, 4777.832775852846, 3584.946225806615, 3705.240425712736, 3716.5725941516803, 3750.287445385368, 3762.0970966967866, 3752.1370084880496, 3766.41620548814, 3773.5471743390694, 3787.16682329887, 3803.50554427924, 3648.434492653643, 3738.8130593470355, 3738.869139580115, 3745.6441638044344, 3747.2692824899154, 3716.163863130801, 3718.925621487555, 3735.62643735627, 3754.812259387047, 3759.248150369937, 3297.5383446317533, 3299.15871452778, 3312.933741325184, 3322.1528510229978, 3332.96667033329, 4591.943852913815, 4630.953690463086, 4631.397918270603, 4636.420447444069, 4640.466346370177, 4176.874693759192, 4241.791089539466, 4253.595908388729, 4268.740721487169, 4274.252005898955, 4868.563773686771, 4870.415550133971, 4881.194602890519, 4887.3890763654545, 4905.362302900636, 3605.2068544920076, 3615.6079909234873, 3616.3671357512594, 3625.3111908737255, 3629.6370362963494, 4969.503049695001, 5121.718305493197, 5155.510226528474, 5191.195364718475, 5203.505666961632, 3685.1339935115225, 3689.94465083024, 3707.1288247261873, 3711.832967516468, 3712.1647629283193, 3759.642833930772, 3777.7544459610035, 3782.243551289698, 3782.924341513154, 3785.0, 4256.169846965834, 4273.166732487135, 4274.1451709658195, 4275.551067137906, 4280.422143010716, 4730.101280756645, 4869.954619060003, 4890.486498917634, 4943.975280123648, 4980.228064649985, 1279.1365828066018, 1284.4091717809724, 1288.7035981724068, 1295.4559085184246, 1297.3448408553809, 847.9067302596709, 856.2678909532385, 883.8674198870092, 884.9601767920459, 889.2930120554175, 4308.763018034038, 4320.891977700583, 4349.26062569364, 4423.668224883147, 4482.686211965131, 5073.315102461121, 5100.132977393852, 5100.285959965608, 5103.209002604603, 5106.15748401517, 4341.9131617367475, 4446.3108218226225, 4448.243798554254, 4451.354553589711, 4482.7758612069265, 2663.4007348346468, 2696.44722831819, 2699.379142797168, 2731.8634068296506, 2733.8633068346503, 4857.1742803723455, 4866.659333846596, 4871.2206047032305, 4900.656954013185, 4924.3105965164905, 5108.310378098983, 5187.1989125871605, 5234.398044224963, 5247.134222853187, 5290.259363689087, 4855.247436647254, 4857.077155340474, 4887.313876712528, 4900.705957642553, 4905.166121759309, 5106.438291787975, 5147.562457191031, 5150.175971844487, 5159.948400516097, 5174.97412512935, 4744.525547445228, 4938.728369939544, 4971.477994810492, 5006.799728010838, 5016.297718319365, 4807.735574543433, 4813.350197723263, 4823.324734537237, 4824.962633033914, 4827.637927155548, 3656.1956369598647, 3677.816109194583, 3681.263747250614, 3682.0978860179425, 3698.2603479304785, 4883.511648835088, 5109.744512774272, 5115.820946266863, 5127.692338459704, 5141.38303403594, 4969.602431805519, 4974.452810190804, 4976.30331753562, 4980.601551875769, 4981.637394758596, 4956.603471722182, 4957.231629097496, 4959.677620954626, 4963.677360971526, 4964.975175124101, 4783.95216047835, 4868.95131048685, 4902.166631672553, 4902.7058376497525, 4911.877203069809, 4722.504137065559, 4871.780769865435, 4906.509349065208, 5000.924616284201, 5005.77474013663, 4886.853394398174, 4893.7797799099835, 4897.918384686565, 4901.975490122527, 4922.286268490977], "value": 3766.361681678456, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.2177539766279, 613.5459759777766, 632.4971647540207, 639.3670266436229, 671.2482020137444, 12754.808677869827, 13770.655733606665, 13803.51687690931, 13804.79292810606, 13808.792868106986, 13190.802137967914, 13690.315484225799, 13932.651683707913, 14428.0, 14441.422343106264, 736.5249414127884, 761.5811303782925, 766.5783818899611, 767.3860911270989, 767.57399643198, 598.8263403612947, 612.6660969771463, 737.5021860244341, 777.510168593788, 780.2782426255719, 786.8347646994138, 796.2236819101358, 797.9680812767511, 798.7843282313772, 799.6961154761183, 787.4566549081115, 788.03072221168, 788.0346575445092, 788.2708494642433, 791.0902462168494, 462.235001073221, 469.3663554201834, 560.330405165827, 583.0612713531211, 583.3670467542721, 12433.316167610777, 13067.803982940264, 13105.2136871788, 13106.60680179596, 13107.606771796862, 12195.207311524811, 12430.378481076, 12576.056795740356, 12621.305828179446, 12726.363681815872, 11745.882541174564, 11918.582849600309, 12101.213421127686, 12212.511499540007, 12383.133180677356, 3921.1961547882615, 3936.212757448493, 3973.602639736032, 4027.0, 4071.0, 64493.35506644921, 65320.3467965319, 65835.3416465834, 66611.66694166498, 68839.0, 10051.447170405698, 10441.582336706599, 10501.159907207406, 10539.84190237147, 10664.306820056672, 18024.639507209784, 18069.367572134914, 18080.457586272434, 18136.63726725458, 18273.17770700322, 6189.97756170531, 6343.788910771286, 6487.643179625166, 6571.145751052428, 6631.27056023837, 3551.5027896094566, 3567.928641427157, 3572.8570857165423, 3573.7498375114014, 3711.740178187555, 2757.26932362924, 2843.1754791110347, 2853.9143825685264, 2864.6992065832787, 2865.885364585435, 496.6862648295239, 500.06487867687656, 507.50011238929625, 515.8194631878812, 527.385595780911, 416.3837520469722, 435.9607635312837, 444.44444444444446, 447.05447977527297, 518.6317714422727, 6902.689378977958, 7179.282071792779, 7319.133620926629, 7406.518576292524, 7543.094828620491, 447.98432054877924, 457.17708125374196, 482.55363788495504, 506.1471420656206, 521.3743507790666, 3378.5945686517775, 3445.8277086145595, 3567.7324200685052, 3664.2671465706967, 3735.495708079429, 102032.48983755182, 102438.122091076, 102462.48768756108, 104196.0, 105064.0, 51434.228486572734, 89675.55162224147, 90089.54955225313, 90500.54749726209, 91743.56872194396, 76153.0, 78064.60967695239, 78819.66491843003, 80297.99999999884, 81777.18222817934, 6699.464042876656, 6821.249662537018, 6858.245592984668, 6937.549059311129, 7116.715331386687, 48276.5172348272, 48795.75602121967, 49031.509684902696, 49058.848820873296, 51111.0, 39721.0, 40781.59218407778, 41312.38031429471, 69930.30069699441, 70843.0, 10199.602677222261, 10407.895921040692, 10520.263581549218, 10736.141108711441, 10860.294080884718, 10718.464076795974, 10833.241673082808, 11032.779344412906, 11489.82765258505, 11936.940315298369, 9616.374935629161, 9624.470654114091, 9673.613055477983, 10101.242406819665, 10738.0, 9238.187557477586, 9317.906820931705, 10061.496925153859, 10156.187504999434, 10835.891641083803, 9860.901390985999, 9954.502274886372, 10659.840102398626, 10670.253082284165, 10673.57305707763, 8722.52026138543, 9010.234130099016, 9121.315901307562, 9313.953430232805, 9606.0, 7746.264104910025, 8119.30985866208, 8416.326693864354, 8555.786105347415, 8607.569621519024], "value": 6246.497430269271, "unit": "score"}], "name": "dromaeo_css", "value": 6272.941549316596, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 116.0, 115.0, 114.0, 114.0, 113.0, 114.0, 114.0, 113.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 123.0, 124.0, 166.0, 140.0, 125.0, 125.0, 135.0, 157.0, 130.0], "value": 138.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 162.0, 162.0, 163.0, 162.0, 160.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 110.0, 79.0, 78.0, 78.0, 77.0, 99.0, 77.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 114.0, 84.0, 84.0, 85.0, 108.0, 84.0, 84.0, 114.0], "value": 92.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 96.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 62.0, 63.0, 64.0, 64.0, 64.0, 65.0, 64.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 66.0, 65.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 85.0, 83.0, 82.0, 83.0, 82.0, 82.0, 82.0, 82.0, 90.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 130.0, 131.0, 135.0, 130.0, 136.0, 131.0, 140.0, 179.0, 148.0], "value": 139.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 176.0, 175.0, 172.0, 173.0, 174.0, 174.0, 174.0, 175.0, 182.0], "value": 175.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 69.0, 69.0, 67.0, 69.0, 69.0, 67.0, 69.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1544.6999999999998, "alertThreshold": 2.0}]} 08:56:51 INFO - Return code: 0 08:56:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:56:51 INFO - # TBPL SUCCESS # 08:56:51 INFO - Running post-action listener: _resource_record_post_action 08:56:51 INFO - [mozharness: 2016-09-13 15:56:51.955307Z] Finished run-tests step (success) 08:56:51 INFO - Running post-run listener: _resource_record_post_run 08:56:52 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392073216; Read time: 12; Write time: 242804 08:56:52 INFO - TinderboxPrint: CPU usage
13.0% 08:56:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:56:52 INFO - TinderboxPrint: I/O write bytes / time
392,073,216 / 242,804 08:56:52 INFO - TinderboxPrint: CPU idle
8,341.4 (87.0%) 08:56:52 INFO - TinderboxPrint: CPU user
1,201.8 (12.5%) 08:56:52 INFO - TinderboxPrint: Swap in / out
0 / 0 08:56:52 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99794944; Read time: 0; Write time: 71104 08:56:52 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 292278272; Read time: 0; Write time: 171700 08:56:52 INFO - Running post-run listener: _upload_blobber_files 08:56:52 INFO - Blob upload gear active. 08:56:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:56:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:56:52 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:56:52 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:56:52 INFO - (blobuploader) - INFO - Open directory for files ... 08:56:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:56:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:56:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:59 INFO - (blobuploader) - INFO - Done attempting. 08:56:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:56:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:56:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:56:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:56:59 INFO - (blobuploader) - INFO - Done attempting. 08:56:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:56:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:56:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:57:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:57:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:57:00 INFO - (blobuploader) - INFO - Done attempting. 08:57:00 INFO - (blobuploader) - INFO - Iteration through files over. 08:57:00 INFO - Return code: 0 08:57:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:57:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:57:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bb61f3e96e79553a5f8532751b302329a93897e4391e3025e216fc0421cb4e95e59128869d8cba38859471e38d54aaa6968841861705ead0ac7af3d2b9fb3b7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/86f589a75836d7d2d6e34f7964f023b81fa75cb54b219fa5c0d5fbc370861ef7a2ce10031b451c2ba552a39e1fdcfb68dee2b8ceac8974daa5b4bf893b8dfcd7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/708ffcb6510ef25da9fdd4921267ff80c9d2b928a3488d748c9d744119b68d1f3566c1decb0063cd12c49b7c50396d66af676c112297325df617e74f3398e6a4"} 08:57:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:57:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:57:00 INFO - Contents: 08:57:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bb61f3e96e79553a5f8532751b302329a93897e4391e3025e216fc0421cb4e95e59128869d8cba38859471e38d54aaa6968841861705ead0ac7af3d2b9fb3b7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/86f589a75836d7d2d6e34f7964f023b81fa75cb54b219fa5c0d5fbc370861ef7a2ce10031b451c2ba552a39e1fdcfb68dee2b8ceac8974daa5b4bf893b8dfcd7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/708ffcb6510ef25da9fdd4921267ff80c9d2b928a3488d748c9d744119b68d1f3566c1decb0063cd12c49b7c50396d66af676c112297325df617e74f3398e6a4"} 08:57:00 INFO - Running post-run listener: copy_logs_to_upload_dir 08:57:00 INFO - Copying logs to upload dir... 08:57:00 INFO - mkdir: /builds/slave/test/build/upload/logs 08:57:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.633390 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-09-13 08:56:59.964598) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-13 08:56:59.968188) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1473780638.400966-1998685341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bb61f3e96e79553a5f8532751b302329a93897e4391e3025e216fc0421cb4e95e59128869d8cba38859471e38d54aaa6968841861705ead0ac7af3d2b9fb3b7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/86f589a75836d7d2d6e34f7964f023b81fa75cb54b219fa5c0d5fbc370861ef7a2ce10031b451c2ba552a39e1fdcfb68dee2b8ceac8974daa5b4bf893b8dfcd7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/708ffcb6510ef25da9fdd4921267ff80c9d2b928a3488d748c9d744119b68d1f3566c1decb0063cd12c49b7c50396d66af676c112297325df617e74f3398e6a4"} build_url:https://queue.taskcluster.net/v1/task/eDB_si_OTW6T4BQTqjv_Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/eDB_si_OTW6T4BQTqjv_Og/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bb61f3e96e79553a5f8532751b302329a93897e4391e3025e216fc0421cb4e95e59128869d8cba38859471e38d54aaa6968841861705ead0ac7af3d2b9fb3b7b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/86f589a75836d7d2d6e34f7964f023b81fa75cb54b219fa5c0d5fbc370861ef7a2ce10031b451c2ba552a39e1fdcfb68dee2b8ceac8974daa5b4bf893b8dfcd7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/708ffcb6510ef25da9fdd4921267ff80c9d2b928a3488d748c9d744119b68d1f3566c1decb0063cd12c49b7c50396d66af676c112297325df617e74f3398e6a4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-13 08:56:59.996332) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 08:56:59.997135) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1473780638.400966-1998685341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004411 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 08:57:00.080453) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-13 08:57:00.081103) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-13 08:57:00.081830) ========= ========= Total master_lag: 0.17 =========