builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1471908031.34 results: success (0) buildid: 20160822143002 builduid: 503c2600f6764e28a171ecf5ffcb612b revision: 08e9ded26ada149385af32e1c1d89f30e3d8279c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 16:20:31.342176) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 16:20:31.342742) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 16:20:31.343028) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 16:20:31.357760) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:20:31.358055) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1471908030.817639-284414530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-22 16:20:31-- 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% 21.6M=0.001s 2016-08-22 16:20:32 (21.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.308510 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:20:31.680804) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:20:31.681156) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1471908030.817639-284414530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020283 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:20:31.731372) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 16:20:31.731796) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 08e9ded26ada149385af32e1c1d89f30e3d8279c --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 08e9ded26ada149385af32e1c1d89f30e3d8279c --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=8c6b6742ce8f6f39ef4ce27d000001f1-1471908030.817639-284414530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-22 16:20:32,122 truncating revision to first 12 chars 2016-08-22 16:20:32,122 Setting DEBUG logging. 2016-08-22 16:20:32,122 attempt 1/10 2016-08-22 16:20:32,122 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/08e9ded26ada?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 16:20:33,022 unpacking tar archive at: fx-team-08e9ded26ada/testing/mozharness/ program finished with exit code 0 elapsedTime=1.176909 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 16:20:32.923786) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 16:20:32.924129) ========= script_repo_revision: 08e9ded26ada149385af32e1c1d89f30e3d8279c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 16:20:32.924567) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 16:20:32.924835) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 16:20:32.935913) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-22 16:20:32.936364) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=8c6b6742ce8f6f39ef4ce27d000001f1-1471908030.817639-284414530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:20:33 INFO - MultiFileLogger online at 20160822 16:20:33 in /builds/slave/test 16:20:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:20:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:20:33 INFO - {'append_to_log': False, 16:20:33 INFO - 'base_work_dir': '/builds/slave/test', 16:20:33 INFO - 'blob_upload_branch': 'Fx-Team', 16:20:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:20:33 INFO - 'branch': 'Fx-Team', 16:20:33 INFO - 'buildbot_json_path': 'buildprops.json', 16:20:33 INFO - 'config_files': ('talos/linux_config.py',), 16:20:33 INFO - 'default_actions': ('clobber', 16:20:33 INFO - 'read-buildbot-config', 16:20:33 INFO - 'download-and-extract', 16:20:33 INFO - 'populate-webroot', 16:20:33 INFO - 'create-virtualenv', 16:20:33 INFO - 'install', 16:20:33 INFO - 'run-tests'), 16:20:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:20:33 INFO - 'download_minidump_stackwalk': True, 16:20:33 INFO - 'download_symbols': 'ondemand', 16:20:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:20:33 INFO - 'tooltool.py': '/tools/tooltool.py', 16:20:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:20:33 INFO - '/tools/misc-python/virtualenv.py')}, 16:20:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:20:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:20:33 INFO - 'installer_path': 'installer.exe', 16:20:33 INFO - 'log_level': 'info', 16:20:33 INFO - 'log_name': 'talos', 16:20:33 INFO - 'log_to_console': True, 16:20:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:20:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:20:33 INFO - 'opt_config_files': (), 16:20:33 INFO - 'pip_index': False, 16:20:33 INFO - 'sps_profile': False, 16:20:33 INFO - 'sps_profile_interval': 0, 16:20:33 INFO - 'suite': 'dromaeojs', 16:20:33 INFO - 'system_bits': '32', 16:20:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:20:33 INFO - 'title': 'talos-linux64-ix-041', 16:20:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:20:33 INFO - 'use_talos_json': True, 16:20:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:20:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:20:33 INFO - 'work_dir': 'build'} 16:20:33 INFO - [mozharness: 2016-08-22 23:20:33.420481Z] Running clobber step. 16:20:33 INFO - Running pre-action listener: _resource_record_pre_action 16:20:33 INFO - Running main action method: clobber 16:20:33 INFO - rmtree: /builds/slave/test/build 16:20:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:20:33 INFO - Running post-action listener: _resource_record_post_action 16:20:33 INFO - [mozharness: 2016-08-22 23:20:33.880140Z] Finished clobber step (success) 16:20:33 INFO - [mozharness: 2016-08-22 23:20:33.880240Z] Running read-buildbot-config step. 16:20:33 INFO - Running pre-action listener: _resource_record_pre_action 16:20:33 INFO - Running main action method: read_buildbot_config 16:20:33 INFO - Using buildbot properties: 16:20:33 INFO - { 16:20:33 INFO - "project": "", 16:20:33 INFO - "product": "firefox", 16:20:33 INFO - "script_repo_revision": "production", 16:20:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:20:33 INFO - "repository": "", 16:20:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 16:20:33 INFO - "buildid": "20160822143002", 16:20:33 INFO - "pgo_build": "True", 16:20:33 INFO - "basedir": "/builds/slave/test", 16:20:33 INFO - "buildnumber": 382, 16:20:33 INFO - "slavename": "talos-linux64-ix-041", 16:20:33 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:20:33 INFO - "platform": "ubuntu64_hw", 16:20:33 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:20:33 INFO - "branch": "fx-team", 16:20:33 INFO - "repo_path": "integration/fx-team", 16:20:33 INFO - "revision": "08e9ded26ada149385af32e1c1d89f30e3d8279c", 16:20:33 INFO - "stage_platform": "linux64-pgo", 16:20:33 INFO - "builduid": "503c2600f6764e28a171ecf5ffcb612b", 16:20:33 INFO - "slavebuilddir": "test" 16:20:33 INFO - } 16:20:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 16:20:33 INFO - Running post-action listener: _resource_record_post_action 16:20:33 INFO - [mozharness: 2016-08-22 23:20:33.882643Z] Finished read-buildbot-config step (success) 16:20:33 INFO - [mozharness: 2016-08-22 23:20:33.882729Z] Running download-and-extract step. 16:20:33 INFO - Running pre-action listener: _resource_record_pre_action 16:20:33 INFO - Running main action method: download_and_extract 16:20:33 INFO - mkdir: /builds/slave/test/build/tests 16:20:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:33 INFO - trying https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:20:33 INFO - Downloading https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/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 16:20:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/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 16:20:34 INFO - Downloaded 1361 bytes. 16:20:34 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:20:34 INFO - Using the following test package requirements: 16:20:34 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:20:34 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:20:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:20:34 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:20:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:20:34 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:20:34 INFO - u'jsshell-linux-x86_64.zip'], 16:20:34 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:20:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:20:34 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:20:34 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:20:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:20:34 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:20:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:20:34 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:20:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:20:34 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:20:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:20:34 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:34 INFO - trying https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:20:34 INFO - Downloading https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/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 16:20:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/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 16:20:35 INFO - Downloaded 21921014 bytes. 16:20:35 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 16:20:39 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 16:20:39 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')]} 16:20:39 INFO - trying https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:20:39 INFO - Downloading https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/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 16:20:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/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 16:20:40 INFO - Downloaded 21921014 bytes. 16:20:40 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 16:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:45 INFO - trying https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:20:45 INFO - Downloading https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/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 16:20:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/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 16:20:45 INFO - Downloaded 14413981 bytes. 16:20:45 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 16:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:46 INFO - trying https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:20:46 INFO - Downloading https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/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 16:20:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/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 16:20:47 INFO - Downloaded 59778083 bytes. 16:20:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:20:47 INFO - mkdir: /builds/slave/test/properties 16:20:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:20:47 INFO - Writing to file /builds/slave/test/properties/build_url 16:20:47 INFO - Contents: 16:20:47 INFO - build_url:https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:20:48 INFO - Running post-action listener: _resource_record_post_action 16:20:48 INFO - Running post-action listener: set_extra_try_arguments 16:20:48 INFO - [mozharness: 2016-08-22 23:20:48.926087Z] Finished download-and-extract step (success) 16:20:48 INFO - [mozharness: 2016-08-22 23:20:48.926312Z] Running populate-webroot step. 16:20:48 INFO - Running pre-action listener: _resource_record_pre_action 16:20:48 INFO - Running main action method: populate_webroot 16:20:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:20:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:20:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:20:48 INFO - '--tppagecycles', 16:20:48 INFO - '7'], 16:20:48 INFO - 'tests': ['tsvgm']}}, 16:20:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:20:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:20:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:20:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:20:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:20:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:20:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:20:48 INFO - 'talos_options': ['--disable-e10s'], 16:20:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:20:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:20:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:20:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:20:48 INFO - 'talos_options': ['--disable-e10s'], 16:20:48 INFO - 'tests': ['damp', 'tps']}, 16:20:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:20:48 INFO - 'tests': ['damp', 'tps']}, 16:20:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:20:48 INFO - 'tests': ['dromaeo_dom']}, 16:20:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:20:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:20:48 INFO - 'tests': ['basic_compositor_video']}, 16:20:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:20:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:20:48 INFO - 'tests': ['a11yr', 16:20:48 INFO - 'ts_paint', 16:20:48 INFO - 'tpaint', 16:20:48 INFO - 'sessionrestore', 16:20:48 INFO - 'sessionrestore_no_auto_restore', 16:20:48 INFO - 'tabpaint']}, 16:20:48 INFO - 'other-e10s': {'tests': ['a11yr', 16:20:48 INFO - 'ts_paint', 16:20:48 INFO - 'tpaint', 16:20:48 INFO - 'sessionrestore', 16:20:48 INFO - 'sessionrestore_no_auto_restore', 16:20:48 INFO - 'tabpaint']}, 16:20:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:20:48 INFO - 'ts_paint', 16:20:48 INFO - 'tpaint', 16:20:48 INFO - 'sessionrestore', 16:20:48 INFO - 'sessionrestore_no_auto_restore', 16:20:48 INFO - 'tabpaint']}, 16:20:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:20:48 INFO - 'ts_paint', 16:20:48 INFO - 'tpaint', 16:20:48 INFO - 'sessionrestore', 16:20:48 INFO - 'sessionrestore_no_auto_restore', 16:20:48 INFO - 'tabpaint']}, 16:20:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:20:48 INFO - 'tests': ['a11yr', 16:20:48 INFO - 'ts_paint', 16:20:48 INFO - 'tpaint', 16:20:48 INFO - 'sessionrestore', 16:20:48 INFO - 'sessionrestore_no_auto_restore', 16:20:48 INFO - 'tabpaint']}, 16:20:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:20:48 INFO - 'tests': ['a11yr', 16:20:48 INFO - 'ts_paint', 16:20:48 INFO - 'tpaint', 16:20:48 INFO - 'sessionrestore', 16:20:48 INFO - 'sessionrestore_no_auto_restore', 16:20:48 INFO - 'tabpaint']}, 16:20:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:20:48 INFO - 'tests': ['tsvgx', 16:20:48 INFO - 'tsvgr_opacity', 16:20:48 INFO - 'tart', 16:20:48 INFO - 'tscrollx', 16:20:48 INFO - 'cart']}, 16:20:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:20:48 INFO - 'tsvgr_opacity', 16:20:48 INFO - 'tart', 16:20:48 INFO - 'tscrollx', 16:20:48 INFO - 'cart']}, 16:20:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:20:48 INFO - 'talos_options': ['--disable-e10s'], 16:20:48 INFO - 'tests': ['tp5o']}, 16:20:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:20:48 INFO - 'tests': ['tp5o']}, 16:20:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:20:48 INFO - 'talos_options': ['--disable-e10s', 16:20:48 INFO - '--xperf_path', 16:20:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:20:48 INFO - 'tests': ['tp5n']}, 16:20:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:20:48 INFO - 'talos_options': ['--xperf_path', 16:20:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:20:48 INFO - 'tests': ['tp5n']}}, 16:20:48 INFO - 'talos.zip': {'path': '', 16:20:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:20:48 INFO - Running post-action listener: _resource_record_post_action 16:20:48 INFO - [mozharness: 2016-08-22 23:20:48.944973Z] Finished populate-webroot step (success) 16:20:48 INFO - [mozharness: 2016-08-22 23:20:48.945060Z] Running create-virtualenv step. 16:20:48 INFO - Running pre-action listener: _resource_record_pre_action 16:20:48 INFO - Running main action method: create_virtualenv 16:20:48 INFO - Creating virtualenv /builds/slave/test/build/venv 16:20:48 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 16:20:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:20:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:20:49 INFO - Using real prefix '/usr' 16:20:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:20:49 INFO - Installing distribute.............................................................................................................................................................................................done. 16:20:51 INFO - Installing pip.................done. 16:20:51 INFO - Return code: 0 16:20:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:51 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 0x7f545de0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x155e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1559370>, '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 0x155c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155cd80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471908030.817639-284414530', '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 16:20:51 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 16:20:51 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 16:20:51 INFO - Using env: {'DISPLAY': ':0', 16:20:51 INFO - 'HOME': '/home/cltbld', 16:20:51 INFO - 'LANG': 'en_US.UTF-8', 16:20:51 INFO - 'LANGUAGE': 'en_US:en', 16:20:51 INFO - 'LOGNAME': 'cltbld', 16:20:51 INFO - 'MAIL': '/var/mail/cltbld', 16:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:51 INFO - 'MOZ_NO_REMOTE': '1', 16:20:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:51 INFO - 'NO_EM_RESTART': '1', 16:20:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:51 INFO - 'PWD': '/builds/slave/test', 16:20:51 INFO - 'SHELL': '/bin/bash', 16:20:51 INFO - 'SHLVL': '1', 16:20:51 INFO - 'TERM': 'linux', 16:20:51 INFO - 'TMOUT': '86400', 16:20:51 INFO - 'USER': 'cltbld', 16:20:51 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471908030.817639-284414530', 16:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:51 INFO - '_': '/tools/buildbot/bin/python'} 16:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:51 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 16:20:51 INFO - Cleaning up... 16:20:51 INFO - Return code: 0 16:20:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:51 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 0x7f545de0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x155e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1559370>, '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 0x155c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155cd80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471908030.817639-284414530', '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 16:20:51 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 16:20:51 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 16:20:51 INFO - Using env: {'DISPLAY': ':0', 16:20:51 INFO - 'HOME': '/home/cltbld', 16:20:51 INFO - 'LANG': 'en_US.UTF-8', 16:20:51 INFO - 'LANGUAGE': 'en_US:en', 16:20:51 INFO - 'LOGNAME': 'cltbld', 16:20:51 INFO - 'MAIL': '/var/mail/cltbld', 16:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:51 INFO - 'MOZ_NO_REMOTE': '1', 16:20:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:51 INFO - 'NO_EM_RESTART': '1', 16:20:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:51 INFO - 'PWD': '/builds/slave/test', 16:20:51 INFO - 'SHELL': '/bin/bash', 16:20:51 INFO - 'SHLVL': '1', 16:20:51 INFO - 'TERM': 'linux', 16:20:51 INFO - 'TMOUT': '86400', 16:20:51 INFO - 'USER': 'cltbld', 16:20:51 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471908030.817639-284414530', 16:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:51 INFO - '_': '/tools/buildbot/bin/python'} 16:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:51 INFO - Downloading/unpacking psutil>=3.1.1 16:20:51 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 16:20:51 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 16:20:51 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 16:20:51 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 16:20:51 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 16:20:51 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 16:20:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:20:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:20:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:20:53 INFO - Installing collected packages: psutil 16:20:53 INFO - Running setup.py install for psutil 16:20:53 INFO - building 'psutil._psutil_linux' extension 16:20:53 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 16:20:54 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 16:20:54 INFO - building 'psutil._psutil_posix' extension 16:20:54 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 16:20:54 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 16:20:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:20:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:20:54 INFO - Successfully installed psutil 16:20:54 INFO - Cleaning up... 16:20:54 INFO - Return code: 0 16:20:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:20:54 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')]} 16:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:54 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')]} 16:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:54 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 0x7f545de0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x155e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1559370>, '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 0x155c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155cd80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471908030.817639-284414530', '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 16:20:54 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 16:20:54 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 16:20:54 INFO - Using env: {'DISPLAY': ':0', 16:20:54 INFO - 'HOME': '/home/cltbld', 16:20:54 INFO - 'LANG': 'en_US.UTF-8', 16:20:54 INFO - 'LANGUAGE': 'en_US:en', 16:20:54 INFO - 'LOGNAME': 'cltbld', 16:20:54 INFO - 'MAIL': '/var/mail/cltbld', 16:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:54 INFO - 'MOZ_NO_REMOTE': '1', 16:20:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:54 INFO - 'NO_EM_RESTART': '1', 16:20:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:54 INFO - 'PWD': '/builds/slave/test', 16:20:54 INFO - 'SHELL': '/bin/bash', 16:20:54 INFO - 'SHLVL': '1', 16:20:54 INFO - 'TERM': 'linux', 16:20:54 INFO - 'TMOUT': '86400', 16:20:54 INFO - 'USER': 'cltbld', 16:20:54 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471908030.817639-284414530', 16:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:54 INFO - '_': '/tools/buildbot/bin/python'} 16:20:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:20:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:20:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:20:56 INFO - Installing collected packages: mozsystemmonitor 16:20:56 INFO - Running setup.py install for mozsystemmonitor 16:20:56 INFO - Successfully installed mozsystemmonitor 16:20:56 INFO - Cleaning up... 16:20:56 INFO - Return code: 0 16:20:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:20:56 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')]} 16:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:56 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')]} 16:20:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:56 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 0x7f545de0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x155e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1559370>, '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 0x155c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155cd80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471908030.817639-284414530', '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 16:20:56 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 16:20:56 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 16:20:56 INFO - Using env: {'DISPLAY': ':0', 16:20:56 INFO - 'HOME': '/home/cltbld', 16:20:56 INFO - 'LANG': 'en_US.UTF-8', 16:20:56 INFO - 'LANGUAGE': 'en_US:en', 16:20:56 INFO - 'LOGNAME': 'cltbld', 16:20:56 INFO - 'MAIL': '/var/mail/cltbld', 16:20:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:56 INFO - 'MOZ_NO_REMOTE': '1', 16:20:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:56 INFO - 'NO_EM_RESTART': '1', 16:20:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:56 INFO - 'PWD': '/builds/slave/test', 16:20:56 INFO - 'SHELL': '/bin/bash', 16:20:56 INFO - 'SHLVL': '1', 16:20:56 INFO - 'TERM': 'linux', 16:20:56 INFO - 'TMOUT': '86400', 16:20:56 INFO - 'USER': 'cltbld', 16:20:56 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471908030.817639-284414530', 16:20:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:56 INFO - '_': '/tools/buildbot/bin/python'} 16:20:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:56 INFO - Downloading/unpacking jsonschema==2.5.1 16:20:56 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 16:20:56 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 16:20:56 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 16:20:56 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 16:20:56 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 16:20:56 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 16:20:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:20:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:20:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:59 INFO - Downloading functools32-3.2.3-2.tar.gz 16:20:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:20:59 INFO - warning: no files found matching '*.txt' 16:20:59 INFO - no previously-included directories found matching 'build' 16:20:59 INFO - no previously-included directories found matching 'dist' 16:20:59 INFO - no previously-included directories found matching '.git*' 16:20:59 INFO - Installing collected packages: jsonschema, functools32 16:20:59 INFO - Running setup.py install for functools32 16:20:59 INFO - warning: no files found matching '*.txt' 16:20:59 INFO - no previously-included directories found matching 'build' 16:20:59 INFO - no previously-included directories found matching 'dist' 16:20:59 INFO - no previously-included directories found matching '.git*' 16:20:59 INFO - Successfully installed jsonschema functools32 16:20:59 INFO - Cleaning up... 16:20:59 INFO - Return code: 0 16:20:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:20: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')]} 16:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20: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')]} 16:20:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:59 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 0x7f545de0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x155e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1559370>, '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 0x155c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155cd80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471908030.817639-284414530', '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 16:20:59 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 16:20:59 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 16:20:59 INFO - Using env: {'DISPLAY': ':0', 16:20:59 INFO - 'HOME': '/home/cltbld', 16:20:59 INFO - 'LANG': 'en_US.UTF-8', 16:20:59 INFO - 'LANGUAGE': 'en_US:en', 16:20:59 INFO - 'LOGNAME': 'cltbld', 16:20:59 INFO - 'MAIL': '/var/mail/cltbld', 16:20:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:59 INFO - 'MOZ_NO_REMOTE': '1', 16:20:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:59 INFO - 'NO_EM_RESTART': '1', 16:20:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:59 INFO - 'PWD': '/builds/slave/test', 16:20:59 INFO - 'SHELL': '/bin/bash', 16:20:59 INFO - 'SHLVL': '1', 16:20:59 INFO - 'TERM': 'linux', 16:20:59 INFO - 'TMOUT': '86400', 16:20:59 INFO - 'USER': 'cltbld', 16:20:59 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471908030.817639-284414530', 16:20:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:59 INFO - '_': '/tools/buildbot/bin/python'} 16:20:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:20:59 INFO - Cleaning up... 16:20:59 INFO - Return code: 0 16:20:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:20: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')]} 16:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20: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')]} 16:20:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:59 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 0x7f545de0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x155e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1559370>, '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 0x155c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155cd80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471908030.817639-284414530', '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 16:20:59 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 16:20:59 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 16:20:59 INFO - Using env: {'DISPLAY': ':0', 16:20:59 INFO - 'HOME': '/home/cltbld', 16:20:59 INFO - 'LANG': 'en_US.UTF-8', 16:20:59 INFO - 'LANGUAGE': 'en_US:en', 16:20:59 INFO - 'LOGNAME': 'cltbld', 16:20:59 INFO - 'MAIL': '/var/mail/cltbld', 16:20:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:59 INFO - 'MOZ_NO_REMOTE': '1', 16:20:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:59 INFO - 'NO_EM_RESTART': '1', 16:20:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:59 INFO - 'PWD': '/builds/slave/test', 16:20:59 INFO - 'SHELL': '/bin/bash', 16:20:59 INFO - 'SHLVL': '1', 16:20:59 INFO - 'TERM': 'linux', 16:20:59 INFO - 'TMOUT': '86400', 16:20:59 INFO - 'USER': 'cltbld', 16:20:59 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471908030.817639-284414530', 16:20:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:59 INFO - '_': '/tools/buildbot/bin/python'} 16:20:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:59 INFO - Downloading/unpacking blobuploader==1.2.4 16:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:20:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:01 INFO - Downloading blobuploader-1.2.4.tar.gz 16:21:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:21:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:21:01 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 16:21:01 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 16:21:01 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 16:21:01 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 16:21:01 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 16:21:01 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 16:21:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:21:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:21:02 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 16:21:02 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 16:21:02 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 16:21:02 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 16:21:02 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 16:21:02 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 16:21:02 INFO - Downloading docopt-0.6.1.tar.gz 16:21:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:21:02 INFO - Installing collected packages: blobuploader, requests, docopt 16:21:02 INFO - Running setup.py install for blobuploader 16:21:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:21:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:21:02 INFO - Running setup.py install for requests 16:21:02 INFO - Running setup.py install for docopt 16:21:02 INFO - Successfully installed blobuploader requests docopt 16:21:02 INFO - Cleaning up... 16:21:02 INFO - Return code: 0 16:21:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:21:02 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')]} 16:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:02 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')]} 16:21:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:02 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 0x7f545de0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x155e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1559370>, '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 0x155c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155cd80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471908030.817639-284414530', '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 16:21:02 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 16:21:02 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 16:21:02 INFO - Using env: {'DISPLAY': ':0', 16:21:02 INFO - 'HOME': '/home/cltbld', 16:21:02 INFO - 'LANG': 'en_US.UTF-8', 16:21:02 INFO - 'LANGUAGE': 'en_US:en', 16:21:02 INFO - 'LOGNAME': 'cltbld', 16:21:02 INFO - 'MAIL': '/var/mail/cltbld', 16:21:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:02 INFO - 'MOZ_NO_REMOTE': '1', 16:21:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:02 INFO - 'NO_EM_RESTART': '1', 16:21:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:02 INFO - 'PWD': '/builds/slave/test', 16:21:02 INFO - 'SHELL': '/bin/bash', 16:21:02 INFO - 'SHLVL': '1', 16:21:02 INFO - 'TERM': 'linux', 16:21:02 INFO - 'TMOUT': '86400', 16:21:02 INFO - 'USER': 'cltbld', 16:21:02 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471908030.817639-284414530', 16:21:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:02 INFO - '_': '/tools/buildbot/bin/python'} 16:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:21:03 INFO - Running setup.py (path:/tmp/pip-_eSqr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:21:03 INFO - Running setup.py (path:/tmp/pip-bS5kEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:21:03 INFO - Running setup.py (path:/tmp/pip-rppHpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:21:03 INFO - Running setup.py (path:/tmp/pip-sojBGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:21:03 INFO - Running setup.py (path:/tmp/pip-E4K665-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:21:03 INFO - Running setup.py (path:/tmp/pip-IMGeKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:21:03 INFO - Running setup.py (path:/tmp/pip-t63WsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:21:03 INFO - Running setup.py (path:/tmp/pip-ASV8Zh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:21:03 INFO - Running setup.py (path:/tmp/pip-6hCmks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:21:03 INFO - Running setup.py (path:/tmp/pip-gLIIbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:21:03 INFO - Running setup.py (path:/tmp/pip-rBwUaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:21:03 INFO - Running setup.py (path:/tmp/pip-eAQk_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:21:04 INFO - Running setup.py (path:/tmp/pip-uNJoME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:21:04 INFO - Running setup.py (path:/tmp/pip-PSvaW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:04 INFO - Running setup.py (path:/tmp/pip-Hb6FR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:21:04 INFO - Running setup.py (path:/tmp/pip-6la7ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:21:04 INFO - Running setup.py (path:/tmp/pip-uEc0yU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:21:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:21:04 INFO - Running setup.py install for manifestparser 16:21:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:21:04 INFO - Running setup.py install for mozcrash 16:21:04 INFO - Running setup.py install for mozdebug 16:21:04 INFO - Running setup.py install for mozdevice 16:21:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:21:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:21:04 INFO - Running setup.py install for mozfile 16:21:04 INFO - Running setup.py install for mozhttpd 16:21:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:21:05 INFO - Running setup.py install for mozinfo 16:21:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:21:05 INFO - Running setup.py install for mozInstall 16:21:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:21:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:21:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:21:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:21:05 INFO - Running setup.py install for mozleak 16:21:05 INFO - Running setup.py install for mozlog 16:21:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:21:05 INFO - Running setup.py install for moznetwork 16:21:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:21:05 INFO - Running setup.py install for mozprocess 16:21:05 INFO - Running setup.py install for mozprofile 16:21:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:21:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:21:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:21:05 INFO - Running setup.py install for mozrunner 16:21:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:21:05 INFO - Running setup.py install for mozscreenshot 16:21:05 INFO - Running setup.py install for moztest 16:21:06 INFO - Running setup.py install for mozversion 16:21:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:21:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:21:06 INFO - Cleaning up... 16:21:06 INFO - Return code: 0 16:21:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:06 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 0x7f545de0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x155e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1559370>, '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 0x155c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155cd80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471908030.817639-284414530', '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 16:21:06 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 16:21:06 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 16:21:06 INFO - Using env: {'DISPLAY': ':0', 16:21:06 INFO - 'HOME': '/home/cltbld', 16:21:06 INFO - 'LANG': 'en_US.UTF-8', 16:21:06 INFO - 'LANGUAGE': 'en_US:en', 16:21:06 INFO - 'LOGNAME': 'cltbld', 16:21:06 INFO - 'MAIL': '/var/mail/cltbld', 16:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:06 INFO - 'MOZ_NO_REMOTE': '1', 16:21:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:06 INFO - 'NO_EM_RESTART': '1', 16:21:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:06 INFO - 'PWD': '/builds/slave/test', 16:21:06 INFO - 'SHELL': '/bin/bash', 16:21:06 INFO - 'SHLVL': '1', 16:21:06 INFO - 'TERM': 'linux', 16:21:06 INFO - 'TMOUT': '86400', 16:21:06 INFO - 'USER': 'cltbld', 16:21:06 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471908030.817639-284414530', 16:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:06 INFO - '_': '/tools/buildbot/bin/python'} 16:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:21:06 INFO - Running setup.py (path:/tmp/pip-HX0DiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:21:06 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)) 16:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:21:06 INFO - Running setup.py (path:/tmp/pip-D8lqpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:21:06 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)) 16:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:21:06 INFO - Running setup.py (path:/tmp/pip-6pBPSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:21:06 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)) 16:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:21:06 INFO - Running setup.py (path:/tmp/pip-Le6Ap3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:21:06 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)) 16:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:21:06 INFO - Running setup.py (path:/tmp/pip-qzteCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:21:06 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)) 16:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:21:06 INFO - Running setup.py (path:/tmp/pip-m2es6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:21:06 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)) 16:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:21:06 INFO - Running setup.py (path:/tmp/pip-x4Y6MQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:21:07 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)) 16:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:21:07 INFO - Running setup.py (path:/tmp/pip-NAnCyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:21:07 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)) 16:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:21:07 INFO - Running setup.py (path:/tmp/pip-5Wi5na-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:21:07 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)) 16:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:21:07 INFO - Running setup.py (path:/tmp/pip-Bkfrcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:21:07 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)) 16:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:21:07 INFO - Running setup.py (path:/tmp/pip-oHGT_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:21:07 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)) 16:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:21:07 INFO - Running setup.py (path:/tmp/pip-XGP1F4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:21:07 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)) 16:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:21:07 INFO - Running setup.py (path:/tmp/pip-Q9R1eZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:21:07 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)) 16:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:21:07 INFO - Running setup.py (path:/tmp/pip-kGNs2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:21:07 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)) 16:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:07 INFO - Running setup.py (path:/tmp/pip-RZ2A4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:07 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)) 16:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:21:07 INFO - Running setup.py (path:/tmp/pip-TzSREn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:21:07 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)) 16:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:21:07 INFO - Running setup.py (path:/tmp/pip-Tp3G14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:21:07 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)) 16:21:07 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)) 16:21:07 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)) 16:21:07 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)) 16:21:07 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)) 16:21:07 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)) 16:21:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:21: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 16:21: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 16:21: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 16:21: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 16:21: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 16:21: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 16:21:09 INFO - Downloading blessings-1.6.tar.gz 16:21:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:21:09 INFO - Installing collected packages: blessings 16:21:09 INFO - Running setup.py install for blessings 16:21:09 INFO - Successfully installed blessings 16:21:09 INFO - Cleaning up... 16:21:09 INFO - Return code: 0 16:21:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:21:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:21:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:21:10 INFO - Reading from file tmpfile_stdout 16:21:10 INFO - Current package versions: 16:21:10 INFO - argparse == 1.2.1 16:21:10 INFO - blessings == 1.6 16:21:10 INFO - blobuploader == 1.2.4 16:21:10 INFO - docopt == 0.6.1 16:21:10 INFO - functools32 == 3.2.3-2 16:21:10 INFO - jsonschema == 2.5.1 16:21:10 INFO - manifestparser == 1.1 16:21:10 INFO - mozInstall == 1.12 16:21:10 INFO - mozcrash == 0.17 16:21:10 INFO - mozdebug == 0.1 16:21:10 INFO - mozdevice == 0.48 16:21:10 INFO - mozfile == 1.2 16:21:10 INFO - mozhttpd == 0.7 16:21:10 INFO - mozinfo == 0.9 16:21:10 INFO - mozleak == 0.1 16:21:10 INFO - mozlog == 3.3 16:21:10 INFO - moznetwork == 0.27 16:21:10 INFO - mozprocess == 0.23 16:21:10 INFO - mozprofile == 0.28 16:21:10 INFO - mozrunner == 6.12 16:21:10 INFO - mozscreenshot == 0.1 16:21:10 INFO - mozsystemmonitor == 0.3 16:21:10 INFO - moztest == 0.7 16:21:10 INFO - mozversion == 1.4 16:21:10 INFO - psutil == 3.1.1 16:21:10 INFO - requests == 1.2.3 16:21:10 INFO - wsgiref == 0.1.2 16:21:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:21:10 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')]} 16:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:10 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')]} 16:21:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:10 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 0x7f545de0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x155e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1559370>, '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 0x155c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155cd80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471908030.817639-284414530', '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 16:21:10 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 16:21:10 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 16:21:10 INFO - Using env: {'DISPLAY': ':0', 16:21:10 INFO - 'HOME': '/home/cltbld', 16:21:10 INFO - 'LANG': 'en_US.UTF-8', 16:21:10 INFO - 'LANGUAGE': 'en_US:en', 16:21:10 INFO - 'LOGNAME': 'cltbld', 16:21:10 INFO - 'MAIL': '/var/mail/cltbld', 16:21:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:10 INFO - 'MOZ_NO_REMOTE': '1', 16:21:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:10 INFO - 'NO_EM_RESTART': '1', 16:21:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:10 INFO - 'PWD': '/builds/slave/test', 16:21:10 INFO - 'SHELL': '/bin/bash', 16:21:10 INFO - 'SHLVL': '1', 16:21:10 INFO - 'TERM': 'linux', 16:21:10 INFO - 'TMOUT': '86400', 16:21:10 INFO - 'USER': 'cltbld', 16:21:10 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471908030.817639-284414530', 16:21:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:10 INFO - '_': '/tools/buildbot/bin/python'} 16:21:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:10 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)) 16:21:10 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)) 16:21:10 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)) 16:21:10 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)) 16:21:10 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)) 16:21:10 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)) 16:21:10 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)) 16:21:10 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)) 16:21:10 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)) 16:21:10 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)) 16:21:10 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)) 16:21:10 INFO - Cleaning up... 16:21:10 INFO - Return code: 0 16:21:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:21:10 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')]} 16:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:10 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')]} 16:21:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:10 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 0x7f545de0bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x155e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1559370>, '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 0x155c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155cd80>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1471908030.817639-284414530', '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 16:21:10 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 16:21:10 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 16:21:10 INFO - Using env: {'DISPLAY': ':0', 16:21:10 INFO - 'HOME': '/home/cltbld', 16:21:10 INFO - 'LANG': 'en_US.UTF-8', 16:21:10 INFO - 'LANGUAGE': 'en_US:en', 16:21:10 INFO - 'LOGNAME': 'cltbld', 16:21:10 INFO - 'MAIL': '/var/mail/cltbld', 16:21:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:10 INFO - 'MOZ_NO_REMOTE': '1', 16:21:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:10 INFO - 'NO_EM_RESTART': '1', 16:21:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:10 INFO - 'PWD': '/builds/slave/test', 16:21:10 INFO - 'SHELL': '/bin/bash', 16:21:10 INFO - 'SHLVL': '1', 16:21:10 INFO - 'TERM': 'linux', 16:21:10 INFO - 'TMOUT': '86400', 16:21:10 INFO - 'USER': 'cltbld', 16:21:10 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471908030.817639-284414530', 16:21:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:10 INFO - '_': '/tools/buildbot/bin/python'} 16:21:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:21:10 INFO - Cleaning up... 16:21:10 INFO - Return code: 0 16:21:10 INFO - Running post-action listener: _resource_record_post_action 16:21:10 INFO - Running post-action listener: _start_resource_monitoring 16:21:10 INFO - Starting resource monitoring. 16:21:10 INFO - [mozharness: 2016-08-22 23:21:10.550946Z] Finished create-virtualenv step (success) 16:21:10 INFO - [mozharness: 2016-08-22 23:21:10.551411Z] Running install step. 16:21:10 INFO - Running pre-action listener: _resource_record_pre_action 16:21:10 INFO - Running main action method: install 16:21:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:21:10 INFO - Reading from file tmpfile_stdout 16:21:10 INFO - Detecting whether we're running mozinstall >=1.0... 16:21:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:21:10 INFO - Reading from file tmpfile_stdout 16:21:10 INFO - Output received: 16:21:10 INFO - Usage: mozinstall [options] installer 16:21:10 INFO - Options: 16:21:10 INFO - -h, --help show this help message and exit 16:21:10 INFO - -d DEST, --destination=DEST 16:21:10 INFO - Directory to install application into. [default: 16:21:10 INFO - "/builds/slave/test"] 16:21:10 INFO - --app=APP Application being installed. [default: firefox] 16:21:10 INFO - mkdir: /builds/slave/test/build/application 16:21:10 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'] 16:21:10 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 16:21:27 INFO - Reading from file tmpfile_stdout 16:21:27 INFO - Output received: 16:21:27 INFO - /builds/slave/test/build/application/firefox/firefox 16:21:27 INFO - Running post-action listener: _resource_record_post_action 16:21:27 INFO - [mozharness: 2016-08-22 23:21:27.848765Z] Finished install step (success) 16:21:27 INFO - [mozharness: 2016-08-22 23:21:27.849011Z] Running run-tests step. 16:21:27 INFO - Running pre-action listener: _resource_record_pre_action 16:21:27 INFO - Running main action method: run_tests 16:21:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:21:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:21:27 INFO - Python 2.7.3 16:21:27 INFO - Return code: 0 16:21:27 INFO - grabbing minidump binary from tooltool 16:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:21:27 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 0x1559370>, '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 0x155c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x155cd80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:21:27 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 16:21:27 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 16:21:27 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 16:21:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:21:27 INFO - Return code: 0 16:21:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:21:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:21:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:21:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:21:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:21:27 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:21:27 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:21:27 INFO - Using env: {'DISPLAY': ':0', 16:21:27 INFO - 'HOME': '/home/cltbld', 16:21:27 INFO - 'LANG': 'en_US.UTF-8', 16:21:27 INFO - 'LANGUAGE': 'en_US:en', 16:21:27 INFO - 'LOGNAME': 'cltbld', 16:21:27 INFO - 'MAIL': '/var/mail/cltbld', 16:21:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:21:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:21:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:27 INFO - 'MOZ_NO_REMOTE': '1', 16:21:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:21:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:27 INFO - 'NO_EM_RESTART': '1', 16:21:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:27 INFO - 'PWD': '/builds/slave/test', 16:21:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:21:27 INFO - 'SHELL': '/bin/bash', 16:21:27 INFO - 'SHLVL': '1', 16:21:27 INFO - 'TERM': 'linux', 16:21:27 INFO - 'TMOUT': '86400', 16:21:27 INFO - 'USER': 'cltbld', 16:21:27 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1471908030.817639-284414530', 16:21:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:27 INFO - '_': '/tools/buildbot/bin/python'} 16:21:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:21:28 INFO - mozversion application_buildid: 20160822143002 16:21:28 INFO - mozversion application_changeset: 08e9ded26ada149385af32e1c1d89f30e3d8279c 16:21:28 INFO - mozversion application_display_name: Nightly 16:21:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:21:28 INFO - mozversion application_name: Firefox 16:21:28 INFO - mozversion application_remotingname: firefox 16:21:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:21:28 INFO - mozversion application_vendor: Mozilla 16:21:28 INFO - mozversion application_version: 51.0a1 16:21:28 INFO - mozversion platform_buildid: 20160822143002 16:21:28 INFO - mozversion platform_changeset: 08e9ded26ada149385af32e1c1d89f30e3d8279c 16:21:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:21:28 INFO - mozversion platform_version: 51.0a1 16:21:28 INFO - using testdate: 1471908088 16:21:28 INFO - actual date: 1471908088 16:21:28 INFO - starting webserver on 'localhost:56194' 16:21:28 INFO - SUITE-START | Running 2 tests 16:21:28 INFO - TEST-START | dromaeo_css 16:21:28 INFO - operating with platform_type : linux_ 16:21:28 INFO - Initialising browser for dromaeo_css test... 16:21:28 INFO - TEST-INFO | started process 22275 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1hCsdZ/profile http://localhost:56194/getInfo.html) 16:21:32 INFO - PROCESS | 22275 | __metrics Screen width/height:1600/1200 16:21:32 INFO - PROCESS | 22275 | colorDepth:24 16:21:32 INFO - PROCESS | 22275 | Browser inner width/height: 1024/697 16:21:32 INFO - PROCESS | 22275 | __metrics 16:21:32 INFO - PROCESS | 22275 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:21:32 INFO - PROCESS | 22275 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:21:33 INFO - PROCESS | 22275 | console.error: PushService: 16:21:33 INFO - PROCESS | 22275 | stateChangeProcessEnqueue: Error transitioning state 16:21:33 INFO - PROCESS | 22275 | UnknownError 16:21:34 INFO - TEST-INFO | 22275: exit 0 16:21:34 INFO - Browser initialized. 16:21:34 INFO - Running cycle 1/1 for dromaeo_css test... 16:21:34 INFO - TEST-INFO | started process 22359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1hCsdZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:21:46 INFO - PROCESS | 22359 | RSS: Main: 173940736 16:21:46 INFO - PROCESS | 22359 | 16:22:37 INFO - PROCESS | 22359 | 1471908157622 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] 16:24:47 INFO - PROCESS | 22359 | Cycle 1(1): loaded http://localhost:56194/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56194/tests/dromaeo/cssquery-ext.html) 16:24:48 INFO - PROCESS | 22359 | RSS: Main: 275853312 16:24:48 INFO - PROCESS | 22359 | 16:27:50 INFO - PROCESS | 22359 | Cycle 1(1): loaded http://localhost:56194/tests/dromaeo/cssquery-ext.html (next: http://localhost:56194/tests/dromaeo/cssquery-jquery.html) 16:27:51 INFO - PROCESS | 22359 | RSS: Main: 277942272 16:27:51 INFO - PROCESS | 22359 | 16:30:53 INFO - PROCESS | 22359 | Cycle 1(1): loaded http://localhost:56194/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56194/tests/dromaeo/cssquery-mootools.html) 16:30:54 INFO - PROCESS | 22359 | RSS: Main: 277278720 16:30:54 INFO - PROCESS | 22359 | 16:33:56 INFO - PROCESS | 22359 | Cycle 1(1): loaded http://localhost:56194/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56194/tests/dromaeo/cssquery-prototype.html) 16:33:57 INFO - PROCESS | 22359 | RSS: Main: 264282112 16:33:57 INFO - PROCESS | 22359 | 16:36:59 INFO - PROCESS | 22359 | Cycle 1(1): loaded http://localhost:56194/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56194/tests/dromaeo/cssquery-yui.html) 16:37:00 INFO - PROCESS | 22359 | RSS: Main: 220516352 16:37:00 INFO - PROCESS | 22359 | 16:40:03 INFO - PROCESS | 22359 | Cycle 1(1): loaded http://localhost:56194/tests/dromaeo/cssquery-yui.html (next: http://localhost:56194/tests/dromaeo/cssquery-dojo.html) 16:40:03 INFO - PROCESS | 22359 | RSS: Main: 315060224 16:40:03 INFO - PROCESS | 22359 | 16:40:03 INFO - PROCESS | 22359 | __start_tp_report 16:40:03 INFO - PROCESS | 22359 | _x_x_mozilla_page_load 16:40:03 INFO - PROCESS | 22359 | _x_x_mozilla_page_load_details 16:40:03 INFO - PROCESS | 22359 | |i|pagename|runs| 16:40:03 INFO - PROCESS | 22359 | |0;dojo.html;3018.260526171088;3033.9544906826386;3053.1145967669377;3061.540768884667;3073.3392320651055;5180.6891586504835;5314.787408503656;5410.648307859991;5442.863928401792;5445.128779395292;5411;5419.295491586088;5421.430749771276;5535.778568857241;5537.058700020996;4641.698289611165;4944.1594928862;5020.874478138039;5057.620678449131;5102.897942041157;5037.319961805146;5092.8472145835685;5095.108356037697;5096.847094587169;5097.745112744366;4757.500462451462;4789.640776941708;4794.592459640935;4981.676191047571;4986.326845875797;4810.158222311116;4844.10384078943;4854.271859221145;4859.198232291667;4899.093667671492;4826.420829500447;4843.636727245435;4852.660313778037;4920.089783390084;4925.433575138869;5409.323834520685;5416.51251387377;5425.430329815392;5431.701256430894;5433.212184233264;5587.972060139714;5748.856278593027;5757.107648314518;5768.394318596529;5804.767809287666;5849.590528662995;5874.794382196603;5877;5879.206307148523;5889.852753681193;5471.890562188773;5488.862778430571;5491.588130890159;5500.339959204921;5500.697461639648;5700.344460387026;5836.299644042742;5913.674747888907;5919.496842768327;6006.12911127884;5738.139279108167;5750.568707346882;5758.712064396764;5764.221830052973;5765.250517432707;5782.335031471351;5829.941700583025;5837.795677151279;5845.795397161079;5852.063669812809;5553.333599968029;5699.914501282484;5724.4561766632105;5735.4551317624755;5820.068788993825;5750.913736293959;5785.566082543742;5790.826275211751;5796.913046304308;5798.797042103506;4442.888927776767;4450.532694067141;4456.108778244364;4461.776911154494;4471.128130014616;3841.2701586698436;3905.511811023622;3959;3959.0696186396176;4015.859444919414;5500.50495455411;5501.724913754297;5508;5508.724563771795;5514.862128446821;5849.356570777211;5852.941470585325;5854.912176317359;5860.472557469763;5867.794627188028;5295.15277555597;5429.945700543023;5485.067538518461;5500.669959802424;5573.386927437979;5108.2848401223855;5120.974395128001;5131;5131.461196574381;5132.358455193101;6107.083937409336;6122.908156377569;6127.20346354971;6138.877222455526;6139.539534535017;5672.943270567406;5692.060809966475;5717.628354156966;5727.198192253005;5822.214001109796;5990.041593345044;5997.490213331741;5997.640141591344;6000.489958353589;6004.0693692477735;5689.6586204827845;5696.287964004499;5697.829065128053;5704;5707.343655479673;5612.130119831432;5655.943440565542;5658.462446067617;5721.799737009184;5786.768529258951;5612.887742245214;5620.3536593290655;5621.747021383966;5651.067573850269;5652.491275785199;5611.747471363717;5622.100463925753;5626.578006649435;5631.2960879890015;5643.1535269709875;5405.108157154025;5469.480399362054;5494.835154945358;5520.723963801875;5604.495595396434;5714.5999780015;5721.685307308138;5723.484886360081;5727.427257274239;5727.627704199213;5571.693556854412;5577.60956733041;5580.832575022756;5586.581006424453;5591 16:40:03 INFO - PROCESS | 22359 | |1;ext.html;569.4191924237277;593.350281441821;595.6307089604446;597.4592993341025;609.3632154398653;44169.012394442245;45138.09723805526;45322.280663160236;48669.75665121678;49007.50992490074;46284.074318513696;46766;46788.53211467884;46809.531904680945;46918;7941.602919854013;9027.774305642346;9181.95409022954;9192.35653504255;10827;10718.839217411745;11157.051650609666;11167.106631469504;11167.497462614201;11171.66485005451;11309.886901130965;11358.31850088993;11360;11360.091192704564;11364.943175284154;11215.775684486305;11251.0436612888;11251.156163287786;11256.774864502746;11261.211715179941;10964.506597203144;11035.724106897393;11039.779204415947;11042.227044106916;11042.392668403234;44084;44302.55697443017;44507;44523.55476445259;44548;3439.5528581284525;3589.353916295066;3657.4513822926506;3899.74651647642;4059.2084543514025;32799;32948.50577241343;33197.3360532788;33281.3343733124;33375.83312083448;3580.964190358089;3599.7840129592046;3627.7097832173627;3797.9620203797886;3804.5624753153465;349529;351773;352628;352751;354233;58180;58860;58869.411305887246;58888;58920;61042;61135.694321528106;61170;61836;61936.69031654813;15173.317200725995;15368.615784605474;15386;15391;15398.46105386306;9900.752481188028;10005.949970250102;10025.799484010426;11569.76860462786;11671.708207294885;15979.280932358071;16380.180990950405;16501.669966600602;16604.83395166033;16607.667846643;5899.557533185029;5917.289925209003;5929.881402371929;5946.643201407929;6006.249218847644;892.1836519584507;1026.8049070676548;1059.0309866472091;1066.274933045521;1120.3110087296418;32522.186945326557;33023.66976330206;33378.49932251018;33445.83277083599;33659.45437441233;1088.78768640116;1109.6060898380958;1120.2438354110943;1199.7767857142808;1200.3458115327167;17477.213525391388;17530.298788048334;17543.561410964827;17615;17639.470815875546;499694;502578;504324;505976;507896;61362.38637613656;61582.076268856006;61619.38380616226;61702.691486543175;61798.69100654468;1237.5730373021293;1271.2944315904763;1307.666545030992;1342.2550484481208;1363.6795353092016;29506.262343441587;34124.65875341314;34351.14122146966;34660.30679386348;34697.826510867286;51305.23042154445;51978.74010629923;52018.73990630022;52025;52040;397640;397885;397951;398415;398910.1743721107;28454.71545284521;29333.55999659964;29453.558196627495;30871.382572348877;36597.26805463929;49614.75192624014;50197;50675;51348;51522.22716659178;41509.169816602895;42023.7898810504;42148.789256053526;44001;44445.55554444544;41773.79113104415;42089.78955105205;42158.789206055;42531.3620295702;43503;42118;42811;42831.78584107184;42932.57067429286;43521.78239108784;34763.826180868935;37626.2474750498;37924.62075379321;38718.419223711106;38726;28128.29679258035;28165.43669126565;28235.294117647223;28470.715292846806;28879.85560072186 16:40:03 INFO - PROCESS | 22359 | |2;jquery.html;374.7264496917252;388.9027743064232;396.95831937646545;400.2755013425699;422.56601972637617;14287.142771433708;17851.821481785195;19440.805591944078;19548.120334584943;19596.216151353947;18078.638427231446;18108.275668973227;18191.45425637233;18245.36141235057;19010.524736881584;4087.828896445998;5712.942870571293;5930.169776231331;5934.139549765281;5935.49548288396;6387.680615969206;6682.398584127428;6731.596104233761;6760.323967603225;6796.218434879978;5768.451997060272;6002.2197114375285;6023.668698221596;6679.499037572177;6683.699233534503;5941.079132734433;6059.636421814683;6136.877262454771;6145;6146.5390095743;5862.970685146547;5957.851053723648;5962.880742385128;5965.761369545213;5971.134185543072;14298.428062877472;14393.856061439355;14434.927825360806;14452.566423007327;14480;2279.9658005129936;2614.673165854268;2665.866706664659;3044.756419486458;3086.36729470458;10254;10260.179185665129;10369.429681367521;10779.622713205;11013.174011949135;1760.251892945493;1796.8023517413073;1850.6113716119496;1926.3450426854797;2018.8082132197565;86363.56818215869;92158.53920730353;92847.53576232144;92861.53569232178;93874;11112.111031117653;11119.833202501968;11272;11335.376554289429;11560;15982.440614578434;16007.759883601755;16018.958767680064;16036.11801350937;16042.518724438285;7704.26809453101;7895.68417263303;8022.679092836338;8033.156518565466;8156.755297341089;7341.339279464767;7401.0748656417945;7614.847703045908;7643.7324693635455;7645.120811106683;4754.690945088558;4796.664233503621;4828.227483602606;4830.806767729251;5050.621203409759;1903.5716963683337;1936.448112287991;1977.2189984955862;2029.4114706735177;2063.0819285418147;870.3341943413294;965.7440778193784;993.9155171810477;1010.2372708604956;1031.6904928521565;19167.233310667416;19644.214231430582;19871.801281986995;19904.00959903998;19996.400107996782;966.5070813884829;969.6654654144309;976.6142373762324;982.40564458503;1040.3705758016442;10321.174306055498;10947.646658418846;10979.451027448597;10991.780164396667;11103.555857765761;533071;540316;540546;543716;553852;92431;96503;97230;100524;102129;931.3434029009532;965.9130678238852;986.1666891476691;986.7582442301539;998.3111652959435;16462.341506339613;16775.161241938098;16873.746893796848;17234;17807.19867605935;43312.566874330856;43373.56626433822;43431.565684344016;43713.125737484435;44140.55859441365;57591.424085760285;58541.70729146327;58927.705361472916;58959.41040589539;59042.40957590369;8175.468594541336;8499.872501912352;8736.388452808242;8791.560421979004;8951.239144672776;9433.669821556212;13023.283719395524;13260.403281852532;13374.197548146753;14012.369443374868;11572.768544629229;11733.882661173278;11930.701732456411;11964.64106076819;12065.939670301592;11139.3873336964;11422.714432139262;11779.587714429954;11965.700857478632;12245.632631021084;11805.763884722086;11806.940965295118;11941.76116477683;11954.10344224204;12299.69250768738;8643.567821608769;8688.78278043054;8732.519711415933;8858.025617181976;8992.46045237288;10451.111655509367;10698.304610200312;11017.669469915916;11161.991700415925;11229.27009744364 16:40:03 INFO - PROCESS | 22359 | |3;mootools.html;1322.3652646729563;1467.750482417989;1530.9464168754093;1665.3921318718665;1809.0773705410236;7775.144734079254;7810.726624568141;8001.8399632007395;8017.398695097876;8253.587320633975;8025.598720064003;8096.10942796292;8102.230288122619;8108.7161949331785;8112.107668156498;2330.1611419888786;2358.068562917655;2358.398608354867;2359.0445869422824;2359.386559494535;2276.3284830974903;2323.8954247058923;2329.650552417134;2329.9883500582473;2334.031376978552;2285.1202287119495;2295.116380193629;2305.5504176685554;2340.0171927790284;2343.5078633486987;2226.832987525926;2250.3586477853814;2256.8758718270487;2257.932262032142;2260.152442833937;2260.1185537640335;2265.105283413059;2268.376196545963;2273.2043784675398;2273.57938781326;8132.512049277003;8156;8171.795705107361;9044.457332560067;9085.863712044325;5299.470052994709;5414.91877621836;5447.5914306426785;5449.891002179974;5452.073147564924;3365.461526155828;3385.441402168664;3431.2108215110666;3438.570178727659;3471.63547827477;1037.5175543372293;1053.8261186904151;1908.5876451425984;1981.465004448805;1993.8864803308538;12671.303078330688;12684.238945663197;12779.552715655;12800.6799830005;12805.167664101804;4379.671524635665;4508.571685689854;4582.381378513858;4597.402337696145;4601.102784956901;9991.600335986624;10013.09882110599;10024.348417352849;10025.799484010426;10047.09576138151;5303.522682958553;5307.01820163271;5307.389650190277;5308.044551980681;5311.017461769585;4362.062156636275;4716.95283047172;4838.104950584153;4847.127517046965;4975.0796102721115;3756.6619004289746;3845.1732877430927;3876.7673939563715;3953.0512676957323;3977.164795392942;1166.836642869999;1179.0744265751516;1179.4102948525738;1191.5472120594118;1192.7375977285158;975.1077763846143;976.8009768009824;981.293468702533;985.980280394388;992.5285489392625;5955.821325360246;6091.817245482643;6184.9485587450245;6229.1590635264565;6241.282252540925;478.55476461088017;486.54994130429213;493.7605261448195;495.7496464285513;499.5529001543598;4168.749875007509;4271.594198551133;4323.567643235651;4455.977720111378;4464.285714285698;11079.390633515233;11356.94321528387;11374.260673056226;11408.88591114095;11444.656660300205;11325.660230193107;11330.206885517935;11343.149263805082;11367.829482557769;11382.715432114097;8077.232662897015;8329.292010179082;8345.958270208732;8351.749447516584;8603.741887743377;5814.273215848019;5844;5974.970125149346;5978.760849565969;6012.368701286302;9522.285828562746;9526.333156678966;9529.761755956157;9537.666181683608;9639;9547.093026162504;10157.339772914736;10569.577216911544;10570.735731606772;10973.890261097287;7215.8556828864175;7680.155182929985;8040.477368970998;8055.838883222185;8252.133525979685;8934.195922367018;9117.498537580497;9148.130927561871;9150.084991500797;9166.17504424605;7740.961295193488;7838.529688218497;7896.368290536629;8206.343492520704;8341.332693384393;7691.923080769121;7930.286274235346;7936.087349954598;7996.32031277348;8036.075851277178;7371.557706537625;7485.5508669480005;7490.70037198506;7492.7752167435065;7492.850142997218;5364.892702146013;5365.3293338332705;5512.779488820403;5516.9448305516435;5517.531009864207;5191.61062920275;5407.080796264566;5417.133258678593;5541;5614.63504872182 16:40:03 INFO - PROCESS | 22359 | |4;prototype.html;311.7739638761898;313.80857676817135;320;320.7914855344026;332.1546663740779;5053.292539044527;5144.948550514494;5218.0868348039085;5229.346331708536;5244.980682437261;5170.612204084699;5173.818916337929;5234.79060837567;5236.423993360727;5282.709450980195;4095.7133000689964;4119.196756632457;4146.419501269825;4163.042500224942;4163.188178305231;3893.785841778701;4024.5109309555505;4107.7535347879075;4112.424260603518;4138.627523522882;4014.739041962263;4031.6774658027434;4033.7579745215235;4035.6367926886574;4035.9596404036024;3996.2007598480277;4005.5994400560003;4007.278689835814;4032;4035.8385664573384;3439.673231043072;3551.147724546116;3567.661072198137;3575.66031227033;3578.427451607756;5054;5058.570021548173;5064;5084.618653600995;5133.12736834739;4607.424071991001;4621.399218101659;4659.953400465985;4693.155232058228;4724.645651576146;5283.128139072793;5368.62419630626;5427.810026649048;5436.21174929637;5517.151754162361;3896.3571010783185;3896.3571010783185;3899.8245078971513;3909.824057917372;3947.9013024674327;5700.629459085188;5711.714864155531;5712.942870571324;5720.342160651537;5753.194552762617;3814.6185381462187;3947.4078888167005;3954.5056867891512;4012.8394864205106;4022.879313620596;4023.074692820609;4025.798710064485;4031.697622678252;4042.7776472293717;4043.6360727534075;4584.372547745503;4608.723476591415;4613.146567884952;4694.647901407408;4695.9530404695515;5264.236685680555;5461.836144915659;5468.890622187534;5471.781128754885;5512.897420515833;1323.7749582570987;1334.833145856768;1360.5714200027157;1365.6722386627139;1367.7401293754156;939.9859002114973;940.9623615055322;961.33667769239;976.9316147869723;979.5396163803001;5140.177571588602;5171.5862730981435;5198.558122559625;5218;5255.710935898563;5514.448555144453;5541.251930989345;5558.110702287615;5559.749811258503;5566.944330556724;5035.748212589356;5156.917047420009;5213.400458947193;5229.294045303911;5281.9207711884355;2956.1722717639095;2975.4941659917868;2992.6558445779015;2999.31015866352;3011.5181570948544;5734.2258795062135;5762.971185144132;5805.809808989147;5864.618799778001;5870.853228669317;5599.916001259984;5651.237082993825;5695.971520142456;5703.258576385043;5737.827865164052;5730.598858079894;5764.74058667361;5779.8555036124435;5814.534837213013;5825.446582574648;5414.377346605191;5489.835304940699;5625.8593535161945;5668.149777533238;5668.234788303691;5516.91724624139;5524.696141712245;5524.723763811713;5532;5566.443355664401;5750.750825783419;5750.971245143747;5761.683107429131;5781.5663825214115;5792.768289268382;3847.9038024049623;3867.632574905492;3945.2109578085074;3970.4044393340073;3974.2647610192207;5417.539509141609;5511.834644960658;5529.751161197675;5660.698039450867;5691.63004404729;5377.354717433933;5443.346798384061;5445.537129343892;5456.59075569326;5503.972480137573;5452.182172674131;5461.42655021233;5467.72661366938;5472.726363681721;5512.889742205053;5188.325517682677;5265.552428043659;5349.57203423733;5385.1922211667;5411.026015317123;5450.672959622435;5460.3993560707495;5533.806316778893;5537.169424586345;5544.972275138599;5394.595405344537;5395.03081375303;5404.891902162013;5430.8099216527235;5439.918401223906 16:40:03 INFO - PROCESS | 22359 | |5;yui.html;763.6372722956596;777.1606664802015;803.7950322667723;851.64656667483;885.1502557544757;14078.084924479914;15047.47333843313;15059.096454212755;15073.321700523475;15129.470468533604;14871.107733535995;15683.529494115195;15701.136437495934;15707.685846283068;15709.528714138565;653.4249860123085;770.1720650300921;782.221689419026;784.8077221080844;798.9121196668361;800.5316889619551;812.7196117339538;813.5606772342928;813.6379311206515;813.7680760983121;852.4672079950032;858.0861382627481;858.4119877883638;859.6776208921655;861.9913800861974;683.4122654517112;823.4935514658501;832.983340333196;853.3940901959617;854.5086575219274;615.8768246350747;616.0758861707438;616.4451993206105;618.1778234947509;620.4663988969482;13589.592312230649;13617.523386681418;13623.455061797516;13628.659283517893;13631.727365452734;14288.142711437244;14752.336144873507;15069.09585424867;15155.924220378938;15236.619084522865;13458.93270533641;13557.864421355858;13613.591592252249;13792.93103534486;13846.238456884867;4338.869833904988;4484.955150448519;4514.984128571045;4516.254817955033;4523.276275795857;79044.60477697632;79787;80120.19879801186;80969;81075;10470.738231544272;11015.944920275508;11288.887111128948;11353.943230283961;11574.131940104526;20892.1643134276;21077.683834742493;21081.578368432547;21102.47243818917;21134.788652113588;8210.261076503144;8295.875561866576;8303.294219991369;8485.618147183392;8547.10255423184;4673.742944138037;4760.119377915027;4765.617628216279;4790.664653474223;4821.541953514481;3506.193575477603;3629.7459177857295;3638.581563120222;3638.890833275006;3639.745217834779;605.2374008749008;605.5912259225094;611.721666641677;615.9445649891532;618.9473894718909;502.9119904016782;586.5131940489383;591.361329763854;605.3976293587821;621.6736213487955;8473.788155296166;8995.595198216097;9171.495567743705;9233.538323083952;9356.90643093574;680.2381332907175;706.8162277807704;710.4316546762569;714.6069661686156;724.1165777751136;4115.08648478459;4317.942104184495;4321.805518751664;4378.426837180987;4442.155990361821;126556;130625;130771.34614326867;131603;133330;111234;112321;114083;116540;116905.41547292209;94075.52962235281;96626;96939.51530242445;97406;98863;8275.875861861956;8494.872576911228;8589.484630922165;8657.177568131017;8698.304135669257;53619.731901340245;54872;55068.724656376464;55552.500412443806;56244.15633765579;23129.421764456023;39177.8041109804;47912;64009;65845.34154658584;12577.308248046445;13207.933960330136;13418.39617217208;13553.119047261896;13781.173129612256;13431.19412835233;13959.720805584035;14325.498607548685;14418.279086045866;14923.701525969636;12851.807222891477;12897.41961611711;13035.739285214433;13287.13633613812;13783;12924.28916409569;13254.403551839998;13346.532871349456;13569.52506662262;14004.719905602034;12999.350032498527;13046.478140874258;13262.933685331898;13322.600321990356;13322.733545329233;10767.407792571485;10827.446872936793;11524.193306468467;11586.71033224176;11865.169438139592;9494.816192275954;10496.317739346918;10778.245522813328;10925.617603384162;11342.262752921033 16:40:03 INFO - PROCESS | 22359 | __end_tp_report 16:40:03 INFO - PROCESS | 22359 | __start_cc_report 16:40:03 INFO - PROCESS | 22359 | _x_x_mozilla_cycle_collect,980 16:40:03 INFO - PROCESS | 22359 | __end_cc_report 16:40:03 INFO - PROCESS | 22359 | __startTimestamp1471909203556__endTimestamp 16:40:03 INFO - PROCESS | 22359 | 16:40:03 INFO - PROCESS | 22359 | ------- Summary: start ------- 16:40:03 INFO - PROCESS | 22359 | Number of tests: 6 16:40:03 INFO - PROCESS | 22359 | 16:40:03 INFO - PROCESS | 22359 | [#0] dojo.html Cycles:165 Average:5382.08 Median:5580.83 stddev:621.44 (11.1%) stddev-sans-first:595.04 16:40:03 INFO - PROCESS | 22359 | Values: 3018.3 3034.0 3053.1 3061.5 3073.3 5180.7 5314.8 5410.6 5442.9 5445.1 5411.0 5419.3 5421.4 5535.8 5537.1 4641.7 4944.2 5020.9 5057.6 5102.9 5037.3 5092.8 5095.1 5096.8 5097.7 4757.5 4789.6 4794.6 4981.7 4986.3 4810.2 4844.1 4854.3 4859.2 4899.1 4826.4 4843.6 4852.7 4920.1 4925.4 5409.3 5416.5 5425.4 5431.7 5433.2 5588.0 5748.9 5757.1 5768.4 5804.8 5849.6 5874.8 5877.0 5879.2 5889.9 5471.9 5488.9 5491.6 5500.3 5500.7 5700.3 5836.3 5913.7 5919.5 6006.1 5738.1 5750.6 5758.7 5764.2 5765.3 5782.3 5829.9 5837.8 5845.8 5852.1 5553.3 5699.9 5724.5 5735.5 5820.1 5750.9 5785.6 5790.8 5796.9 5798.8 4442.9 4450.5 4456.1 4461.8 4471.1 3841.3 3905.5 3959.0 3959.1 4015.9 5500.5 5501.7 5508.0 5508.7 5514.9 5849.4 5852.9 5854.9 5860.5 5867.8 5295.2 5429.9 5485.1 5500.7 5573.4 5108.3 5121.0 5131.0 5131.5 5132.4 6107.1 6122.9 6127.2 6138.9 6139.5 5672.9 5692.1 5717.6 5727.2 5822.2 5990.0 5997.5 5997.6 6000.5 6004.1 5689.7 5696.3 5697.8 5704.0 5707.3 5612.1 5655.9 5658.5 5721.8 5786.8 5612.9 5620.4 5621.7 5651.1 5652.5 5611.7 5622.1 5626.6 5631.3 5643.2 5405.1 5469.5 5494.8 5520.7 5604.5 5714.6 5721.7 5723.5 5727.4 5727.6 5571.7 5577.6 5580.8 5586.6 5591.0 16:40:03 INFO - PROCESS | 22359 | 16:40:03 INFO - PROCESS | 22359 | [#1] ext.html Cycles:180 Average:59232.97 Median:37111.76 stddev:111682.16 (300.9%) stddev-sans-first:111908.60 16:40:03 INFO - PROCESS | 22359 | Values: 569.4 593.4 595.6 597.5 609.4 44169.0 45138.1 45322.3 48669.8 49007.5 46284.1 46766.0 46788.5 46809.5 46918.0 7941.6 9027.8 9182.0 9192.4 10827.0 10718.8 11157.1 11167.1 11167.5 11171.7 11309.9 11358.3 11360.0 11360.1 11364.9 11215.8 11251.0 11251.2 11256.8 11261.2 10964.5 11035.7 11039.8 11042.2 11042.4 44084.0 44302.6 44507.0 44523.6 44548.0 3439.6 3589.4 3657.5 3899.7 4059.2 32799.0 32948.5 33197.3 33281.3 33375.8 3581.0 3599.8 3627.7 3798.0 3804.6 349529.0 351773.0 352628.0 352751.0 354233.0 58180.0 58860.0 58869.4 58888.0 58920.0 61042.0 61135.7 61170.0 61836.0 61936.7 15173.3 15368.6 15386.0 15391.0 15398.5 9900.8 10005.9 10025.8 11569.8 11671.7 15979.3 16380.2 16501.7 16604.8 16607.7 5899.6 5917.3 5929.9 5946.6 6006.2 892.2 1026.8 1059.0 1066.3 1120.3 32522.2 33023.7 33378.5 33445.8 33659.5 1088.8 1109.6 1120.2 1199.8 1200.3 17477.2 17530.3 17543.6 17615.0 17639.5 499694.0 502578.0 504324.0 505976.0 507896.0 61362.4 61582.1 61619.4 61702.7 61798.7 1237.6 1271.3 1307.7 1342.3 1363.7 29506.3 34124.7 34351.1 34660.3 34697.8 51305.2 51978.7 52018.7 52025.0 52040.0 397640.0 397885.0 397951.0 398415.0 398910.2 28454.7 29333.6 29453.6 30871.4 36597.3 49614.8 50197.0 50675.0 51348.0 51522.2 41509.2 42023.8 42148.8 44001.0 44445.6 41773.8 42089.8 42158.8 42531.4 43503.0 42118.0 42811.0 42831.8 42932.6 43521.8 34763.8 37626.2 37924.6 38718.4 38726.0 28128.3 28165.4 28235.3 28470.7 28879.9 16:40:03 INFO - PROCESS | 22359 | 16:40:03 INFO - PROCESS | 22359 | [#2] jquery.html Cycles:180 Average:30761.55 Median:392.93 stddev:89497.02 (22776.8%) stddev-sans-first:89719.00 16:40:03 INFO - PROCESS | 22359 | Values: 374.7 388.9 397.0 400.3 422.6 14287.1 17851.8 19440.8 19548.1 19596.2 18078.6 18108.3 18191.5 18245.4 19010.5 4087.8 5712.9 5930.2 5934.1 5935.5 6387.7 6682.4 6731.6 6760.3 6796.2 5768.5 6002.2 6023.7 6679.5 6683.7 5941.1 6059.6 6136.9 6145.0 6146.5 5863.0 5957.9 5962.9 5965.8 5971.1 14298.4 14393.9 14434.9 14452.6 14480.0 2280.0 2614.7 2665.9 3044.8 3086.4 10254.0 10260.2 10369.4 10779.6 11013.2 1760.3 1796.8 1850.6 1926.3 2018.8 86363.6 92158.5 92847.5 92861.5 93874.0 11112.1 11119.8 11272.0 11335.4 11560.0 15982.4 16007.8 16019.0 16036.1 16042.5 7704.3 7895.7 8022.7 8033.2 8156.8 7341.3 7401.1 7614.8 7643.7 7645.1 4754.7 4796.7 4828.2 4830.8 5050.6 1903.6 1936.4 1977.2 2029.4 2063.1 870.3 965.7 993.9 1010.2 1031.7 19167.2 19644.2 19871.8 19904.0 19996.4 966.5 969.7 976.6 982.4 1040.4 10321.2 10947.6 10979.5 10991.8 11103.6 533071.0 540316.0 540546.0 543716.0 553852.0 92431.0 96503.0 97230.0 100524.0 102129.0 931.3 965.9 986.2 986.8 998.3 16462.3 16775.2 16873.7 17234.0 17807.2 43312.6 43373.6 43431.6 43713.1 44140.6 57591.4 58541.7 58927.7 58959.4 59042.4 8175.5 8499.9 8736.4 8791.6 8951.2 9433.7 13023.3 13260.4 13374.2 14012.4 11572.8 11733.9 11930.7 11964.6 12065.9 11139.4 11422.7 11779.6 11965.7 12245.6 11805.8 11806.9 11941.8 11954.1 12299.7 8643.6 8688.8 8732.5 8858.0 8992.5 10451.1 10698.3 11017.7 11162.0 11229.3 16:40:03 INFO - PROCESS | 22359 | 16:40:03 INFO - PROCESS | 22359 | [#3] mootools.html Cycles:180 Average:5848.21 Median:2735.41 stddev:3338.56 (122.0%) stddev-sans-first:3330.60 16:40:03 INFO - PROCESS | 22359 | Values: 1322.4 1467.8 1530.9 1665.4 1809.1 7775.1 7810.7 8001.8 8017.4 8253.6 8025.6 8096.1 8102.2 8108.7 8112.1 2330.2 2358.1 2358.4 2359.0 2359.4 2276.3 2323.9 2329.7 2330.0 2334.0 2285.1 2295.1 2305.6 2340.0 2343.5 2226.8 2250.4 2256.9 2257.9 2260.2 2260.1 2265.1 2268.4 2273.2 2273.6 8132.5 8156.0 8171.8 9044.5 9085.9 5299.5 5414.9 5447.6 5449.9 5452.1 3365.5 3385.4 3431.2 3438.6 3471.6 1037.5 1053.8 1908.6 1981.5 1993.9 12671.3 12684.2 12779.6 12800.7 12805.2 4379.7 4508.6 4582.4 4597.4 4601.1 9991.6 10013.1 10024.3 10025.8 10047.1 5303.5 5307.0 5307.4 5308.0 5311.0 4362.1 4717.0 4838.1 4847.1 4975.1 3756.7 3845.2 3876.8 3953.1 3977.2 1166.8 1179.1 1179.4 1191.5 1192.7 975.1 976.8 981.3 986.0 992.5 5955.8 6091.8 6184.9 6229.2 6241.3 478.6 486.5 493.8 495.7 499.6 4168.7 4271.6 4323.6 4456.0 4464.3 11079.4 11356.9 11374.3 11408.9 11444.7 11325.7 11330.2 11343.1 11367.8 11382.7 8077.2 8329.3 8346.0 8351.7 8603.7 5814.3 5844.0 5975.0 5978.8 6012.4 9522.3 9526.3 9529.8 9537.7 9639.0 9547.1 10157.3 10569.6 10570.7 10973.9 7215.9 7680.2 8040.5 8055.8 8252.1 8934.2 9117.5 9148.1 9150.1 9166.2 7741.0 7838.5 7896.4 8206.3 8341.3 7691.9 7930.3 7936.1 7996.3 8036.1 7371.6 7485.6 7490.7 7492.8 7492.9 5364.9 5365.3 5512.8 5516.9 5517.5 5191.6 5407.1 5417.1 5541.0 5614.6 16:40:03 INFO - PROCESS | 22359 | 16:40:03 INFO - PROCESS | 22359 | [#4] prototype.html Cycles:180 Average:4592.85 Median:5235.61 stddev:1353.20 (25.8%) stddev-sans-first:1318.30 16:40:03 INFO - PROCESS | 22359 | Values: 311.8 313.8 320.0 320.8 332.2 5053.3 5144.9 5218.1 5229.3 5245.0 5170.6 5173.8 5234.8 5236.4 5282.7 4095.7 4119.2 4146.4 4163.0 4163.2 3893.8 4024.5 4107.8 4112.4 4138.6 4014.7 4031.7 4033.8 4035.6 4036.0 3996.2 4005.6 4007.3 4032.0 4035.8 3439.7 3551.1 3567.7 3575.7 3578.4 5054.0 5058.6 5064.0 5084.6 5133.1 4607.4 4621.4 4660.0 4693.2 4724.6 5283.1 5368.6 5427.8 5436.2 5517.2 3896.4 3896.4 3899.8 3909.8 3947.9 5700.6 5711.7 5712.9 5720.3 5753.2 3814.6 3947.4 3954.5 4012.8 4022.9 4023.1 4025.8 4031.7 4042.8 4043.6 4584.4 4608.7 4613.1 4694.6 4696.0 5264.2 5461.8 5468.9 5471.8 5512.9 1323.8 1334.8 1360.6 1365.7 1367.7 940.0 941.0 961.3 976.9 979.5 5140.2 5171.6 5198.6 5218.0 5255.7 5514.4 5541.3 5558.1 5559.7 5566.9 5035.7 5156.9 5213.4 5229.3 5281.9 2956.2 2975.5 2992.7 2999.3 3011.5 5734.2 5763.0 5805.8 5864.6 5870.9 5599.9 5651.2 5696.0 5703.3 5737.8 5730.6 5764.7 5779.9 5814.5 5825.4 5414.4 5489.8 5625.9 5668.1 5668.2 5516.9 5524.7 5524.7 5532.0 5566.4 5750.8 5751.0 5761.7 5781.6 5792.8 3847.9 3867.6 3945.2 3970.4 3974.3 5417.5 5511.8 5529.8 5660.7 5691.6 5377.4 5443.3 5445.5 5456.6 5504.0 5452.2 5461.4 5467.7 5472.7 5512.9 5188.3 5265.6 5349.6 5385.2 5411.0 5450.7 5460.4 5533.8 5537.2 5545.0 5394.6 5395.0 5404.9 5430.8 5439.9 16:40:03 INFO - PROCESS | 22359 | 16:40:03 INFO - PROCESS | 22359 | [#5] yui.html Cycles:180 Average:21348.85 Median:4410.29 stddev:32652.84 (740.4%) stddev-sans-first:32707.85 16:40:03 INFO - PROCESS | 22359 | Values: 763.6 777.2 803.8 851.6 885.2 14078.1 15047.5 15059.1 15073.3 15129.5 14871.1 15683.5 15701.1 15707.7 15709.5 653.4 770.2 782.2 784.8 798.9 800.5 812.7 813.6 813.6 813.8 852.5 858.1 858.4 859.7 862.0 683.4 823.5 833.0 853.4 854.5 615.9 616.1 616.4 618.2 620.5 13589.6 13617.5 13623.5 13628.7 13631.7 14288.1 14752.3 15069.1 15155.9 15236.6 13458.9 13557.9 13613.6 13792.9 13846.2 4338.9 4485.0 4515.0 4516.3 4523.3 79044.6 79787.0 80120.2 80969.0 81075.0 10470.7 11015.9 11288.9 11353.9 11574.1 20892.2 21077.7 21081.6 21102.5 21134.8 8210.3 8295.9 8303.3 8485.6 8547.1 4673.7 4760.1 4765.6 4790.7 4821.5 3506.2 3629.7 3638.6 3638.9 3639.7 605.2 605.6 611.7 615.9 618.9 502.9 586.5 591.4 605.4 621.7 8473.8 8995.6 9171.5 9233.5 9356.9 680.2 706.8 710.4 714.6 724.1 4115.1 4317.9 4321.8 4378.4 4442.2 126556.0 130625.0 130771.3 131603.0 133330.0 111234.0 112321.0 114083.0 116540.0 116905.4 94075.5 96626.0 96939.5 97406.0 98863.0 8275.9 8494.9 8589.5 8657.2 8698.3 53619.7 54872.0 55068.7 55552.5 56244.2 23129.4 39177.8 47912.0 64009.0 65845.3 12577.3 13207.9 13418.4 13553.1 13781.2 13431.2 13959.7 14325.5 14418.3 14923.7 12851.8 12897.4 13035.7 13287.1 13783.0 12924.3 13254.4 13346.5 13569.5 14004.7 12999.4 13046.5 13262.9 13322.6 13322.7 10767.4 10827.4 11524.2 11586.7 11865.2 9494.8 10496.3 10778.2 10925.6 11342.3 16:40:03 INFO - PROCESS | 22359 | -------- Summary: end -------- 16:40:03 INFO - PROCESS | 22359 | 16:40:04 INFO - TEST-INFO | 22359: exit 0 16:40:04 INFO - TEST-OK | dromaeo_css | took 1116406ms 16:40:04 INFO - TEST-START | kraken 16:40:04 INFO - operating with platform_type : linux_ 16:40:04 INFO - Initialising browser for kraken test... 16:40:04 INFO - TEST-INFO | started process 22664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEeuN7M/profile http://localhost:56194/getInfo.html) 16:40:08 INFO - PROCESS | 22664 | __metrics Screen width/height:1600/1200 16:40:08 INFO - PROCESS | 22664 | colorDepth:24 16:40:08 INFO - PROCESS | 22664 | Browser inner width/height: 1024/697 16:40:08 INFO - PROCESS | 22664 | __metrics 16:40:09 INFO - PROCESS | 22664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:40:09 INFO - PROCESS | 22664 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:40:10 INFO - TEST-INFO | 22664: exit 0 16:40:10 INFO - Browser initialized. 16:40:10 INFO - Running cycle 1/1 for kraken test... 16:40:10 INFO - TEST-INFO | started process 22744 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEeuN7M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:40:22 INFO - PROCESS | 22744 | RSS: Main: 176726016 16:40:22 INFO - PROCESS | 22744 | 16:40:25 INFO - PROCESS | 22744 | Cycle 1(1): loaded http://localhost:56194/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56194/tests/kraken/driver.html?testName=audio-beat-detection) 16:40:26 INFO - PROCESS | 22744 | RSS: Main: 235470848 16:40:26 INFO - PROCESS | 22744 | 16:40:28 INFO - PROCESS | 22744 | Cycle 1(1): loaded http://localhost:56194/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56194/tests/kraken/driver.html?testName=audio-dft) 16:40:29 INFO - PROCESS | 22744 | RSS: Main: 226197504 16:40:29 INFO - PROCESS | 22744 | 16:40:32 INFO - PROCESS | 22744 | Cycle 1(1): loaded http://localhost:56194/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56194/tests/kraken/driver.html?testName=audio-fft) 16:40:33 INFO - PROCESS | 22744 | RSS: Main: 300990464 16:40:33 INFO - PROCESS | 22744 | 16:40:35 INFO - PROCESS | 22744 | Cycle 1(1): loaded http://localhost:56194/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56194/tests/kraken/driver.html?testName=audio-oscillator) 16:40:35 INFO - PROCESS | 22744 | RSS: Main: 209313792 16:40:35 INFO - PROCESS | 22744 | 16:40:38 INFO - PROCESS | 22744 | Cycle 1(1): loaded http://localhost:56194/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56194/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:40:38 INFO - PROCESS | 22744 | RSS: Main: 213151744 16:40:38 INFO - PROCESS | 22744 | 16:40:41 INFO - PROCESS | 22744 | Cycle 1(1): loaded http://localhost:56194/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56194/tests/kraken/driver.html?testName=imaging-darkroom) 16:40:42 INFO - PROCESS | 22744 | RSS: Main: 249790464 16:40:42 INFO - PROCESS | 22744 | 16:40:45 INFO - PROCESS | 22744 | Cycle 1(1): loaded http://localhost:56194/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56194/tests/kraken/driver.html?testName=imaging-desaturate) 16:40:46 INFO - PROCESS | 22744 | RSS: Main: 248328192 16:40:46 INFO - PROCESS | 22744 | 16:40:49 INFO - PROCESS | 22744 | Cycle 1(1): loaded http://localhost:56194/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56194/tests/kraken/driver.html?testName=json-parse-financial) 16:40:49 INFO - PROCESS | 22744 | RSS: Main: 247255040 16:40:49 INFO - PROCESS | 22744 | 16:40:51 INFO - PROCESS | 22744 | Cycle 1(1): loaded http://localhost:56194/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56194/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:40:51 INFO - PROCESS | 22744 | RSS: Main: 211062784 16:40:51 INFO - PROCESS | 22744 | 16:40:53 INFO - PROCESS | 22744 | Cycle 1(1): loaded http://localhost:56194/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56194/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:40:54 INFO - PROCESS | 22744 | RSS: Main: 219684864 16:40:54 INFO - PROCESS | 22744 | 16:40:56 INFO - PROCESS | 22744 | Cycle 1(1): loaded http://localhost:56194/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56194/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:40:57 INFO - PROCESS | 22744 | RSS: Main: 223887360 16:40:57 INFO - PROCESS | 22744 | 16:40:59 INFO - PROCESS | 22744 | Cycle 1(1): loaded http://localhost:56194/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56194/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:41:00 INFO - PROCESS | 22744 | RSS: Main: 217616384 16:41:00 INFO - PROCESS | 22744 | 16:41:03 INFO - PROCESS | 22744 | Cycle 1(1): loaded http://localhost:56194/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56194/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:41:03 INFO - PROCESS | 22744 | RSS: Main: 221339648 16:41:03 INFO - PROCESS | 22744 | 16:41:05 INFO - PROCESS | 22744 | Cycle 1(1): loaded http://localhost:56194/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56194/tests/kraken/driver.html?testName=ai-astar) 16:41:05 INFO - PROCESS | 22744 | RSS: Main: 271343616 16:41:05 INFO - PROCESS | 22744 | 16:41:05 INFO - PROCESS | 22744 | __start_tp_report 16:41:05 INFO - PROCESS | 22744 | _x_x_mozilla_page_load 16:41:05 INFO - PROCESS | 22744 | _x_x_mozilla_page_load_details 16:41:05 INFO - PROCESS | 22744 | |i|pagename|runs| 16:41:05 INFO - PROCESS | 22744 | |0;ai-astar;99;111;108;110;111;111;117;112;112;110 16:41:05 INFO - PROCESS | 22744 | |1;audio-beat-detection;146;117;145;186;124;148;147;120;178;118 16:41:05 INFO - PROCESS | 22744 | |2;audio-dft;160;160;163;163;159;162;162;161;160;160 16:41:05 INFO - PROCESS | 22744 | |3;audio-fft;75;74;75;172;75;74;74;121;118;75 16:41:05 INFO - PROCESS | 22744 | |4;audio-oscillator;86;85;155;86;86;86;143;87;86;148 16:41:05 INFO - PROCESS | 22744 | |5;imaging-gaussian-blur;117;117;117;117;118;117;117;117;117;117 16:41:05 INFO - PROCESS | 22744 | |6;imaging-darkroom;145;145;146;147;145;145;146;146;146;146 16:41:05 INFO - PROCESS | 22744 | |7;imaging-desaturate;95;95;95;94;95;95;95;95;95;95 16:41:05 INFO - PROCESS | 22744 | |8;json-parse-financial;51;50;50;52;50;51;51;51;50;50 16:41:05 INFO - PROCESS | 22744 | |9;json-stringify-tinderbox;62;63;62;62;62;62;63;62;61;62 16:41:05 INFO - PROCESS | 22744 | |10;stanford-crypto-aes;85;77;78;77;83;81;83;78;78;87 16:41:05 INFO - PROCESS | 22744 | |11;stanford-crypto-ccm;130;126;131;126;133;130;123;134;160;128 16:41:05 INFO - PROCESS | 22744 | |12;stanford-crypto-pbkdf2;165;167;165;166;168;163;164;164;165;167 16:41:05 INFO - PROCESS | 22744 | |13;stanford-crypto-sha256-iterative;67;68;66;65;66;65;66;65;64;65 16:41:05 INFO - PROCESS | 22744 | __end_tp_report 16:41:05 INFO - PROCESS | 22744 | __start_cc_report 16:41:05 INFO - PROCESS | 22744 | _x_x_mozilla_cycle_collect,1663 16:41:05 INFO - PROCESS | 22744 | __end_cc_report 16:41:05 INFO - PROCESS | 22744 | __startTimestamp1471909265966__endTimestamp 16:41:05 INFO - PROCESS | 22744 | 16:41:05 INFO - PROCESS | 22744 | ------- Summary: start ------- 16:41:05 INFO - PROCESS | 22744 | Number of tests: 14 16:41:05 INFO - PROCESS | 22744 | 16:41:05 INFO - PROCESS | 22744 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.50 stddev:4.53 (4.1%) stddev-sans-first:2.45 16:41:05 INFO - PROCESS | 22744 | Values: 99.0 111.0 108.0 110.0 111.0 111.0 117.0 112.0 112.0 110.0 16:41:05 INFO - PROCESS | 22744 | 16:41:05 INFO - PROCESS | 22744 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:146.50 stddev:24.31 (16.6%) stddev-sans-first:25.76 16:41:05 INFO - PROCESS | 22744 | Values: 146.0 117.0 145.0 186.0 124.0 148.0 147.0 120.0 178.0 118.0 16:41:05 INFO - PROCESS | 22744 | 16:41:05 INFO - PROCESS | 22744 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.41 (0.9%) stddev-sans-first:1.45 16:41:05 INFO - PROCESS | 22744 | Values: 160.0 160.0 163.0 163.0 159.0 162.0 162.0 161.0 160.0 160.0 16:41:05 INFO - PROCESS | 22744 | 16:41:05 INFO - PROCESS | 22744 | [#3] audio-fft Cycles:10 Average:93.30 Median:74.50 stddev:33.38 (44.8%) stddev-sans-first:34.74 16:41:05 INFO - PROCESS | 22744 | Values: 75.0 74.0 75.0 172.0 75.0 74.0 74.0 121.0 118.0 75.0 16:41:05 INFO - PROCESS | 22744 | 16:41:05 INFO - PROCESS | 22744 | [#4] audio-oscillator Cycles:10 Average:104.80 Median:86.00 stddev:30.41 (35.4%) stddev-sans-first:31.48 16:41:05 INFO - PROCESS | 22744 | Values: 86.0 85.0 155.0 86.0 86.0 86.0 143.0 87.0 86.0 148.0 16:41:05 INFO - PROCESS | 22744 | 16:41:05 INFO - PROCESS | 22744 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:41:05 INFO - PROCESS | 22744 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 16:41:05 INFO - PROCESS | 22744 | 16:41:05 INFO - PROCESS | 22744 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 16:41:05 INFO - PROCESS | 22744 | Values: 145.0 145.0 146.0 147.0 145.0 145.0 146.0 146.0 146.0 146.0 16:41:05 INFO - PROCESS | 22744 | 16:41:05 INFO - PROCESS | 22744 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:41:05 INFO - PROCESS | 22744 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 16:41:05 INFO - PROCESS | 22744 | 16:41:05 INFO - PROCESS | 22744 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:51.00 stddev:0.70 (1.4%) stddev-sans-first:0.73 16:41:05 INFO - PROCESS | 22744 | Values: 51.0 50.0 50.0 52.0 50.0 51.0 51.0 51.0 50.0 50.0 16:41:05 INFO - PROCESS | 22744 | 16:41:05 INFO - PROCESS | 22744 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 16:41:05 INFO - PROCESS | 22744 | Values: 62.0 63.0 62.0 62.0 62.0 62.0 63.0 62.0 61.0 62.0 16:41:05 INFO - PROCESS | 22744 | 16:41:05 INFO - PROCESS | 22744 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:82.00 stddev:3.62 (4.4%) stddev-sans-first:3.49 16:41:05 INFO - PROCESS | 22744 | Values: 85.0 77.0 78.0 77.0 83.0 81.0 83.0 78.0 78.0 87.0 16:41:05 INFO - PROCESS | 22744 | 16:41:05 INFO - PROCESS | 22744 | [#11] stanford-crypto-ccm Cycles:10 Average:132.10 Median:130.50 stddev:10.37 (7.9%) stddev-sans-first:10.97 16:41:05 INFO - PROCESS | 22744 | Values: 130.0 126.0 131.0 126.0 133.0 130.0 123.0 134.0 160.0 128.0 16:41:05 INFO - PROCESS | 22744 | 16:41:05 INFO - PROCESS | 22744 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.40 Median:165.50 stddev:1.58 (1.0%) stddev-sans-first:1.67 16:41:05 INFO - PROCESS | 22744 | Values: 165.0 167.0 165.0 166.0 168.0 163.0 164.0 164.0 165.0 167.0 16:41:05 INFO - PROCESS | 22744 | 16:41:05 INFO - PROCESS | 22744 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:1.16 (1.8%) stddev-sans-first:1.13 16:41:05 INFO - PROCESS | 22744 | Values: 67.0 68.0 66.0 65.0 66.0 65.0 66.0 65.0 64.0 65.0 16:41:05 INFO - PROCESS | 22744 | -------- Summary: end -------- 16:41:05 INFO - PROCESS | 22744 | 16:41:07 INFO - TEST-INFO | 22744: exit 0 16:41:07 INFO - TEST-OK | kraken | took 62638ms 16:41:07 INFO - SUITE-END | took 1179s 16:41:07 INFO - Completed test suite (00:19:39) 16:41:07 INFO - javascript benchmark 16:41:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3018.260526171088, 3033.9544906826386, 3053.1145967669377, 3061.540768884667, 3073.3392320651055, 5180.6891586504835, 5314.787408503656, 5410.648307859991, 5442.863928401792, 5445.128779395292, 5411.0, 5419.295491586088, 5421.430749771276, 5535.778568857241, 5537.058700020996, 4641.698289611165, 4944.1594928862, 5020.874478138039, 5057.620678449131, 5102.897942041157, 5037.319961805146, 5092.8472145835685, 5095.108356037697, 5096.847094587169, 5097.745112744366, 4757.500462451462, 4789.640776941708, 4794.592459640935, 4981.676191047571, 4986.326845875797, 4810.158222311116, 4844.10384078943, 4854.271859221145, 4859.198232291667, 4899.093667671492, 4826.420829500447, 4843.636727245435, 4852.660313778037, 4920.089783390084, 4925.433575138869, 5409.323834520685, 5416.51251387377, 5425.430329815392, 5431.701256430894, 5433.212184233264, 5587.972060139714, 5748.856278593027, 5757.107648314518, 5768.394318596529, 5804.767809287666, 5849.590528662995, 5874.794382196603, 5877.0, 5879.206307148523, 5889.852753681193, 5471.890562188773, 5488.862778430571, 5491.588130890159, 5500.339959204921, 5500.697461639648, 5700.344460387026, 5836.299644042742, 5913.674747888907, 5919.496842768327, 6006.12911127884, 5738.139279108167, 5750.568707346882, 5758.712064396764, 5764.221830052973, 5765.250517432707, 5782.335031471351, 5829.941700583025, 5837.795677151279, 5845.795397161079, 5852.063669812809, 5553.333599968029, 5699.914501282484, 5724.4561766632105, 5735.4551317624755, 5820.068788993825, 5750.913736293959, 5785.566082543742, 5790.826275211751, 5796.913046304308, 5798.797042103506, 4442.888927776767, 4450.532694067141, 4456.108778244364, 4461.776911154494, 4471.128130014616, 3841.2701586698436, 3905.511811023622, 3959.0, 3959.0696186396176, 4015.859444919414, 5500.50495455411, 5501.724913754297, 5508.0, 5508.724563771795, 5514.862128446821, 5849.356570777211, 5852.941470585325, 5854.912176317359, 5860.472557469763, 5867.794627188028, 5295.15277555597, 5429.945700543023, 5485.067538518461, 5500.669959802424, 5573.386927437979, 5108.2848401223855, 5120.974395128001, 5131.0, 5131.461196574381, 5132.358455193101, 6107.083937409336, 6122.908156377569, 6127.20346354971, 6138.877222455526, 6139.539534535017, 5672.943270567406, 5692.060809966475, 5717.628354156966, 5727.198192253005, 5822.214001109796, 5990.041593345044, 5997.490213331741, 5997.640141591344, 6000.489958353589, 6004.0693692477735, 5689.6586204827845, 5696.287964004499, 5697.829065128053, 5704.0, 5707.343655479673, 5612.130119831432, 5655.943440565542, 5658.462446067617, 5721.799737009184, 5786.768529258951, 5612.887742245214, 5620.3536593290655, 5621.747021383966, 5651.067573850269, 5652.491275785199, 5611.747471363717, 5622.100463925753, 5626.578006649435, 5631.2960879890015, 5643.1535269709875, 5405.108157154025, 5469.480399362054, 5494.835154945358, 5520.723963801875, 5604.495595396434, 5714.5999780015, 5721.685307308138, 5723.484886360081, 5727.427257274239, 5727.627704199213, 5571.693556854412, 5577.60956733041, 5580.832575022756, 5586.581006424453, 5591.0], "value": 5338.86067293512, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.4191924237277, 593.350281441821, 595.6307089604446, 597.4592993341025, 609.3632154398653, 44169.012394442245, 45138.09723805526, 45322.280663160236, 48669.75665121678, 49007.50992490074, 46284.074318513696, 46766.0, 46788.53211467884, 46809.531904680945, 46918.0, 7941.602919854013, 9027.774305642346, 9181.95409022954, 9192.35653504255, 10827.0, 10718.839217411745, 11157.051650609666, 11167.106631469504, 11167.497462614201, 11171.66485005451, 11309.886901130965, 11358.31850088993, 11360.0, 11360.091192704564, 11364.943175284154, 11215.775684486305, 11251.0436612888, 11251.156163287786, 11256.774864502746, 11261.211715179941, 10964.506597203144, 11035.724106897393, 11039.779204415947, 11042.227044106916, 11042.392668403234, 44084.0, 44302.55697443017, 44507.0, 44523.55476445259, 44548.0, 3439.5528581284525, 3589.353916295066, 3657.4513822926506, 3899.74651647642, 4059.2084543514025, 32799.0, 32948.50577241343, 33197.3360532788, 33281.3343733124, 33375.83312083448, 3580.964190358089, 3599.7840129592046, 3627.7097832173627, 3797.9620203797886, 3804.5624753153465, 349529.0, 351773.0, 352628.0, 352751.0, 354233.0, 58180.0, 58860.0, 58869.411305887246, 58888.0, 58920.0, 61042.0, 61135.694321528106, 61170.0, 61836.0, 61936.69031654813, 15173.317200725995, 15368.615784605474, 15386.0, 15391.0, 15398.46105386306, 9900.752481188028, 10005.949970250102, 10025.799484010426, 11569.76860462786, 11671.708207294885, 15979.280932358071, 16380.180990950405, 16501.669966600602, 16604.83395166033, 16607.667846643, 5899.557533185029, 5917.289925209003, 5929.881402371929, 5946.643201407929, 6006.249218847644, 892.1836519584507, 1026.8049070676548, 1059.0309866472091, 1066.274933045521, 1120.3110087296418, 32522.186945326557, 33023.66976330206, 33378.49932251018, 33445.83277083599, 33659.45437441233, 1088.78768640116, 1109.6060898380958, 1120.2438354110943, 1199.7767857142808, 1200.3458115327167, 17477.213525391388, 17530.298788048334, 17543.561410964827, 17615.0, 17639.470815875546, 499694.0, 502578.0, 504324.0, 505976.0, 507896.0, 61362.38637613656, 61582.076268856006, 61619.38380616226, 61702.691486543175, 61798.69100654468, 1237.5730373021293, 1271.2944315904763, 1307.666545030992, 1342.2550484481208, 1363.6795353092016, 29506.262343441587, 34124.65875341314, 34351.14122146966, 34660.30679386348, 34697.826510867286, 51305.23042154445, 51978.74010629923, 52018.73990630022, 52025.0, 52040.0, 397640.0, 397885.0, 397951.0, 398415.0, 398910.1743721107, 28454.71545284521, 29333.55999659964, 29453.558196627495, 30871.382572348877, 36597.26805463929, 49614.75192624014, 50197.0, 50675.0, 51348.0, 51522.22716659178, 41509.169816602895, 42023.7898810504, 42148.789256053526, 44001.0, 44445.55554444544, 41773.79113104415, 42089.78955105205, 42158.789206055, 42531.3620295702, 43503.0, 42118.0, 42811.0, 42831.78584107184, 42932.57067429286, 43521.78239108784, 34763.826180868935, 37626.2474750498, 37924.62075379321, 38718.419223711106, 38726.0, 28128.29679258035, 28165.43669126565, 28235.294117647223, 28470.715292846806, 28879.85560072186], "value": 20574.702405676337, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.7264496917252, 388.9027743064232, 396.95831937646545, 400.2755013425699, 422.56601972637617, 14287.142771433708, 17851.821481785195, 19440.805591944078, 19548.120334584943, 19596.216151353947, 18078.638427231446, 18108.275668973227, 18191.45425637233, 18245.36141235057, 19010.524736881584, 4087.828896445998, 5712.942870571293, 5930.169776231331, 5934.139549765281, 5935.49548288396, 6387.680615969206, 6682.398584127428, 6731.596104233761, 6760.323967603225, 6796.218434879978, 5768.451997060272, 6002.2197114375285, 6023.668698221596, 6679.499037572177, 6683.699233534503, 5941.079132734433, 6059.636421814683, 6136.877262454771, 6145.0, 6146.5390095743, 5862.970685146547, 5957.851053723648, 5962.880742385128, 5965.761369545213, 5971.134185543072, 14298.428062877472, 14393.856061439355, 14434.927825360806, 14452.566423007327, 14480.0, 2279.9658005129936, 2614.673165854268, 2665.866706664659, 3044.756419486458, 3086.36729470458, 10254.0, 10260.179185665129, 10369.429681367521, 10779.622713205, 11013.174011949135, 1760.251892945493, 1796.8023517413073, 1850.6113716119496, 1926.3450426854797, 2018.8082132197565, 86363.56818215869, 92158.53920730353, 92847.53576232144, 92861.53569232178, 93874.0, 11112.111031117653, 11119.833202501968, 11272.0, 11335.376554289429, 11560.0, 15982.440614578434, 16007.759883601755, 16018.958767680064, 16036.11801350937, 16042.518724438285, 7704.26809453101, 7895.68417263303, 8022.679092836338, 8033.156518565466, 8156.755297341089, 7341.339279464767, 7401.0748656417945, 7614.847703045908, 7643.7324693635455, 7645.120811106683, 4754.690945088558, 4796.664233503621, 4828.227483602606, 4830.806767729251, 5050.621203409759, 1903.5716963683337, 1936.448112287991, 1977.2189984955862, 2029.4114706735177, 2063.0819285418147, 870.3341943413294, 965.7440778193784, 993.9155171810477, 1010.2372708604956, 1031.6904928521565, 19167.233310667416, 19644.214231430582, 19871.801281986995, 19904.00959903998, 19996.400107996782, 966.5070813884829, 969.6654654144309, 976.6142373762324, 982.40564458503, 1040.3705758016442, 10321.174306055498, 10947.646658418846, 10979.451027448597, 10991.780164396667, 11103.555857765761, 533071.0, 540316.0, 540546.0, 543716.0, 553852.0, 92431.0, 96503.0, 97230.0, 100524.0, 102129.0, 931.3434029009532, 965.9130678238852, 986.1666891476691, 986.7582442301539, 998.3111652959435, 16462.341506339613, 16775.161241938098, 16873.746893796848, 17234.0, 17807.19867605935, 43312.566874330856, 43373.56626433822, 43431.565684344016, 43713.125737484435, 44140.55859441365, 57591.424085760285, 58541.70729146327, 58927.705361472916, 58959.41040589539, 59042.40957590369, 8175.468594541336, 8499.872501912352, 8736.388452808242, 8791.560421979004, 8951.239144672776, 9433.669821556212, 13023.283719395524, 13260.403281852532, 13374.197548146753, 14012.369443374868, 11572.768544629229, 11733.882661173278, 11930.701732456411, 11964.64106076819, 12065.939670301592, 11139.3873336964, 11422.714432139262, 11779.587714429954, 11965.700857478632, 12245.632631021084, 11805.763884722086, 11806.940965295118, 11941.76116477683, 11954.10344224204, 12299.69250768738, 8643.567821608769, 8688.78278043054, 8732.519711415933, 8858.025617181976, 8992.46045237288, 10451.111655509367, 10698.304610200312, 11017.669469915916, 11161.991700415925, 11229.27009744364], "value": 9271.269266872312, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1322.3652646729563, 1467.750482417989, 1530.9464168754093, 1665.3921318718665, 1809.0773705410236, 7775.144734079254, 7810.726624568141, 8001.8399632007395, 8017.398695097876, 8253.587320633975, 8025.598720064003, 8096.10942796292, 8102.230288122619, 8108.7161949331785, 8112.107668156498, 2330.1611419888786, 2358.068562917655, 2358.398608354867, 2359.0445869422824, 2359.386559494535, 2276.3284830974903, 2323.8954247058923, 2329.650552417134, 2329.9883500582473, 2334.031376978552, 2285.1202287119495, 2295.116380193629, 2305.5504176685554, 2340.0171927790284, 2343.5078633486987, 2226.832987525926, 2250.3586477853814, 2256.8758718270487, 2257.932262032142, 2260.152442833937, 2260.1185537640335, 2265.105283413059, 2268.376196545963, 2273.2043784675398, 2273.57938781326, 8132.512049277003, 8156.0, 8171.795705107361, 9044.457332560067, 9085.863712044325, 5299.470052994709, 5414.91877621836, 5447.5914306426785, 5449.891002179974, 5452.073147564924, 3365.461526155828, 3385.441402168664, 3431.2108215110666, 3438.570178727659, 3471.63547827477, 1037.5175543372293, 1053.8261186904151, 1908.5876451425984, 1981.465004448805, 1993.8864803308538, 12671.303078330688, 12684.238945663197, 12779.552715655, 12800.6799830005, 12805.167664101804, 4379.671524635665, 4508.571685689854, 4582.381378513858, 4597.402337696145, 4601.102784956901, 9991.600335986624, 10013.09882110599, 10024.348417352849, 10025.799484010426, 10047.09576138151, 5303.522682958553, 5307.01820163271, 5307.389650190277, 5308.044551980681, 5311.017461769585, 4362.062156636275, 4716.95283047172, 4838.104950584153, 4847.127517046965, 4975.0796102721115, 3756.6619004289746, 3845.1732877430927, 3876.7673939563715, 3953.0512676957323, 3977.164795392942, 1166.836642869999, 1179.0744265751516, 1179.4102948525738, 1191.5472120594118, 1192.7375977285158, 975.1077763846143, 976.8009768009824, 981.293468702533, 985.980280394388, 992.5285489392625, 5955.821325360246, 6091.817245482643, 6184.9485587450245, 6229.1590635264565, 6241.282252540925, 478.55476461088017, 486.54994130429213, 493.7605261448195, 495.7496464285513, 499.5529001543598, 4168.749875007509, 4271.594198551133, 4323.567643235651, 4455.977720111378, 4464.285714285698, 11079.390633515233, 11356.94321528387, 11374.260673056226, 11408.88591114095, 11444.656660300205, 11325.660230193107, 11330.206885517935, 11343.149263805082, 11367.829482557769, 11382.715432114097, 8077.232662897015, 8329.292010179082, 8345.958270208732, 8351.749447516584, 8603.741887743377, 5814.273215848019, 5844.0, 5974.970125149346, 5978.760849565969, 6012.368701286302, 9522.285828562746, 9526.333156678966, 9529.761755956157, 9537.666181683608, 9639.0, 9547.093026162504, 10157.339772914736, 10569.577216911544, 10570.735731606772, 10973.890261097287, 7215.8556828864175, 7680.155182929985, 8040.477368970998, 8055.838883222185, 8252.133525979685, 8934.195922367018, 9117.498537580497, 9148.130927561871, 9150.084991500797, 9166.17504424605, 7740.961295193488, 7838.529688218497, 7896.368290536629, 8206.343492520704, 8341.332693384393, 7691.923080769121, 7930.286274235346, 7936.087349954598, 7996.32031277348, 8036.075851277178, 7371.557706537625, 7485.5508669480005, 7490.70037198506, 7492.7752167435065, 7492.850142997218, 5364.892702146013, 5365.3293338332705, 5512.779488820403, 5516.9448305516435, 5517.531009864207, 5191.61062920275, 5407.080796264566, 5417.133258678593, 5541.0, 5614.63504872182], "value": 4626.069806519637, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.7739638761898, 313.80857676817135, 320.0, 320.7914855344026, 332.1546663740779, 5053.292539044527, 5144.948550514494, 5218.0868348039085, 5229.346331708536, 5244.980682437261, 5170.612204084699, 5173.818916337929, 5234.79060837567, 5236.423993360727, 5282.709450980195, 4095.7133000689964, 4119.196756632457, 4146.419501269825, 4163.042500224942, 4163.188178305231, 3893.785841778701, 4024.5109309555505, 4107.7535347879075, 4112.424260603518, 4138.627523522882, 4014.739041962263, 4031.6774658027434, 4033.7579745215235, 4035.6367926886574, 4035.9596404036024, 3996.2007598480277, 4005.5994400560003, 4007.278689835814, 4032.0, 4035.8385664573384, 3439.673231043072, 3551.147724546116, 3567.661072198137, 3575.66031227033, 3578.427451607756, 5054.0, 5058.570021548173, 5064.0, 5084.618653600995, 5133.12736834739, 4607.424071991001, 4621.399218101659, 4659.953400465985, 4693.155232058228, 4724.645651576146, 5283.128139072793, 5368.62419630626, 5427.810026649048, 5436.21174929637, 5517.151754162361, 3896.3571010783185, 3896.3571010783185, 3899.8245078971513, 3909.824057917372, 3947.9013024674327, 5700.629459085188, 5711.714864155531, 5712.942870571324, 5720.342160651537, 5753.194552762617, 3814.6185381462187, 3947.4078888167005, 3954.5056867891512, 4012.8394864205106, 4022.879313620596, 4023.074692820609, 4025.798710064485, 4031.697622678252, 4042.7776472293717, 4043.6360727534075, 4584.372547745503, 4608.723476591415, 4613.146567884952, 4694.647901407408, 4695.9530404695515, 5264.236685680555, 5461.836144915659, 5468.890622187534, 5471.781128754885, 5512.897420515833, 1323.7749582570987, 1334.833145856768, 1360.5714200027157, 1365.6722386627139, 1367.7401293754156, 939.9859002114973, 940.9623615055322, 961.33667769239, 976.9316147869723, 979.5396163803001, 5140.177571588602, 5171.5862730981435, 5198.558122559625, 5218.0, 5255.710935898563, 5514.448555144453, 5541.251930989345, 5558.110702287615, 5559.749811258503, 5566.944330556724, 5035.748212589356, 5156.917047420009, 5213.400458947193, 5229.294045303911, 5281.9207711884355, 2956.1722717639095, 2975.4941659917868, 2992.6558445779015, 2999.31015866352, 3011.5181570948544, 5734.2258795062135, 5762.971185144132, 5805.809808989147, 5864.618799778001, 5870.853228669317, 5599.916001259984, 5651.237082993825, 5695.971520142456, 5703.258576385043, 5737.827865164052, 5730.598858079894, 5764.74058667361, 5779.8555036124435, 5814.534837213013, 5825.446582574648, 5414.377346605191, 5489.835304940699, 5625.8593535161945, 5668.149777533238, 5668.234788303691, 5516.91724624139, 5524.696141712245, 5524.723763811713, 5532.0, 5566.443355664401, 5750.750825783419, 5750.971245143747, 5761.683107429131, 5781.5663825214115, 5792.768289268382, 3847.9038024049623, 3867.632574905492, 3945.2109578085074, 3970.4044393340073, 3974.2647610192207, 5417.539509141609, 5511.834644960658, 5529.751161197675, 5660.698039450867, 5691.63004404729, 5377.354717433933, 5443.346798384061, 5445.537129343892, 5456.59075569326, 5503.972480137573, 5452.182172674131, 5461.42655021233, 5467.72661366938, 5472.726363681721, 5512.889742205053, 5188.325517682677, 5265.552428043659, 5349.57203423733, 5385.1922211667, 5411.026015317123, 5450.672959622435, 5460.3993560707495, 5533.806316778893, 5537.169424586345, 5544.972275138599, 5394.595405344537, 5395.03081375303, 5404.891902162013, 5430.8099216527235, 5439.918401223906], "value": 4160.107604143689, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.6372722956596, 777.1606664802015, 803.7950322667723, 851.64656667483, 885.1502557544757, 14078.084924479914, 15047.47333843313, 15059.096454212755, 15073.321700523475, 15129.470468533604, 14871.107733535995, 15683.529494115195, 15701.136437495934, 15707.685846283068, 15709.528714138565, 653.4249860123085, 770.1720650300921, 782.221689419026, 784.8077221080844, 798.9121196668361, 800.5316889619551, 812.7196117339538, 813.5606772342928, 813.6379311206515, 813.7680760983121, 852.4672079950032, 858.0861382627481, 858.4119877883638, 859.6776208921655, 861.9913800861974, 683.4122654517112, 823.4935514658501, 832.983340333196, 853.3940901959617, 854.5086575219274, 615.8768246350747, 616.0758861707438, 616.4451993206105, 618.1778234947509, 620.4663988969482, 13589.592312230649, 13617.523386681418, 13623.455061797516, 13628.659283517893, 13631.727365452734, 14288.142711437244, 14752.336144873507, 15069.09585424867, 15155.924220378938, 15236.619084522865, 13458.93270533641, 13557.864421355858, 13613.591592252249, 13792.93103534486, 13846.238456884867, 4338.869833904988, 4484.955150448519, 4514.984128571045, 4516.254817955033, 4523.276275795857, 79044.60477697632, 79787.0, 80120.19879801186, 80969.0, 81075.0, 10470.738231544272, 11015.944920275508, 11288.887111128948, 11353.943230283961, 11574.131940104526, 20892.1643134276, 21077.683834742493, 21081.578368432547, 21102.47243818917, 21134.788652113588, 8210.261076503144, 8295.875561866576, 8303.294219991369, 8485.618147183392, 8547.10255423184, 4673.742944138037, 4760.119377915027, 4765.617628216279, 4790.664653474223, 4821.541953514481, 3506.193575477603, 3629.7459177857295, 3638.581563120222, 3638.890833275006, 3639.745217834779, 605.2374008749008, 605.5912259225094, 611.721666641677, 615.9445649891532, 618.9473894718909, 502.9119904016782, 586.5131940489383, 591.361329763854, 605.3976293587821, 621.6736213487955, 8473.788155296166, 8995.595198216097, 9171.495567743705, 9233.538323083952, 9356.90643093574, 680.2381332907175, 706.8162277807704, 710.4316546762569, 714.6069661686156, 724.1165777751136, 4115.08648478459, 4317.942104184495, 4321.805518751664, 4378.426837180987, 4442.155990361821, 126556.0, 130625.0, 130771.34614326867, 131603.0, 133330.0, 111234.0, 112321.0, 114083.0, 116540.0, 116905.41547292209, 94075.52962235281, 96626.0, 96939.51530242445, 97406.0, 98863.0, 8275.875861861956, 8494.872576911228, 8589.484630922165, 8657.177568131017, 8698.304135669257, 53619.731901340245, 54872.0, 55068.724656376464, 55552.500412443806, 56244.15633765579, 23129.421764456023, 39177.8041109804, 47912.0, 64009.0, 65845.34154658584, 12577.308248046445, 13207.933960330136, 13418.39617217208, 13553.119047261896, 13781.173129612256, 13431.19412835233, 13959.720805584035, 14325.498607548685, 14418.279086045866, 14923.701525969636, 12851.807222891477, 12897.41961611711, 13035.739285214433, 13287.13633613812, 13783.0, 12924.28916409569, 13254.403551839998, 13346.532871349456, 13569.52506662262, 14004.719905602034, 12999.350032498527, 13046.478140874258, 13262.933685331898, 13322.600321990356, 13322.733545329233, 10767.407792571485, 10827.446872936793, 11524.193306468467, 11586.71033224176, 11865.169438139592, 9494.816192275954, 10496.317739346918, 10778.245522813328, 10925.617603384162, 11342.262752921033], "value": 7477.830770842424, "unit": "score"}], "name": "dromaeo_css", "value": 7261.228159706765, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 111.0, 108.0, 110.0, 111.0, 111.0, 117.0, 112.0, 112.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 117.0, 145.0, 186.0, 124.0, 148.0, 147.0, 120.0, 178.0, 118.0], "value": 142.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 163.0, 163.0, 159.0, 162.0, 162.0, 161.0, 160.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 172.0, 75.0, 74.0, 74.0, 121.0, 118.0, 75.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 155.0, 86.0, 86.0, 86.0, 143.0, 87.0, 86.0, 148.0], "value": 104.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 147.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 50.0, 52.0, 50.0, 51.0, 51.0, 51.0, 50.0, 50.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 61.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 77.0, 78.0, 77.0, 83.0, 81.0, 83.0, 78.0, 78.0, 87.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 126.0, 131.0, 126.0, 133.0, 130.0, 123.0, 134.0, 160.0, 128.0], "value": 132.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 165.0, 166.0, 168.0, 163.0, 164.0, 164.0, 165.0, 167.0], "value": 165.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 65.0, 66.0, 65.0, 66.0, 65.0, 64.0, 65.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1526.4, "alertThreshold": 2.0}]} 16:41:07 INFO - Return code: 0 16:41:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:41:07 INFO - # TBPL SUCCESS # 16:41:07 INFO - Running post-action listener: _resource_record_post_action 16:41:07 INFO - [mozharness: 2016-08-22 23:41:07.734058Z] Finished run-tests step (success) 16:41:07 INFO - Running post-run listener: _resource_record_post_run 16:41:07 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 406876160; Read time: 8; Write time: 304620 16:41:07 INFO - TinderboxPrint: CPU usage
13.3% 16:41:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 16:41:07 INFO - TinderboxPrint: I/O write bytes / time
406,876,160 / 304,620 16:41:07 INFO - TinderboxPrint: CPU idle
8,283.0 (86.7%) 16:41:07 INFO - TinderboxPrint: CPU user
1,201.6 (12.6%) 16:41:07 INFO - TinderboxPrint: Swap in / out
0 / 0 16:41:07 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118349824; Read time: 0; Write time: 100644 16:41:07 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288526336; Read time: 0; Write time: 203976 16:41:08 INFO - Running post-run listener: _upload_blobber_files 16:41:08 INFO - Blob upload gear active. 16:41:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:41:08 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 16:41:08 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'] 16:41:08 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 16:41:08 INFO - (blobuploader) - INFO - Open directory for files ... 16:41:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:41:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:41:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:41:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:41:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:41:12 INFO - (blobuploader) - INFO - Done attempting. 16:41:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:41:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:41:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:41:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:41:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:41:13 INFO - (blobuploader) - INFO - Done attempting. 16:41:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:41:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:41:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:41:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:41:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:41:14 INFO - (blobuploader) - INFO - Done attempting. 16:41:14 INFO - (blobuploader) - INFO - Iteration through files over. 16:41:14 INFO - Return code: 0 16:41:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:41:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:41:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3317130ba4cf4408c82330f4ca69e2a631e9c35c1c36a073cba91cb16020b44358918ed3895aff9d8176d2c29100b7d4a1a9a050eefa7e0e9251da4101506d1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0afe2cd1fa161f2bb8557b04cb091dc4aae37b6fe4150c0e470e2061e46548b9cbca87ebdc6c23d27d30402ed716af7deec74e09af988ca56e3ba0cb66691bd6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d830afaf7d8816a622c32a0028b38840b39d29c49562a4da9fa181d8eef1e67e9ac501f87f6edac2b989da1fe21051f53b1b0a451af266079dddd7cfb7a778d2"} 16:41:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:41:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:41:14 INFO - Contents: 16:41:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3317130ba4cf4408c82330f4ca69e2a631e9c35c1c36a073cba91cb16020b44358918ed3895aff9d8176d2c29100b7d4a1a9a050eefa7e0e9251da4101506d1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0afe2cd1fa161f2bb8557b04cb091dc4aae37b6fe4150c0e470e2061e46548b9cbca87ebdc6c23d27d30402ed716af7deec74e09af988ca56e3ba0cb66691bd6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d830afaf7d8816a622c32a0028b38840b39d29c49562a4da9fa181d8eef1e67e9ac501f87f6edac2b989da1fe21051f53b1b0a451af266079dddd7cfb7a778d2"} 16:41:14 INFO - Running post-run listener: copy_logs_to_upload_dir 16:41:14 INFO - Copying logs to upload dir... 16:41:14 INFO - mkdir: /builds/slave/test/build/upload/logs 16:41:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.335875 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-22 16:41:14.294963) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 16:41:14.298500) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1471908030.817639-284414530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3317130ba4cf4408c82330f4ca69e2a631e9c35c1c36a073cba91cb16020b44358918ed3895aff9d8176d2c29100b7d4a1a9a050eefa7e0e9251da4101506d1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0afe2cd1fa161f2bb8557b04cb091dc4aae37b6fe4150c0e470e2061e46548b9cbca87ebdc6c23d27d30402ed716af7deec74e09af988ca56e3ba0cb66691bd6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d830afaf7d8816a622c32a0028b38840b39d29c49562a4da9fa181d8eef1e67e9ac501f87f6edac2b989da1fe21051f53b1b0a451af266079dddd7cfb7a778d2"} build_url:https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011376 build_url: 'https://queue.taskcluster.net/v1/task/Pj-VaPN8T7i1ueaiKO7P6Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3317130ba4cf4408c82330f4ca69e2a631e9c35c1c36a073cba91cb16020b44358918ed3895aff9d8176d2c29100b7d4a1a9a050eefa7e0e9251da4101506d1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0afe2cd1fa161f2bb8557b04cb091dc4aae37b6fe4150c0e470e2061e46548b9cbca87ebdc6c23d27d30402ed716af7deec74e09af988ca56e3ba0cb66691bd6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d830afaf7d8816a622c32a0028b38840b39d29c49562a4da9fa181d8eef1e67e9ac501f87f6edac2b989da1fe21051f53b1b0a451af266079dddd7cfb7a778d2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 16:41:14.323668) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:41:14.323983) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1471908030.817639-284414530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 16:41:14.406333) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 16:41:14.406648) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 16:41:14.406995) ========= ========= Total master_lag: 0.17 =========