builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-011 starttime: 1471350586.19 results: success (0) buildid: 20160816023007 builduid: d9b42e2330714556945bf7b07b2b10d1 revision: b773199257dc43a4ed4ded8f41dc01f12e2ba222 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 05:29:46.194114) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 05:29:46.194611) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 05:29:46.194913) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 05:29:46.211267) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:29:46.211626) ========= 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=5cf47e208febbcd81da23b2e0000026f-1471350584.54030-1830642097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-16 05:29:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 51.1M=0s 2016-08-16 05:29:46 (51.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.231361 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:29:46.456906) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:29:46.457892) ========= 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=5cf47e208febbcd81da23b2e0000026f-1471350584.54030-1830642097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017264 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:29:46.507102) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:29:46.507522) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b773199257dc43a4ed4ded8f41dc01f12e2ba222 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev b773199257dc43a4ed4ded8f41dc01f12e2ba222 --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=5cf47e208febbcd81da23b2e0000026f-1471350584.54030-1830642097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-16 05:29:46,518 truncating revision to first 12 chars 2016-08-16 05:29:46,518 Setting DEBUG logging. 2016-08-16 05:29:46,518 attempt 1/10 2016-08-16 05:29:46,518 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b773199257dc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 05:29:47,136 unpacking tar archive at: fx-team-b773199257dc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.929941 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:29:47.451701) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 05:29:47.452022) ========= script_repo_revision: b773199257dc43a4ed4ded8f41dc01f12e2ba222 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 05:29:47.452513) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 05:29:47.452777) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 05:29:47.463553) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-16 05:29:47.463853) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=5cf47e208febbcd81da23b2e0000026f-1471350584.54030-1830642097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:29:47 INFO - MultiFileLogger online at 20160816 05:29:47 in /builds/slave/test 05:29:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:29:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:29:47 INFO - {'append_to_log': False, 05:29:47 INFO - 'base_work_dir': '/builds/slave/test', 05:29:47 INFO - 'blob_upload_branch': 'Fx-Team', 05:29:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:29:47 INFO - 'branch': 'Fx-Team', 05:29:47 INFO - 'buildbot_json_path': 'buildprops.json', 05:29:47 INFO - 'config_files': ('talos/linux_config.py',), 05:29:47 INFO - 'default_actions': ('clobber', 05:29:47 INFO - 'read-buildbot-config', 05:29:47 INFO - 'download-and-extract', 05:29:47 INFO - 'populate-webroot', 05:29:47 INFO - 'create-virtualenv', 05:29:47 INFO - 'install', 05:29:47 INFO - 'run-tests'), 05:29:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:29:47 INFO - 'download_minidump_stackwalk': True, 05:29:47 INFO - 'download_symbols': 'ondemand', 05:29:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:29:47 INFO - 'tooltool.py': '/tools/tooltool.py', 05:29:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:29:47 INFO - '/tools/misc-python/virtualenv.py')}, 05:29:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:29:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:29:47 INFO - 'installer_path': 'installer.exe', 05:29:47 INFO - 'log_level': 'info', 05:29:47 INFO - 'log_name': 'talos', 05:29:47 INFO - 'log_to_console': True, 05:29:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:29:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:29:47 INFO - 'opt_config_files': (), 05:29:47 INFO - 'pip_index': False, 05:29:47 INFO - 'sps_profile': False, 05:29:47 INFO - 'sps_profile_interval': 0, 05:29:47 INFO - 'suite': 'dromaeojs-e10s', 05:29:47 INFO - 'system_bits': '32', 05:29:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:29:47 INFO - 'title': 'talos-linux64-ix-011', 05:29:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:29:47 INFO - 'use_talos_json': True, 05:29:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:29:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:29:47 INFO - 'work_dir': 'build'} 05:29:47 INFO - [mozharness: 2016-08-16 12:29:47.574423Z] Running clobber step. 05:29:47 INFO - Running pre-action listener: _resource_record_pre_action 05:29:47 INFO - Running main action method: clobber 05:29:47 INFO - rmtree: /builds/slave/test/build 05:29:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:29:48 INFO - Running post-action listener: _resource_record_post_action 05:29:48 INFO - [mozharness: 2016-08-16 12:29:48.024719Z] Finished clobber step (success) 05:29:48 INFO - [mozharness: 2016-08-16 12:29:48.024819Z] Running read-buildbot-config step. 05:29:48 INFO - Running pre-action listener: _resource_record_pre_action 05:29:48 INFO - Running main action method: read_buildbot_config 05:29:48 INFO - Using buildbot properties: 05:29:48 INFO - { 05:29:48 INFO - "project": "", 05:29:48 INFO - "product": "firefox", 05:29:48 INFO - "script_repo_revision": "production", 05:29:48 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:29:48 INFO - "repository": "", 05:29:48 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:29:48 INFO - "buildid": "20160816023007", 05:29:48 INFO - "pgo_build": "True", 05:29:48 INFO - "basedir": "/builds/slave/test", 05:29:48 INFO - "buildnumber": 702, 05:29:48 INFO - "slavename": "talos-linux64-ix-011", 05:29:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:29:48 INFO - "platform": "ubuntu64_hw", 05:29:48 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:29:48 INFO - "branch": "fx-team", 05:29:48 INFO - "repo_path": "integration/fx-team", 05:29:48 INFO - "revision": "b773199257dc43a4ed4ded8f41dc01f12e2ba222", 05:29:48 INFO - "stage_platform": "linux64-pgo", 05:29:48 INFO - "builduid": "d9b42e2330714556945bf7b07b2b10d1", 05:29:48 INFO - "slavebuilddir": "test" 05:29:48 INFO - } 05:29:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/J9spd8UbT3qp_OKvNcii3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:29:48 INFO - Running post-action listener: _resource_record_post_action 05:29:48 INFO - [mozharness: 2016-08-16 12:29:48.027538Z] Finished read-buildbot-config step (success) 05:29:48 INFO - [mozharness: 2016-08-16 12:29:48.027626Z] Running download-and-extract step. 05:29:48 INFO - Running pre-action listener: _resource_record_pre_action 05:29:48 INFO - Running main action method: download_and_extract 05:29:48 INFO - mkdir: /builds/slave/test/build/tests 05:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:29:48 INFO - trying https://queue.taskcluster.net/v1/task/J9spd8UbT3qp_OKvNcii3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:29:48 INFO - Downloading https://queue.taskcluster.net/v1/task/J9spd8UbT3qp_OKvNcii3Q/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 05:29:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J9spd8UbT3qp_OKvNcii3Q/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 05:29:48 INFO - Downloaded 1361 bytes. 05:29:48 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:29:48 INFO - Using the following test package requirements: 05:29:48 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:29:48 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:48 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:29:48 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:48 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:29:48 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:48 INFO - u'jsshell-linux-x86_64.zip'], 05:29:48 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:48 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:29:48 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:29:48 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:48 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:29:48 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:48 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:29:48 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:48 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:29:48 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:29:48 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:29:48 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:29:48 INFO - trying https://queue.taskcluster.net/v1/task/J9spd8UbT3qp_OKvNcii3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:29:48 INFO - Downloading https://queue.taskcluster.net/v1/task/J9spd8UbT3qp_OKvNcii3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:29:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J9spd8UbT3qp_OKvNcii3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:29:49 INFO - Downloaded 21836273 bytes. 05:29:49 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 05:29:53 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 05:29:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:29:53 INFO - trying https://queue.taskcluster.net/v1/task/J9spd8UbT3qp_OKvNcii3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:29:53 INFO - Downloading https://queue.taskcluster.net/v1/task/J9spd8UbT3qp_OKvNcii3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:29:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J9spd8UbT3qp_OKvNcii3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:29:54 INFO - Downloaded 21836273 bytes. 05:29:54 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 05:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:29:59 INFO - trying https://queue.taskcluster.net/v1/task/J9spd8UbT3qp_OKvNcii3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:29:59 INFO - Downloading https://queue.taskcluster.net/v1/task/J9spd8UbT3qp_OKvNcii3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:29:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J9spd8UbT3qp_OKvNcii3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:29:59 INFO - Downloaded 14413719 bytes. 05:29:59 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 05:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:00 INFO - trying https://queue.taskcluster.net/v1/task/J9spd8UbT3qp_OKvNcii3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:30:00 INFO - Downloading https://queue.taskcluster.net/v1/task/J9spd8UbT3qp_OKvNcii3Q/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 05:30:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J9spd8UbT3qp_OKvNcii3Q/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 05:30:01 INFO - Downloaded 59421205 bytes. 05:30:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J9spd8UbT3qp_OKvNcii3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:30:01 INFO - mkdir: /builds/slave/test/properties 05:30:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:30:01 INFO - Writing to file /builds/slave/test/properties/build_url 05:30:01 INFO - Contents: 05:30:01 INFO - build_url:https://queue.taskcluster.net/v1/task/J9spd8UbT3qp_OKvNcii3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:30:01 INFO - Running post-action listener: _resource_record_post_action 05:30:01 INFO - Running post-action listener: set_extra_try_arguments 05:30:01 INFO - [mozharness: 2016-08-16 12:30:01.764990Z] Finished download-and-extract step (success) 05:30:01 INFO - [mozharness: 2016-08-16 12:30:01.765327Z] Running populate-webroot step. 05:30:01 INFO - Running pre-action listener: _resource_record_pre_action 05:30:01 INFO - Running main action method: populate_webroot 05:30:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:30:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:30:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:30:01 INFO - '--tppagecycles', 05:30:01 INFO - '7'], 05:30:01 INFO - 'tests': ['tsvgm']}}, 05:30:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:30:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:30:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:30:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:30:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:30:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:30:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:01 INFO - 'talos_options': ['--disable-e10s'], 05:30:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:01 INFO - 'talos_options': ['--disable-e10s'], 05:30:01 INFO - 'tests': ['damp', 'tps']}, 05:30:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:01 INFO - 'tests': ['damp', 'tps']}, 05:30:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:30:01 INFO - 'tests': ['dromaeo_dom']}, 05:30:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:30:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:30:01 INFO - 'tests': ['basic_compositor_video']}, 05:30:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:30:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:30:01 INFO - 'tests': ['a11yr', 05:30:01 INFO - 'ts_paint', 05:30:01 INFO - 'tpaint', 05:30:01 INFO - 'sessionrestore', 05:30:01 INFO - 'sessionrestore_no_auto_restore', 05:30:01 INFO - 'tabpaint']}, 05:30:01 INFO - 'other-e10s': {'tests': ['a11yr', 05:30:01 INFO - 'ts_paint', 05:30:01 INFO - 'tpaint', 05:30:01 INFO - 'sessionrestore', 05:30:01 INFO - 'sessionrestore_no_auto_restore', 05:30:01 INFO - 'tabpaint']}, 05:30:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:30:01 INFO - 'ts_paint', 05:30:01 INFO - 'tpaint', 05:30:01 INFO - 'sessionrestore', 05:30:01 INFO - 'sessionrestore_no_auto_restore', 05:30:01 INFO - 'tabpaint']}, 05:30:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:30:01 INFO - 'ts_paint', 05:30:01 INFO - 'tpaint', 05:30:01 INFO - 'sessionrestore', 05:30:01 INFO - 'sessionrestore_no_auto_restore', 05:30:01 INFO - 'tabpaint']}, 05:30:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:30:01 INFO - 'tests': ['a11yr', 05:30:01 INFO - 'ts_paint', 05:30:01 INFO - 'tpaint', 05:30:01 INFO - 'sessionrestore', 05:30:01 INFO - 'sessionrestore_no_auto_restore', 05:30:01 INFO - 'tabpaint']}, 05:30:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:30:01 INFO - 'tests': ['a11yr', 05:30:01 INFO - 'ts_paint', 05:30:01 INFO - 'tpaint', 05:30:01 INFO - 'sessionrestore', 05:30:01 INFO - 'sessionrestore_no_auto_restore', 05:30:01 INFO - 'tabpaint']}, 05:30:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:30:01 INFO - 'tests': ['tsvgx', 05:30:01 INFO - 'tsvgr_opacity', 05:30:01 INFO - 'tart', 05:30:01 INFO - 'tscrollx', 05:30:01 INFO - 'cart']}, 05:30:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:30:01 INFO - 'tsvgr_opacity', 05:30:01 INFO - 'tart', 05:30:01 INFO - 'tscrollx', 05:30:01 INFO - 'cart']}, 05:30:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:01 INFO - 'talos_options': ['--disable-e10s'], 05:30:01 INFO - 'tests': ['tp5o']}, 05:30:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:01 INFO - 'tests': ['tp5o']}, 05:30:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:01 INFO - 'talos_options': ['--disable-e10s', 05:30:01 INFO - '--xperf_path', 05:30:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:01 INFO - 'tests': ['tp5n']}, 05:30:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:01 INFO - 'talos_options': ['--xperf_path', 05:30:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:01 INFO - 'tests': ['tp5n']}}, 05:30:01 INFO - 'talos.zip': {'path': '', 05:30:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:30:01 INFO - Running post-action listener: _resource_record_post_action 05:30:01 INFO - [mozharness: 2016-08-16 12:30:01.783135Z] Finished populate-webroot step (success) 05:30:01 INFO - [mozharness: 2016-08-16 12:30:01.783227Z] Running create-virtualenv step. 05:30:01 INFO - Running pre-action listener: _resource_record_pre_action 05:30:01 INFO - Running main action method: create_virtualenv 05:30:01 INFO - Creating virtualenv /builds/slave/test/build/venv 05:30:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:30:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:30:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:30:01 INFO - Using real prefix '/usr' 05:30:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:30:02 INFO - Installing distribute.............................................................................................................................................................................................done. 05:30:04 INFO - Installing pip.................done. 05:30:04 INFO - Return code: 0 05:30:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:04 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 0x7fe327d52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe00850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfb370>, '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 0xdfe8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfed80>, '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': '5cf47e208febbcd81da23b2e0000026f-1471350584.54030-1830642097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:30:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:30:04 INFO - Using env: {'DISPLAY': ':0', 05:30:04 INFO - 'HOME': '/home/cltbld', 05:30:04 INFO - 'LANG': 'en_US.UTF-8', 05:30:04 INFO - 'LANGUAGE': 'en_US:en', 05:30:04 INFO - 'LOGNAME': 'cltbld', 05:30:04 INFO - 'MAIL': '/var/mail/cltbld', 05:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:04 INFO - 'MOZ_NO_REMOTE': '1', 05:30:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:04 INFO - 'NO_EM_RESTART': '1', 05:30:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:04 INFO - 'PWD': '/builds/slave/test', 05:30:04 INFO - 'SHELL': '/bin/bash', 05:30:04 INFO - 'SHLVL': '1', 05:30:04 INFO - 'TERM': 'linux', 05:30:04 INFO - 'TMOUT': '86400', 05:30:04 INFO - 'USER': 'cltbld', 05:30:04 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471350584.54030-1830642097', 05:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:04 INFO - '_': '/tools/buildbot/bin/python'} 05:30:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:30:04 INFO - Cleaning up... 05:30:04 INFO - Return code: 0 05:30:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:04 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 0x7fe327d52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe00850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfb370>, '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 0xdfe8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfed80>, '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': '5cf47e208febbcd81da23b2e0000026f-1471350584.54030-1830642097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:30:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:30:04 INFO - Using env: {'DISPLAY': ':0', 05:30:04 INFO - 'HOME': '/home/cltbld', 05:30:04 INFO - 'LANG': 'en_US.UTF-8', 05:30:04 INFO - 'LANGUAGE': 'en_US:en', 05:30:04 INFO - 'LOGNAME': 'cltbld', 05:30:04 INFO - 'MAIL': '/var/mail/cltbld', 05:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:04 INFO - 'MOZ_NO_REMOTE': '1', 05:30:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:04 INFO - 'NO_EM_RESTART': '1', 05:30:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:04 INFO - 'PWD': '/builds/slave/test', 05:30:04 INFO - 'SHELL': '/bin/bash', 05:30:04 INFO - 'SHLVL': '1', 05:30:04 INFO - 'TERM': 'linux', 05:30:04 INFO - 'TMOUT': '86400', 05:30:04 INFO - 'USER': 'cltbld', 05:30:04 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471350584.54030-1830642097', 05:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:04 INFO - '_': '/tools/buildbot/bin/python'} 05:30:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:04 INFO - Downloading/unpacking psutil>=3.1.1 05:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:30:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:06 INFO - Installing collected packages: psutil 05:30:06 INFO - Running setup.py install for psutil 05:30:06 INFO - building 'psutil._psutil_linux' extension 05:30:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:30:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:30:07 INFO - building 'psutil._psutil_posix' extension 05:30:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:30:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:30:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:07 INFO - Successfully installed psutil 05:30:07 INFO - Cleaning up... 05:30:07 INFO - Return code: 0 05:30:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:30:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:07 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 0x7fe327d52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe00850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfb370>, '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 0xdfe8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfed80>, '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': '5cf47e208febbcd81da23b2e0000026f-1471350584.54030-1830642097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:30:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:30:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:30:07 INFO - Using env: {'DISPLAY': ':0', 05:30:07 INFO - 'HOME': '/home/cltbld', 05:30:07 INFO - 'LANG': 'en_US.UTF-8', 05:30:07 INFO - 'LANGUAGE': 'en_US:en', 05:30:07 INFO - 'LOGNAME': 'cltbld', 05:30:07 INFO - 'MAIL': '/var/mail/cltbld', 05:30:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:07 INFO - 'MOZ_NO_REMOTE': '1', 05:30:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:07 INFO - 'NO_EM_RESTART': '1', 05:30:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:07 INFO - 'PWD': '/builds/slave/test', 05:30:07 INFO - 'SHELL': '/bin/bash', 05:30:07 INFO - 'SHLVL': '1', 05:30:07 INFO - 'TERM': 'linux', 05:30:07 INFO - 'TMOUT': '86400', 05:30:07 INFO - 'USER': 'cltbld', 05:30:07 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471350584.54030-1830642097', 05:30:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:07 INFO - '_': '/tools/buildbot/bin/python'} 05:30:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:30:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:30:09 INFO - Installing collected packages: mozsystemmonitor 05:30:09 INFO - Running setup.py install for mozsystemmonitor 05:30:09 INFO - Successfully installed mozsystemmonitor 05:30:09 INFO - Cleaning up... 05:30:09 INFO - Return code: 0 05:30:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:09 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 0x7fe327d52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe00850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfb370>, '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 0xdfe8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfed80>, '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': '5cf47e208febbcd81da23b2e0000026f-1471350584.54030-1830642097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:30:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:30:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:30:09 INFO - Using env: {'DISPLAY': ':0', 05:30:09 INFO - 'HOME': '/home/cltbld', 05:30:09 INFO - 'LANG': 'en_US.UTF-8', 05:30:09 INFO - 'LANGUAGE': 'en_US:en', 05:30:09 INFO - 'LOGNAME': 'cltbld', 05:30:09 INFO - 'MAIL': '/var/mail/cltbld', 05:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:09 INFO - 'MOZ_NO_REMOTE': '1', 05:30:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:09 INFO - 'NO_EM_RESTART': '1', 05:30:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:09 INFO - 'PWD': '/builds/slave/test', 05:30:09 INFO - 'SHELL': '/bin/bash', 05:30:09 INFO - 'SHLVL': '1', 05:30:09 INFO - 'TERM': 'linux', 05:30:09 INFO - 'TMOUT': '86400', 05:30:09 INFO - 'USER': 'cltbld', 05:30:09 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471350584.54030-1830642097', 05:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:09 INFO - '_': '/tools/buildbot/bin/python'} 05:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:09 INFO - Downloading/unpacking jsonschema==2.5.1 05:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:30:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:11 INFO - Downloading functools32-3.2.3-2.tar.gz 05:30:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:30:11 INFO - warning: no files found matching '*.txt' 05:30:11 INFO - no previously-included directories found matching 'build' 05:30:11 INFO - no previously-included directories found matching 'dist' 05:30:11 INFO - no previously-included directories found matching '.git*' 05:30:11 INFO - Installing collected packages: jsonschema, functools32 05:30:12 INFO - Running setup.py install for functools32 05:30:12 INFO - warning: no files found matching '*.txt' 05:30:12 INFO - no previously-included directories found matching 'build' 05:30:12 INFO - no previously-included directories found matching 'dist' 05:30:12 INFO - no previously-included directories found matching '.git*' 05:30:12 INFO - Successfully installed jsonschema functools32 05:30:12 INFO - Cleaning up... 05:30:12 INFO - Return code: 0 05:30:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:30: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')]} 05:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30: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')]} 05:30:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:12 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 0x7fe327d52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe00850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfb370>, '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 0xdfe8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfed80>, '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': '5cf47e208febbcd81da23b2e0000026f-1471350584.54030-1830642097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:30:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:30:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:30:12 INFO - Using env: {'DISPLAY': ':0', 05:30:12 INFO - 'HOME': '/home/cltbld', 05:30:12 INFO - 'LANG': 'en_US.UTF-8', 05:30:12 INFO - 'LANGUAGE': 'en_US:en', 05:30:12 INFO - 'LOGNAME': 'cltbld', 05:30:12 INFO - 'MAIL': '/var/mail/cltbld', 05:30:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:12 INFO - 'MOZ_NO_REMOTE': '1', 05:30:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:12 INFO - 'NO_EM_RESTART': '1', 05:30:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:12 INFO - 'PWD': '/builds/slave/test', 05:30:12 INFO - 'SHELL': '/bin/bash', 05:30:12 INFO - 'SHLVL': '1', 05:30:12 INFO - 'TERM': 'linux', 05:30:12 INFO - 'TMOUT': '86400', 05:30:12 INFO - 'USER': 'cltbld', 05:30:12 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471350584.54030-1830642097', 05:30:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:12 INFO - '_': '/tools/buildbot/bin/python'} 05:30:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:30:12 INFO - Cleaning up... 05:30:12 INFO - Return code: 0 05:30:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:30: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')]} 05:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30: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')]} 05:30:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:12 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 0x7fe327d52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe00850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfb370>, '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 0xdfe8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfed80>, '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': '5cf47e208febbcd81da23b2e0000026f-1471350584.54030-1830642097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:30:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:30:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:30:12 INFO - Using env: {'DISPLAY': ':0', 05:30:12 INFO - 'HOME': '/home/cltbld', 05:30:12 INFO - 'LANG': 'en_US.UTF-8', 05:30:12 INFO - 'LANGUAGE': 'en_US:en', 05:30:12 INFO - 'LOGNAME': 'cltbld', 05:30:12 INFO - 'MAIL': '/var/mail/cltbld', 05:30:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:12 INFO - 'MOZ_NO_REMOTE': '1', 05:30:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:12 INFO - 'NO_EM_RESTART': '1', 05:30:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:12 INFO - 'PWD': '/builds/slave/test', 05:30:12 INFO - 'SHELL': '/bin/bash', 05:30:12 INFO - 'SHLVL': '1', 05:30:12 INFO - 'TERM': 'linux', 05:30:12 INFO - 'TMOUT': '86400', 05:30:12 INFO - 'USER': 'cltbld', 05:30:12 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471350584.54030-1830642097', 05:30:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:12 INFO - '_': '/tools/buildbot/bin/python'} 05:30:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:12 INFO - Downloading/unpacking blobuploader==1.2.4 05:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:14 INFO - Downloading blobuploader-1.2.4.tar.gz 05:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:30:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:30:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:15 INFO - Downloading docopt-0.6.1.tar.gz 05:30:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:30:15 INFO - Installing collected packages: blobuploader, requests, docopt 05:30:15 INFO - Running setup.py install for blobuploader 05:30:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:30:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:30:15 INFO - Running setup.py install for requests 05:30:15 INFO - Running setup.py install for docopt 05:30:15 INFO - Successfully installed blobuploader requests docopt 05:30:15 INFO - Cleaning up... 05:30:15 INFO - Return code: 0 05:30:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:15 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 0x7fe327d52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe00850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfb370>, '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 0xdfe8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfed80>, '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': '5cf47e208febbcd81da23b2e0000026f-1471350584.54030-1830642097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:30:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:30:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:30:15 INFO - Using env: {'DISPLAY': ':0', 05:30:15 INFO - 'HOME': '/home/cltbld', 05:30:15 INFO - 'LANG': 'en_US.UTF-8', 05:30:15 INFO - 'LANGUAGE': 'en_US:en', 05:30:15 INFO - 'LOGNAME': 'cltbld', 05:30:15 INFO - 'MAIL': '/var/mail/cltbld', 05:30:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:15 INFO - 'MOZ_NO_REMOTE': '1', 05:30:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:15 INFO - 'NO_EM_RESTART': '1', 05:30:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:15 INFO - 'PWD': '/builds/slave/test', 05:30:15 INFO - 'SHELL': '/bin/bash', 05:30:15 INFO - 'SHLVL': '1', 05:30:15 INFO - 'TERM': 'linux', 05:30:15 INFO - 'TMOUT': '86400', 05:30:15 INFO - 'USER': 'cltbld', 05:30:15 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471350584.54030-1830642097', 05:30:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:15 INFO - '_': '/tools/buildbot/bin/python'} 05:30:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:30:16 INFO - Running setup.py (path:/tmp/pip-4H9V9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:30:16 INFO - Running setup.py (path:/tmp/pip-IlNsaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:30:16 INFO - Running setup.py (path:/tmp/pip-pQd_vY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:30:16 INFO - Running setup.py (path:/tmp/pip-4bUS6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:30:16 INFO - Running setup.py (path:/tmp/pip-TmLLIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:30:16 INFO - Running setup.py (path:/tmp/pip-0FjBAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:30:16 INFO - Running setup.py (path:/tmp/pip-FGbvcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:30:16 INFO - Running setup.py (path:/tmp/pip-rJROZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:30:16 INFO - Running setup.py (path:/tmp/pip-GmGoCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:30:16 INFO - Running setup.py (path:/tmp/pip-Y5X_gx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:30:16 INFO - Running setup.py (path:/tmp/pip-ywnihK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:30:16 INFO - Running setup.py (path:/tmp/pip-GqHB6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:30:16 INFO - Running setup.py (path:/tmp/pip-y0JzPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:30:17 INFO - Running setup.py (path:/tmp/pip-jAbLIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:17 INFO - Running setup.py (path:/tmp/pip-sQI1LB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:30:17 INFO - Running setup.py (path:/tmp/pip-l2kb3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:30:17 INFO - Running setup.py (path:/tmp/pip-BCOJmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:30:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:30:17 INFO - Running setup.py install for manifestparser 05:30:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:30:17 INFO - Running setup.py install for mozcrash 05:30:17 INFO - Running setup.py install for mozdebug 05:30:17 INFO - Running setup.py install for mozdevice 05:30:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:30:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:30:17 INFO - Running setup.py install for mozfile 05:30:17 INFO - Running setup.py install for mozhttpd 05:30:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:30:17 INFO - Running setup.py install for mozinfo 05:30:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:30:18 INFO - Running setup.py install for mozInstall 05:30:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:30:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:30:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:30:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:30:18 INFO - Running setup.py install for mozleak 05:30:18 INFO - Running setup.py install for mozlog 05:30:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:30:18 INFO - Running setup.py install for moznetwork 05:30:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:30:18 INFO - Running setup.py install for mozprocess 05:30:18 INFO - Running setup.py install for mozprofile 05:30:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:30:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:30:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:30:18 INFO - Running setup.py install for mozrunner 05:30:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:30:18 INFO - Running setup.py install for mozscreenshot 05:30:18 INFO - Running setup.py install for moztest 05:30:18 INFO - Running setup.py install for mozversion 05:30:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:30:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:30:19 INFO - Cleaning up... 05:30:19 INFO - Return code: 0 05:30:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:19 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 0x7fe327d52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe00850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfb370>, '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 0xdfe8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfed80>, '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': '5cf47e208febbcd81da23b2e0000026f-1471350584.54030-1830642097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:30:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:30:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:30:19 INFO - Using env: {'DISPLAY': ':0', 05:30:19 INFO - 'HOME': '/home/cltbld', 05:30:19 INFO - 'LANG': 'en_US.UTF-8', 05:30:19 INFO - 'LANGUAGE': 'en_US:en', 05:30:19 INFO - 'LOGNAME': 'cltbld', 05:30:19 INFO - 'MAIL': '/var/mail/cltbld', 05:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:19 INFO - 'MOZ_NO_REMOTE': '1', 05:30:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:19 INFO - 'NO_EM_RESTART': '1', 05:30:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:19 INFO - 'PWD': '/builds/slave/test', 05:30:19 INFO - 'SHELL': '/bin/bash', 05:30:19 INFO - 'SHLVL': '1', 05:30:19 INFO - 'TERM': 'linux', 05:30:19 INFO - 'TMOUT': '86400', 05:30:19 INFO - 'USER': 'cltbld', 05:30:19 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471350584.54030-1830642097', 05:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:19 INFO - '_': '/tools/buildbot/bin/python'} 05:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:30:19 INFO - Running setup.py (path:/tmp/pip-kf4aHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:30:19 INFO - Running setup.py (path:/tmp/pip-w2WXEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:30:19 INFO - Running setup.py (path:/tmp/pip-1HjtEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:30:19 INFO - Running setup.py (path:/tmp/pip-czXs38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:30:19 INFO - Running setup.py (path:/tmp/pip-JfywbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:30:19 INFO - Running setup.py (path:/tmp/pip-TpPZKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:30:19 INFO - Running setup.py (path:/tmp/pip-K1rkz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:30:19 INFO - Running setup.py (path:/tmp/pip-NgHnVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:30:19 INFO - Running setup.py (path:/tmp/pip-p6NslG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:30:20 INFO - Running setup.py (path:/tmp/pip-6NFx8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:30:20 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)) 05:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:30:20 INFO - Running setup.py (path:/tmp/pip-vIbmcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:30:20 INFO - Running setup.py (path:/tmp/pip-X4qJsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:30:20 INFO - Running setup.py (path:/tmp/pip-d10edF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:30:20 INFO - Running setup.py (path:/tmp/pip-RdIFOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:20 INFO - Running setup.py (path:/tmp/pip-ydIpxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:30:20 INFO - Running setup.py (path:/tmp/pip-C8buhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:30:20 INFO - Running setup.py (path:/tmp/pip-lXe4J6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:30:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:30:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:22 INFO - Downloading blessings-1.6.tar.gz 05:30:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:30:22 INFO - Installing collected packages: blessings 05:30:22 INFO - Running setup.py install for blessings 05:30:22 INFO - Successfully installed blessings 05:30:22 INFO - Cleaning up... 05:30:22 INFO - Return code: 0 05:30:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:30:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:30:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:30:22 INFO - Reading from file tmpfile_stdout 05:30:22 INFO - Current package versions: 05:30:22 INFO - argparse == 1.2.1 05:30:22 INFO - blessings == 1.6 05:30:22 INFO - blobuploader == 1.2.4 05:30:22 INFO - docopt == 0.6.1 05:30:22 INFO - functools32 == 3.2.3-2 05:30:22 INFO - jsonschema == 2.5.1 05:30:22 INFO - manifestparser == 1.1 05:30:22 INFO - mozInstall == 1.12 05:30:22 INFO - mozcrash == 0.17 05:30:22 INFO - mozdebug == 0.1 05:30:22 INFO - mozdevice == 0.48 05:30:22 INFO - mozfile == 1.2 05:30:22 INFO - mozhttpd == 0.7 05:30:22 INFO - mozinfo == 0.9 05:30:22 INFO - mozleak == 0.1 05:30:22 INFO - mozlog == 3.3 05:30:22 INFO - moznetwork == 0.27 05:30:22 INFO - mozprocess == 0.23 05:30:22 INFO - mozprofile == 0.28 05:30:22 INFO - mozrunner == 6.12 05:30:22 INFO - mozscreenshot == 0.1 05:30:22 INFO - mozsystemmonitor == 0.3 05:30:22 INFO - moztest == 0.7 05:30:22 INFO - mozversion == 1.4 05:30:22 INFO - psutil == 3.1.1 05:30:22 INFO - requests == 1.2.3 05:30:22 INFO - wsgiref == 0.1.2 05:30:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:22 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 0x7fe327d52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe00850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfb370>, '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 0xdfe8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfed80>, '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': '5cf47e208febbcd81da23b2e0000026f-1471350584.54030-1830642097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:30:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:30:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:30:22 INFO - Using env: {'DISPLAY': ':0', 05:30:22 INFO - 'HOME': '/home/cltbld', 05:30:22 INFO - 'LANG': 'en_US.UTF-8', 05:30:22 INFO - 'LANGUAGE': 'en_US:en', 05:30:22 INFO - 'LOGNAME': 'cltbld', 05:30:22 INFO - 'MAIL': '/var/mail/cltbld', 05:30:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:22 INFO - 'MOZ_NO_REMOTE': '1', 05:30:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:22 INFO - 'NO_EM_RESTART': '1', 05:30:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:22 INFO - 'PWD': '/builds/slave/test', 05:30:22 INFO - 'SHELL': '/bin/bash', 05:30:22 INFO - 'SHLVL': '1', 05:30:22 INFO - 'TERM': 'linux', 05:30:22 INFO - 'TMOUT': '86400', 05:30:22 INFO - 'USER': 'cltbld', 05:30:22 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471350584.54030-1830642097', 05:30:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:22 INFO - '_': '/tools/buildbot/bin/python'} 05:30:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:30:23 INFO - Cleaning up... 05:30:23 INFO - Return code: 0 05:30:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:30:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe327d52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe00850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfb370>, '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 0xdfe8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfed80>, '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': '5cf47e208febbcd81da23b2e0000026f-1471350584.54030-1830642097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:30:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:30:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:30:23 INFO - Using env: {'DISPLAY': ':0', 05:30:23 INFO - 'HOME': '/home/cltbld', 05:30:23 INFO - 'LANG': 'en_US.UTF-8', 05:30:23 INFO - 'LANGUAGE': 'en_US:en', 05:30:23 INFO - 'LOGNAME': 'cltbld', 05:30:23 INFO - 'MAIL': '/var/mail/cltbld', 05:30:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:23 INFO - 'MOZ_NO_REMOTE': '1', 05:30:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:23 INFO - 'NO_EM_RESTART': '1', 05:30:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:23 INFO - 'PWD': '/builds/slave/test', 05:30:23 INFO - 'SHELL': '/bin/bash', 05:30:23 INFO - 'SHLVL': '1', 05:30:23 INFO - 'TERM': 'linux', 05:30:23 INFO - 'TMOUT': '86400', 05:30:23 INFO - 'USER': 'cltbld', 05:30:23 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471350584.54030-1830642097', 05:30:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:23 INFO - '_': '/tools/buildbot/bin/python'} 05:30:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:30:23 INFO - Cleaning up... 05:30:23 INFO - Return code: 0 05:30:23 INFO - Running post-action listener: _resource_record_post_action 05:30:23 INFO - Running post-action listener: _start_resource_monitoring 05:30:23 INFO - Starting resource monitoring. 05:30:23 INFO - [mozharness: 2016-08-16 12:30:23.444246Z] Finished create-virtualenv step (success) 05:30:23 INFO - [mozharness: 2016-08-16 12:30:23.444745Z] Running install step. 05:30:23 INFO - Running pre-action listener: _resource_record_pre_action 05:30:23 INFO - Running main action method: install 05:30:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:30:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:30:23 INFO - Reading from file tmpfile_stdout 05:30:23 INFO - Detecting whether we're running mozinstall >=1.0... 05:30:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:30:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:30:23 INFO - Reading from file tmpfile_stdout 05:30:23 INFO - Output received: 05:30:23 INFO - Usage: mozinstall [options] installer 05:30:23 INFO - Options: 05:30:23 INFO - -h, --help show this help message and exit 05:30:23 INFO - -d DEST, --destination=DEST 05:30:23 INFO - Directory to install application into. [default: 05:30:23 INFO - "/builds/slave/test"] 05:30:23 INFO - --app=APP Application being installed. [default: firefox] 05:30:23 INFO - mkdir: /builds/slave/test/build/application 05:30:23 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'] 05:30:23 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 05:30:40 INFO - Reading from file tmpfile_stdout 05:30:40 INFO - Output received: 05:30:40 INFO - /builds/slave/test/build/application/firefox/firefox 05:30:40 INFO - Running post-action listener: _resource_record_post_action 05:30:40 INFO - [mozharness: 2016-08-16 12:30:40.655530Z] Finished install step (success) 05:30:40 INFO - [mozharness: 2016-08-16 12:30:40.655777Z] Running run-tests step. 05:30:40 INFO - Running pre-action listener: _resource_record_pre_action 05:30:40 INFO - Running main action method: run_tests 05:30:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:30:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:30:40 INFO - Python 2.7.3 05:30:40 INFO - Return code: 0 05:30:40 INFO - grabbing minidump binary from tooltool 05:30:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:40 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 0xdfb370>, '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 0xdfe8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdfed80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:30:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:30:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:30:40 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:30:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:30:40 INFO - Return code: 0 05:30:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:30:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:30:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:30:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:30:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:30:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J9spd8UbT3qp_OKvNcii3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:30:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J9spd8UbT3qp_OKvNcii3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:30:40 INFO - Using env: {'DISPLAY': ':0', 05:30:40 INFO - 'HOME': '/home/cltbld', 05:30:40 INFO - 'LANG': 'en_US.UTF-8', 05:30:40 INFO - 'LANGUAGE': 'en_US:en', 05:30:40 INFO - 'LOGNAME': 'cltbld', 05:30:40 INFO - 'MAIL': '/var/mail/cltbld', 05:30:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:30:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:30:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:40 INFO - 'MOZ_NO_REMOTE': '1', 05:30:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:30:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:40 INFO - 'NO_EM_RESTART': '1', 05:30:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:40 INFO - 'PWD': '/builds/slave/test', 05:30:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:30:40 INFO - 'SHELL': '/bin/bash', 05:30:40 INFO - 'SHLVL': '1', 05:30:40 INFO - 'TERM': 'linux', 05:30:40 INFO - 'TMOUT': '86400', 05:30:40 INFO - 'USER': 'cltbld', 05:30:40 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471350584.54030-1830642097', 05:30:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:40 INFO - '_': '/tools/buildbot/bin/python'} 05:30:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J9spd8UbT3qp_OKvNcii3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:30:40 INFO - mozversion application_buildid: 20160816023007 05:30:40 INFO - mozversion application_changeset: b773199257dc43a4ed4ded8f41dc01f12e2ba222 05:30:40 INFO - mozversion application_display_name: Nightly 05:30:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:30:40 INFO - mozversion application_name: Firefox 05:30:40 INFO - mozversion application_remotingname: firefox 05:30:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:30:40 INFO - mozversion application_vendor: Mozilla 05:30:40 INFO - mozversion application_version: 51.0a1 05:30:40 INFO - mozversion platform_buildid: 20160816023007 05:30:40 INFO - mozversion platform_changeset: b773199257dc43a4ed4ded8f41dc01f12e2ba222 05:30:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:30:40 INFO - mozversion platform_version: 51.0a1 05:30:40 INFO - using testdate: 1471350640 05:30:40 INFO - actual date: 1471350640 05:30:40 INFO - starting webserver on 'localhost:55689' 05:30:40 INFO - SUITE-START | Running 2 tests 05:30:40 INFO - TEST-START | dromaeo_css 05:30:40 INFO - operating with platform_type : linux_ 05:30:40 INFO - Initialising browser for dromaeo_css test... 05:30:40 INFO - TEST-INFO | started process 8133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHoJH37/profile http://localhost:55689/getInfo.html) 05:30:46 INFO - PROCESS | 8133 | __metrics Screen width/height:1600/1200 05:30:46 INFO - PROCESS | 8133 | colorDepth:24 05:30:46 INFO - PROCESS | 8133 | Browser inner width/height: 1024/697 05:30:46 INFO - PROCESS | 8133 | __metrics 05:30:46 ERROR - PROCESS | 8133 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 05:30:47 INFO - TEST-INFO | 8133: exit 0 05:30:47 INFO - Browser initialized. 05:30:47 INFO - Running cycle 1/1 for dromaeo_css test... 05:30:47 INFO - TEST-INFO | started process 8254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHoJH37/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:30:59 INFO - PROCESS | 8254 | RSS: Main: 163569664 05:30:59 INFO - PROCESS | 8254 | 05:31:48 INFO - PROCESS | 8254 | 1471350708890 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:33:58 INFO - PROCESS | 8254 | Cycle 1(1): loaded http://localhost:55689/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55689/tests/dromaeo/cssquery-ext.html) 05:33:59 INFO - PROCESS | 8254 | RSS: Main: 167333888 05:33:59 INFO - PROCESS | 8254 | 05:37:01 INFO - PROCESS | 8254 | Cycle 1(1): loaded http://localhost:55689/tests/dromaeo/cssquery-ext.html (next: http://localhost:55689/tests/dromaeo/cssquery-jquery.html) 05:37:01 INFO - PROCESS | 8254 | RSS: Main: 166199296 05:37:01 INFO - PROCESS | 8254 | 05:40:03 INFO - PROCESS | 8254 | Cycle 1(1): loaded http://localhost:55689/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55689/tests/dromaeo/cssquery-mootools.html) 05:40:04 INFO - PROCESS | 8254 | RSS: Main: 166457344 05:40:04 INFO - PROCESS | 8254 | 05:43:06 INFO - PROCESS | 8254 | Cycle 1(1): loaded http://localhost:55689/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55689/tests/dromaeo/cssquery-prototype.html) 05:43:06 INFO - PROCESS | 8254 | RSS: Main: 164122624 05:43:06 INFO - PROCESS | 8254 | 05:46:09 INFO - PROCESS | 8254 | Cycle 1(1): loaded http://localhost:55689/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55689/tests/dromaeo/cssquery-yui.html) 05:46:10 INFO - PROCESS | 8254 | RSS: Main: 167006208 05:46:10 INFO - PROCESS | 8254 | 05:49:13 INFO - PROCESS | 8254 | Cycle 1(1): loaded http://localhost:55689/tests/dromaeo/cssquery-yui.html (next: http://localhost:55689/tests/dromaeo/cssquery-dojo.html) 05:49:13 INFO - PROCESS | 8254 | RSS: Main: 167403520 05:49:13 INFO - PROCESS | 8254 | 05:49:13 INFO - PROCESS | 8254 | __start_tp_report 05:49:13 INFO - PROCESS | 8254 | _x_x_mozilla_page_load 05:49:13 INFO - PROCESS | 8254 | _x_x_mozilla_page_load_details 05:49:13 INFO - PROCESS | 8254 | |i|pagename|runs| 05:49:13 INFO - PROCESS | 8254 | |0;dojo.html;3030.1969977955837;3047.558104074908;3048.4969979953307;3057.908262752117;3072.5391191321314;5210.374755029402;5242.266082748413;5337.8398648040575;5352.946470535294;5372.650777699447;5242.580593552516;5280.1551751719735;5286.418493965661;5306.124489459245;5329.173978033401;4734.455537613184;4815.518448155191;4863.337227997648;4879.341288926003;4961.20620700688;4948.455669876311;4964.528369804862;4986.950130498685;5010;5045;4773.618110551148;4806.927896081562;4838.395200599925;4895.828645997391;4901.975490122544;4850.442199147108;4856.708597484127;4875.7074575525585;4889.511048895118;4902.166631672624;4795.472498025214;4797.160496913027;4800.975995120002;4825.493323201048;4836.879078023042;5130.666506677054;5206.635535512516;5265.157574788015;5267.078261304257;5276.683398996072;5633.070543360341;5650.717464126818;5671.858203544944;5685;5716.056850619642;5657.8019769307875;5671.319441667027;5697.487226149625;5707.942920570824;5716.742746576414;5166.302549155854;5267.55225805807;5268.157094864841;5283.128283833124;5320.281761962163;5758.654480731169;5800.361960184377;5803.129530570363;5829.562782791308;5864.648121112747;5572.60991730575;5611.2144299798065;5625.606207565513;5630.8029218977135;5640;5547.1679248113105;5558.833235002957;5581.49766521015;5599.944000560024;5700.173474846207;5584.720763961785;5615.8596035098635;5621.409751976065;5640.435956404327;5663.518600918886;5603.663780173202;5607.074832652648;5621.831345059655;5657.038303488417;5659.915101273484;4251.787410629456;4287.6998610097;4358.825646974085;4363.061941682554;4365.738055716667;3884.6892248620043;3886.261610294035;3892.805359732002;3921.784301863368;3923;5391.16436952273;5415.350157981067;5417.295751552352;5429.67421954684;5465.262189604353;5519.862003449865;5582.720863956786;5586.385497595261;5616.1014237721765;5697.173909783059;5301.284326615934;5323.30796996388;5323.680579165185;5332;5383.300170977748;4820.566149046603;4832.9275060874115;4833.685810422311;4846.273059041101;4911.778969946289;5700.25896633435;5757.021306377926;5832.737526811304;5871.911921321183;5918.615290006222;5752.194692742935;5758.0499217630295;5771.07662773971;5795.739191736467;5803.129530570448;5954.345022047484;5956.434138756811;5956.940430595639;5958.225430693982;5962.19510366095;5450.5367043801725;5555.861103472445;5557.249771280987;5567.8886422272135;5612.522935550524;5702.600817942704;5744.856378590569;5756.481916627356;5764.510016648632;5792.275965504312;5592.161175823659;5615.550755939434;5630.493255607015;5634.183043458594;5635.492805647511;5412.134058550613;5490.313710786152;5556.805511807067;5583.162525621189;5601.5238704710555;5562.805301814417;5566.554675626021;5572.359178694502;5621.831345059655;5634.2393776841245;5567.526760225264;5608.046632072639;5633.943660563342;5638.802641907513;5658.207850900795;5254.632175747661;5381.48875856793;5429.701366424727;5479.671219726829;5504.779808807763 05:49:13 INFO - PROCESS | 8254 | |1;ext.html;541.1484885639744;580.4949693766421;584.6375247346645;596.7374355283675;611.2084850119095;38757.41863872041;42740.99999999996;42771.57228427715;42813.78593107034;42865;39662;40127.19745605086;40144.39783403244;40165.59834401655;40539.39190912139;8835.204831565174;8960.551972401354;8990.820183596325;8994.910050899505;9003.819923601524;8801.163889430525;8804.735857924241;8870.246029087535;8898.065703101145;8910.643574257021;8898.199162075412;8922.910770892273;8961.193492585666;8970.551472426352;8974.955125224365;8873.467591944473;8921.55392230389;8948;8954.328425368123;8963.955180224122;8746.73759787201;8874.334424918092;8875.778105547348;8879.733607991771;8900.287976961827;38130.42804357937;38318.23363532714;38420;38702.61297387046;38706.41940370897;3179.316446963891;3581.5702115746276;3795.2599243147597;4064.166845796605;4155.10665206979;31618.209544761336;32081.83959080213;32197;32371.190720231945;32515.837420812746;4150.659471525901;4192.266353388145;4285.507166675841;4344.63070638996;4378.540253273424;350462;350853;351346;351714;352823.2358838215;53825;54203.72898135484;54217;54318;54420.183697244574;38967;39612.60387396089;39725.80137099296;39725.80137099354;39734.40398394026;14945.925270373797;14980.925095374454;15047.247637618075;15099;15110.244487775568;11204.495797689124;11296.54813807455;11319.151063670257;11359.772804543863;11362.772744545064;19482.512937176685;19550.608987820164;19559.11983960725;19566.988767302668;19608.313709020116;7151.213366529678;7166.53417527859;7189.281071892873;7205.747798827121;7281.162666293338;887.3300658003167;914.4558987402485;1025.1644909398817;1101.9558718577084;1124.8312753087102;30228.395432091234;33083;33106.17234569107;33163.17092072718;33222;1042.525650828871;1058.772363941756;1081.6160263106642;1097.1880808201872;1110.7167672243527;16755.581110472092;17111.91444042797;17318.567035824206;17387.217575209146;17410.738838917427;514648;517842;520395;522988;525234;60288.698556507814;60587;60807.69596151991;60896;61194.694026529585;1286.343964578072;1321.7951217561485;1322.4247452358254;1323.6360000999803;1340.7184491256946;29659.851700741357;31173.376532469676;32349.676503234667;32358.19104522406;32595.718299718792;52301.7384913073;52496;52663.473365265854;52683.73658131685;52752.47247527476;498404;498963;500226;501964;504015;29446.411071778017;29607.703922961355;29936.25159371033;30014.69985300119;30058.098257052323;49350.25974610312;49694.25458618051;49884;49966;50212.748936255084;40850.387244190766;41602;43606.781966091236;45023.774881126694;46021.76989115033;37657.62342376541;37712.48541888989;38396.232075358894;38626.80686596549;39296.60703392929;41160.79419602883;41630.58369416267;41819.581804181566;42424.36363454613;42722.57277427186;35996;36947.44578831266;38232.42651360288;38636.80681596574;38798.80600597092;28776.083147498903;28776.56835147516;29247.85376073106;29547.556786647787;29553.26116847096 05:49:13 INFO - PROCESS | 8254 | |2;jquery.html;397.3304981106837;398.37256321293967;407.66775078311184;409.6354244722197;426.97651629160384;18225.817741822593;20032;20091.698624520643;20120.89939550302;20608.9695515224;18971.52571185721;19289.80710192898;19295;19593.02034898253;19631;5353.437889021665;5618.129189975561;5845.707714614274;5897.882042359151;5968.074948383008;5837.474627283544;5842;5862.120681897707;5871.1193321001765;5880.55895807814;5902.704864756766;5983.820485385424;6008.75964961401;6050.909236361458;6057.666828324441;5914.733836977346;5961.463468287853;5999.040153575451;6016.518678505709;6034.426729460716;5761.222234998306;5779.653220806765;5817.563682723812;5825.417458254141;5844.9415505845245;14338.35477403509;14528.854711452961;14992.400303987828;15002.62493437662;15010.099394036393;2270.126001489422;2279.7492275849645;2325.058351367699;2380.4405964598304;2417.987910060456;10319.678072433717;10435.426051567161;10624.893751062546;10772.299800512941;10870.836937445945;1893.8768980016255;1908.23670531787;1955.4622478818296;1972.0829814136353;2041.0815133190124;81693;83068;84407.99999999939;85624;85651;10989.780204396027;11016.339019658686;11187.888121118847;11442.485088171052;11458;15836.366545338287;15961.600959976093;15966.680666386606;16013.119278439797;16018.359265629477;7100.857982840314;7195.92804071963;7220.386267167244;7229.168645605822;7496.437767167485;6239.875202495925;6272.937270627326;6434.806955791334;6443.194600674916;6459.483241340681;4803.567678908845;4832.371791667061;4844.467108618049;4934.629902757308;5102;2001.5496513284395;2001.899905004744;2002.8397728182001;2050.4668786115717;2097.6643737002005;911.4759013567225;989.5349185882624;1010.2170817616259;1028.7633844215873;1031.7111208861531;19959.4640468063;19988;20098.89950550238;20250.291239806535;20262.493437664176;960.8798900137483;963.7879666473365;966.3235734985539;1022.7085280694967;1047.2773786087575;10826.783464330669;10922.344659320466;11269.154813388865;11327.207095503236;11395.430228488542;447075;452914;456248;457363;481298;89730.55134724415;90859;91460.54269728609;91473;92051.61922571032;986.1765425869336;1001.0290018681867;1005.3766664667953;1055.3456856748712;1057.2704833664748;14664.780028299798;16175.27211275519;17655.790784557907;18272.451826445227;18409.171587278335;39991;43190.40857548557;43461.782691086344;45631;46613.3008004887;50727;57090.42909571017;58889.70555147197;60016.39983600108;60564.39435605588;8076.111627721063;8155.918440815516;8232.217939295757;8525.317974561896;9069.727908162766;6868.793936181923;11318.434078295888;11618.186726929034;12129;12538.87461125377;11138.832917506406;11160.944195278971;11240.381779002233;11250.606228781953;11524.135689823464;10613.20400969915;10667.253292269466;10973.945130274298;11136;11319.660410187707;10657.413842238751;11044.668659940215;11101.666949991513;11291.153163512605;11638.777928317744;8710.259627931444;8893.110688931056;8945.552722363986;8987.685431009882;9491.66779162726;9929.3545919515;11258.21192516516;11259.549618015188;11448.255863368855;11559.07527397823 05:49:13 INFO - PROCESS | 8254 | |3;mootools.html;1493.1041375174893;1500.2648702135953;1652.388616212001;1738.6001219719456;1765.8852174608658;7260.092488438945;7875.724349647763;7978.6808527658895;8597.3122150228;8599.183077607626;8216.260536551708;8282.91717082829;8310.085890552034;8329.250367466926;8370.497770133796;2318.13070098713;2363.291012696193;2366.526694661066;2367.7750613691674;2368.3842201027683;2286.7598902115287;2296.0586159674535;2341.519988402382;2367.088670861722;2374.287713685896;2282.2924893283134;2302.194232018797;2311.9653205201935;2357.57563638545;2358.1157066100213;2277.0664027748626;2289.1415719105335;2293.415179129328;2301.9654705179437;2303.2974942642572;2236;2249.2352600115873;2252.279270633398;2252.3468194223656;2256.954860902773;8426.705065322683;8436;8459;8482.87275690859;8538.44500107491;5042.773075211624;5223.582113430954;5226.660267082628;5240.056789777838;5269.6311258211945;3256.5278034685075;3319.867205311785;3382.695557399821;3420.538227339302;3460.688538031564;1178.6994316449336;1210.3706072842074;1211.5577814097878;1222.1322860768864;1236.9876301236961;11526.884731152664;11640.18518703691;11647.184697071209;11706.590269340531;11721.88278117225;4317.229935726337;4468.620167285752;4615.584597386184;4629.791659375336;4638.6752927294765;9832.557534910946;9867.654632087842;9896.851547226797;9916.603335866628;9922.305438619373;5176.922346164811;5200.089984252816;5203.583713302926;5206.088934436459;5214.296070030573;4171.10321280926;4564.589186973189;4665.790039448233;4677.719336839732;4782.426108866889;3779.9244015119543;3919.1769728356794;3923.6861051115843;3939.1924655445564;4042.191561687674;1280.3150314581653;1285.3765923527083;1287.4206607026874;1300.9089363744447;1309.8952083833271;884.2439714044399;911.1389736698889;926.333040211047;948.7817801905601;969.7721035556639;5690.658560486384;5692.57305702074;5883.14694369314;5903.970480147657;6019.337872833985;985.0691096913491;993.7515621094726;1003.2074661017714;1020.1889497849228;1029.4955471818755;3838.9232215355537;3862.5129325209996;3916;4131.029208136086;4139.855105071308;10482.213833962483;10701.03690667828;10702.73243168927;10708.571657133783;10716.624918127984;10637.893621063691;10641.467926603638;10672.252942293964;10686;10698.090662293636;7320.9267907320245;7587.279208475186;7664.425168112414;7674.386049116169;7812.218778122142;5794.884102317846;5870.765169393348;5879.559033072451;5932.733027013708;6067.271927368744;9212.355135140744;9358.11097945694;9416.482093484925;9468.621255149717;9487.193588545051;8952.731418057208;9526.666566670134;9568.80389951256;9778.41329520231;9784;7130.180029296697;7773.961130194313;7988.121306656147;8071.273585377344;8318.085010648945;8412.831743364975;8438.071812100541;8450.577471126297;8470.83058338842;8504.53225072627;7174.390176834819;7402.9629851850395;7569.394448444222;7611.923880761343;7638.274363935418;6985.406240469414;7287.125544934642;7312.378447831994;7397.075365579302;7467;6436.259830119409;6439.710213040331;6486.9351306488215;6488.480921526172;6507.934920650733;4811.158047341772;4871.269309603588;4940.333055037524;4969.378827646544;5043.596512279082;4769.61843052548;4802.303665968485;4840.854774356775;4944.75276236194;5033.169527028146 05:49:13 INFO - PROCESS | 8254 | |4;prototype.html;332.7689597798455;336.9831508424579;345.6388074462188;350.8333541567757;351.89619062376596;5376;5386.569074474042;5597.748101335439;5621;5654.180143879135;5326.547243484309;5413.296271484712;5448.782048718046;5453.291072160623;5464.808731694382;4357.912841743179;4367.148406060819;4374.03771170342;4394.121175764843;4408.126546217861;4254.893627659302;4375.518692943773;4385.048653349261;4420.823167073329;4427.180971520263;4323.610875021247;4332.263515202423;4341.479022517302;4344.717593356421;4348.108637729274;4325.329573916048;4341.370501277297;4352.194843953863;4364.083542456088;4380.6276466500385;3604.873829415958;3900.687944964396;3906.726529142961;3919.510061242345;3937.251922134785;5300.44345343741;5339.65292256006;5343.893122137535;5374.328208973879;5400.487863398254;4920.852374428773;4921.80312787488;4939.6789208701675;4942.393722040315;4970.552650261494;5461.808836690697;5737.254156959611;5743.798967036134;5756.121939030485;5804.680742559158;4232.090100628379;4244.257254980397;4258.169656916903;4263.893402664927;4279.251131052053;6059.909101363483;6083.6349819011;6086.6348019119;6116.327204007555;6118.541109416767;4228.556001619786;4293.635041021485;4309.181255561433;4395.384646149541;4400.867973960786;4371.606555410029;4373.912521749611;4376.3654270130655;4376.627986621109;4390.143921935192;4981.2030075187795;4990.17662085759;5020.497950205024;5026.321446604735;5036.32009678696;5730.512906402919;5833.620814647034;5852.736626851802;5883.911741323884;5898.14476900847;1476.2987580899203;1526.221626970231;1529.4781692216093;1529.5640742388366;1531.4563330017907;972.7762614598682;999.8100360931545;1012.9290949633455;1019.898010198989;1021.402479549457;4916.50046735749;4917.975410122926;4940.555350018443;4940.925886111711;4944.826931057396;5225.4635290594815;5247.816326428633;5263.894722105537;5295.602829787781;5304.257403963448;4692.436907571113;4952.826651067196;4985.684519794296;4993.325901003318;5024.572911302507;2751.8073734838367;2773.3205364685377;2813.6482939632547;2827.886884524596;2832.1928250448523;5426.484483974016;5432.239486471897;5447.836564903059;5457.2359869618285;5478.561715062785;5048.949510504922;5276;5337.7989952261205;5366.370478465602;5394.676319420769;5310.495502927216;5371.62398632092;5389.380221274603;5417.729113544307;5441.755121019563;5199.946021321482;5222.764975576032;5258.8948221036135;5316.016536940679;5360.839174824761;4868.269759536098;5064.82273120439;5125;5127.230915362726;5147.948520514747;5367.704776237344;5403.324584426947;5417.6478528895495;5471.699056551928;5513.062779327604;4001;4016.0763024503945;4025.5370632377653;4031.879043628696;4037.8384864605086;5571.387147413862;5818.4763371296785;5977;6016.278046634432;6036;5871.442212989759;5874.853128671817;5876.764929402776;5918.556108291981;5919.141724449844;5811.82564523065;5813.79651712188;5819.127130930395;5827.650340979555;5864.9413505864395;5618.634788738719;5757.453041961007;5777.653340799566;5778.711064446845;5833.095870140135;5889.823305300848;5903.704814759159;5916.201312822714;5948.851278718067;5960.76156953717;5451.391839407305;5720.741436883879;5725;5730.765001649277;5742.339630942495 05:49:13 INFO - PROCESS | 8254 | |5;yui.html;625.3059104394122;672.6939242644601;708.3200127877237;718.1956209045869;749.4341771962166;14091;14246.358913848875;14852.18312992785;14879.47921822735;14879.851201487982;14945.551633450987;15050;15152.545423637308;15197.24013799311;15223.847761522382;786.67746224048;788.0385929166437;788.2314743125464;791.7189397763798;794.2018271636997;824.884516167734;826.305903041445;828.7513745876244;830.4104086098877;833.6665333866441;870.2472361407368;870.6691457246237;871.2594294849391;871.760265926872;872.8472517309477;859.5057841740993;865.536937738307;866.017070624839;866.7139843851545;867.9739607811775;631.9652419116946;637.0158105726664;637.3339859846425;639.1882309466951;639.5203597302024;16337.754933676004;16513.504594862174;16513.587160320967;16524.25640846165;16557.25492352835;14661.41354345825;14705.92647036758;14826.851731482655;14860.256987150598;14887.70224595502;12045;12118.81821772674;12128.151029427943;12445.813312800316;12698.365081745877;3829.5978922213044;3844.1350696093436;3874.7093967952515;3901.336772748611;4028.234635419261;85089;85696;85905;86146;86607;11366;11390.829137562943;11546;11547.133964952662;11570.132240082028;22236.666450003264;22246.332610021724;22337.44156396103;22393.104275828784;22444.214452494085;8200.42597018203;8524.70163544273;8893.510856902933;8979.281657467387;8991.460512369278;4531.682782205214;4569.817207311737;4658.277966915133;4684.180268453007;4866.245731911559;3233.159378561591;3302.752293577991;3319.8838040668943;3332.5334453176574;3340.565726455594;538.090626840638;538.4749868877813;548.9752961116759;553.8670719027485;555.8138023762085;515.2477383020831;595.7709216049025;628.1269036039909;653.2879161713755;674.8460133172232;9019.594118264693;9424.811503770023;9498.667546635972;9519.243733988518;9693.70918872435;583.9926127430149;620.404411764711;643.4080645805869;650.4763665249425;661.9238787539495;4308.852652004484;4485.170243504962;4485.618722408632;4488.326750987313;4625.4911959684405;119878.4006079964;121847.39076304562;124762;125575;131263;76832.61583692046;107940;109253.45373273082;112049.43975280071;112868.43565782119;77863.61068194623;89772.55113724389;90675;92401.53799231096;93465.53267233756;9515.04849515043;9911.687382278913;9961.153301969414;10042.899571004196;10062.345947513388;48914;50094.74952625213;50516.74741626268;50812.49187508078;52002.21996669977;75140;75623.29485312832;76540.61729691316;77455;77798.6110069446;12218.327991960528;12480.687982800502;12506.374681266083;12560.874391256337;12803.679908002374;13763.46647214405;13872.861271387157;14243.501477448239;14295.428182872569;14731.852681473049;13181.80227296572;13445.957765837811;13610.183388996691;13614.251216183206;13899.652508687364;13209.471621135048;13460.050613703808;13460.461581536629;13530.18818870871;13730.588082357544;13215.405306761026;13469.46122155142;13572.457101715821;13575.185488870698;13973.231472268717;10476.580936762444;10551;10953.068989136013;10963.177761668067;10976.945115274373;9707.708768736667;10588.947055264674;11133.721656958642;11296.887031129583;11359.432028398713 05:49:13 INFO - PROCESS | 8254 | __end_tp_report 05:49:13 INFO - PROCESS | 8254 | __start_cc_report 05:49:13 INFO - PROCESS | 8254 | _x_x_mozilla_cycle_collect,319 05:49:13 INFO - PROCESS | 8254 | __end_cc_report 05:49:13 INFO - PROCESS | 8254 | __startTimestamp1471351753332__endTimestamp 05:49:13 INFO - PROCESS | 8254 | 05:49:13 INFO - PROCESS | 8254 | ------- Summary: start ------- 05:49:13 INFO - PROCESS | 8254 | Number of tests: 6 05:49:13 INFO - PROCESS | 8254 | 05:49:13 INFO - PROCESS | 8254 | [#0] dojo.html Cycles:165 Average:5278.90 Median:5504.78 stddev:598.60 (10.9%) stddev-sans-first:573.85 05:49:13 INFO - PROCESS | 8254 | Values: 3030.2 3047.6 3048.5 3057.9 3072.5 5210.4 5242.3 5337.8 5352.9 5372.7 5242.6 5280.2 5286.4 5306.1 5329.2 4734.5 4815.5 4863.3 4879.3 4961.2 4948.5 4964.5 4987.0 5010.0 5045.0 4773.6 4806.9 4838.4 4895.8 4902.0 4850.4 4856.7 4875.7 4889.5 4902.2 4795.5 4797.2 4801.0 4825.5 4836.9 5130.7 5206.6 5265.2 5267.1 5276.7 5633.1 5650.7 5671.9 5685.0 5716.1 5657.8 5671.3 5697.5 5707.9 5716.7 5166.3 5267.6 5268.2 5283.1 5320.3 5758.7 5800.4 5803.1 5829.6 5864.6 5572.6 5611.2 5625.6 5630.8 5640.0 5547.2 5558.8 5581.5 5599.9 5700.2 5584.7 5615.9 5621.4 5640.4 5663.5 5603.7 5607.1 5621.8 5657.0 5659.9 4251.8 4287.7 4358.8 4363.1 4365.7 3884.7 3886.3 3892.8 3921.8 3923.0 5391.2 5415.4 5417.3 5429.7 5465.3 5519.9 5582.7 5586.4 5616.1 5697.2 5301.3 5323.3 5323.7 5332.0 5383.3 4820.6 4832.9 4833.7 4846.3 4911.8 5700.3 5757.0 5832.7 5871.9 5918.6 5752.2 5758.0 5771.1 5795.7 5803.1 5954.3 5956.4 5956.9 5958.2 5962.2 5450.5 5555.9 5557.2 5567.9 5612.5 5702.6 5744.9 5756.5 5764.5 5792.3 5592.2 5615.6 5630.5 5634.2 5635.5 5412.1 5490.3 5556.8 5583.2 5601.5 5562.8 5566.6 5572.4 5621.8 5634.2 5567.5 5608.0 5633.9 5638.8 5658.2 5254.6 5381.5 5429.7 5479.7 5504.8 05:49:13 INFO - PROCESS | 8254 | 05:49:13 INFO - PROCESS | 8254 | [#1] ext.html Cycles:180 Average:60930.06 Median:40352.50 stddev:123090.88 (305.0%) stddev-sans-first:123352.67 05:49:13 INFO - PROCESS | 8254 | Values: 541.1 580.5 584.6 596.7 611.2 38757.4 42741.0 42771.6 42813.8 42865.0 39662.0 40127.2 40144.4 40165.6 40539.4 8835.2 8960.6 8990.8 8994.9 9003.8 8801.2 8804.7 8870.2 8898.1 8910.6 8898.2 8922.9 8961.2 8970.6 8975.0 8873.5 8921.6 8948.0 8954.3 8964.0 8746.7 8874.3 8875.8 8879.7 8900.3 38130.4 38318.2 38420.0 38702.6 38706.4 3179.3 3581.6 3795.3 4064.2 4155.1 31618.2 32081.8 32197.0 32371.2 32515.8 4150.7 4192.3 4285.5 4344.6 4378.5 350462.0 350853.0 351346.0 351714.0 352823.2 53825.0 54203.7 54217.0 54318.0 54420.2 38967.0 39612.6 39725.8 39725.8 39734.4 14945.9 14980.9 15047.2 15099.0 15110.2 11204.5 11296.5 11319.2 11359.8 11362.8 19482.5 19550.6 19559.1 19567.0 19608.3 7151.2 7166.5 7189.3 7205.7 7281.2 887.3 914.5 1025.2 1102.0 1124.8 30228.4 33083.0 33106.2 33163.2 33222.0 1042.5 1058.8 1081.6 1097.2 1110.7 16755.6 17111.9 17318.6 17387.2 17410.7 514648.0 517842.0 520395.0 522988.0 525234.0 60288.7 60587.0 60807.7 60896.0 61194.7 1286.3 1321.8 1322.4 1323.6 1340.7 29659.9 31173.4 32349.7 32358.2 32595.7 52301.7 52496.0 52663.5 52683.7 52752.5 498404.0 498963.0 500226.0 501964.0 504015.0 29446.4 29607.7 29936.3 30014.7 30058.1 49350.3 49694.3 49884.0 49966.0 50212.7 40850.4 41602.0 43606.8 45023.8 46021.8 37657.6 37712.5 38396.2 38626.8 39296.6 41160.8 41630.6 41819.6 42424.4 42722.6 35996.0 36947.4 38232.4 38636.8 38798.8 28776.1 28776.6 29247.9 29547.6 29553.3 05:49:13 INFO - PROCESS | 8254 | 05:49:13 INFO - PROCESS | 8254 | [#2] jquery.html Cycles:180 Average:27940.06 Median:2399.21 stddev:75982.31 (3167.0%) stddev-sans-first:76167.32 05:49:13 INFO - PROCESS | 8254 | Values: 397.3 398.4 407.7 409.6 427.0 18225.8 20032.0 20091.7 20120.9 20609.0 18971.5 19289.8 19295.0 19593.0 19631.0 5353.4 5618.1 5845.7 5897.9 5968.1 5837.5 5842.0 5862.1 5871.1 5880.6 5902.7 5983.8 6008.8 6050.9 6057.7 5914.7 5961.5 5999.0 6016.5 6034.4 5761.2 5779.7 5817.6 5825.4 5844.9 14338.4 14528.9 14992.4 15002.6 15010.1 2270.1 2279.7 2325.1 2380.4 2418.0 10319.7 10435.4 10624.9 10772.3 10870.8 1893.9 1908.2 1955.5 1972.1 2041.1 81693.0 83068.0 84408.0 85624.0 85651.0 10989.8 11016.3 11187.9 11442.5 11458.0 15836.4 15961.6 15966.7 16013.1 16018.4 7100.9 7195.9 7220.4 7229.2 7496.4 6239.9 6272.9 6434.8 6443.2 6459.5 4803.6 4832.4 4844.5 4934.6 5102.0 2001.5 2001.9 2002.8 2050.5 2097.7 911.5 989.5 1010.2 1028.8 1031.7 19959.5 19988.0 20098.9 20250.3 20262.5 960.9 963.8 966.3 1022.7 1047.3 10826.8 10922.3 11269.2 11327.2 11395.4 447075.0 452914.0 456248.0 457363.0 481298.0 89730.6 90859.0 91460.5 91473.0 92051.6 986.2 1001.0 1005.4 1055.3 1057.3 14664.8 16175.3 17655.8 18272.5 18409.2 39991.0 43190.4 43461.8 45631.0 46613.3 50727.0 57090.4 58889.7 60016.4 60564.4 8076.1 8155.9 8232.2 8525.3 9069.7 6868.8 11318.4 11618.2 12129.0 12538.9 11138.8 11160.9 11240.4 11250.6 11524.1 10613.2 10667.3 10973.9 11136.0 11319.7 10657.4 11044.7 11101.7 11291.2 11638.8 8710.3 8893.1 8945.6 8987.7 9491.7 9929.4 11258.2 11259.5 11448.3 11559.1 05:49:13 INFO - PROCESS | 8254 | 05:49:13 INFO - PROCESS | 8254 | [#3] mootools.html Cycles:180 Average:5603.41 Median:5001.27 stddev:3115.43 (62.3%) stddev-sans-first:3108.86 05:49:13 INFO - PROCESS | 8254 | Values: 1493.1 1500.3 1652.4 1738.6 1765.9 7260.1 7875.7 7978.7 8597.3 8599.2 8216.3 8282.9 8310.1 8329.3 8370.5 2318.1 2363.3 2366.5 2367.8 2368.4 2286.8 2296.1 2341.5 2367.1 2374.3 2282.3 2302.2 2312.0 2357.6 2358.1 2277.1 2289.1 2293.4 2302.0 2303.3 2236.0 2249.2 2252.3 2252.3 2257.0 8426.7 8436.0 8459.0 8482.9 8538.4 5042.8 5223.6 5226.7 5240.1 5269.6 3256.5 3319.9 3382.7 3420.5 3460.7 1178.7 1210.4 1211.6 1222.1 1237.0 11526.9 11640.2 11647.2 11706.6 11721.9 4317.2 4468.6 4615.6 4629.8 4638.7 9832.6 9867.7 9896.9 9916.6 9922.3 5176.9 5200.1 5203.6 5206.1 5214.3 4171.1 4564.6 4665.8 4677.7 4782.4 3779.9 3919.2 3923.7 3939.2 4042.2 1280.3 1285.4 1287.4 1300.9 1309.9 884.2 911.1 926.3 948.8 969.8 5690.7 5692.6 5883.1 5904.0 6019.3 985.1 993.8 1003.2 1020.2 1029.5 3838.9 3862.5 3916.0 4131.0 4139.9 10482.2 10701.0 10702.7 10708.6 10716.6 10637.9 10641.5 10672.3 10686.0 10698.1 7320.9 7587.3 7664.4 7674.4 7812.2 5794.9 5870.8 5879.6 5932.7 6067.3 9212.4 9358.1 9416.5 9468.6 9487.2 8952.7 9526.7 9568.8 9778.4 9784.0 7130.2 7774.0 7988.1 8071.3 8318.1 8412.8 8438.1 8450.6 8470.8 8504.5 7174.4 7403.0 7569.4 7611.9 7638.3 6985.4 7287.1 7312.4 7397.1 7467.0 6436.3 6439.7 6486.9 6488.5 6507.9 4811.2 4871.3 4940.3 4969.4 5043.6 4769.6 4802.3 4840.9 4944.8 5033.2 05:49:13 INFO - PROCESS | 8254 | 05:49:13 INFO - PROCESS | 8254 | [#4] prototype.html Cycles:180 Average:4716.84 Median:5224.11 stddev:1348.17 (25.8%) stddev-sans-first:1311.18 05:49:13 INFO - PROCESS | 8254 | Values: 332.8 337.0 345.6 350.8 351.9 5376.0 5386.6 5597.7 5621.0 5654.2 5326.5 5413.3 5448.8 5453.3 5464.8 4357.9 4367.1 4374.0 4394.1 4408.1 4254.9 4375.5 4385.0 4420.8 4427.2 4323.6 4332.3 4341.5 4344.7 4348.1 4325.3 4341.4 4352.2 4364.1 4380.6 3604.9 3900.7 3906.7 3919.5 3937.3 5300.4 5339.7 5343.9 5374.3 5400.5 4920.9 4921.8 4939.7 4942.4 4970.6 5461.8 5737.3 5743.8 5756.1 5804.7 4232.1 4244.3 4258.2 4263.9 4279.3 6059.9 6083.6 6086.6 6116.3 6118.5 4228.6 4293.6 4309.2 4395.4 4400.9 4371.6 4373.9 4376.4 4376.6 4390.1 4981.2 4990.2 5020.5 5026.3 5036.3 5730.5 5833.6 5852.7 5883.9 5898.1 1476.3 1526.2 1529.5 1529.6 1531.5 972.8 999.8 1012.9 1019.9 1021.4 4916.5 4918.0 4940.6 4940.9 4944.8 5225.5 5247.8 5263.9 5295.6 5304.3 4692.4 4952.8 4985.7 4993.3 5024.6 2751.8 2773.3 2813.6 2827.9 2832.2 5426.5 5432.2 5447.8 5457.2 5478.6 5048.9 5276.0 5337.8 5366.4 5394.7 5310.5 5371.6 5389.4 5417.7 5441.8 5199.9 5222.8 5258.9 5316.0 5360.8 4868.3 5064.8 5125.0 5127.2 5147.9 5367.7 5403.3 5417.6 5471.7 5513.1 4001.0 4016.1 4025.5 4031.9 4037.8 5571.4 5818.5 5977.0 6016.3 6036.0 5871.4 5874.9 5876.8 5918.6 5919.1 5811.8 5813.8 5819.1 5827.7 5864.9 5618.6 5757.5 5777.7 5778.7 5833.1 5889.8 5903.7 5916.2 5948.9 5960.8 5451.4 5720.7 5725.0 5730.8 5742.3 05:49:13 INFO - PROCESS | 8254 | 05:49:13 INFO - PROCESS | 8254 | [#5] yui.html Cycles:180 Average:21583.27 Median:4397.01 stddev:31990.50 (727.6%) stddev-sans-first:32041.53 05:49:13 INFO - PROCESS | 8254 | Values: 625.3 672.7 708.3 718.2 749.4 14091.0 14246.4 14852.2 14879.5 14879.9 14945.6 15050.0 15152.5 15197.2 15223.8 786.7 788.0 788.2 791.7 794.2 824.9 826.3 828.8 830.4 833.7 870.2 870.7 871.3 871.8 872.8 859.5 865.5 866.0 866.7 868.0 632.0 637.0 637.3 639.2 639.5 16337.8 16513.5 16513.6 16524.3 16557.3 14661.4 14705.9 14826.9 14860.3 14887.7 12045.0 12118.8 12128.2 12445.8 12698.4 3829.6 3844.1 3874.7 3901.3 4028.2 85089.0 85696.0 85905.0 86146.0 86607.0 11366.0 11390.8 11546.0 11547.1 11570.1 22236.7 22246.3 22337.4 22393.1 22444.2 8200.4 8524.7 8893.5 8979.3 8991.5 4531.7 4569.8 4658.3 4684.2 4866.2 3233.2 3302.8 3319.9 3332.5 3340.6 538.1 538.5 549.0 553.9 555.8 515.2 595.8 628.1 653.3 674.8 9019.6 9424.8 9498.7 9519.2 9693.7 584.0 620.4 643.4 650.5 661.9 4308.9 4485.2 4485.6 4488.3 4625.5 119878.4 121847.4 124762.0 125575.0 131263.0 76832.6 107940.0 109253.5 112049.4 112868.4 77863.6 89772.6 90675.0 92401.5 93465.5 9515.0 9911.7 9961.2 10042.9 10062.3 48914.0 50094.7 50516.7 50812.5 52002.2 75140.0 75623.3 76540.6 77455.0 77798.6 12218.3 12480.7 12506.4 12560.9 12803.7 13763.5 13872.9 14243.5 14295.4 14731.9 13181.8 13446.0 13610.2 13614.3 13899.7 13209.5 13460.1 13460.5 13530.2 13730.6 13215.4 13469.5 13572.5 13575.2 13973.2 10476.6 10551.0 10953.1 10963.2 10976.9 9707.7 10588.9 11133.7 11296.9 11359.4 05:49:13 INFO - PROCESS | 8254 | -------- Summary: end -------- 05:49:13 INFO - PROCESS | 8254 | 05:49:14 INFO - TEST-INFO | 8254: exit 0 05:49:14 INFO - TEST-OK | dromaeo_css | took 1113148ms 05:49:14 INFO - TEST-START | kraken 05:49:14 INFO - operating with platform_type : linux_ 05:49:14 INFO - Initialising browser for kraken test... 05:49:14 INFO - TEST-INFO | started process 8609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIlO4lX/profile http://localhost:55689/getInfo.html) 05:49:19 INFO - PROCESS | 8609 | __metrics Screen width/height:1600/1200 05:49:19 INFO - PROCESS | 8609 | colorDepth:24 05:49:19 INFO - PROCESS | 8609 | Browser inner width/height: 1024/697 05:49:19 INFO - PROCESS | 8609 | __metrics 05:49:20 ERROR - PROCESS | 8609 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 05:49:20 INFO - TEST-INFO | 8609: exit 0 05:49:20 INFO - Browser initialized. 05:49:20 INFO - Running cycle 1/1 for kraken test... 05:49:20 INFO - TEST-INFO | started process 8728 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIlO4lX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:49:32 INFO - PROCESS | 8728 | RSS: Main: 163532800 05:49:32 INFO - PROCESS | 8728 | 05:49:35 INFO - PROCESS | 8728 | Cycle 1(1): loaded http://localhost:55689/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55689/tests/kraken/driver.html?testName=audio-beat-detection) 05:49:36 INFO - PROCESS | 8728 | RSS: Main: 169033728 05:49:36 INFO - PROCESS | 8728 | 05:49:38 INFO - PROCESS | 8728 | Cycle 1(1): loaded http://localhost:55689/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55689/tests/kraken/driver.html?testName=audio-dft) 05:49:39 INFO - PROCESS | 8728 | RSS: Main: 167616512 05:49:39 INFO - PROCESS | 8728 | 05:49:42 INFO - PROCESS | 8728 | Cycle 1(1): loaded http://localhost:55689/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55689/tests/kraken/driver.html?testName=audio-fft) 05:49:42 INFO - PROCESS | 8728 | RSS: Main: 164032512 05:49:42 INFO - PROCESS | 8728 | 05:49:45 INFO - PROCESS | 8728 | Cycle 1(1): loaded http://localhost:55689/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55689/tests/kraken/driver.html?testName=audio-oscillator) 05:49:45 INFO - PROCESS | 8728 | RSS: Main: 164638720 05:49:45 INFO - PROCESS | 8728 | 05:49:47 INFO - PROCESS | 8728 | Cycle 1(1): loaded http://localhost:55689/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55689/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:49:48 INFO - PROCESS | 8728 | RSS: Main: 165122048 05:49:48 INFO - PROCESS | 8728 | 05:49:51 INFO - PROCESS | 8728 | Cycle 1(1): loaded http://localhost:55689/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55689/tests/kraken/driver.html?testName=imaging-darkroom) 05:49:52 INFO - PROCESS | 8728 | RSS: Main: 165068800 05:49:52 INFO - PROCESS | 8728 | 05:49:55 INFO - PROCESS | 8728 | Cycle 1(1): loaded http://localhost:55689/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55689/tests/kraken/driver.html?testName=imaging-desaturate) 05:49:56 INFO - PROCESS | 8728 | RSS: Main: 163196928 05:49:56 INFO - PROCESS | 8728 | 05:49:59 INFO - PROCESS | 8728 | Cycle 1(1): loaded http://localhost:55689/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55689/tests/kraken/driver.html?testName=json-parse-financial) 05:49:59 INFO - PROCESS | 8728 | RSS: Main: 164896768 05:49:59 INFO - PROCESS | 8728 | 05:50:01 INFO - PROCESS | 8728 | Cycle 1(1): loaded http://localhost:55689/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55689/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:50:02 INFO - PROCESS | 8728 | RSS: Main: 164671488 05:50:02 INFO - PROCESS | 8728 | 05:50:03 INFO - PROCESS | 8728 | Cycle 1(1): loaded http://localhost:55689/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55689/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:50:04 INFO - PROCESS | 8728 | RSS: Main: 164716544 05:50:04 INFO - PROCESS | 8728 | 05:50:06 INFO - PROCESS | 8728 | Cycle 1(1): loaded http://localhost:55689/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55689/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:50:07 INFO - PROCESS | 8728 | RSS: Main: 164945920 05:50:07 INFO - PROCESS | 8728 | 05:50:09 INFO - PROCESS | 8728 | Cycle 1(1): loaded http://localhost:55689/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55689/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:50:10 INFO - PROCESS | 8728 | RSS: Main: 165224448 05:50:10 INFO - PROCESS | 8728 | 05:50:13 INFO - PROCESS | 8728 | Cycle 1(1): loaded http://localhost:55689/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55689/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:50:13 INFO - PROCESS | 8728 | RSS: Main: 165720064 05:50:13 INFO - PROCESS | 8728 | 05:50:15 INFO - PROCESS | 8728 | Cycle 1(1): loaded http://localhost:55689/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55689/tests/kraken/driver.html?testName=ai-astar) 05:50:15 INFO - PROCESS | 8728 | RSS: Main: 166105088 05:50:15 INFO - PROCESS | 8728 | 05:50:15 INFO - PROCESS | 8728 | __start_tp_report 05:50:15 INFO - PROCESS | 8728 | _x_x_mozilla_page_load 05:50:15 INFO - PROCESS | 8728 | _x_x_mozilla_page_load_details 05:50:15 INFO - PROCESS | 8728 | |i|pagename|runs| 05:50:15 INFO - PROCESS | 8728 | |0;ai-astar;107;113;108;113;116;113;116;112;112;112 05:50:15 INFO - PROCESS | 8728 | |1;audio-beat-detection;148;119;142;188;123;151;152;125;190;118 05:50:15 INFO - PROCESS | 8728 | |2;audio-dft;163;163;161;162;164;176;163;163;164;161 05:50:15 INFO - PROCESS | 8728 | |3;audio-fft;75;75;75;175;76;78;76;75;166;75 05:50:15 INFO - PROCESS | 8728 | |4;audio-oscillator;86;84;152;85;85;85;143;85;86;149 05:50:15 INFO - PROCESS | 8728 | |5;imaging-gaussian-blur;117;118;117;117;117;119;119;118;117;117 05:50:15 INFO - PROCESS | 8728 | |6;imaging-darkroom;146;147;148;147;146;148;148;147;147;149 05:50:15 INFO - PROCESS | 8728 | |7;imaging-desaturate;97;96;95;95;96;95;96;96;98;95 05:50:15 INFO - PROCESS | 8728 | |8;json-parse-financial;52;51;55;51;52;56;52;53;52;60 05:50:15 INFO - PROCESS | 8728 | |9;json-stringify-tinderbox;62;63;61;62;62;61;62;61;62;62 05:50:15 INFO - PROCESS | 8728 | |10;stanford-crypto-aes;85;84;81;81;79;80;85;79;79;83 05:50:15 INFO - PROCESS | 8728 | |11;stanford-crypto-ccm;133;124;129;125;127;124;126;137;142;129 05:50:15 INFO - PROCESS | 8728 | |12;stanford-crypto-pbkdf2;168;170;172;169;165;168;168;166;175;169 05:50:15 INFO - PROCESS | 8728 | |13;stanford-crypto-sha256-iterative;65;67;66;65;69;65;67;67;68;71 05:50:15 INFO - PROCESS | 8728 | __end_tp_report 05:50:15 INFO - PROCESS | 8728 | __start_cc_report 05:50:15 INFO - PROCESS | 8728 | _x_x_mozilla_cycle_collect,848 05:50:15 INFO - PROCESS | 8728 | __end_cc_report 05:50:15 INFO - PROCESS | 8728 | __startTimestamp1471351815966__endTimestamp 05:50:15 INFO - PROCESS | 8728 | 05:50:15 INFO - PROCESS | 8728 | ------- Summary: start ------- 05:50:15 INFO - PROCESS | 8728 | Number of tests: 14 05:50:15 INFO - PROCESS | 8728 | 05:50:15 INFO - PROCESS | 8728 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:2.90 (2.6%) stddev-sans-first:2.39 05:50:15 INFO - PROCESS | 8728 | Values: 107.0 113.0 108.0 113.0 116.0 113.0 116.0 112.0 112.0 112.0 05:50:15 INFO - PROCESS | 8728 | 05:50:15 INFO - PROCESS | 8728 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:149.50 stddev:26.38 (17.6%) stddev-sans-first:27.96 05:50:15 INFO - PROCESS | 8728 | Values: 148.0 119.0 142.0 188.0 123.0 151.0 152.0 125.0 190.0 118.0 05:50:15 INFO - PROCESS | 8728 | 05:50:15 INFO - PROCESS | 8728 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:4.35 (2.7%) stddev-sans-first:4.59 05:50:15 INFO - PROCESS | 8728 | Values: 163.0 163.0 161.0 162.0 164.0 176.0 163.0 163.0 164.0 161.0 05:50:15 INFO - PROCESS | 8728 | 05:50:15 INFO - PROCESS | 8728 | [#3] audio-fft Cycles:10 Average:94.60 Median:75.00 stddev:40.07 (53.4%) stddev-sans-first:41.87 05:50:15 INFO - PROCESS | 8728 | Values: 75.0 75.0 75.0 175.0 76.0 78.0 76.0 75.0 166.0 75.0 05:50:15 INFO - PROCESS | 8728 | 05:50:15 INFO - PROCESS | 8728 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:85.00 stddev:30.44 (35.8%) stddev-sans-first:31.59 05:50:15 INFO - PROCESS | 8728 | Values: 86.0 84.0 152.0 85.0 85.0 85.0 143.0 85.0 86.0 149.0 05:50:15 INFO - PROCESS | 8728 | 05:50:15 INFO - PROCESS | 8728 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.50 stddev:0.84 (0.7%) stddev-sans-first:0.87 05:50:15 INFO - PROCESS | 8728 | Values: 117.0 118.0 117.0 117.0 117.0 119.0 119.0 118.0 117.0 117.0 05:50:15 INFO - PROCESS | 8728 | 05:50:15 INFO - PROCESS | 8728 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.95 (0.6%) stddev-sans-first:0.88 05:50:15 INFO - PROCESS | 8728 | Values: 146.0 147.0 148.0 147.0 146.0 148.0 148.0 147.0 147.0 149.0 05:50:15 INFO - PROCESS | 8728 | 05:50:15 INFO - PROCESS | 8728 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.99 (1.0%) stddev-sans-first:0.97 05:50:15 INFO - PROCESS | 8728 | Values: 97.0 96.0 95.0 95.0 96.0 95.0 96.0 96.0 98.0 95.0 05:50:15 INFO - PROCESS | 8728 | 05:50:15 INFO - PROCESS | 8728 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:52.50 stddev:2.84 (5.4%) stddev-sans-first:2.96 05:50:15 INFO - PROCESS | 8728 | Values: 52.0 51.0 55.0 51.0 52.0 56.0 52.0 53.0 52.0 60.0 05:50:15 INFO - PROCESS | 8728 | 05:50:15 INFO - PROCESS | 8728 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 05:50:15 INFO - PROCESS | 8728 | Values: 62.0 63.0 61.0 62.0 62.0 61.0 62.0 61.0 62.0 62.0 05:50:15 INFO - PROCESS | 8728 | 05:50:15 INFO - PROCESS | 8728 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:82.00 stddev:2.46 (3.0%) stddev-sans-first:2.28 05:50:15 INFO - PROCESS | 8728 | Values: 85.0 84.0 81.0 81.0 79.0 80.0 85.0 79.0 79.0 83.0 05:50:15 INFO - PROCESS | 8728 | 05:50:15 INFO - PROCESS | 8728 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:129.00 stddev:6.00 (4.7%) stddev-sans-first:6.24 05:50:15 INFO - PROCESS | 8728 | Values: 133.0 124.0 129.0 125.0 127.0 124.0 126.0 137.0 142.0 129.0 05:50:15 INFO - PROCESS | 8728 | 05:50:15 INFO - PROCESS | 8728 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:169.00 stddev:2.87 (1.7%) stddev-sans-first:3.02 05:50:15 INFO - PROCESS | 8728 | Values: 168.0 170.0 172.0 169.0 165.0 168.0 168.0 166.0 175.0 169.0 05:50:15 INFO - PROCESS | 8728 | 05:50:15 INFO - PROCESS | 8728 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.94 (2.9%) stddev-sans-first:1.92 05:50:15 INFO - PROCESS | 8728 | Values: 65.0 67.0 66.0 65.0 69.0 65.0 67.0 67.0 68.0 71.0 05:50:15 INFO - PROCESS | 8728 | -------- Summary: end -------- 05:50:15 INFO - PROCESS | 8728 | 05:50:16 INFO - TEST-INFO | 8728: exit 0 05:50:17 INFO - TEST-OK | kraken | took 62927ms 05:50:17 INFO - SUITE-END | took 1176s 05:50:17 INFO - Completed test suite (00:19:36) 05:50:17 INFO - javascript benchmark 05:50:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7184.834793764533, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3030.1969977955837, 3047.558104074908, 3048.4969979953307, 3057.908262752117, 3072.5391191321314, 5210.374755029402, 5242.266082748413, 5337.8398648040575, 5352.946470535294, 5372.650777699447, 5242.580593552516, 5280.1551751719735, 5286.418493965661, 5306.124489459245, 5329.173978033401, 4734.455537613184, 4815.518448155191, 4863.337227997648, 4879.341288926003, 4961.20620700688, 4948.455669876311, 4964.528369804862, 4986.950130498685, 5010.0, 5045.0, 4773.618110551148, 4806.927896081562, 4838.395200599925, 4895.828645997391, 4901.975490122544, 4850.442199147108, 4856.708597484127, 4875.7074575525585, 4889.511048895118, 4902.166631672624, 4795.472498025214, 4797.160496913027, 4800.975995120002, 4825.493323201048, 4836.879078023042, 5130.666506677054, 5206.635535512516, 5265.157574788015, 5267.078261304257, 5276.683398996072, 5633.070543360341, 5650.717464126818, 5671.858203544944, 5685.0, 5716.056850619642, 5657.8019769307875, 5671.319441667027, 5697.487226149625, 5707.942920570824, 5716.742746576414, 5166.302549155854, 5267.55225805807, 5268.157094864841, 5283.128283833124, 5320.281761962163, 5758.654480731169, 5800.361960184377, 5803.129530570363, 5829.562782791308, 5864.648121112747, 5572.60991730575, 5611.2144299798065, 5625.606207565513, 5630.8029218977135, 5640.0, 5547.1679248113105, 5558.833235002957, 5581.49766521015, 5599.944000560024, 5700.173474846207, 5584.720763961785, 5615.8596035098635, 5621.409751976065, 5640.435956404327, 5663.518600918886, 5603.663780173202, 5607.074832652648, 5621.831345059655, 5657.038303488417, 5659.915101273484, 4251.787410629456, 4287.6998610097, 4358.825646974085, 4363.061941682554, 4365.738055716667, 3884.6892248620043, 3886.261610294035, 3892.805359732002, 3921.784301863368, 3923.0, 5391.16436952273, 5415.350157981067, 5417.295751552352, 5429.67421954684, 5465.262189604353, 5519.862003449865, 5582.720863956786, 5586.385497595261, 5616.1014237721765, 5697.173909783059, 5301.284326615934, 5323.30796996388, 5323.680579165185, 5332.0, 5383.300170977748, 4820.566149046603, 4832.9275060874115, 4833.685810422311, 4846.273059041101, 4911.778969946289, 5700.25896633435, 5757.021306377926, 5832.737526811304, 5871.911921321183, 5918.615290006222, 5752.194692742935, 5758.0499217630295, 5771.07662773971, 5795.739191736467, 5803.129530570448, 5954.345022047484, 5956.434138756811, 5956.940430595639, 5958.225430693982, 5962.19510366095, 5450.5367043801725, 5555.861103472445, 5557.249771280987, 5567.8886422272135, 5612.522935550524, 5702.600817942704, 5744.856378590569, 5756.481916627356, 5764.510016648632, 5792.275965504312, 5592.161175823659, 5615.550755939434, 5630.493255607015, 5634.183043458594, 5635.492805647511, 5412.134058550613, 5490.313710786152, 5556.805511807067, 5583.162525621189, 5601.5238704710555, 5562.805301814417, 5566.554675626021, 5572.359178694502, 5621.831345059655, 5634.2393776841245, 5567.526760225264, 5608.046632072639, 5633.943660563342, 5638.802641907513, 5658.207850900795, 5254.632175747661, 5381.48875856793, 5429.701366424727, 5479.671219726829, 5504.779808807763], "value": 5238.3017970217, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.1484885639744, 580.4949693766421, 584.6375247346645, 596.7374355283675, 611.2084850119095, 38757.41863872041, 42740.99999999996, 42771.57228427715, 42813.78593107034, 42865.0, 39662.0, 40127.19745605086, 40144.39783403244, 40165.59834401655, 40539.39190912139, 8835.204831565174, 8960.551972401354, 8990.820183596325, 8994.910050899505, 9003.819923601524, 8801.163889430525, 8804.735857924241, 8870.246029087535, 8898.065703101145, 8910.643574257021, 8898.199162075412, 8922.910770892273, 8961.193492585666, 8970.551472426352, 8974.955125224365, 8873.467591944473, 8921.55392230389, 8948.0, 8954.328425368123, 8963.955180224122, 8746.73759787201, 8874.334424918092, 8875.778105547348, 8879.733607991771, 8900.287976961827, 38130.42804357937, 38318.23363532714, 38420.0, 38702.61297387046, 38706.41940370897, 3179.316446963891, 3581.5702115746276, 3795.2599243147597, 4064.166845796605, 4155.10665206979, 31618.209544761336, 32081.83959080213, 32197.0, 32371.190720231945, 32515.837420812746, 4150.659471525901, 4192.266353388145, 4285.507166675841, 4344.63070638996, 4378.540253273424, 350462.0, 350853.0, 351346.0, 351714.0, 352823.2358838215, 53825.0, 54203.72898135484, 54217.0, 54318.0, 54420.183697244574, 38967.0, 39612.60387396089, 39725.80137099296, 39725.80137099354, 39734.40398394026, 14945.925270373797, 14980.925095374454, 15047.247637618075, 15099.0, 15110.244487775568, 11204.495797689124, 11296.54813807455, 11319.151063670257, 11359.772804543863, 11362.772744545064, 19482.512937176685, 19550.608987820164, 19559.11983960725, 19566.988767302668, 19608.313709020116, 7151.213366529678, 7166.53417527859, 7189.281071892873, 7205.747798827121, 7281.162666293338, 887.3300658003167, 914.4558987402485, 1025.1644909398817, 1101.9558718577084, 1124.8312753087102, 30228.395432091234, 33083.0, 33106.17234569107, 33163.17092072718, 33222.0, 1042.525650828871, 1058.772363941756, 1081.6160263106642, 1097.1880808201872, 1110.7167672243527, 16755.581110472092, 17111.91444042797, 17318.567035824206, 17387.217575209146, 17410.738838917427, 514648.0, 517842.0, 520395.0, 522988.0, 525234.0, 60288.698556507814, 60587.0, 60807.69596151991, 60896.0, 61194.694026529585, 1286.343964578072, 1321.7951217561485, 1322.4247452358254, 1323.6360000999803, 1340.7184491256946, 29659.851700741357, 31173.376532469676, 32349.676503234667, 32358.19104522406, 32595.718299718792, 52301.7384913073, 52496.0, 52663.473365265854, 52683.73658131685, 52752.47247527476, 498404.0, 498963.0, 500226.0, 501964.0, 504015.0, 29446.411071778017, 29607.703922961355, 29936.25159371033, 30014.69985300119, 30058.098257052323, 49350.25974610312, 49694.25458618051, 49884.0, 49966.0, 50212.748936255084, 40850.387244190766, 41602.0, 43606.781966091236, 45023.774881126694, 46021.76989115033, 37657.62342376541, 37712.48541888989, 38396.232075358894, 38626.80686596549, 39296.60703392929, 41160.79419602883, 41630.58369416267, 41819.581804181566, 42424.36363454613, 42722.57277427186, 35996.0, 36947.44578831266, 38232.42651360288, 38636.80681596574, 38798.80600597092, 28776.083147498903, 28776.56835147516, 29247.85376073106, 29547.556786647787, 29553.26116847096], "value": 19800.31638110503, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.3304981106837, 398.37256321293967, 407.66775078311184, 409.6354244722197, 426.97651629160384, 18225.817741822593, 20032.0, 20091.698624520643, 20120.89939550302, 20608.9695515224, 18971.52571185721, 19289.80710192898, 19295.0, 19593.02034898253, 19631.0, 5353.437889021665, 5618.129189975561, 5845.707714614274, 5897.882042359151, 5968.074948383008, 5837.474627283544, 5842.0, 5862.120681897707, 5871.1193321001765, 5880.55895807814, 5902.704864756766, 5983.820485385424, 6008.75964961401, 6050.909236361458, 6057.666828324441, 5914.733836977346, 5961.463468287853, 5999.040153575451, 6016.518678505709, 6034.426729460716, 5761.222234998306, 5779.653220806765, 5817.563682723812, 5825.417458254141, 5844.9415505845245, 14338.35477403509, 14528.854711452961, 14992.400303987828, 15002.62493437662, 15010.099394036393, 2270.126001489422, 2279.7492275849645, 2325.058351367699, 2380.4405964598304, 2417.987910060456, 10319.678072433717, 10435.426051567161, 10624.893751062546, 10772.299800512941, 10870.836937445945, 1893.8768980016255, 1908.23670531787, 1955.4622478818296, 1972.0829814136353, 2041.0815133190124, 81693.0, 83068.0, 84407.99999999939, 85624.0, 85651.0, 10989.780204396027, 11016.339019658686, 11187.888121118847, 11442.485088171052, 11458.0, 15836.366545338287, 15961.600959976093, 15966.680666386606, 16013.119278439797, 16018.359265629477, 7100.857982840314, 7195.92804071963, 7220.386267167244, 7229.168645605822, 7496.437767167485, 6239.875202495925, 6272.937270627326, 6434.806955791334, 6443.194600674916, 6459.483241340681, 4803.567678908845, 4832.371791667061, 4844.467108618049, 4934.629902757308, 5102.0, 2001.5496513284395, 2001.899905004744, 2002.8397728182001, 2050.4668786115717, 2097.6643737002005, 911.4759013567225, 989.5349185882624, 1010.2170817616259, 1028.7633844215873, 1031.7111208861531, 19959.4640468063, 19988.0, 20098.89950550238, 20250.291239806535, 20262.493437664176, 960.8798900137483, 963.7879666473365, 966.3235734985539, 1022.7085280694967, 1047.2773786087575, 10826.783464330669, 10922.344659320466, 11269.154813388865, 11327.207095503236, 11395.430228488542, 447075.0, 452914.0, 456248.0, 457363.0, 481298.0, 89730.55134724415, 90859.0, 91460.54269728609, 91473.0, 92051.61922571032, 986.1765425869336, 1001.0290018681867, 1005.3766664667953, 1055.3456856748712, 1057.2704833664748, 14664.780028299798, 16175.27211275519, 17655.790784557907, 18272.451826445227, 18409.171587278335, 39991.0, 43190.40857548557, 43461.782691086344, 45631.0, 46613.3008004887, 50727.0, 57090.42909571017, 58889.70555147197, 60016.39983600108, 60564.39435605588, 8076.111627721063, 8155.918440815516, 8232.217939295757, 8525.317974561896, 9069.727908162766, 6868.793936181923, 11318.434078295888, 11618.186726929034, 12129.0, 12538.87461125377, 11138.832917506406, 11160.944195278971, 11240.381779002233, 11250.606228781953, 11524.135689823464, 10613.20400969915, 10667.253292269466, 10973.945130274298, 11136.0, 11319.660410187707, 10657.413842238751, 11044.668659940215, 11101.666949991513, 11291.153163512605, 11638.777928317744, 8710.259627931444, 8893.110688931056, 8945.552722363986, 8987.685431009882, 9491.66779162726, 9929.3545919515, 11258.21192516516, 11259.549618015188, 11448.255863368855, 11559.07527397823], "value": 9052.487804601282, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1493.1041375174893, 1500.2648702135953, 1652.388616212001, 1738.6001219719456, 1765.8852174608658, 7260.092488438945, 7875.724349647763, 7978.6808527658895, 8597.3122150228, 8599.183077607626, 8216.260536551708, 8282.91717082829, 8310.085890552034, 8329.250367466926, 8370.497770133796, 2318.13070098713, 2363.291012696193, 2366.526694661066, 2367.7750613691674, 2368.3842201027683, 2286.7598902115287, 2296.0586159674535, 2341.519988402382, 2367.088670861722, 2374.287713685896, 2282.2924893283134, 2302.194232018797, 2311.9653205201935, 2357.57563638545, 2358.1157066100213, 2277.0664027748626, 2289.1415719105335, 2293.415179129328, 2301.9654705179437, 2303.2974942642572, 2236.0, 2249.2352600115873, 2252.279270633398, 2252.3468194223656, 2256.954860902773, 8426.705065322683, 8436.0, 8459.0, 8482.87275690859, 8538.44500107491, 5042.773075211624, 5223.582113430954, 5226.660267082628, 5240.056789777838, 5269.6311258211945, 3256.5278034685075, 3319.867205311785, 3382.695557399821, 3420.538227339302, 3460.688538031564, 1178.6994316449336, 1210.3706072842074, 1211.5577814097878, 1222.1322860768864, 1236.9876301236961, 11526.884731152664, 11640.18518703691, 11647.184697071209, 11706.590269340531, 11721.88278117225, 4317.229935726337, 4468.620167285752, 4615.584597386184, 4629.791659375336, 4638.6752927294765, 9832.557534910946, 9867.654632087842, 9896.851547226797, 9916.603335866628, 9922.305438619373, 5176.922346164811, 5200.089984252816, 5203.583713302926, 5206.088934436459, 5214.296070030573, 4171.10321280926, 4564.589186973189, 4665.790039448233, 4677.719336839732, 4782.426108866889, 3779.9244015119543, 3919.1769728356794, 3923.6861051115843, 3939.1924655445564, 4042.191561687674, 1280.3150314581653, 1285.3765923527083, 1287.4206607026874, 1300.9089363744447, 1309.8952083833271, 884.2439714044399, 911.1389736698889, 926.333040211047, 948.7817801905601, 969.7721035556639, 5690.658560486384, 5692.57305702074, 5883.14694369314, 5903.970480147657, 6019.337872833985, 985.0691096913491, 993.7515621094726, 1003.2074661017714, 1020.1889497849228, 1029.4955471818755, 3838.9232215355537, 3862.5129325209996, 3916.0, 4131.029208136086, 4139.855105071308, 10482.213833962483, 10701.03690667828, 10702.73243168927, 10708.571657133783, 10716.624918127984, 10637.893621063691, 10641.467926603638, 10672.252942293964, 10686.0, 10698.090662293636, 7320.9267907320245, 7587.279208475186, 7664.425168112414, 7674.386049116169, 7812.218778122142, 5794.884102317846, 5870.765169393348, 5879.559033072451, 5932.733027013708, 6067.271927368744, 9212.355135140744, 9358.11097945694, 9416.482093484925, 9468.621255149717, 9487.193588545051, 8952.731418057208, 9526.666566670134, 9568.80389951256, 9778.41329520231, 9784.0, 7130.180029296697, 7773.961130194313, 7988.121306656147, 8071.273585377344, 8318.085010648945, 8412.831743364975, 8438.071812100541, 8450.577471126297, 8470.83058338842, 8504.53225072627, 7174.390176834819, 7402.9629851850395, 7569.394448444222, 7611.923880761343, 7638.274363935418, 6985.406240469414, 7287.125544934642, 7312.378447831994, 7397.075365579302, 7467.0, 6436.259830119409, 6439.710213040331, 6486.9351306488215, 6488.480921526172, 6507.934920650733, 4811.158047341772, 4871.269309603588, 4940.333055037524, 4969.378827646544, 5043.596512279082, 4769.61843052548, 4802.303665968485, 4840.854774356775, 4944.75276236194, 5033.169527028146], "value": 4541.306946347237, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.7689597798455, 336.9831508424579, 345.6388074462188, 350.8333541567757, 351.89619062376596, 5376.0, 5386.569074474042, 5597.748101335439, 5621.0, 5654.180143879135, 5326.547243484309, 5413.296271484712, 5448.782048718046, 5453.291072160623, 5464.808731694382, 4357.912841743179, 4367.148406060819, 4374.03771170342, 4394.121175764843, 4408.126546217861, 4254.893627659302, 4375.518692943773, 4385.048653349261, 4420.823167073329, 4427.180971520263, 4323.610875021247, 4332.263515202423, 4341.479022517302, 4344.717593356421, 4348.108637729274, 4325.329573916048, 4341.370501277297, 4352.194843953863, 4364.083542456088, 4380.6276466500385, 3604.873829415958, 3900.687944964396, 3906.726529142961, 3919.510061242345, 3937.251922134785, 5300.44345343741, 5339.65292256006, 5343.893122137535, 5374.328208973879, 5400.487863398254, 4920.852374428773, 4921.80312787488, 4939.6789208701675, 4942.393722040315, 4970.552650261494, 5461.808836690697, 5737.254156959611, 5743.798967036134, 5756.121939030485, 5804.680742559158, 4232.090100628379, 4244.257254980397, 4258.169656916903, 4263.893402664927, 4279.251131052053, 6059.909101363483, 6083.6349819011, 6086.6348019119, 6116.327204007555, 6118.541109416767, 4228.556001619786, 4293.635041021485, 4309.181255561433, 4395.384646149541, 4400.867973960786, 4371.606555410029, 4373.912521749611, 4376.3654270130655, 4376.627986621109, 4390.143921935192, 4981.2030075187795, 4990.17662085759, 5020.497950205024, 5026.321446604735, 5036.32009678696, 5730.512906402919, 5833.620814647034, 5852.736626851802, 5883.911741323884, 5898.14476900847, 1476.2987580899203, 1526.221626970231, 1529.4781692216093, 1529.5640742388366, 1531.4563330017907, 972.7762614598682, 999.8100360931545, 1012.9290949633455, 1019.898010198989, 1021.402479549457, 4916.50046735749, 4917.975410122926, 4940.555350018443, 4940.925886111711, 4944.826931057396, 5225.4635290594815, 5247.816326428633, 5263.894722105537, 5295.602829787781, 5304.257403963448, 4692.436907571113, 4952.826651067196, 4985.684519794296, 4993.325901003318, 5024.572911302507, 2751.8073734838367, 2773.3205364685377, 2813.6482939632547, 2827.886884524596, 2832.1928250448523, 5426.484483974016, 5432.239486471897, 5447.836564903059, 5457.2359869618285, 5478.561715062785, 5048.949510504922, 5276.0, 5337.7989952261205, 5366.370478465602, 5394.676319420769, 5310.495502927216, 5371.62398632092, 5389.380221274603, 5417.729113544307, 5441.755121019563, 5199.946021321482, 5222.764975576032, 5258.8948221036135, 5316.016536940679, 5360.839174824761, 4868.269759536098, 5064.82273120439, 5125.0, 5127.230915362726, 5147.948520514747, 5367.704776237344, 5403.324584426947, 5417.6478528895495, 5471.699056551928, 5513.062779327604, 4001.0, 4016.0763024503945, 4025.5370632377653, 4031.879043628696, 4037.8384864605086, 5571.387147413862, 5818.4763371296785, 5977.0, 6016.278046634432, 6036.0, 5871.442212989759, 5874.853128671817, 5876.764929402776, 5918.556108291981, 5919.141724449844, 5811.82564523065, 5813.79651712188, 5819.127130930395, 5827.650340979555, 5864.9413505864395, 5618.634788738719, 5757.453041961007, 5777.653340799566, 5778.711064446845, 5833.095870140135, 5889.823305300848, 5903.704814759159, 5916.201312822714, 5948.851278718067, 5960.76156953717, 5451.391839407305, 5720.741436883879, 5725.0, 5730.765001649277, 5742.339630942495], "value": 4293.351613180273, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.3059104394122, 672.6939242644601, 708.3200127877237, 718.1956209045869, 749.4341771962166, 14091.0, 14246.358913848875, 14852.18312992785, 14879.47921822735, 14879.851201487982, 14945.551633450987, 15050.0, 15152.545423637308, 15197.24013799311, 15223.847761522382, 786.67746224048, 788.0385929166437, 788.2314743125464, 791.7189397763798, 794.2018271636997, 824.884516167734, 826.305903041445, 828.7513745876244, 830.4104086098877, 833.6665333866441, 870.2472361407368, 870.6691457246237, 871.2594294849391, 871.760265926872, 872.8472517309477, 859.5057841740993, 865.536937738307, 866.017070624839, 866.7139843851545, 867.9739607811775, 631.9652419116946, 637.0158105726664, 637.3339859846425, 639.1882309466951, 639.5203597302024, 16337.754933676004, 16513.504594862174, 16513.587160320967, 16524.25640846165, 16557.25492352835, 14661.41354345825, 14705.92647036758, 14826.851731482655, 14860.256987150598, 14887.70224595502, 12045.0, 12118.81821772674, 12128.151029427943, 12445.813312800316, 12698.365081745877, 3829.5978922213044, 3844.1350696093436, 3874.7093967952515, 3901.336772748611, 4028.234635419261, 85089.0, 85696.0, 85905.0, 86146.0, 86607.0, 11366.0, 11390.829137562943, 11546.0, 11547.133964952662, 11570.132240082028, 22236.666450003264, 22246.332610021724, 22337.44156396103, 22393.104275828784, 22444.214452494085, 8200.42597018203, 8524.70163544273, 8893.510856902933, 8979.281657467387, 8991.460512369278, 4531.682782205214, 4569.817207311737, 4658.277966915133, 4684.180268453007, 4866.245731911559, 3233.159378561591, 3302.752293577991, 3319.8838040668943, 3332.5334453176574, 3340.565726455594, 538.090626840638, 538.4749868877813, 548.9752961116759, 553.8670719027485, 555.8138023762085, 515.2477383020831, 595.7709216049025, 628.1269036039909, 653.2879161713755, 674.8460133172232, 9019.594118264693, 9424.811503770023, 9498.667546635972, 9519.243733988518, 9693.70918872435, 583.9926127430149, 620.404411764711, 643.4080645805869, 650.4763665249425, 661.9238787539495, 4308.852652004484, 4485.170243504962, 4485.618722408632, 4488.326750987313, 4625.4911959684405, 119878.4006079964, 121847.39076304562, 124762.0, 125575.0, 131263.0, 76832.61583692046, 107940.0, 109253.45373273082, 112049.43975280071, 112868.43565782119, 77863.61068194623, 89772.55113724389, 90675.0, 92401.53799231096, 93465.53267233756, 9515.04849515043, 9911.687382278913, 9961.153301969414, 10042.899571004196, 10062.345947513388, 48914.0, 50094.74952625213, 50516.74741626268, 50812.49187508078, 52002.21996669977, 75140.0, 75623.29485312832, 76540.61729691316, 77455.0, 77798.6110069446, 12218.327991960528, 12480.687982800502, 12506.374681266083, 12560.874391256337, 12803.679908002374, 13763.46647214405, 13872.861271387157, 14243.501477448239, 14295.428182872569, 14731.852681473049, 13181.80227296572, 13445.957765837811, 13610.183388996691, 13614.251216183206, 13899.652508687364, 13209.471621135048, 13460.050613703808, 13460.461581536629, 13530.18818870871, 13730.588082357544, 13215.405306761026, 13469.46122155142, 13572.457101715821, 13575.185488870698, 13973.231472268717, 10476.580936762444, 10551.0, 10953.068989136013, 10963.177761668067, 10976.945115274373, 9707.708768736667, 10588.947055264674, 11133.721656958642, 11296.887031129583, 11359.432028398713], "value": 7513.600402110754, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 113.0, 108.0, 113.0, 116.0, 113.0, 116.0, 112.0, 112.0, 112.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 119.0, 142.0, 188.0, 123.0, 151.0, 152.0, 125.0, 190.0, 118.0], "value": 145.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 162.0, 164.0, 176.0, 163.0, 163.0, 164.0, 161.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 175.0, 76.0, 78.0, 76.0, 75.0, 166.0, 75.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 152.0, 85.0, 85.0, 85.0, 143.0, 85.0, 86.0, 149.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 119.0, 119.0, 118.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 147.0, 146.0, 148.0, 148.0, 147.0, 147.0, 149.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 98.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 55.0, 51.0, 52.0, 56.0, 52.0, 53.0, 52.0, 60.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 62.0, 62.0, 61.0, 62.0, 61.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 81.0, 81.0, 79.0, 80.0, 85.0, 79.0, 79.0, 83.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 124.0, 129.0, 125.0, 127.0, 124.0, 126.0, 137.0, 142.0, 129.0], "value": 129.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 170.0, 172.0, 169.0, 165.0, 168.0, 168.0, 166.0, 175.0, 169.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 65.0, 69.0, 65.0, 67.0, 67.0, 68.0, 71.0], "value": 67.0, "unit": "score"}]}]} 05:50:17 INFO - Return code: 0 05:50:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:50:17 ERROR - # TBPL SUCCESS # 05:50:17 INFO - Running post-action listener: _resource_record_post_action 05:50:17 INFO - [mozharness: 2016-08-16 12:50:17.286133Z] Finished run-tests step (success) 05:50:17 INFO - Running post-run listener: _resource_record_post_run 05:50:17 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 200704; Write bytes: 405909504; Read time: 320; Write time: 664020 05:50:17 INFO - TinderboxPrint: CPU usage
13.4% 05:50:17 INFO - TinderboxPrint: I/O read bytes / time
200,704 / 320 05:50:17 INFO - TinderboxPrint: I/O write bytes / time
405,909,504 / 664,020 05:50:17 INFO - TinderboxPrint: CPU idle
8,239.4 (86.6%) 05:50:17 INFO - TinderboxPrint: CPU user
1,215.2 (12.8%) 05:50:17 INFO - TinderboxPrint: Swap in / out
0 / 0 05:50:17 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118005760; Read time: 0; Write time: 245044 05:50:17 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 196608; Write bytes: 287555584; Read time: 304; Write time: 418972 05:50:17 INFO - Running post-run listener: _upload_blobber_files 05:50:17 INFO - Blob upload gear active. 05:50:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:50:17 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:50:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:50:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:50:18 INFO - (blobuploader) - INFO - Open directory for files ... 05:50:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:50:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:50:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:50:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:50:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:50:18 INFO - (blobuploader) - INFO - Done attempting. 05:50:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:50:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:50:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:50:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:50:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:50:19 INFO - (blobuploader) - INFO - Done attempting. 05:50:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:50:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:50:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:50:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:50:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:50:23 INFO - (blobuploader) - INFO - Done attempting. 05:50:23 INFO - (blobuploader) - INFO - Iteration through files over. 05:50:23 INFO - Return code: 0 05:50:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:50:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:50:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5159a07ab3560fc72bede2fdb6b037aca81319e58cf01b8471a53c809c1dbfcab5034d0b4c8bb25e366fa04f3b446e70aa2a76d8e2b4eab2472c2ee79e74f460", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9096e56c9c8bed31cfceb76f851e979dff95f2a5c9fef769d4a186fb1a6440ba9d8a08a6d038f35147085503d8c97947d00f1c7bfdecdcde75b5e8930ad0f500", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2fb77fc7385d438283264039dcad736de9c32ddfa09c12454997815ada5247ebd305a9b7295460899f41b2a16d9e404db5b4cc541d3094cd85a0568d51ec91c5"} 05:50:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:50:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:50:23 INFO - Contents: 05:50:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5159a07ab3560fc72bede2fdb6b037aca81319e58cf01b8471a53c809c1dbfcab5034d0b4c8bb25e366fa04f3b446e70aa2a76d8e2b4eab2472c2ee79e74f460", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9096e56c9c8bed31cfceb76f851e979dff95f2a5c9fef769d4a186fb1a6440ba9d8a08a6d038f35147085503d8c97947d00f1c7bfdecdcde75b5e8930ad0f500", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2fb77fc7385d438283264039dcad736de9c32ddfa09c12454997815ada5247ebd305a9b7295460899f41b2a16d9e404db5b4cc541d3094cd85a0568d51ec91c5"} 05:50:23 INFO - Running post-run listener: copy_logs_to_upload_dir 05:50:23 INFO - Copying logs to upload dir... 05:50:23 INFO - mkdir: /builds/slave/test/build/upload/logs 05:50:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.329331 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-16 05:50:23.808442) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 05:50:23.811557) ========= 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=5cf47e208febbcd81da23b2e0000026f-1471350584.54030-1830642097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5159a07ab3560fc72bede2fdb6b037aca81319e58cf01b8471a53c809c1dbfcab5034d0b4c8bb25e366fa04f3b446e70aa2a76d8e2b4eab2472c2ee79e74f460", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9096e56c9c8bed31cfceb76f851e979dff95f2a5c9fef769d4a186fb1a6440ba9d8a08a6d038f35147085503d8c97947d00f1c7bfdecdcde75b5e8930ad0f500", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2fb77fc7385d438283264039dcad736de9c32ddfa09c12454997815ada5247ebd305a9b7295460899f41b2a16d9e404db5b4cc541d3094cd85a0568d51ec91c5"} build_url:https://queue.taskcluster.net/v1/task/J9spd8UbT3qp_OKvNcii3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011495 build_url: 'https://queue.taskcluster.net/v1/task/J9spd8UbT3qp_OKvNcii3Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5159a07ab3560fc72bede2fdb6b037aca81319e58cf01b8471a53c809c1dbfcab5034d0b4c8bb25e366fa04f3b446e70aa2a76d8e2b4eab2472c2ee79e74f460", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9096e56c9c8bed31cfceb76f851e979dff95f2a5c9fef769d4a186fb1a6440ba9d8a08a6d038f35147085503d8c97947d00f1c7bfdecdcde75b5e8930ad0f500", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2fb77fc7385d438283264039dcad736de9c32ddfa09c12454997815ada5247ebd305a9b7295460899f41b2a16d9e404db5b4cc541d3094cd85a0568d51ec91c5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 05:50:23.836849) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:50:23.837160) ========= 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=5cf47e208febbcd81da23b2e0000026f-1471350584.54030-1830642097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 05:50:23.919113) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 05:50:23.919439) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 05:50:23.919732) ========= ========= Total master_lag: 0.17 =========