builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-038 starttime: 1469123033.89 results: success (0) buildid: 20160721101219 builduid: 81f5b3ef69b344f78121921179e1e781 revision: b9d5aa8be125a6323c33b8a9950b38e449a24a3b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 10:43:53.890879) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 10:43:53.891421) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 10:43:53.891739) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 10:43:53.908345) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 10:43:53.908969) ========= 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=8783db0840cc980e80bb0bd400000236-1469122922.939821-1982516718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-21 10:43:54-- 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% 228M=0s 2016-07-21 10:43:54 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075487 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 10:43:54.001797) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 10:43:54.002145) ========= 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=8783db0840cc980e80bb0bd400000236-1469122922.939821-1982516718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016877 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 10:43:54.056178) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 10:43:54.057024) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b9d5aa8be125a6323c33b8a9950b38e449a24a3b --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 b9d5aa8be125a6323c33b8a9950b38e449a24a3b --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=8783db0840cc980e80bb0bd400000236-1469122922.939821-1982516718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-21 10:43:54,375 truncating revision to first 12 chars 2016-07-21 10:43:54,375 Setting DEBUG logging. 2016-07-21 10:43:54,375 attempt 1/10 2016-07-21 10:43:54,375 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b9d5aa8be125?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 10:43:55,296 unpacking tar archive at: fx-team-b9d5aa8be125/testing/mozharness/ program finished with exit code 0 elapsedTime=1.260205 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 10:43:55.337848) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 10:43:55.338169) ========= script_repo_revision: b9d5aa8be125a6323c33b8a9950b38e449a24a3b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 10:43:55.338589) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 10:43:55.338888) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 10:43:55.349768) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-07-21 10:43:55.350087) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1469122922.939821-1982516718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:43:55 INFO - MultiFileLogger online at 20160721 10:43:55 in /builds/slave/test 10:43:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:43:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:43:55 INFO - {'append_to_log': False, 10:43:55 INFO - 'base_work_dir': '/builds/slave/test', 10:43:55 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:43:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:43:55 INFO - 'branch': 'Fx-Team-Non-PGO', 10:43:55 INFO - 'buildbot_json_path': 'buildprops.json', 10:43:55 INFO - 'config_files': ('talos/linux_config.py',), 10:43:55 INFO - 'default_actions': ('clobber', 10:43:55 INFO - 'read-buildbot-config', 10:43:55 INFO - 'download-and-extract', 10:43:55 INFO - 'populate-webroot', 10:43:55 INFO - 'create-virtualenv', 10:43:55 INFO - 'install', 10:43:55 INFO - 'run-tests'), 10:43:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:43:55 INFO - 'download_minidump_stackwalk': True, 10:43:55 INFO - 'download_symbols': 'ondemand', 10:43:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:43:55 INFO - 'tooltool.py': '/tools/tooltool.py', 10:43:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:43:55 INFO - '/tools/misc-python/virtualenv.py')}, 10:43:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:43:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:43:55 INFO - 'installer_path': 'installer.exe', 10:43:55 INFO - 'log_level': 'info', 10:43:55 INFO - 'log_name': 'talos', 10:43:55 INFO - 'log_to_console': True, 10:43:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:43:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:43:55 INFO - 'opt_config_files': (), 10:43:55 INFO - 'pip_index': False, 10:43:55 INFO - 'sps_profile': False, 10:43:55 INFO - 'sps_profile_interval': 0, 10:43:55 INFO - 'suite': 'dromaeojs', 10:43:55 INFO - 'system_bits': '32', 10:43:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:43:55 INFO - 'title': 'talos-linux64-ix-038', 10:43:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:43:55 INFO - 'use_talos_json': True, 10:43:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:43:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:43:55 INFO - 'work_dir': 'build'} 10:43:55 INFO - [mozharness: 2016-07-21 17:43:55.766435Z] Running clobber step. 10:43:55 INFO - Running pre-action listener: _resource_record_pre_action 10:43:55 INFO - Running main action method: clobber 10:43:55 INFO - rmtree: /builds/slave/test/build 10:43:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:43:56 INFO - Running post-action listener: _resource_record_post_action 10:43:56 INFO - [mozharness: 2016-07-21 17:43:56.759028Z] Finished clobber step (success) 10:43:56 INFO - [mozharness: 2016-07-21 17:43:56.759131Z] Running read-buildbot-config step. 10:43:56 INFO - Running pre-action listener: _resource_record_pre_action 10:43:56 INFO - Running main action method: read_buildbot_config 10:43:56 INFO - Using buildbot properties: 10:43:56 INFO - { 10:43:56 INFO - "project": "", 10:43:56 INFO - "product": "firefox", 10:43:56 INFO - "script_repo_revision": "production", 10:43:56 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:43:56 INFO - "repository": "", 10:43:56 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:43:56 INFO - "buildid": "20160721101219", 10:43:56 INFO - "pgo_build": "False", 10:43:56 INFO - "basedir": "/builds/slave/test", 10:43:56 INFO - "buildnumber": 1817, 10:43:56 INFO - "slavename": "talos-linux64-ix-038", 10:43:56 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:43:56 INFO - "platform": "ubuntu64_hw", 10:43:56 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:43:56 INFO - "branch": "fx-team", 10:43:56 INFO - "repo_path": "integration/fx-team", 10:43:56 INFO - "revision": "b9d5aa8be125a6323c33b8a9950b38e449a24a3b", 10:43:56 INFO - "stage_platform": "linux64", 10:43:56 INFO - "builduid": "81f5b3ef69b344f78121921179e1e781", 10:43:56 INFO - "slavebuilddir": "test" 10:43:56 INFO - } 10:43:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:43:56 INFO - Running post-action listener: _resource_record_post_action 10:43:56 INFO - [mozharness: 2016-07-21 17:43:56.761644Z] Finished read-buildbot-config step (success) 10:43:56 INFO - [mozharness: 2016-07-21 17:43:56.761734Z] Running download-and-extract step. 10:43:56 INFO - Running pre-action listener: _resource_record_pre_action 10:43:56 INFO - Running main action method: download_and_extract 10:43:56 INFO - mkdir: /builds/slave/test/build/tests 10:43: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:43:56 INFO - https://queue.taskcluster.net/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:43:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:43:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:43:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:43:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:44:04 INFO - Downloaded 1361 bytes. 10:44:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:44:04 INFO - Using the following test package requirements: 10:44:04 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:44:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:44:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:44:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:44:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:44:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:44:04 INFO - u'jsshell-linux-x86_64.zip'], 10:44:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:44:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:44:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:44:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:44:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:44:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:44:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:44:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:44:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:44:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:44:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:44:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:04 INFO - https://queue.taskcluster.net/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:44:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:44:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:44:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:44:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:44:08 INFO - Downloaded 22735533 bytes. 10:44:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:44:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:44:10 INFO - Return code: 0 10:44:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:44: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:10 INFO - https://queue.taskcluster.net/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:44:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:44:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:44:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:44:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:44:11 INFO - Downloaded 22735533 bytes. 10:44:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:44:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:44:12 INFO - Return code: 0 10:44:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:12 INFO - https://queue.taskcluster.net/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:44:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:44:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:44:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:44:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:44:14 INFO - Downloaded 14403317 bytes. 10:44:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:44:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:44:14 INFO - Return code: 0 10:44:14 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:14 INFO - https://queue.taskcluster.net/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:44:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:44:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:44:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:44:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:44:16 INFO - Downloaded 57149658 bytes. 10:44:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:44:16 INFO - mkdir: /builds/slave/test/properties 10:44:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:44:16 INFO - Writing to file /builds/slave/test/properties/build_url 10:44:16 INFO - Contents: 10:44:16 INFO - build_url:https://queue.taskcluster.net/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:44:17 INFO - Running post-action listener: _resource_record_post_action 10:44:17 INFO - Running post-action listener: set_extra_try_arguments 10:44:17 INFO - [mozharness: 2016-07-21 17:44:17.496746Z] Finished download-and-extract step (success) 10:44:17 INFO - [mozharness: 2016-07-21 17:44:17.496981Z] Running populate-webroot step. 10:44:17 INFO - Running pre-action listener: _resource_record_pre_action 10:44:17 INFO - Running main action method: populate_webroot 10:44:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:44:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:44:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:44:17 INFO - '--tppagecycles', 10:44:17 INFO - '7'], 10:44:17 INFO - 'tests': ['tsvgm']}}, 10:44:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:44:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:44:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:44:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:44:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:44:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:44:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:17 INFO - 'talos_options': ['--disable-e10s'], 10:44:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:44:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:44:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:17 INFO - 'talos_options': ['--disable-e10s'], 10:44:17 INFO - 'tests': ['damp', 'tps']}, 10:44:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:17 INFO - 'tests': ['damp', 'tps']}, 10:44:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:44:17 INFO - 'tests': ['dromaeo_dom']}, 10:44:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:44:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:44:17 INFO - 'tests': ['basic_compositor_video']}, 10:44:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:44:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:44:17 INFO - 'tests': ['a11yr', 10:44:17 INFO - 'ts_paint', 10:44:17 INFO - 'tpaint', 10:44:17 INFO - 'sessionrestore', 10:44:17 INFO - 'sessionrestore_no_auto_restore', 10:44:17 INFO - 'tabpaint']}, 10:44:17 INFO - 'other-e10s': {'tests': ['a11yr', 10:44:17 INFO - 'ts_paint', 10:44:17 INFO - 'tpaint', 10:44:17 INFO - 'sessionrestore', 10:44:17 INFO - 'sessionrestore_no_auto_restore', 10:44:17 INFO - 'tabpaint']}, 10:44:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:44:17 INFO - 'ts_paint', 10:44:17 INFO - 'tpaint', 10:44:17 INFO - 'sessionrestore', 10:44:17 INFO - 'sessionrestore_no_auto_restore', 10:44:17 INFO - 'tabpaint']}, 10:44:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:44:17 INFO - 'ts_paint', 10:44:17 INFO - 'tpaint', 10:44:17 INFO - 'sessionrestore', 10:44:17 INFO - 'sessionrestore_no_auto_restore', 10:44:17 INFO - 'tabpaint']}, 10:44:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:44:17 INFO - 'tests': ['a11yr', 10:44:17 INFO - 'ts_paint', 10:44:17 INFO - 'tpaint', 10:44:17 INFO - 'sessionrestore', 10:44:17 INFO - 'sessionrestore_no_auto_restore', 10:44:17 INFO - 'tabpaint']}, 10:44:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:44:17 INFO - 'tests': ['a11yr', 10:44:17 INFO - 'ts_paint', 10:44:17 INFO - 'tpaint', 10:44:17 INFO - 'sessionrestore', 10:44:17 INFO - 'sessionrestore_no_auto_restore', 10:44:17 INFO - 'tabpaint']}, 10:44:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:44:17 INFO - 'tests': ['tsvgx', 10:44:17 INFO - 'tsvgr_opacity', 10:44:17 INFO - 'tart', 10:44:17 INFO - 'tscrollx', 10:44:17 INFO - 'cart']}, 10:44:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:44:17 INFO - 'tsvgr_opacity', 10:44:17 INFO - 'tart', 10:44:17 INFO - 'tscrollx', 10:44:17 INFO - 'cart']}, 10:44:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:17 INFO - 'talos_options': ['--disable-e10s'], 10:44:17 INFO - 'tests': ['tp5o']}, 10:44:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:17 INFO - 'tests': ['tp5o']}, 10:44:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:17 INFO - 'talos_options': ['--disable-e10s', 10:44:17 INFO - '--xperf_path', 10:44:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:44:17 INFO - 'tests': ['tp5n']}, 10:44:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:44:17 INFO - 'talos_options': ['--xperf_path', 10:44:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:44:17 INFO - 'tests': ['tp5n']}}, 10:44:17 INFO - 'talos.zip': {'path': '', 10:44:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:44:17 INFO - Running post-action listener: _resource_record_post_action 10:44:17 INFO - [mozharness: 2016-07-21 17:44:17.518228Z] Finished populate-webroot step (success) 10:44:17 INFO - [mozharness: 2016-07-21 17:44:17.518318Z] Running create-virtualenv step. 10:44:17 INFO - Running pre-action listener: _resource_record_pre_action 10:44:17 INFO - Running main action method: create_virtualenv 10:44:17 INFO - Creating virtualenv /builds/slave/test/build/venv 10:44:17 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 10:44:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:44:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:44:17 INFO - Using real prefix '/usr' 10:44:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:44:18 INFO - Installing distribute.............................................................................................................................................................................................done. 10:44:20 INFO - Installing pip.................done. 10:44:20 INFO - Return code: 0 10:44:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:44:20 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:20 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:20 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 0x10ec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ad180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ab3b0>, '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 0x13ac2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ac740>, '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': '8783db0840cc980e80bb0bd400000236-1469122922.939821-1982516718', '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 10:44:20 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 10:44:20 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 10:44:20 INFO - Using env: {'DISPLAY': ':0', 10:44:20 INFO - 'HOME': '/home/cltbld', 10:44:20 INFO - 'LANG': 'en_US.UTF-8', 10:44:20 INFO - 'LANGUAGE': 'en_US:en', 10:44:20 INFO - 'LOGNAME': 'cltbld', 10:44:20 INFO - 'MAIL': '/var/mail/cltbld', 10:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:20 INFO - 'MOZ_NO_REMOTE': '1', 10:44:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:20 INFO - 'NO_EM_RESTART': '1', 10:44:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:20 INFO - 'PWD': '/builds/slave/test', 10:44:20 INFO - 'SHELL': '/bin/bash', 10:44:20 INFO - 'SHLVL': '1', 10:44:20 INFO - 'TERM': 'linux', 10:44:20 INFO - 'TMOUT': '86400', 10:44:20 INFO - 'USER': 'cltbld', 10:44:20 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469122922.939821-1982516718', 10:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:20 INFO - '_': '/tools/buildbot/bin/python'} 10:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:20 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 10:44:20 INFO - Cleaning up... 10:44:20 INFO - Return code: 0 10:44:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:44:20 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:20 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:20 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 0x10ec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ad180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ab3b0>, '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 0x13ac2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ac740>, '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': '8783db0840cc980e80bb0bd400000236-1469122922.939821-1982516718', '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 10:44:20 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 10:44:20 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 10:44:20 INFO - Using env: {'DISPLAY': ':0', 10:44:20 INFO - 'HOME': '/home/cltbld', 10:44:20 INFO - 'LANG': 'en_US.UTF-8', 10:44:20 INFO - 'LANGUAGE': 'en_US:en', 10:44:20 INFO - 'LOGNAME': 'cltbld', 10:44:20 INFO - 'MAIL': '/var/mail/cltbld', 10:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:20 INFO - 'MOZ_NO_REMOTE': '1', 10:44:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:20 INFO - 'NO_EM_RESTART': '1', 10:44:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:20 INFO - 'PWD': '/builds/slave/test', 10:44:20 INFO - 'SHELL': '/bin/bash', 10:44:20 INFO - 'SHLVL': '1', 10:44:20 INFO - 'TERM': 'linux', 10:44:20 INFO - 'TMOUT': '86400', 10:44:20 INFO - 'USER': 'cltbld', 10:44:20 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469122922.939821-1982516718', 10:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:20 INFO - '_': '/tools/buildbot/bin/python'} 10:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:20 INFO - Downloading/unpacking psutil>=3.1.1 10:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:44:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:44:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:44:22 INFO - Installing collected packages: psutil 10:44:22 INFO - Running setup.py install for psutil 10:44:22 INFO - building 'psutil._psutil_linux' extension 10:44:22 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 10:44:22 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 10:44:22 INFO - building 'psutil._psutil_posix' extension 10:44:22 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 10:44:22 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 10:44:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:44:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:44:23 INFO - Successfully installed psutil 10:44:23 INFO - Cleaning up... 10:44:23 INFO - Return code: 0 10:44:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:44:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ad180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ab3b0>, '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 0x13ac2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ac740>, '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': '8783db0840cc980e80bb0bd400000236-1469122922.939821-1982516718', '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 10:44:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:44:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:44:23 INFO - Using env: {'DISPLAY': ':0', 10:44:23 INFO - 'HOME': '/home/cltbld', 10:44:23 INFO - 'LANG': 'en_US.UTF-8', 10:44:23 INFO - 'LANGUAGE': 'en_US:en', 10:44:23 INFO - 'LOGNAME': 'cltbld', 10:44:23 INFO - 'MAIL': '/var/mail/cltbld', 10:44:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:23 INFO - 'MOZ_NO_REMOTE': '1', 10:44:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:23 INFO - 'NO_EM_RESTART': '1', 10:44:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:23 INFO - 'PWD': '/builds/slave/test', 10:44:23 INFO - 'SHELL': '/bin/bash', 10:44:23 INFO - 'SHLVL': '1', 10:44:23 INFO - 'TERM': 'linux', 10:44:23 INFO - 'TMOUT': '86400', 10:44:23 INFO - 'USER': 'cltbld', 10:44:23 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469122922.939821-1982516718', 10:44:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:23 INFO - '_': '/tools/buildbot/bin/python'} 10:44:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:44:23 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 10:44:23 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 10:44:23 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 10:44:23 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 10:44:23 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 10:44:23 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 10:44:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:44:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:44:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:44:25 INFO - Installing collected packages: mozsystemmonitor 10:44:25 INFO - Running setup.py install for mozsystemmonitor 10:44:25 INFO - Successfully installed mozsystemmonitor 10:44:25 INFO - Cleaning up... 10:44:25 INFO - Return code: 0 10:44:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:25 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 0x10ec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ad180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ab3b0>, '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 0x13ac2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ac740>, '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': '8783db0840cc980e80bb0bd400000236-1469122922.939821-1982516718', '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 10:44:25 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 10:44:25 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 10:44:25 INFO - Using env: {'DISPLAY': ':0', 10:44:25 INFO - 'HOME': '/home/cltbld', 10:44:25 INFO - 'LANG': 'en_US.UTF-8', 10:44:25 INFO - 'LANGUAGE': 'en_US:en', 10:44:25 INFO - 'LOGNAME': 'cltbld', 10:44:25 INFO - 'MAIL': '/var/mail/cltbld', 10:44:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:25 INFO - 'MOZ_NO_REMOTE': '1', 10:44:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:25 INFO - 'NO_EM_RESTART': '1', 10:44:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:25 INFO - 'PWD': '/builds/slave/test', 10:44:25 INFO - 'SHELL': '/bin/bash', 10:44:25 INFO - 'SHLVL': '1', 10:44:25 INFO - 'TERM': 'linux', 10:44:25 INFO - 'TMOUT': '86400', 10:44:25 INFO - 'USER': 'cltbld', 10:44:25 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469122922.939821-1982516718', 10:44:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:25 INFO - '_': '/tools/buildbot/bin/python'} 10:44:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:25 INFO - Downloading/unpacking jsonschema==2.5.1 10:44:25 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 10:44:25 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 10:44:25 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 10:44:25 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 10:44:25 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 10:44:25 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 10:44:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:44:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:44:27 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 10:44:27 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 10:44:27 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 10:44:27 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 10:44:27 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 10:44:27 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 10:44:27 INFO - Downloading functools32-3.2.3-2.tar.gz 10:44:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:44:27 INFO - warning: no files found matching '*.txt' 10:44:27 INFO - no previously-included directories found matching 'build' 10:44:27 INFO - no previously-included directories found matching 'dist' 10:44:27 INFO - no previously-included directories found matching '.git*' 10:44:27 INFO - Installing collected packages: jsonschema, functools32 10:44:27 INFO - Running setup.py install for functools32 10:44:27 INFO - warning: no files found matching '*.txt' 10:44:27 INFO - no previously-included directories found matching 'build' 10:44:27 INFO - no previously-included directories found matching 'dist' 10:44:27 INFO - no previously-included directories found matching '.git*' 10:44:27 INFO - Successfully installed jsonschema functools32 10:44:27 INFO - Cleaning up... 10:44:28 INFO - Return code: 0 10:44:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:44:28 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:28 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:28 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 0x10ec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ad180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ab3b0>, '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 0x13ac2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ac740>, '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': '8783db0840cc980e80bb0bd400000236-1469122922.939821-1982516718', '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 10:44:28 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 10:44:28 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 10:44:28 INFO - Using env: {'DISPLAY': ':0', 10:44:28 INFO - 'HOME': '/home/cltbld', 10:44:28 INFO - 'LANG': 'en_US.UTF-8', 10:44:28 INFO - 'LANGUAGE': 'en_US:en', 10:44:28 INFO - 'LOGNAME': 'cltbld', 10:44:28 INFO - 'MAIL': '/var/mail/cltbld', 10:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:28 INFO - 'MOZ_NO_REMOTE': '1', 10:44:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:28 INFO - 'NO_EM_RESTART': '1', 10:44:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:28 INFO - 'PWD': '/builds/slave/test', 10:44:28 INFO - 'SHELL': '/bin/bash', 10:44:28 INFO - 'SHLVL': '1', 10:44:28 INFO - 'TERM': 'linux', 10:44:28 INFO - 'TMOUT': '86400', 10:44:28 INFO - 'USER': 'cltbld', 10:44:28 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469122922.939821-1982516718', 10:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:28 INFO - '_': '/tools/buildbot/bin/python'} 10:44:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:28 INFO - Downloading/unpacking blobuploader==1.2.4 10:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:30 INFO - Downloading blobuploader-1.2.4.tar.gz 10:44:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:44:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:44:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:30 INFO - Downloading docopt-0.6.1.tar.gz 10:44:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:44:30 INFO - Installing collected packages: blobuploader, requests, docopt 10:44:30 INFO - Running setup.py install for blobuploader 10:44:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:44:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:44:31 INFO - Running setup.py install for requests 10:44:31 INFO - Running setup.py install for docopt 10:44:31 INFO - Successfully installed blobuploader requests docopt 10:44:31 INFO - Cleaning up... 10:44:31 INFO - Return code: 0 10:44:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:44:31 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:31 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:31 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 0x10ec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ad180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ab3b0>, '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 0x13ac2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ac740>, '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': '8783db0840cc980e80bb0bd400000236-1469122922.939821-1982516718', '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 10:44:31 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 10:44:31 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 10:44:31 INFO - Using env: {'DISPLAY': ':0', 10:44:31 INFO - 'HOME': '/home/cltbld', 10:44:31 INFO - 'LANG': 'en_US.UTF-8', 10:44:31 INFO - 'LANGUAGE': 'en_US:en', 10:44:31 INFO - 'LOGNAME': 'cltbld', 10:44:31 INFO - 'MAIL': '/var/mail/cltbld', 10:44:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:31 INFO - 'MOZ_NO_REMOTE': '1', 10:44:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:31 INFO - 'NO_EM_RESTART': '1', 10:44:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:31 INFO - 'PWD': '/builds/slave/test', 10:44:31 INFO - 'SHELL': '/bin/bash', 10:44:31 INFO - 'SHLVL': '1', 10:44:31 INFO - 'TERM': 'linux', 10:44:31 INFO - 'TMOUT': '86400', 10:44:31 INFO - 'USER': 'cltbld', 10:44:31 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469122922.939821-1982516718', 10:44:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:31 INFO - '_': '/tools/buildbot/bin/python'} 10:44:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:44:31 INFO - Running setup.py (path:/tmp/pip-uI6m_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:44:31 INFO - Running setup.py (path:/tmp/pip-MJPHyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:44:31 INFO - Running setup.py (path:/tmp/pip-TO4Tlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:44:31 INFO - Running setup.py (path:/tmp/pip-eBI4Rh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:44:32 INFO - Running setup.py (path:/tmp/pip-ZjBX5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:44:32 INFO - Running setup.py (path:/tmp/pip-jDVtxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:44:32 INFO - Running setup.py (path:/tmp/pip-CT8cbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:44:32 INFO - Running setup.py (path:/tmp/pip-LH_mmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:44:32 INFO - Running setup.py (path:/tmp/pip-UxIaL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:44:32 INFO - Running setup.py (path:/tmp/pip-UnO36I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:44:32 INFO - Running setup.py (path:/tmp/pip-PCncN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:44:32 INFO - Running setup.py (path:/tmp/pip-MVvRK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:44:32 INFO - Running setup.py (path:/tmp/pip-Kwcr3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:44:32 INFO - Running setup.py (path:/tmp/pip-YvyKaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:44:32 INFO - Running setup.py (path:/tmp/pip-PrYMYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:44:32 INFO - Running setup.py (path:/tmp/pip-eTNbFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:44:32 INFO - Running setup.py (path:/tmp/pip-YMDMQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:44:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:44:32 INFO - Running setup.py install for manifestparser 10:44:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:44:33 INFO - Running setup.py install for mozcrash 10:44:33 INFO - Running setup.py install for mozdebug 10:44:33 INFO - Running setup.py install for mozdevice 10:44:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:44:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:44:33 INFO - Running setup.py install for mozfile 10:44:33 INFO - Running setup.py install for mozhttpd 10:44:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:44:33 INFO - Running setup.py install for mozinfo 10:44:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:44:33 INFO - Running setup.py install for mozInstall 10:44:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:44:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:44:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:44:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:44:33 INFO - Running setup.py install for mozleak 10:44:33 INFO - Running setup.py install for mozlog 10:44:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:44:33 INFO - Running setup.py install for moznetwork 10:44:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:44:34 INFO - Running setup.py install for mozprocess 10:44:34 INFO - Running setup.py install for mozprofile 10:44:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:44:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:44:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:44:34 INFO - Running setup.py install for mozrunner 10:44:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:44:34 INFO - Running setup.py install for mozscreenshot 10:44:34 INFO - Running setup.py install for moztest 10:44:34 INFO - Running setup.py install for mozversion 10:44:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:44:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:44:34 INFO - Cleaning up... 10:44:34 INFO - Return code: 0 10:44:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:44: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:34 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 0x10ec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ad180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ab3b0>, '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 0x13ac2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ac740>, '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': '8783db0840cc980e80bb0bd400000236-1469122922.939821-1982516718', '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 10:44:34 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 10:44:34 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 10:44:34 INFO - Using env: {'DISPLAY': ':0', 10:44:34 INFO - 'HOME': '/home/cltbld', 10:44:34 INFO - 'LANG': 'en_US.UTF-8', 10:44:34 INFO - 'LANGUAGE': 'en_US:en', 10:44:34 INFO - 'LOGNAME': 'cltbld', 10:44:34 INFO - 'MAIL': '/var/mail/cltbld', 10:44:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:34 INFO - 'MOZ_NO_REMOTE': '1', 10:44:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:34 INFO - 'NO_EM_RESTART': '1', 10:44:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:34 INFO - 'PWD': '/builds/slave/test', 10:44:34 INFO - 'SHELL': '/bin/bash', 10:44:34 INFO - 'SHLVL': '1', 10:44:34 INFO - 'TERM': 'linux', 10:44:34 INFO - 'TMOUT': '86400', 10:44:34 INFO - 'USER': 'cltbld', 10:44:34 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469122922.939821-1982516718', 10:44:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:34 INFO - '_': '/tools/buildbot/bin/python'} 10:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:44:35 INFO - Running setup.py (path:/tmp/pip-VPyCCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:44:35 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)) 10:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:44:35 INFO - Running setup.py (path:/tmp/pip-QqbFCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:44:35 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)) 10:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:44:35 INFO - Running setup.py (path:/tmp/pip-haLvHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:44:35 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)) 10:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:44:35 INFO - Running setup.py (path:/tmp/pip-hCgWSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:44:35 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)) 10:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:44:35 INFO - Running setup.py (path:/tmp/pip-XkPQLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:44:35 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)) 10:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:44:35 INFO - Running setup.py (path:/tmp/pip-K5DRRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:44:35 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)) 10:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:44:35 INFO - Running setup.py (path:/tmp/pip-r1ySjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:44:35 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)) 10:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:44:35 INFO - Running setup.py (path:/tmp/pip-bAXDVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:44:35 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)) 10:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:44:35 INFO - Running setup.py (path:/tmp/pip-F7EQhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:44:35 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)) 10:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:44:35 INFO - Running setup.py (path:/tmp/pip-J2SQyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:44:35 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)) 10:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:44:35 INFO - Running setup.py (path:/tmp/pip-eh0WAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:44:35 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)) 10:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:44:35 INFO - Running setup.py (path:/tmp/pip-MKIF9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:44:35 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)) 10:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:44:35 INFO - Running setup.py (path:/tmp/pip-Multwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:44:36 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)) 10:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:44:36 INFO - Running setup.py (path:/tmp/pip-HLaU9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:44:36 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)) 10:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:44:36 INFO - Running setup.py (path:/tmp/pip-P5PsmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:44:36 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)) 10:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:44:36 INFO - Running setup.py (path:/tmp/pip-4QN9Dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:44:36 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)) 10:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:44:36 INFO - Running setup.py (path:/tmp/pip-8QzYky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:44:36 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)) 10:44:36 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)) 10:44:36 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)) 10:44:36 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)) 10:44:36 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)) 10:44:36 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)) 10:44:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:44:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:44:38 INFO - Downloading blessings-1.6.tar.gz 10:44:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:44:38 INFO - Installing collected packages: blessings 10:44:38 INFO - Running setup.py install for blessings 10:44:38 INFO - Successfully installed blessings 10:44:38 INFO - Cleaning up... 10:44:38 INFO - Return code: 0 10:44:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:44:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:44:38 INFO - Reading from file tmpfile_stdout 10:44:38 INFO - Current package versions: 10:44:38 INFO - argparse == 1.2.1 10:44:38 INFO - blessings == 1.6 10:44:38 INFO - blobuploader == 1.2.4 10:44:38 INFO - docopt == 0.6.1 10:44:38 INFO - functools32 == 3.2.3-2 10:44:38 INFO - jsonschema == 2.5.1 10:44:38 INFO - manifestparser == 1.1 10:44:38 INFO - mozInstall == 1.12 10:44:38 INFO - mozcrash == 0.17 10:44:38 INFO - mozdebug == 0.1 10:44:38 INFO - mozdevice == 0.48 10:44:38 INFO - mozfile == 1.2 10:44:38 INFO - mozhttpd == 0.7 10:44:38 INFO - mozinfo == 0.9 10:44:38 INFO - mozleak == 0.1 10:44:38 INFO - mozlog == 3.3 10:44:38 INFO - moznetwork == 0.27 10:44:38 INFO - mozprocess == 0.23 10:44:38 INFO - mozprofile == 0.28 10:44:38 INFO - mozrunner == 6.12 10:44:38 INFO - mozscreenshot == 0.1 10:44:38 INFO - mozsystemmonitor == 0.3 10:44:38 INFO - moztest == 0.7 10:44:38 INFO - mozversion == 1.4 10:44:38 INFO - psutil == 3.1.1 10:44:38 INFO - requests == 1.2.3 10:44:38 INFO - wsgiref == 0.1.2 10:44:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:38 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 0x10ec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ad180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ab3b0>, '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 0x13ac2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ac740>, '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': '8783db0840cc980e80bb0bd400000236-1469122922.939821-1982516718', '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 10:44:38 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 10:44:38 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 10:44:38 INFO - Using env: {'DISPLAY': ':0', 10:44:38 INFO - 'HOME': '/home/cltbld', 10:44:38 INFO - 'LANG': 'en_US.UTF-8', 10:44:38 INFO - 'LANGUAGE': 'en_US:en', 10:44:38 INFO - 'LOGNAME': 'cltbld', 10:44:38 INFO - 'MAIL': '/var/mail/cltbld', 10:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:38 INFO - 'MOZ_NO_REMOTE': '1', 10:44:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:38 INFO - 'NO_EM_RESTART': '1', 10:44:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:38 INFO - 'PWD': '/builds/slave/test', 10:44:38 INFO - 'SHELL': '/bin/bash', 10:44:38 INFO - 'SHLVL': '1', 10:44:38 INFO - 'TERM': 'linux', 10:44:38 INFO - 'TMOUT': '86400', 10:44:38 INFO - 'USER': 'cltbld', 10:44:38 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469122922.939821-1982516718', 10:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:38 INFO - '_': '/tools/buildbot/bin/python'} 10:44:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:38 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)) 10:44:38 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)) 10:44:38 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)) 10:44:38 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)) 10:44:38 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)) 10:44:38 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)) 10:44:38 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)) 10:44:38 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)) 10:44:38 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)) 10:44:38 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)) 10:44:38 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)) 10:44:38 INFO - Cleaning up... 10:44:38 INFO - Return code: 0 10:44:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:44:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:44:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:44:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ad180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ab3b0>, '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 0x13ac2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ac740>, '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': '8783db0840cc980e80bb0bd400000236-1469122922.939821-1982516718', '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 10:44:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:44:38 INFO - Using env: {'DISPLAY': ':0', 10:44:38 INFO - 'HOME': '/home/cltbld', 10:44:38 INFO - 'LANG': 'en_US.UTF-8', 10:44:38 INFO - 'LANGUAGE': 'en_US:en', 10:44:38 INFO - 'LOGNAME': 'cltbld', 10:44:38 INFO - 'MAIL': '/var/mail/cltbld', 10:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:38 INFO - 'MOZ_NO_REMOTE': '1', 10:44:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:38 INFO - 'NO_EM_RESTART': '1', 10:44:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:38 INFO - 'PWD': '/builds/slave/test', 10:44:38 INFO - 'SHELL': '/bin/bash', 10:44:38 INFO - 'SHLVL': '1', 10:44:38 INFO - 'TERM': 'linux', 10:44:38 INFO - 'TMOUT': '86400', 10:44:38 INFO - 'USER': 'cltbld', 10:44:38 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469122922.939821-1982516718', 10:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:38 INFO - '_': '/tools/buildbot/bin/python'} 10:44:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:44:39 INFO - Cleaning up... 10:44:39 INFO - Return code: 0 10:44:39 INFO - Running post-action listener: _resource_record_post_action 10:44:39 INFO - Running post-action listener: _start_resource_monitoring 10:44:39 INFO - Starting resource monitoring. 10:44:39 INFO - [mozharness: 2016-07-21 17:44:39.197078Z] Finished create-virtualenv step (success) 10:44:39 INFO - [mozharness: 2016-07-21 17:44:39.197591Z] Running install step. 10:44:39 INFO - Running pre-action listener: _resource_record_pre_action 10:44:39 INFO - Running main action method: install 10:44:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:44:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:44:39 INFO - Reading from file tmpfile_stdout 10:44:39 INFO - Detecting whether we're running mozinstall >=1.0... 10:44:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:44:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:44:39 INFO - Reading from file tmpfile_stdout 10:44:39 INFO - Output received: 10:44:39 INFO - Usage: mozinstall [options] installer 10:44:39 INFO - Options: 10:44:39 INFO - -h, --help show this help message and exit 10:44:39 INFO - -d DEST, --destination=DEST 10:44:39 INFO - Directory to install application into. [default: 10:44:39 INFO - "/builds/slave/test"] 10:44:39 INFO - --app=APP Application being installed. [default: firefox] 10:44:39 INFO - mkdir: /builds/slave/test/build/application 10:44:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:44:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:44:57 INFO - Reading from file tmpfile_stdout 10:44:57 INFO - Output received: 10:44:57 INFO - /builds/slave/test/build/application/firefox/firefox 10:44:57 INFO - Running post-action listener: _resource_record_post_action 10:44:57 INFO - [mozharness: 2016-07-21 17:44:57.742139Z] Finished install step (success) 10:44:57 INFO - [mozharness: 2016-07-21 17:44:57.742416Z] Running run-tests step. 10:44:57 INFO - Running pre-action listener: _resource_record_pre_action 10:44:57 INFO - Running main action method: run_tests 10:44:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:44:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:44:57 INFO - Python 2.7.3 10:44:57 INFO - Return code: 0 10:44:57 INFO - grabbing minidump binary from tooltool 10:44:57 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:44:57 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 0x13ab3b0>, '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 0x13ac2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ac740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:44:57 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 10:44:57 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 10:44:57 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 10:44:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:44:57 INFO - Return code: 0 10:44:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:44:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:44:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:44:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:44:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:44:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 10:44:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 10:44:57 INFO - Using env: {'DISPLAY': ':0', 10:44:57 INFO - 'HOME': '/home/cltbld', 10:44:57 INFO - 'LANG': 'en_US.UTF-8', 10:44:57 INFO - 'LANGUAGE': 'en_US:en', 10:44:57 INFO - 'LOGNAME': 'cltbld', 10:44:57 INFO - 'MAIL': '/var/mail/cltbld', 10:44:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:44:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:44:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:44:57 INFO - 'MOZ_NO_REMOTE': '1', 10:44:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:44:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:44:57 INFO - 'NO_EM_RESTART': '1', 10:44:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:44:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:44:57 INFO - 'PWD': '/builds/slave/test', 10:44:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:44:57 INFO - 'SHELL': '/bin/bash', 10:44:57 INFO - 'SHLVL': '1', 10:44:57 INFO - 'TERM': 'linux', 10:44:57 INFO - 'TMOUT': '86400', 10:44:57 INFO - 'USER': 'cltbld', 10:44:57 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1469122922.939821-1982516718', 10:44:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:44:57 INFO - '_': '/tools/buildbot/bin/python'} 10:44:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 10:44:58 INFO - mozversion application_buildid: 20160721101219 10:44:58 INFO - mozversion application_changeset: b9d5aa8be125a6323c33b8a9950b38e449a24a3b 10:44:58 INFO - mozversion application_display_name: Nightly 10:44:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:44:58 INFO - mozversion application_name: Firefox 10:44:58 INFO - mozversion application_remotingname: firefox 10:44:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:44:58 INFO - mozversion application_vendor: Mozilla 10:44:58 INFO - mozversion application_version: 50.0a1 10:44:58 INFO - mozversion platform_buildid: 20160721101219 10:44:58 INFO - mozversion platform_changeset: b9d5aa8be125a6323c33b8a9950b38e449a24a3b 10:44:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:44:58 INFO - mozversion platform_version: 50.0a1 10:44:58 INFO - using testdate: 1469123098 10:44:58 INFO - actual date: 1469123098 10:44:58 INFO - starting webserver on 'localhost:60146' 10:44:58 INFO - SUITE-START | Running 2 tests 10:44:58 INFO - TEST-START | dromaeo_css 10:44:58 INFO - operating with platform_type : linux_ 10:44:58 INFO - Initialising browser for dromaeo_css test... 10:44:58 INFO - TEST-INFO | started process 32655 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphAhMwo/profile http://localhost:60146/getInfo.html) 10:45:02 INFO - PROCESS | 32655 | JavaScript error: , line 0: uncaught exception: undefined 10:45:03 INFO - PROCESS | 32655 | __metrics Screen width/height:1600/1200 10:45:03 INFO - PROCESS | 32655 | colorDepth:24 10:45:03 INFO - PROCESS | 32655 | Browser inner width/height: 1024/697 10:45:03 INFO - PROCESS | 32655 | __metrics 10:45:04 INFO - PROCESS | 32655 | 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" 10:45:04 INFO - PROCESS | 32655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:45:05 INFO - TEST-INFO | 32655: exit 0 10:45:05 INFO - Browser initialized. 10:45:05 INFO - Running cycle 1/1 for dromaeo_css test... 10:45:05 INFO - TEST-INFO | started process 32737 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphAhMwo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:45:17 INFO - PROCESS | 32737 | RSS: Main: 159010816 10:45:17 INFO - PROCESS | 32737 | 10:46:09 INFO - PROCESS | 32737 | 1469123169820 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] 10:48:21 INFO - PROCESS | 32737 | Cycle 1(1): loaded http://localhost:60146/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60146/tests/dromaeo/cssquery-ext.html) 10:48:22 INFO - PROCESS | 32737 | RSS: Main: 249270272 10:48:22 INFO - PROCESS | 32737 | 10:51:25 INFO - PROCESS | 32737 | Cycle 1(1): loaded http://localhost:60146/tests/dromaeo/cssquery-ext.html (next: http://localhost:60146/tests/dromaeo/cssquery-jquery.html) 10:51:26 INFO - PROCESS | 32737 | RSS: Main: 238313472 10:51:26 INFO - PROCESS | 32737 | 10:54:28 INFO - PROCESS | 32737 | Cycle 1(1): loaded http://localhost:60146/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60146/tests/dromaeo/cssquery-mootools.html) 10:54:28 INFO - PROCESS | 32737 | RSS: Main: 189313024 10:54:28 INFO - PROCESS | 32737 | 10:57:31 INFO - PROCESS | 32737 | Cycle 1(1): loaded http://localhost:60146/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60146/tests/dromaeo/cssquery-prototype.html) 10:57:31 INFO - PROCESS | 32737 | RSS: Main: 240738304 10:57:31 INFO - PROCESS | 32737 | 11:00:34 INFO - PROCESS | 32737 | Cycle 1(1): loaded http://localhost:60146/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60146/tests/dromaeo/cssquery-yui.html) 11:00:35 INFO - PROCESS | 32737 | RSS: Main: 191328256 11:00:35 INFO - PROCESS | 32737 | 11:03:38 INFO - PROCESS | 32737 | Cycle 1(1): loaded http://localhost:60146/tests/dromaeo/cssquery-yui.html (next: http://localhost:60146/tests/dromaeo/cssquery-dojo.html) 11:03:38 INFO - PROCESS | 32737 | RSS: Main: 264409088 11:03:38 INFO - PROCESS | 32737 | 11:03:38 INFO - PROCESS | 32737 | __start_tp_report 11:03:38 INFO - PROCESS | 32737 | _x_x_mozilla_page_load 11:03:38 INFO - PROCESS | 32737 | _x_x_mozilla_page_load_details 11:03:38 INFO - PROCESS | 32737 | |i|pagename|runs| 11:03:38 INFO - PROCESS | 32737 | |0;dojo.html;2569.3705042264646;2581.4191806843455;2627.750363715447;2638.1030449647114;2638.802089843261;4549.795259213335;4640.327152562885;4708.4820669726305;4756.09634169508;4769.046190761844;4691.88270293242;4718.268668356411;4726.409198850144;4781.689190202643;4797.0645724083815;4210.957890421102;4258.723182993095;4305.031367942203;4358.324459708734;4435.090806384684;4354.651627869779;4380.934285985712;4398.560143985592;4399.5160532341415;4415.955840441603;4235.8729238122905;4258.233517966764;4278.529361770203;4279.1013887083745;4329.220740266751;4232.407462955189;4235.894102647428;4294.012377153273;4355.542668019844;4365.912681746379;4263.424437700902;4267.466566679165;4268.0823622921225;4300.010997470568;4313.654907607384;4557.430321209848;4603.631709463235;4672.929906051412;4703.882402939954;4720.976395118037;4909.533594308535;4956.306117143603;4961.875953101166;4976.850694479135;5024.84925452237;4972.005598880239;5012.373453318335;5024.648274620778;5033.471485494007;5036.320096786923;4550;4668.2064049111395;4675.13510000651;4716.481187069419;4721;5137.152369859006;5143.27994080829;5211.791528338824;5216.739163041832;5223.869403264873;4924.901501969941;4958.628102892298;5007.349044624249;5007.39911210657;5008.624353173526;4898.559129678346;4973.303737476756;5043.394792624835;5082.898342033139;5096.566791822736;4981.3026176334615;5009.348784657971;5014.323066386064;5033.345665063592;5047.87380315495;4982.651214415028;4997.125503036954;4998.850034498971;5001.724905130252;5044.344235249394;4125.29869922114;4192;4258.488981322261;4267.97866010668;4312.5903039211225;3690.5755838078426;3708.517892673935;3719.590845007047;3731.570869350005;3791;4350.6736994725525;4351.6083552479795;4368.5194628590825;4402.031553058322;4412.227860124465;4947.925781113287;5022.974885125551;5027.974860125676;5037.899242015139;5059.2916991621205;4311.0300182458695;4315.417418648505;4352.347147927773;4364.75993820343;4401.933970990438;4531.56950089741;4563.95436045642;4564.680472366969;4570.223062079454;4610.4467463903875;4674.368960190399;4684.50812664679;4686.531346865422;4687.48437671849;4740.194166991689;4849.903001940012;5006.449290578106;5050.49495050492;5065.366829146356;5127.974360128175;4648.2330415481065;4648.721076735406;4676.298555216608;4685.835995740133;4717.693349932243;5007.524285192901;5016.297718319365;5019.84940451787;5019.899602008012;5055.620828437808;4913.1893237615395;4923.655344125877;4948.406191257072;4963.975180124076;5014;4851.151048566416;4853.417589889094;4861.6596838220985;4863.076015557032;4902.779374928065;4847.2729090636685;4853.247746599282;4857.247126695368;4860.586850117779;4903.362562866804;4721.480637129845;4739.241721324572;4773.689710168828;4782.52174782519;4843.6367272454;4839.516048395273;4882.853514394574;4884.462709102067;4887.877803054952;4926.088673595396;4775.092732380976;4783.4738178801;4783.760811959319;4785.282207668738;4831.73425461603 11:03:38 INFO - PROCESS | 32737 | |1;ext.html;568.1335962656945;569.923060386848;572.2360648534207;580.0892598620168;582.7377680043978;27037.459250814998;29741;37204;38633.22733545327;38756;40437;40885.364585416544;40912.79543602278;40951.59048409515;40960.79519602398;7648.311651951323;7790.571518566477;7792.142864284924;7793.22067793219;7797.727079552217;7400.592967386791;9700.126988571028;9883.703488895344;9898.356606820533;10228.48857557123;10060.899391006105;10146.325856233712;10149.695509134737;10158.238132140083;10168.44073575953;7417.51786133905;9994.350367226143;10029.097381235651;10041.899581004243;10048.69853904384;9604.135627793532;10009.59961601535;10042.297039207258;10306.330088544295;10380.480975951172;37697;38038.239235215144;38049.42925856114;38064.42903356452;38104.42843357352;2844.7013063628433;2922.473954688155;3073.0627158716584;3422.19578399076;3563.821808909544;28887.277818054506;28953.710462895313;28981.85509072462;29654.406911861643;29796;3273.508973653947;3274.9345013099605;3313.685199906005;3340.2985373071683;3387.61042480113;261817;262645.30160237866;262688;262788;262821;31733.8413307932;33111;53035.469645303056;53314.20028699573;53469.7326513365;33211.16972075669;33548.49677254843;33651.83174084114;33830.323393531995;33836.49245261323;13014.284214368301;13079.346032698328;13119.868801311864;13130.080894337305;13148.868511314955;9270.212031977357;9343.486108264111;10836.837447438294;10880.075193608633;10901.509432075576;7464.253574642492;7516.098068231738;7795.532268063935;7910.129885712567;7975.003124609424;3022.30486987994;3082.460569400346;3094.257378229209;3130.2800355918266;3160.2099475131217;935.4948327902993;936.7096200177966;966.1160038564775;977.3061126600194;1014.5586669798661;27026.351442555395;28370.2907427316;28681.426371472455;28701;28789.712102878704;917.7430319510547;1014.9086582207636;1019.50553981319;1052.4001319247955;1084.6854412220525;15041.774373384407;15252.847471525365;15301.923490382476;15327.770083448757;15530.534083977498;382981;383927;385194;386215;387872;49582.25626615604;49884.50115498871;49900.50099498958;49931;49937.75031124821;1141.1099342512853;1153.653903828848;1186.0748616079472;1188.5084219304717;1201.819727040951;27557.58663620007;28896.7110328894;29194.7080529192;29389.56604102777;29557.85221073881;40648.39027414532;41318;41335.793321033205;41353.586464134976;41358.58641413668;318872;319962.20245684887;320890;321953;322591;22971.196008139636;23479.530409392057;24347.51304973855;25026.74973250244;25286.873565632053;39849.2030159401;40292.1941561173;40350.798246008584;40438;40591.3911291325;34798.82600586981;34882.825585872924;34922.12694682653;35429.1142721434;35597.28805423929;34881.30237395289;35023;35501;35597.46603800893;35758.4636230462;33747.131493822315;33860.32279354448;34464.48303275503;34501.827490862386;35026.64973350234;30597.54103688402;32455.513167302983;32689.18277043093;32786.34427311488;32843.83578082094;23793.881030594737;24440.51118977575;24578.34913386594;24642.876785615957;24738.134165304127 11:03:38 INFO - PROCESS | 32737 | |2;jquery.html;341.26116956788553;359.0789624612866;369.20804873546246;369.73748638466685;386.8587965392631;12404.379781010946;15952.760708589365;16258.674826503462;17373.13134343284;17394.130293485337;16428.83571164288;16882.915585422088;16984.915075424637;17100.486985390457;17210.741838872425;4774.28385742138;4803.279508073782;5008.4240312364;5035.496450354972;5038.345015148026;3685.63143685632;4970.254461830737;5048.091343558158;5442.8842087371995;5726.284214473191;5749.281339832521;5755.223044888929;5767.682777447239;5770.04794208955;5774.6535207887455;5620.185073164389;5751.597388182829;5830;5869.1196320551835;5877.265341832271;5183.196604526304;5191.22131680251;5192.1432963560965;5194.428612852583;5198.428172900978;19863.503412414662;20464.897675511675;20478.590428191503;20504.794952050437;20533.38399848007;1917.3768525229216;1931.5364312565023;2083.9996801535194;2365.44412063165;2470.7899828514596;13093.934530327288;13227.206367617877;13351.399187036606;13581.456741730319;13670.316484175752;1732.7400889866494;1784.4379020608467;1791.3730194431844;1813.2565648084221;1854.165625468531;45489;46843.53156468426;67657;67803;69314.3068569318;8200.753977380688;8612.311015118776;8657;8673.176048275403;9010.27917766577;13104.606861794162;13133.868661313456;13134.73730525384;13137.60587182386;13156.868431315565;7112.822179445555;7153.785386438415;7243.74646887367;7321.560706357635;7364.0426744522865;6816.863662726718;6842.247352791189;6842.692078856364;7024.192217894905;7025.683844227022;6016.157737916695;6026.5178785697035;6038.516918646497;6062.757489700362;6096.573239873255;1744.4853768138175;1745.2059313012549;1765.496833402474;1777.146969454669;1777.7688900442859;833.0877688930611;850.6852464588142;852.5311078906576;877.1929824561419;961.4375590279765;16793.07638079917;17081.914590427215;17419.216135273942;17534.912325438545;17859;842.9704960326359;861.7974775927652;869.3610196505564;907.981840363189;925.8472352061834;9537.475438850792;10051.346662466916;10064.597416103421;10091.596336146471;10159.476078588123;268867;269724;270747;385283;411912;78192.21807781963;80302;80726;82111.58944205241;82269;805.0379796143552;835.2941764209233;839.9370047246481;840.6259214649423;879.4415546128382;14616.123032618078;15661;16142.67714645724;16342.346306147621;16424.09667468253;37546.436803448516;38134.455375370155;39341.40987885127;39714.60285397109;40174.79912600418;52057.7397113012;52553.7372313136;53181.4681853192;53982.46017539931;54696.72651636716;7492;7537.6984920604755;7581.166071731995;7607.049118860143;7909.367250619822;6286.842828929313;7220.927790722236;8706.736248575542;10793.352398856094;12274.202176858476;9471.384360016576;9554.665586704432;9738.659146929824;9830.115289623967;10561.155107591529;4482.148391805546;7746.49647772893;7895.447318687637;9758.56086476096;10027.949860250652;10104.242181836245;10134.898651013396;10258.43578603184;10371.27401081917;10683.732906677395;6446.161998940295;6768.612434450827;6777.6272305023695;6953.721851125898;7095.929040709527;7703.653335600024;9157.626356046647;10031.849522257318;10044.397336159855;10184.134348580157 11:03:38 INFO - PROCESS | 32737 | |3;mootools.html;1278.1436437586829;1359.069037709169;1417.8653027962343;1455.257818512559;1700.5833570775155;6595.373439523243;7603.315701586856;7829.45193836431;7836.804079897991;8099.433039687225;7947.046354437462;7997.400194985385;8011.078725946518;8014.038315402146;8024.478408903417;2125.0543508138885;2148.8495805293637;2150.1077053023055;2150.5698860228017;2152.397328747953;2176.3906106290183;2219.101263988079;2227.866328020316;2229.108356657342;2229.5317983223545;2126.840486963476;2150.365642135566;2156.202205184084;2157.622416077188;2162.8810415427147;2151.8601290916117;2154.8168405685537;2159.222679835258;2160.9567808643737;2162.23240749534;2097.1925808563815;2132.3602919124355;2135.263334149716;2136.7329083864515;2138.315738963532;7974.760757177294;7976.162502937166;7997.440179187459;8039.477433966774;8053.557054362008;4585.220512512881;4764.976175119137;4792.856214313576;4796.112719146934;4806.831760888387;2848.5869548915293;2951.140781307762;2991.2671395508023;3005.0984704588536;3018.0493144659363;841.1336323586654;852.6120615120168;865.6537385045968;865.7619154732436;867.9826403471958;10946.890531094667;11023.06303964164;11032.393218372987;11060.17048721341;11078.279911805626;3877.86427475037;4076.8369265229653;4187.24629566681;4227.8097485613225;4230.746155230696;8630.870536941951;8635.740927772176;8648.221660050625;8655.913440865637;8656.134386561294;4549.613282870927;4555.385023021916;4555.40779698637;4556.931646025312;4559.703619264737;3699.1861790406606;4148.502179738391;4238.576142385737;4239.788010599519;4306.1172459645695;3337.599488061448;3383.6616338365966;3457.844397002141;3462.5325581046236;3607.5129857469433;986.6941248213077;993.8757655293089;998.9200863930868;1004.6634377483479;1007.2043085962155;672.3511811102212;805.7260531419346;812.4881324765478;838.9622466989;839.7102999465175;5177.844664660066;5323.441038690959;5325.254464374991;5358.892822143535;5498.532624726863;355;367.4359857618543;367.54424513603476;368.4050258831967;369.6857670979646;3472.4444088945647;3532.4701294805473;3612.512310838056;3729.1422972715886;3819.331616967075;9658.90341096594;10154.898451015542;10226.53980570876;10235.795284094425;10239.948800255952;9142.451452912846;9368.859467107999;10066.899331006596;10126.746831329276;10143.340682855738;7325;7487.064116985377;7509.4367922404945;7512.6243687815395;7531.962340188264;5542.2795036644975;5573.860653483695;5706;5710.17202505626;5841.970790146022;9374.953125234602;9396.154346108882;9444.763880902758;9494.145526902612;9502.429854208769;9279.72160835176;9397.812043759222;9600.951995239979;9607.423554586747;9683.3705809125;5974.40255974399;6846.007328937177;6993.860122797617;7146.249643787328;7161.606111663908;7644.50310729823;7832.530048197126;7919.841603167789;7933.048034235929;7937.285644292041;6933.757318493828;6946.44428445713;7015.859682806417;7039.1553013638695;7206.351428371472;6818.8636227276165;6839.110915580943;6850.280720524473;6886.380225779503;6930.7227710891;6401.391867772554;6405.455536279468;6411.871762564816;6480.967595162183;6481.287058423664;4276.166147601188;4441.955580444154;4635.814567417266;4800.927986080142;4809.975950120227;4533.866533366659;4713.2458806590785;4805.37530121082;4805.879853003703;4893.608511319015 11:03:38 INFO - PROCESS | 32737 | |4;prototype.html;292.59621722023604;298.9387175628996;304.7744668944981;308.0312417447129;310.1563746609222;4575.535828534862;4690.921088149727;4740.525947405258;4812.109759694455;4825.565699087081;4343.717658352205;4636.744979026153;4711.976440117804;4722.8583142505695;4740.407449068866;3760.699144068468;3765.4163604641326;3769.9623003769884;3771.264603402338;3771.4531392948006;3782.3191825471404;3787.110029143149;3792.8103594820286;3812.4090765931323;3820.872842511466;3555.2178520725397;3601.531800865897;3723;3733.1600389912323;3737.663610275075;3725.3666876631037;3732.7387082904206;3741.38267185914;3750.5124333836698;3752.118252210742;3320.750943679234;3339.4322965095994;3349.69852713257;3351.6425847531787;3363.260082781784;4444.577765112309;4641.930371044437;4652.232381657022;4686.578207961265;4692.741899195543;4197;4203.117345357478;4212.9157416851795;4221.24017676818;4226.809793559297;4958.157113290749;4958.975205123951;4966.47851975541;4971.37857767779;4983.15286401309;3551.4672799080085;3553.2538166984964;3558.1104723819044;3564.6435356464144;3572.8034958077296;4893.632977526664;4958.2314741214805;5006.0989021975665;5159.613029022838;5203.297554830087;3559.6440355964196;3584.695300899453;3587.9641203588153;3590.120420496995;3603.621619729943;3656.762310449812;3667.477996631368;3669.3945498992903;3671.8800765766164;3673.7244706647107;4186.539480657125;4193.874183774492;4208.389783481378;4214.093969796509;4218.7468751874985;4827.324174615556;4932.8520144395725;4962.478939711278;4962.60299176065;5032.521910418504;1239.4670291774444;1255.491525931999;1257.25821765159;1257.30848033583;1257.7170136719164;786.3591173193829;806.790234539024;818.0796603820702;830.5058490198322;832.1054866019053;3980.203959208112;3981.3828856527284;3988.222296652183;3994.881433198709;4000.2799496090984;4456.598906098467;4507.805431560573;4527.207738645724;4543;4564.360989461478;3989.2819292527042;3993.480847489866;4001.579834117376;4015.2772500949527;4034.6080602192196;2307.7919102780124;2406.614941609334;2439.243834411338;2447.596146635821;2482.7641374069435;4233.856858648148;4238.533761286256;4254.617084462351;4278.44380230568;4281.764502952367;4551.8179272829375;4619.976900115478;4630.652701047435;4638.373819534387;4666.719996800203;4046.4094330055705;4060.0767447437797;4223.155368926227;4234.724742891703;4243.405923170697;4527.660425468037;4538.795754191004;4542.613877820422;4544.068465964403;4591.9540804591525;4441.71128876622;4489.797959091914;4491.214037543352;4514.367988481681;4514.61625761814;4168.416001919372;4183.853565125206;4208.200441916026;4242.851500197478;4538.773061346986;3554.306910152495;3570.357335679603;3582.1223800169128;3584.193556449778;3610.963890361168;5099.974500127476;5159.942211846637;5179.404368497671;5183.637145399785;5184.222366645034;5012;5028.120078986236;5032.974835125801;5035.615205818429;5054.3176671150395;4767.66626336167;5012.674176178537;5039.244113383022;5043.621728370314;5047.217681259411;4855.295982082507;4905.092557876804;4969.155243608668;4970.9254361183885;4971.154903666313;4973.428055773487;5010.874728131826;5041.8487445376695;5100.107481190851;5114.207297868837;4907.533784290486;4923.113839508779;4931.545194167657;4941.579965702956;4944.233643785219 11:03:38 INFO - PROCESS | 32737 | |5;yui.html;603.233892955946;622.2191150106619;685.1914740606082;703.4442790195744;711.8540699156673;11926.64220073398;13384.130031547955;13517.526886558973;13521.12112712673;13539.796903046437;13231.669208269797;13407.396667149977;13408.932955335235;13412.128211666235;13428;627.1846599420758;635.3202073781056;765.0475158427752;784.945053846231;787.0712559180165;756.213537920562;783.7296132834163;787.5825812319451;793.8531371696255;793.972210972616;823.3043078598574;825.3644693585935;826.0129145670926;826.3678286111129;826.3843436639712;657.1653999420756;819.0253598218131;819.1317203763999;819.1767273889762;820.4584973917216;577.2178697864417;591.5799782154676;594.3937184072265;599.8710277290404;600.6156060121526;12842.036847236495;12849.87150128496;12853.485860565566;12877.4205160768;12879.67800804978;11865;12553.309567973758;12563.497460101586;12880.613581592566;13160;11434.142439317002;11553.53785848565;11619.360935148563;11687.240329378648;12102.152849300552;4045.37296719009;4072.083781149218;4102.753834769924;4147.419361289422;4212.368144778277;58534.70732646352;59270.40729592692;59273.40726592765;59424.405755942316;60228.0965785518;9881.558024679167;10003.499825008721;10163.745906352253;10215.897841021644;10493.422861742525;18769;18776.342828000954;18787.24851005972;18826.435206943814;18837.905810471133;6611.371919667624;6628.602283862983;6653.767118150939;6833.077534532874;6948.965255173692;3647.635236476331;3660.139867131222;3698.2418604186078;3720.925581488355;3767.0770661188185;2763.25392144124;2837.233946834343;2846.0892514395196;2856.8285902845896;2860.156253905103;464.1923053886214;474.1252389341659;478.1656010262115;479.5516192360085;482.4668741041169;414.67240879704696;481.2900971067717;503.39843886555946;525.611047824607;530.6815910453697;6902.723891044402;7006.544574602736;7007.404370628554;7132.928670713331;7346.889796653055;422.78250575730493;427.55107137505496;447.51221168926025;474.7222874618387;505.63846849502784;3288.5724855769076;3310.7185889199686;3319.13702437368;3353.1449480382835;3395.4567269237295;50436.24345634819;50710.239346409835;55542;84019.5799021001;90495.54752226197;49265.75367123142;58248.417515825146;71392.64303678449;79991;80813;71159.64420177866;72186.14231647985;73012.26987730055;74118;76588;6416.550841441054;6523.4128928394775;6598.670066496752;6784.660766961731;6934.306569343227;43346;43374;43886.78056609697;44370.55629443664;45287.77356113198;53314;54238;54788;59165.81668366695;59743;9884.209263259067;10146.086852183338;10375.84436233442;10464.581416743245;10767.515461804081;10572.577096916037;11787.469563869476;11820.76358472843;11824.290542567473;12347.75304493923;10249.692509224735;10370.481475926324;10516;10525.578976840841;10689.198310126927;9870.161036311994;10092.495375231356;10133.847992279974;10370.533326000197;10404.58381664725;10737.677869663923;11189.552417903193;11533.826992595286;11576;11577.421128943688;8501.362397820065;8931.240844528027;9174.495402752913;9252.398594091363;9670.70987870365;8666.306695464475;8728.65085396577;9052.909470905206;9133.132352426775;9302.534873256445 11:03:38 INFO - PROCESS | 32737 | __end_tp_report 11:03:38 INFO - PROCESS | 32737 | __start_cc_report 11:03:38 INFO - PROCESS | 32737 | _x_x_mozilla_cycle_collect,993 11:03:38 INFO - PROCESS | 32737 | __end_cc_report 11:03:38 INFO - PROCESS | 32737 | __startTimestamp1469124218580__endTimestamp 11:03:38 INFO - PROCESS | 32737 | 11:03:38 INFO - PROCESS | 32737 | ------- Summary: start ------- 11:03:38 INFO - PROCESS | 32737 | Number of tests: 6 11:03:38 INFO - PROCESS | 32737 | 11:03:38 INFO - PROCESS | 32737 | [#0] dojo.html Cycles:165 Average:4634.09 Median:4740.19 stddev:485.06 (10.2%) stddev-sans-first:458.71 11:03:38 INFO - PROCESS | 32737 | Values: 2569.4 2581.4 2627.8 2638.1 2638.8 4549.8 4640.3 4708.5 4756.1 4769.0 4691.9 4718.3 4726.4 4781.7 4797.1 4211.0 4258.7 4305.0 4358.3 4435.1 4354.7 4380.9 4398.6 4399.5 4416.0 4235.9 4258.2 4278.5 4279.1 4329.2 4232.4 4235.9 4294.0 4355.5 4365.9 4263.4 4267.5 4268.1 4300.0 4313.7 4557.4 4603.6 4672.9 4703.9 4721.0 4909.5 4956.3 4961.9 4976.9 5024.8 4972.0 5012.4 5024.6 5033.5 5036.3 4550.0 4668.2 4675.1 4716.5 4721.0 5137.2 5143.3 5211.8 5216.7 5223.9 4924.9 4958.6 5007.3 5007.4 5008.6 4898.6 4973.3 5043.4 5082.9 5096.6 4981.3 5009.3 5014.3 5033.3 5047.9 4982.7 4997.1 4998.9 5001.7 5044.3 4125.3 4192.0 4258.5 4268.0 4312.6 3690.6 3708.5 3719.6 3731.6 3791.0 4350.7 4351.6 4368.5 4402.0 4412.2 4947.9 5023.0 5028.0 5037.9 5059.3 4311.0 4315.4 4352.3 4364.8 4401.9 4531.6 4564.0 4564.7 4570.2 4610.4 4674.4 4684.5 4686.5 4687.5 4740.2 4849.9 5006.4 5050.5 5065.4 5128.0 4648.2 4648.7 4676.3 4685.8 4717.7 5007.5 5016.3 5019.8 5019.9 5055.6 4913.2 4923.7 4948.4 4964.0 5014.0 4851.2 4853.4 4861.7 4863.1 4902.8 4847.3 4853.2 4857.2 4860.6 4903.4 4721.5 4739.2 4773.7 4782.5 4843.6 4839.5 4882.9 4884.5 4887.9 4926.1 4775.1 4783.5 4783.8 4785.3 4831.7 11:03:38 INFO - PROCESS | 32737 | 11:03:38 INFO - PROCESS | 32737 | [#1] ext.html Cycles:180 Average:46401.18 Median:18262.43 stddev:86131.64 (471.6%) stddev-sans-first:86304.51 11:03:38 INFO - PROCESS | 32737 | Values: 568.1 569.9 572.2 580.1 582.7 27037.5 29741.0 37204.0 38633.2 38756.0 40437.0 40885.4 40912.8 40951.6 40960.8 7648.3 7790.6 7792.1 7793.2 7797.7 7400.6 9700.1 9883.7 9898.4 10228.5 10060.9 10146.3 10149.7 10158.2 10168.4 7417.5 9994.4 10029.1 10041.9 10048.7 9604.1 10009.6 10042.3 10306.3 10380.5 37697.0 38038.2 38049.4 38064.4 38104.4 2844.7 2922.5 3073.1 3422.2 3563.8 28887.3 28953.7 28981.9 29654.4 29796.0 3273.5 3274.9 3313.7 3340.3 3387.6 261817.0 262645.3 262688.0 262788.0 262821.0 31733.8 33111.0 53035.5 53314.2 53469.7 33211.2 33548.5 33651.8 33830.3 33836.5 13014.3 13079.3 13119.9 13130.1 13148.9 9270.2 9343.5 10836.8 10880.1 10901.5 7464.3 7516.1 7795.5 7910.1 7975.0 3022.3 3082.5 3094.3 3130.3 3160.2 935.5 936.7 966.1 977.3 1014.6 27026.4 28370.3 28681.4 28701.0 28789.7 917.7 1014.9 1019.5 1052.4 1084.7 15041.8 15252.8 15301.9 15327.8 15530.5 382981.0 383927.0 385194.0 386215.0 387872.0 49582.3 49884.5 49900.5 49931.0 49937.8 1141.1 1153.7 1186.1 1188.5 1201.8 27557.6 28896.7 29194.7 29389.6 29557.9 40648.4 41318.0 41335.8 41353.6 41358.6 318872.0 319962.2 320890.0 321953.0 322591.0 22971.2 23479.5 24347.5 25026.7 25286.9 39849.2 40292.2 40350.8 40438.0 40591.4 34798.8 34882.8 34922.1 35429.1 35597.3 34881.3 35023.0 35501.0 35597.5 35758.5 33747.1 33860.3 34464.5 34501.8 35026.6 30597.5 32455.5 32689.2 32786.3 32843.8 23793.9 24440.5 24578.3 24642.9 24738.1 11:03:38 INFO - PROCESS | 32737 | 11:03:38 INFO - PROCESS | 32737 | [#2] jquery.html Cycles:180 Average:22271.04 Median:5043.22 stddev:54630.35 (1083.2%) stddev-sans-first:54758.79 11:03:38 INFO - PROCESS | 32737 | Values: 341.3 359.1 369.2 369.7 386.9 12404.4 15952.8 16258.7 17373.1 17394.1 16428.8 16882.9 16984.9 17100.5 17210.7 4774.3 4803.3 5008.4 5035.5 5038.3 3685.6 4970.3 5048.1 5442.9 5726.3 5749.3 5755.2 5767.7 5770.0 5774.7 5620.2 5751.6 5830.0 5869.1 5877.3 5183.2 5191.2 5192.1 5194.4 5198.4 19863.5 20464.9 20478.6 20504.8 20533.4 1917.4 1931.5 2084.0 2365.4 2470.8 13093.9 13227.2 13351.4 13581.5 13670.3 1732.7 1784.4 1791.4 1813.3 1854.2 45489.0 46843.5 67657.0 67803.0 69314.3 8200.8 8612.3 8657.0 8673.2 9010.3 13104.6 13133.9 13134.7 13137.6 13156.9 7112.8 7153.8 7243.7 7321.6 7364.0 6816.9 6842.2 6842.7 7024.2 7025.7 6016.2 6026.5 6038.5 6062.8 6096.6 1744.5 1745.2 1765.5 1777.1 1777.8 833.1 850.7 852.5 877.2 961.4 16793.1 17081.9 17419.2 17534.9 17859.0 843.0 861.8 869.4 908.0 925.8 9537.5 10051.3 10064.6 10091.6 10159.5 268867.0 269724.0 270747.0 385283.0 411912.0 78192.2 80302.0 80726.0 82111.6 82269.0 805.0 835.3 839.9 840.6 879.4 14616.1 15661.0 16142.7 16342.3 16424.1 37546.4 38134.5 39341.4 39714.6 40174.8 52057.7 52553.7 53181.5 53982.5 54696.7 7492.0 7537.7 7581.2 7607.0 7909.4 6286.8 7220.9 8706.7 10793.4 12274.2 9471.4 9554.7 9738.7 9830.1 10561.2 4482.1 7746.5 7895.4 9758.6 10027.9 10104.2 10134.9 10258.4 10371.3 10683.7 6446.2 6768.6 6777.6 6953.7 7095.9 7703.7 9157.6 10031.8 10044.4 10184.1 11:03:38 INFO - PROCESS | 32737 | 11:03:38 INFO - PROCESS | 32737 | [#3] mootools.html Cycles:180 Average:5216.45 Median:4806.36 stddev:3018.41 (62.8%) stddev-sans-first:3012.37 11:03:38 INFO - PROCESS | 32737 | Values: 1278.1 1359.1 1417.9 1455.3 1700.6 6595.4 7603.3 7829.5 7836.8 8099.4 7947.0 7997.4 8011.1 8014.0 8024.5 2125.1 2148.8 2150.1 2150.6 2152.4 2176.4 2219.1 2227.9 2229.1 2229.5 2126.8 2150.4 2156.2 2157.6 2162.9 2151.9 2154.8 2159.2 2161.0 2162.2 2097.2 2132.4 2135.3 2136.7 2138.3 7974.8 7976.2 7997.4 8039.5 8053.6 4585.2 4765.0 4792.9 4796.1 4806.8 2848.6 2951.1 2991.3 3005.1 3018.0 841.1 852.6 865.7 865.8 868.0 10946.9 11023.1 11032.4 11060.2 11078.3 3877.9 4076.8 4187.2 4227.8 4230.7 8630.9 8635.7 8648.2 8655.9 8656.1 4549.6 4555.4 4555.4 4556.9 4559.7 3699.2 4148.5 4238.6 4239.8 4306.1 3337.6 3383.7 3457.8 3462.5 3607.5 986.7 993.9 998.9 1004.7 1007.2 672.4 805.7 812.5 839.0 839.7 5177.8 5323.4 5325.3 5358.9 5498.5 355.0 367.4 367.5 368.4 369.7 3472.4 3532.5 3612.5 3729.1 3819.3 9658.9 10154.9 10226.5 10235.8 10239.9 9142.5 9368.9 10066.9 10126.7 10143.3 7325.0 7487.1 7509.4 7512.6 7532.0 5542.3 5573.9 5706.0 5710.2 5842.0 9375.0 9396.2 9444.8 9494.1 9502.4 9279.7 9397.8 9601.0 9607.4 9683.4 5974.4 6846.0 6993.9 7146.2 7161.6 7644.5 7832.5 7919.8 7933.0 7937.3 6933.8 6946.4 7015.9 7039.2 7206.4 6818.9 6839.1 6850.3 6886.4 6930.7 6401.4 6405.5 6411.9 6481.0 6481.3 4276.2 4442.0 4635.8 4800.9 4810.0 4533.9 4713.2 4805.4 4805.9 4893.6 11:03:38 INFO - PROCESS | 32737 | 11:03:38 INFO - PROCESS | 32737 | [#4] prototype.html Cycles:180 Average:3994.76 Median:4249.01 stddev:1148.64 (27.0%) stddev-sans-first:1117.74 11:03:38 INFO - PROCESS | 32737 | Values: 292.6 298.9 304.8 308.0 310.2 4575.5 4690.9 4740.5 4812.1 4825.6 4343.7 4636.7 4712.0 4722.9 4740.4 3760.7 3765.4 3770.0 3771.3 3771.5 3782.3 3787.1 3792.8 3812.4 3820.9 3555.2 3601.5 3723.0 3733.2 3737.7 3725.4 3732.7 3741.4 3750.5 3752.1 3320.8 3339.4 3349.7 3351.6 3363.3 4444.6 4641.9 4652.2 4686.6 4692.7 4197.0 4203.1 4212.9 4221.2 4226.8 4958.2 4959.0 4966.5 4971.4 4983.2 3551.5 3553.3 3558.1 3564.6 3572.8 4893.6 4958.2 5006.1 5159.6 5203.3 3559.6 3584.7 3588.0 3590.1 3603.6 3656.8 3667.5 3669.4 3671.9 3673.7 4186.5 4193.9 4208.4 4214.1 4218.7 4827.3 4932.9 4962.5 4962.6 5032.5 1239.5 1255.5 1257.3 1257.3 1257.7 786.4 806.8 818.1 830.5 832.1 3980.2 3981.4 3988.2 3994.9 4000.3 4456.6 4507.8 4527.2 4543.0 4564.4 3989.3 3993.5 4001.6 4015.3 4034.6 2307.8 2406.6 2439.2 2447.6 2482.8 4233.9 4238.5 4254.6 4278.4 4281.8 4551.8 4620.0 4630.7 4638.4 4666.7 4046.4 4060.1 4223.2 4234.7 4243.4 4527.7 4538.8 4542.6 4544.1 4592.0 4441.7 4489.8 4491.2 4514.4 4514.6 4168.4 4183.9 4208.2 4242.9 4538.8 3554.3 3570.4 3582.1 3584.2 3611.0 5100.0 5159.9 5179.4 5183.6 5184.2 5012.0 5028.1 5033.0 5035.6 5054.3 4767.7 5012.7 5039.2 5043.6 5047.2 4855.3 4905.1 4969.2 4970.9 4971.2 4973.4 5010.9 5041.8 5100.1 5114.2 4907.5 4923.1 4931.5 4941.6 4944.2 11:03:38 INFO - PROCESS | 32737 | 11:03:38 INFO - PROCESS | 32737 | [#5] yui.html Cycles:180 Average:15894.07 Median:480.42 stddev:21536.38 (4482.8%) stddev-sans-first:21566.19 11:03:38 INFO - PROCESS | 32737 | Values: 603.2 622.2 685.2 703.4 711.9 11926.6 13384.1 13517.5 13521.1 13539.8 13231.7 13407.4 13408.9 13412.1 13428.0 627.2 635.3 765.0 784.9 787.1 756.2 783.7 787.6 793.9 794.0 823.3 825.4 826.0 826.4 826.4 657.2 819.0 819.1 819.2 820.5 577.2 591.6 594.4 599.9 600.6 12842.0 12849.9 12853.5 12877.4 12879.7 11865.0 12553.3 12563.5 12880.6 13160.0 11434.1 11553.5 11619.4 11687.2 12102.2 4045.4 4072.1 4102.8 4147.4 4212.4 58534.7 59270.4 59273.4 59424.4 60228.1 9881.6 10003.5 10163.7 10215.9 10493.4 18769.0 18776.3 18787.2 18826.4 18837.9 6611.4 6628.6 6653.8 6833.1 6949.0 3647.6 3660.1 3698.2 3720.9 3767.1 2763.3 2837.2 2846.1 2856.8 2860.2 464.2 474.1 478.2 479.6 482.5 414.7 481.3 503.4 525.6 530.7 6902.7 7006.5 7007.4 7132.9 7346.9 422.8 427.6 447.5 474.7 505.6 3288.6 3310.7 3319.1 3353.1 3395.5 50436.2 50710.2 55542.0 84019.6 90495.5 49265.8 58248.4 71392.6 79991.0 80813.0 71159.6 72186.1 73012.3 74118.0 76588.0 6416.6 6523.4 6598.7 6784.7 6934.3 43346.0 43374.0 43886.8 44370.6 45287.8 53314.0 54238.0 54788.0 59165.8 59743.0 9884.2 10146.1 10375.8 10464.6 10767.5 10572.6 11787.5 11820.8 11824.3 12347.8 10249.7 10370.5 10516.0 10525.6 10689.2 9870.2 10092.5 10133.8 10370.5 10404.6 10737.7 11189.6 11533.8 11576.0 11577.4 8501.4 8931.2 9174.5 9252.4 9670.7 8666.3 8728.7 9052.9 9133.1 9302.5 11:03:38 INFO - PROCESS | 32737 | -------- Summary: end -------- 11:03:38 INFO - PROCESS | 32737 | 11:03:39 INFO - TEST-INFO | 32737: exit 0 11:03:39 INFO - TEST-OK | dromaeo_css | took 1121432ms 11:03:39 INFO - TEST-START | kraken 11:03:39 INFO - operating with platform_type : linux_ 11:03:39 INFO - Initialising browser for kraken test... 11:03:39 INFO - TEST-INFO | started process 456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcPZydd/profile http://localhost:60146/getInfo.html) 11:03:43 INFO - PROCESS | 456 | JavaScript error: , line 0: uncaught exception: undefined 11:03:44 INFO - PROCESS | 456 | __metrics Screen width/height:1600/1200 11:03:44 INFO - PROCESS | 456 | colorDepth:24 11:03:44 INFO - PROCESS | 456 | Browser inner width/height: 1024/697 11:03:44 INFO - PROCESS | 456 | __metrics 11:03:45 INFO - PROCESS | 456 | 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" 11:03:45 INFO - PROCESS | 456 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:03:46 INFO - TEST-INFO | 456: exit 0 11:03:46 INFO - Browser initialized. 11:03:46 INFO - Running cycle 1/1 for kraken test... 11:03:46 INFO - TEST-INFO | started process 539 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcPZydd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:03:58 INFO - PROCESS | 539 | RSS: Main: 159375360 11:03:58 INFO - PROCESS | 539 | 11:04:00 INFO - PROCESS | 539 | Cycle 1(1): loaded http://localhost:60146/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60146/tests/kraken/driver.html?testName=audio-beat-detection) 11:04:01 INFO - PROCESS | 539 | RSS: Main: 215506944 11:04:01 INFO - PROCESS | 539 | 11:04:04 INFO - PROCESS | 539 | Cycle 1(1): loaded http://localhost:60146/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60146/tests/kraken/driver.html?testName=audio-dft) 11:04:05 INFO - PROCESS | 539 | RSS: Main: 194510848 11:04:05 INFO - PROCESS | 539 | 11:04:08 INFO - PROCESS | 539 | Cycle 1(1): loaded http://localhost:60146/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60146/tests/kraken/driver.html?testName=audio-fft) 11:04:09 INFO - PROCESS | 539 | RSS: Main: 273719296 11:04:09 INFO - PROCESS | 539 | 11:04:11 INFO - PROCESS | 539 | Cycle 1(1): loaded http://localhost:60146/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60146/tests/kraken/driver.html?testName=audio-oscillator) 11:04:11 INFO - PROCESS | 539 | RSS: Main: 182648832 11:04:11 INFO - PROCESS | 539 | 11:04:14 INFO - PROCESS | 539 | Cycle 1(1): loaded http://localhost:60146/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60146/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:04:14 INFO - PROCESS | 539 | RSS: Main: 186576896 11:04:14 INFO - PROCESS | 539 | 11:04:17 INFO - PROCESS | 539 | Cycle 1(1): loaded http://localhost:60146/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60146/tests/kraken/driver.html?testName=imaging-darkroom) 11:04:18 INFO - PROCESS | 539 | RSS: Main: 222949376 11:04:18 INFO - PROCESS | 539 | 11:04:21 INFO - PROCESS | 539 | Cycle 1(1): loaded http://localhost:60146/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60146/tests/kraken/driver.html?testName=imaging-desaturate) 11:04:22 INFO - PROCESS | 539 | RSS: Main: 216702976 11:04:22 INFO - PROCESS | 539 | 11:04:25 INFO - PROCESS | 539 | Cycle 1(1): loaded http://localhost:60146/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60146/tests/kraken/driver.html?testName=json-parse-financial) 11:04:26 INFO - PROCESS | 539 | RSS: Main: 220524544 11:04:26 INFO - PROCESS | 539 | 11:04:27 INFO - PROCESS | 539 | Cycle 1(1): loaded http://localhost:60146/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60146/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:04:28 INFO - PROCESS | 539 | RSS: Main: 185995264 11:04:28 INFO - PROCESS | 539 | 11:04:30 INFO - PROCESS | 539 | Cycle 1(1): loaded http://localhost:60146/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60146/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:04:30 INFO - PROCESS | 539 | RSS: Main: 191709184 11:04:30 INFO - PROCESS | 539 | 11:04:32 INFO - PROCESS | 539 | Cycle 1(1): loaded http://localhost:60146/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60146/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:04:33 INFO - PROCESS | 539 | RSS: Main: 196005888 11:04:33 INFO - PROCESS | 539 | 11:04:36 INFO - PROCESS | 539 | Cycle 1(1): loaded http://localhost:60146/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60146/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:04:37 INFO - PROCESS | 539 | RSS: Main: 191807488 11:04:37 INFO - PROCESS | 539 | 11:04:39 INFO - PROCESS | 539 | Cycle 1(1): loaded http://localhost:60146/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60146/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:04:40 INFO - PROCESS | 539 | RSS: Main: 194412544 11:04:40 INFO - PROCESS | 539 | 11:04:42 INFO - PROCESS | 539 | Cycle 1(1): loaded http://localhost:60146/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60146/tests/kraken/driver.html?testName=ai-astar) 11:04:42 INFO - PROCESS | 539 | RSS: Main: 244359168 11:04:42 INFO - PROCESS | 539 | 11:04:42 INFO - PROCESS | 539 | __start_tp_report 11:04:42 INFO - PROCESS | 539 | _x_x_mozilla_page_load 11:04:42 INFO - PROCESS | 539 | _x_x_mozilla_page_load_details 11:04:42 INFO - PROCESS | 539 | |i|pagename|runs| 11:04:42 INFO - PROCESS | 539 | |0;ai-astar;106;116;113;112;111;112;114;110;113;112 11:04:42 INFO - PROCESS | 539 | |1;audio-beat-detection;146;121;126;184;124;125;147;123;191;122 11:04:42 INFO - PROCESS | 539 | |2;audio-dft;161;161;162;162;160;162;161;163;169;160 11:04:42 INFO - PROCESS | 539 | |3;audio-fft;76;78;77;124;76;78;76;77;99;75 11:04:42 INFO - PROCESS | 539 | |4;audio-oscillator;84;86;121;84;85;87;132;85;85;134 11:04:42 INFO - PROCESS | 539 | |5;imaging-gaussian-blur;117;117;117;116;116;116;116;117;116;117 11:04:42 INFO - PROCESS | 539 | |6;imaging-darkroom;147;146;147;148;146;147;146;148;146;146 11:04:42 INFO - PROCESS | 539 | |7;imaging-desaturate;95;94;96;94;95;95;95;95;94;95 11:04:42 INFO - PROCESS | 539 | |8;json-parse-financial;62;68;61;62;61;62;63;61;61;61 11:04:42 INFO - PROCESS | 539 | |9;json-stringify-tinderbox;66;67;66;66;67;65;67;65;66;66 11:04:42 INFO - PROCESS | 539 | |10;stanford-crypto-aes;82;85;79;80;79;79;93;79;78;78 11:04:42 INFO - PROCESS | 539 | |11;stanford-crypto-ccm;139;133;140;137;141;138;128;130;184;137 11:04:42 INFO - PROCESS | 539 | |12;stanford-crypto-pbkdf2;163;171;167;163;166;170;164;163;161;160 11:04:42 INFO - PROCESS | 539 | |13;stanford-crypto-sha256-iterative;66;69;66;67;66;74;66;67;67;65 11:04:42 INFO - PROCESS | 539 | __end_tp_report 11:04:42 INFO - PROCESS | 539 | __start_cc_report 11:04:42 INFO - PROCESS | 539 | _x_x_mozilla_cycle_collect,1933 11:04:42 INFO - PROCESS | 539 | __end_cc_report 11:04:42 INFO - PROCESS | 539 | __startTimestamp1469124282592__endTimestamp 11:04:42 INFO - PROCESS | 539 | 11:04:42 INFO - PROCESS | 539 | ------- Summary: start ------- 11:04:42 INFO - PROCESS | 539 | Number of tests: 14 11:04:42 INFO - PROCESS | 539 | 11:04:42 INFO - PROCESS | 539 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.50 stddev:2.64 (2.3%) stddev-sans-first:1.74 11:04:42 INFO - PROCESS | 539 | Values: 106.0 116.0 113.0 112.0 111.0 112.0 114.0 110.0 113.0 112.0 11:04:42 INFO - PROCESS | 539 | 11:04:42 INFO - PROCESS | 539 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:136.00 stddev:26.38 (19.4%) stddev-sans-first:27.92 11:04:42 INFO - PROCESS | 539 | Values: 146.0 121.0 126.0 184.0 124.0 125.0 147.0 123.0 191.0 122.0 11:04:42 INFO - PROCESS | 539 | 11:04:42 INFO - PROCESS | 539 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:2.60 (1.6%) stddev-sans-first:2.73 11:04:42 INFO - PROCESS | 539 | Values: 161.0 161.0 162.0 162.0 160.0 162.0 161.0 163.0 169.0 160.0 11:04:42 INFO - PROCESS | 539 | 11:04:42 INFO - PROCESS | 539 | [#3] audio-fft Cycles:10 Average:83.60 Median:77.00 stddev:15.87 (20.6%) stddev-sans-first:16.59 11:04:42 INFO - PROCESS | 539 | Values: 76.0 78.0 77.0 124.0 76.0 78.0 76.0 77.0 99.0 75.0 11:04:42 INFO - PROCESS | 539 | 11:04:42 INFO - PROCESS | 539 | [#4] audio-oscillator Cycles:10 Average:98.30 Median:85.00 stddev:21.46 (25.2%) stddev-sans-first:22.13 11:04:42 INFO - PROCESS | 539 | Values: 84.0 86.0 121.0 84.0 85.0 87.0 132.0 85.0 85.0 134.0 11:04:42 INFO - PROCESS | 539 | 11:04:42 INFO - PROCESS | 539 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 11:04:42 INFO - PROCESS | 539 | Values: 117.0 117.0 117.0 116.0 116.0 116.0 116.0 117.0 116.0 117.0 11:04:42 INFO - PROCESS | 539 | 11:04:42 INFO - PROCESS | 539 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 11:04:42 INFO - PROCESS | 539 | Values: 147.0 146.0 147.0 148.0 146.0 147.0 146.0 148.0 146.0 146.0 11:04:42 INFO - PROCESS | 539 | 11:04:42 INFO - PROCESS | 539 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 11:04:42 INFO - PROCESS | 539 | Values: 95.0 94.0 96.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 11:04:42 INFO - PROCESS | 539 | 11:04:42 INFO - PROCESS | 539 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:62.00 stddev:2.15 (3.5%) stddev-sans-first:2.28 11:04:42 INFO - PROCESS | 539 | Values: 62.0 68.0 61.0 62.0 61.0 62.0 63.0 61.0 61.0 61.0 11:04:42 INFO - PROCESS | 539 | 11:04:42 INFO - PROCESS | 539 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 11:04:42 INFO - PROCESS | 539 | Values: 66.0 67.0 66.0 66.0 67.0 65.0 67.0 65.0 66.0 66.0 11:04:42 INFO - PROCESS | 539 | 11:04:42 INFO - PROCESS | 539 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:79.50 stddev:4.66 (5.9%) stddev-sans-first:4.94 11:04:42 INFO - PROCESS | 539 | Values: 82.0 85.0 79.0 80.0 79.0 79.0 93.0 79.0 78.0 78.0 11:04:42 INFO - PROCESS | 539 | 11:04:42 INFO - PROCESS | 539 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:138.50 stddev:15.80 (11.4%) stddev-sans-first:16.75 11:04:42 INFO - PROCESS | 539 | Values: 139.0 133.0 140.0 137.0 141.0 138.0 128.0 130.0 184.0 137.0 11:04:42 INFO - PROCESS | 539 | 11:04:42 INFO - PROCESS | 539 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.80 Median:165.00 stddev:3.65 (2.2%) stddev-sans-first:3.81 11:04:42 INFO - PROCESS | 539 | Values: 163.0 171.0 167.0 163.0 166.0 170.0 164.0 163.0 161.0 160.0 11:04:42 INFO - PROCESS | 539 | 11:04:42 INFO - PROCESS | 539 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:2.58 (3.9%) stddev-sans-first:2.70 11:04:42 INFO - PROCESS | 539 | Values: 66.0 69.0 66.0 67.0 66.0 74.0 66.0 67.0 67.0 65.0 11:04:42 INFO - PROCESS | 539 | -------- Summary: end -------- 11:04:42 INFO - PROCESS | 539 | 11:04:43 INFO - TEST-INFO | 539: exit 0 11:04:43 INFO - TEST-OK | kraken | took 64266ms 11:04:43 INFO - SUITE-END | took 1185s 11:04:43 INFO - Completed test suite (00:19:45) 11:04:43 INFO - javascript benchmark 11:04:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2569.3705042264646, 2581.4191806843455, 2627.750363715447, 2638.1030449647114, 2638.802089843261, 4549.795259213335, 4640.327152562885, 4708.4820669726305, 4756.09634169508, 4769.046190761844, 4691.88270293242, 4718.268668356411, 4726.409198850144, 4781.689190202643, 4797.0645724083815, 4210.957890421102, 4258.723182993095, 4305.031367942203, 4358.324459708734, 4435.090806384684, 4354.651627869779, 4380.934285985712, 4398.560143985592, 4399.5160532341415, 4415.955840441603, 4235.8729238122905, 4258.233517966764, 4278.529361770203, 4279.1013887083745, 4329.220740266751, 4232.407462955189, 4235.894102647428, 4294.012377153273, 4355.542668019844, 4365.912681746379, 4263.424437700902, 4267.466566679165, 4268.0823622921225, 4300.010997470568, 4313.654907607384, 4557.430321209848, 4603.631709463235, 4672.929906051412, 4703.882402939954, 4720.976395118037, 4909.533594308535, 4956.306117143603, 4961.875953101166, 4976.850694479135, 5024.84925452237, 4972.005598880239, 5012.373453318335, 5024.648274620778, 5033.471485494007, 5036.320096786923, 4550.0, 4668.2064049111395, 4675.13510000651, 4716.481187069419, 4721.0, 5137.152369859006, 5143.27994080829, 5211.791528338824, 5216.739163041832, 5223.869403264873, 4924.901501969941, 4958.628102892298, 5007.349044624249, 5007.39911210657, 5008.624353173526, 4898.559129678346, 4973.303737476756, 5043.394792624835, 5082.898342033139, 5096.566791822736, 4981.3026176334615, 5009.348784657971, 5014.323066386064, 5033.345665063592, 5047.87380315495, 4982.651214415028, 4997.125503036954, 4998.850034498971, 5001.724905130252, 5044.344235249394, 4125.29869922114, 4192.0, 4258.488981322261, 4267.97866010668, 4312.5903039211225, 3690.5755838078426, 3708.517892673935, 3719.590845007047, 3731.570869350005, 3791.0, 4350.6736994725525, 4351.6083552479795, 4368.5194628590825, 4402.031553058322, 4412.227860124465, 4947.925781113287, 5022.974885125551, 5027.974860125676, 5037.899242015139, 5059.2916991621205, 4311.0300182458695, 4315.417418648505, 4352.347147927773, 4364.75993820343, 4401.933970990438, 4531.56950089741, 4563.95436045642, 4564.680472366969, 4570.223062079454, 4610.4467463903875, 4674.368960190399, 4684.50812664679, 4686.531346865422, 4687.48437671849, 4740.194166991689, 4849.903001940012, 5006.449290578106, 5050.49495050492, 5065.366829146356, 5127.974360128175, 4648.2330415481065, 4648.721076735406, 4676.298555216608, 4685.835995740133, 4717.693349932243, 5007.524285192901, 5016.297718319365, 5019.84940451787, 5019.899602008012, 5055.620828437808, 4913.1893237615395, 4923.655344125877, 4948.406191257072, 4963.975180124076, 5014.0, 4851.151048566416, 4853.417589889094, 4861.6596838220985, 4863.076015557032, 4902.779374928065, 4847.2729090636685, 4853.247746599282, 4857.247126695368, 4860.586850117779, 4903.362562866804, 4721.480637129845, 4739.241721324572, 4773.689710168828, 4782.52174782519, 4843.6367272454, 4839.516048395273, 4882.853514394574, 4884.462709102067, 4887.877803054952, 4926.088673595396, 4775.092732380976, 4783.4738178801, 4783.760811959319, 4785.282207668738, 4831.73425461603], "value": 4603.071176898632, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.1335962656945, 569.923060386848, 572.2360648534207, 580.0892598620168, 582.7377680043978, 27037.459250814998, 29741.0, 37204.0, 38633.22733545327, 38756.0, 40437.0, 40885.364585416544, 40912.79543602278, 40951.59048409515, 40960.79519602398, 7648.311651951323, 7790.571518566477, 7792.142864284924, 7793.22067793219, 7797.727079552217, 7400.592967386791, 9700.126988571028, 9883.703488895344, 9898.356606820533, 10228.48857557123, 10060.899391006105, 10146.325856233712, 10149.695509134737, 10158.238132140083, 10168.44073575953, 7417.51786133905, 9994.350367226143, 10029.097381235651, 10041.899581004243, 10048.69853904384, 9604.135627793532, 10009.59961601535, 10042.297039207258, 10306.330088544295, 10380.480975951172, 37697.0, 38038.239235215144, 38049.42925856114, 38064.42903356452, 38104.42843357352, 2844.7013063628433, 2922.473954688155, 3073.0627158716584, 3422.19578399076, 3563.821808909544, 28887.277818054506, 28953.710462895313, 28981.85509072462, 29654.406911861643, 29796.0, 3273.508973653947, 3274.9345013099605, 3313.685199906005, 3340.2985373071683, 3387.61042480113, 261817.0, 262645.30160237866, 262688.0, 262788.0, 262821.0, 31733.8413307932, 33111.0, 53035.469645303056, 53314.20028699573, 53469.7326513365, 33211.16972075669, 33548.49677254843, 33651.83174084114, 33830.323393531995, 33836.49245261323, 13014.284214368301, 13079.346032698328, 13119.868801311864, 13130.080894337305, 13148.868511314955, 9270.212031977357, 9343.486108264111, 10836.837447438294, 10880.075193608633, 10901.509432075576, 7464.253574642492, 7516.098068231738, 7795.532268063935, 7910.129885712567, 7975.003124609424, 3022.30486987994, 3082.460569400346, 3094.257378229209, 3130.2800355918266, 3160.2099475131217, 935.4948327902993, 936.7096200177966, 966.1160038564775, 977.3061126600194, 1014.5586669798661, 27026.351442555395, 28370.2907427316, 28681.426371472455, 28701.0, 28789.712102878704, 917.7430319510547, 1014.9086582207636, 1019.50553981319, 1052.4001319247955, 1084.6854412220525, 15041.774373384407, 15252.847471525365, 15301.923490382476, 15327.770083448757, 15530.534083977498, 382981.0, 383927.0, 385194.0, 386215.0, 387872.0, 49582.25626615604, 49884.50115498871, 49900.50099498958, 49931.0, 49937.75031124821, 1141.1099342512853, 1153.653903828848, 1186.0748616079472, 1188.5084219304717, 1201.819727040951, 27557.58663620007, 28896.7110328894, 29194.7080529192, 29389.56604102777, 29557.85221073881, 40648.39027414532, 41318.0, 41335.793321033205, 41353.586464134976, 41358.58641413668, 318872.0, 319962.20245684887, 320890.0, 321953.0, 322591.0, 22971.196008139636, 23479.530409392057, 24347.51304973855, 25026.74973250244, 25286.873565632053, 39849.2030159401, 40292.1941561173, 40350.798246008584, 40438.0, 40591.3911291325, 34798.82600586981, 34882.825585872924, 34922.12694682653, 35429.1142721434, 35597.28805423929, 34881.30237395289, 35023.0, 35501.0, 35597.46603800893, 35758.4636230462, 33747.131493822315, 33860.32279354448, 34464.48303275503, 34501.827490862386, 35026.64973350234, 30597.54103688402, 32455.513167302983, 32689.18277043093, 32786.34427311488, 32843.83578082094, 23793.881030594737, 24440.51118977575, 24578.34913386594, 24642.876785615957, 24738.134165304127], "value": 16693.76600653189, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.26116956788553, 359.0789624612866, 369.20804873546246, 369.73748638466685, 386.8587965392631, 12404.379781010946, 15952.760708589365, 16258.674826503462, 17373.13134343284, 17394.130293485337, 16428.83571164288, 16882.915585422088, 16984.915075424637, 17100.486985390457, 17210.741838872425, 4774.28385742138, 4803.279508073782, 5008.4240312364, 5035.496450354972, 5038.345015148026, 3685.63143685632, 4970.254461830737, 5048.091343558158, 5442.8842087371995, 5726.284214473191, 5749.281339832521, 5755.223044888929, 5767.682777447239, 5770.04794208955, 5774.6535207887455, 5620.185073164389, 5751.597388182829, 5830.0, 5869.1196320551835, 5877.265341832271, 5183.196604526304, 5191.22131680251, 5192.1432963560965, 5194.428612852583, 5198.428172900978, 19863.503412414662, 20464.897675511675, 20478.590428191503, 20504.794952050437, 20533.38399848007, 1917.3768525229216, 1931.5364312565023, 2083.9996801535194, 2365.44412063165, 2470.7899828514596, 13093.934530327288, 13227.206367617877, 13351.399187036606, 13581.456741730319, 13670.316484175752, 1732.7400889866494, 1784.4379020608467, 1791.3730194431844, 1813.2565648084221, 1854.165625468531, 45489.0, 46843.53156468426, 67657.0, 67803.0, 69314.3068569318, 8200.753977380688, 8612.311015118776, 8657.0, 8673.176048275403, 9010.27917766577, 13104.606861794162, 13133.868661313456, 13134.73730525384, 13137.60587182386, 13156.868431315565, 7112.822179445555, 7153.785386438415, 7243.74646887367, 7321.560706357635, 7364.0426744522865, 6816.863662726718, 6842.247352791189, 6842.692078856364, 7024.192217894905, 7025.683844227022, 6016.157737916695, 6026.5178785697035, 6038.516918646497, 6062.757489700362, 6096.573239873255, 1744.4853768138175, 1745.2059313012549, 1765.496833402474, 1777.146969454669, 1777.7688900442859, 833.0877688930611, 850.6852464588142, 852.5311078906576, 877.1929824561419, 961.4375590279765, 16793.07638079917, 17081.914590427215, 17419.216135273942, 17534.912325438545, 17859.0, 842.9704960326359, 861.7974775927652, 869.3610196505564, 907.981840363189, 925.8472352061834, 9537.475438850792, 10051.346662466916, 10064.597416103421, 10091.596336146471, 10159.476078588123, 268867.0, 269724.0, 270747.0, 385283.0, 411912.0, 78192.21807781963, 80302.0, 80726.0, 82111.58944205241, 82269.0, 805.0379796143552, 835.2941764209233, 839.9370047246481, 840.6259214649423, 879.4415546128382, 14616.123032618078, 15661.0, 16142.67714645724, 16342.346306147621, 16424.09667468253, 37546.436803448516, 38134.455375370155, 39341.40987885127, 39714.60285397109, 40174.79912600418, 52057.7397113012, 52553.7372313136, 53181.4681853192, 53982.46017539931, 54696.72651636716, 7492.0, 7537.6984920604755, 7581.166071731995, 7607.049118860143, 7909.367250619822, 6286.842828929313, 7220.927790722236, 8706.736248575542, 10793.352398856094, 12274.202176858476, 9471.384360016576, 9554.665586704432, 9738.659146929824, 9830.115289623967, 10561.155107591529, 4482.148391805546, 7746.49647772893, 7895.447318687637, 9758.56086476096, 10027.949860250652, 10104.242181836245, 10134.898651013396, 10258.43578603184, 10371.27401081917, 10683.732906677395, 6446.161998940295, 6768.612434450827, 6777.6272305023695, 6953.721851125898, 7095.929040709527, 7703.653335600024, 9157.626356046647, 10031.849522257318, 10044.397336159855, 10184.134348580157], "value": 8116.0589880778825, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1278.1436437586829, 1359.069037709169, 1417.8653027962343, 1455.257818512559, 1700.5833570775155, 6595.373439523243, 7603.315701586856, 7829.45193836431, 7836.804079897991, 8099.433039687225, 7947.046354437462, 7997.400194985385, 8011.078725946518, 8014.038315402146, 8024.478408903417, 2125.0543508138885, 2148.8495805293637, 2150.1077053023055, 2150.5698860228017, 2152.397328747953, 2176.3906106290183, 2219.101263988079, 2227.866328020316, 2229.108356657342, 2229.5317983223545, 2126.840486963476, 2150.365642135566, 2156.202205184084, 2157.622416077188, 2162.8810415427147, 2151.8601290916117, 2154.8168405685537, 2159.222679835258, 2160.9567808643737, 2162.23240749534, 2097.1925808563815, 2132.3602919124355, 2135.263334149716, 2136.7329083864515, 2138.315738963532, 7974.760757177294, 7976.162502937166, 7997.440179187459, 8039.477433966774, 8053.557054362008, 4585.220512512881, 4764.976175119137, 4792.856214313576, 4796.112719146934, 4806.831760888387, 2848.5869548915293, 2951.140781307762, 2991.2671395508023, 3005.0984704588536, 3018.0493144659363, 841.1336323586654, 852.6120615120168, 865.6537385045968, 865.7619154732436, 867.9826403471958, 10946.890531094667, 11023.06303964164, 11032.393218372987, 11060.17048721341, 11078.279911805626, 3877.86427475037, 4076.8369265229653, 4187.24629566681, 4227.8097485613225, 4230.746155230696, 8630.870536941951, 8635.740927772176, 8648.221660050625, 8655.913440865637, 8656.134386561294, 4549.613282870927, 4555.385023021916, 4555.40779698637, 4556.931646025312, 4559.703619264737, 3699.1861790406606, 4148.502179738391, 4238.576142385737, 4239.788010599519, 4306.1172459645695, 3337.599488061448, 3383.6616338365966, 3457.844397002141, 3462.5325581046236, 3607.5129857469433, 986.6941248213077, 993.8757655293089, 998.9200863930868, 1004.6634377483479, 1007.2043085962155, 672.3511811102212, 805.7260531419346, 812.4881324765478, 838.9622466989, 839.7102999465175, 5177.844664660066, 5323.441038690959, 5325.254464374991, 5358.892822143535, 5498.532624726863, 355.0, 367.4359857618543, 367.54424513603476, 368.4050258831967, 369.6857670979646, 3472.4444088945647, 3532.4701294805473, 3612.512310838056, 3729.1422972715886, 3819.331616967075, 9658.90341096594, 10154.898451015542, 10226.53980570876, 10235.795284094425, 10239.948800255952, 9142.451452912846, 9368.859467107999, 10066.899331006596, 10126.746831329276, 10143.340682855738, 7325.0, 7487.064116985377, 7509.4367922404945, 7512.6243687815395, 7531.962340188264, 5542.2795036644975, 5573.860653483695, 5706.0, 5710.17202505626, 5841.970790146022, 9374.953125234602, 9396.154346108882, 9444.763880902758, 9494.145526902612, 9502.429854208769, 9279.72160835176, 9397.812043759222, 9600.951995239979, 9607.423554586747, 9683.3705809125, 5974.40255974399, 6846.007328937177, 6993.860122797617, 7146.249643787328, 7161.606111663908, 7644.50310729823, 7832.530048197126, 7919.841603167789, 7933.048034235929, 7937.285644292041, 6933.757318493828, 6946.44428445713, 7015.859682806417, 7039.1553013638695, 7206.351428371472, 6818.8636227276165, 6839.110915580943, 6850.280720524473, 6886.380225779503, 6930.7227710891, 6401.391867772554, 6405.455536279468, 6411.871762564816, 6480.967595162183, 6481.287058423664, 4276.166147601188, 4441.955580444154, 4635.814567417266, 4800.927986080142, 4809.975950120227, 4533.866533366659, 4713.2458806590785, 4805.37530121082, 4805.879853003703, 4893.608511319015], "value": 4056.359012526639, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.59621722023604, 298.9387175628996, 304.7744668944981, 308.0312417447129, 310.1563746609222, 4575.535828534862, 4690.921088149727, 4740.525947405258, 4812.109759694455, 4825.565699087081, 4343.717658352205, 4636.744979026153, 4711.976440117804, 4722.8583142505695, 4740.407449068866, 3760.699144068468, 3765.4163604641326, 3769.9623003769884, 3771.264603402338, 3771.4531392948006, 3782.3191825471404, 3787.110029143149, 3792.8103594820286, 3812.4090765931323, 3820.872842511466, 3555.2178520725397, 3601.531800865897, 3723.0, 3733.1600389912323, 3737.663610275075, 3725.3666876631037, 3732.7387082904206, 3741.38267185914, 3750.5124333836698, 3752.118252210742, 3320.750943679234, 3339.4322965095994, 3349.69852713257, 3351.6425847531787, 3363.260082781784, 4444.577765112309, 4641.930371044437, 4652.232381657022, 4686.578207961265, 4692.741899195543, 4197.0, 4203.117345357478, 4212.9157416851795, 4221.24017676818, 4226.809793559297, 4958.157113290749, 4958.975205123951, 4966.47851975541, 4971.37857767779, 4983.15286401309, 3551.4672799080085, 3553.2538166984964, 3558.1104723819044, 3564.6435356464144, 3572.8034958077296, 4893.632977526664, 4958.2314741214805, 5006.0989021975665, 5159.613029022838, 5203.297554830087, 3559.6440355964196, 3584.695300899453, 3587.9641203588153, 3590.120420496995, 3603.621619729943, 3656.762310449812, 3667.477996631368, 3669.3945498992903, 3671.8800765766164, 3673.7244706647107, 4186.539480657125, 4193.874183774492, 4208.389783481378, 4214.093969796509, 4218.7468751874985, 4827.324174615556, 4932.8520144395725, 4962.478939711278, 4962.60299176065, 5032.521910418504, 1239.4670291774444, 1255.491525931999, 1257.25821765159, 1257.30848033583, 1257.7170136719164, 786.3591173193829, 806.790234539024, 818.0796603820702, 830.5058490198322, 832.1054866019053, 3980.203959208112, 3981.3828856527284, 3988.222296652183, 3994.881433198709, 4000.2799496090984, 4456.598906098467, 4507.805431560573, 4527.207738645724, 4543.0, 4564.360989461478, 3989.2819292527042, 3993.480847489866, 4001.579834117376, 4015.2772500949527, 4034.6080602192196, 2307.7919102780124, 2406.614941609334, 2439.243834411338, 2447.596146635821, 2482.7641374069435, 4233.856858648148, 4238.533761286256, 4254.617084462351, 4278.44380230568, 4281.764502952367, 4551.8179272829375, 4619.976900115478, 4630.652701047435, 4638.373819534387, 4666.719996800203, 4046.4094330055705, 4060.0767447437797, 4223.155368926227, 4234.724742891703, 4243.405923170697, 4527.660425468037, 4538.795754191004, 4542.613877820422, 4544.068465964403, 4591.9540804591525, 4441.71128876622, 4489.797959091914, 4491.214037543352, 4514.367988481681, 4514.61625761814, 4168.416001919372, 4183.853565125206, 4208.200441916026, 4242.851500197478, 4538.773061346986, 3554.306910152495, 3570.357335679603, 3582.1223800169128, 3584.193556449778, 3610.963890361168, 5099.974500127476, 5159.942211846637, 5179.404368497671, 5183.637145399785, 5184.222366645034, 5012.0, 5028.120078986236, 5032.974835125801, 5035.615205818429, 5054.3176671150395, 4767.66626336167, 5012.674176178537, 5039.244113383022, 5043.621728370314, 5047.217681259411, 4855.295982082507, 4905.092557876804, 4969.155243608668, 4970.9254361183885, 4971.154903666313, 4973.428055773487, 5010.874728131826, 5041.8487445376695, 5100.107481190851, 5114.207297868837, 4907.533784290486, 4923.113839508779, 4931.545194167657, 4941.579965702956, 4944.233643785219], "value": 3634.8201663256245, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.233892955946, 622.2191150106619, 685.1914740606082, 703.4442790195744, 711.8540699156673, 11926.64220073398, 13384.130031547955, 13517.526886558973, 13521.12112712673, 13539.796903046437, 13231.669208269797, 13407.396667149977, 13408.932955335235, 13412.128211666235, 13428.0, 627.1846599420758, 635.3202073781056, 765.0475158427752, 784.945053846231, 787.0712559180165, 756.213537920562, 783.7296132834163, 787.5825812319451, 793.8531371696255, 793.972210972616, 823.3043078598574, 825.3644693585935, 826.0129145670926, 826.3678286111129, 826.3843436639712, 657.1653999420756, 819.0253598218131, 819.1317203763999, 819.1767273889762, 820.4584973917216, 577.2178697864417, 591.5799782154676, 594.3937184072265, 599.8710277290404, 600.6156060121526, 12842.036847236495, 12849.87150128496, 12853.485860565566, 12877.4205160768, 12879.67800804978, 11865.0, 12553.309567973758, 12563.497460101586, 12880.613581592566, 13160.0, 11434.142439317002, 11553.53785848565, 11619.360935148563, 11687.240329378648, 12102.152849300552, 4045.37296719009, 4072.083781149218, 4102.753834769924, 4147.419361289422, 4212.368144778277, 58534.70732646352, 59270.40729592692, 59273.40726592765, 59424.405755942316, 60228.0965785518, 9881.558024679167, 10003.499825008721, 10163.745906352253, 10215.897841021644, 10493.422861742525, 18769.0, 18776.342828000954, 18787.24851005972, 18826.435206943814, 18837.905810471133, 6611.371919667624, 6628.602283862983, 6653.767118150939, 6833.077534532874, 6948.965255173692, 3647.635236476331, 3660.139867131222, 3698.2418604186078, 3720.925581488355, 3767.0770661188185, 2763.25392144124, 2837.233946834343, 2846.0892514395196, 2856.8285902845896, 2860.156253905103, 464.1923053886214, 474.1252389341659, 478.1656010262115, 479.5516192360085, 482.4668741041169, 414.67240879704696, 481.2900971067717, 503.39843886555946, 525.611047824607, 530.6815910453697, 6902.723891044402, 7006.544574602736, 7007.404370628554, 7132.928670713331, 7346.889796653055, 422.78250575730493, 427.55107137505496, 447.51221168926025, 474.7222874618387, 505.63846849502784, 3288.5724855769076, 3310.7185889199686, 3319.13702437368, 3353.1449480382835, 3395.4567269237295, 50436.24345634819, 50710.239346409835, 55542.0, 84019.5799021001, 90495.54752226197, 49265.75367123142, 58248.417515825146, 71392.64303678449, 79991.0, 80813.0, 71159.64420177866, 72186.14231647985, 73012.26987730055, 74118.0, 76588.0, 6416.550841441054, 6523.4128928394775, 6598.670066496752, 6784.660766961731, 6934.306569343227, 43346.0, 43374.0, 43886.78056609697, 44370.55629443664, 45287.77356113198, 53314.0, 54238.0, 54788.0, 59165.81668366695, 59743.0, 9884.209263259067, 10146.086852183338, 10375.84436233442, 10464.581416743245, 10767.515461804081, 10572.577096916037, 11787.469563869476, 11820.76358472843, 11824.290542567473, 12347.75304493923, 10249.692509224735, 10370.481475926324, 10516.0, 10525.578976840841, 10689.198310126927, 9870.161036311994, 10092.495375231356, 10133.847992279974, 10370.533326000197, 10404.58381664725, 10737.677869663923, 11189.552417903193, 11533.826992595286, 11576.0, 11577.421128943688, 8501.362397820065, 8931.240844528027, 9174.495402752913, 9252.398594091363, 9670.70987870365, 8666.306695464475, 8728.65085396577, 9052.909470905206, 9133.132352426775, 9302.534873256445], "value": 6156.608427346512, "unit": "score"}], "name": "dromaeo_css", "value": 6196.68968940064, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 113.0, 112.0, 111.0, 112.0, 114.0, 110.0, 113.0, 112.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 121.0, 126.0, 184.0, 124.0, 125.0, 147.0, 123.0, 191.0, 122.0], "value": 140.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 160.0, 162.0, 161.0, 163.0, 169.0, 160.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 77.0, 124.0, 76.0, 78.0, 76.0, 77.0, 99.0, 75.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 121.0, 84.0, 85.0, 87.0, 132.0, 85.0, 85.0, 134.0], "value": 98.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 148.0, 146.0, 147.0, 146.0, 148.0, 146.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 68.0, 61.0, 62.0, 61.0, 62.0, 63.0, 61.0, 61.0, 61.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 67.0, 65.0, 67.0, 65.0, 66.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 79.0, 80.0, 79.0, 79.0, 93.0, 79.0, 78.0, 78.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 133.0, 140.0, 137.0, 141.0, 138.0, 128.0, 130.0, 184.0, 137.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 171.0, 167.0, 163.0, 166.0, 170.0, 164.0, 163.0, 161.0, 160.0], "value": 164.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 66.0, 67.0, 66.0, 74.0, 66.0, 67.0, 67.0, 65.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1537.1, "alertThreshold": 2.0}]} 11:04:43 INFO - Return code: 0 11:04:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:04:43 INFO - # TBPL SUCCESS # 11:04:43 INFO - Running post-action listener: _resource_record_post_action 11:04:43 INFO - [mozharness: 2016-07-21 18:04:43.919896Z] Finished run-tests step (success) 11:04:43 INFO - Running post-run listener: _resource_record_post_run 11:04:43 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536821760; Read time: 16; Write time: 1508640 11:04:43 INFO - TinderboxPrint: CPU usage
13.1% 11:04:43 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 11:04:43 INFO - TinderboxPrint: I/O write bytes / time
536,821,760 / 1,508,640 11:04:43 INFO - TinderboxPrint: CPU idle
8,348.0 (86.9%) 11:04:43 INFO - TinderboxPrint: CPU user
1,204.9 (12.5%) 11:04:43 INFO - TinderboxPrint: Swap in / out
0 / 0 11:04:43 INFO - install - Wall time: 19s; CPU: 17.0%; Read bytes: 0; Write bytes: 247123968; Read time: 0; Write time: 839976 11:04:44 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 289693696; Read time: 0; Write time: 668664 11:04:44 INFO - Running post-run listener: _upload_blobber_files 11:04:44 INFO - Blob upload gear active. 11:04:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:04:44 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 11:04:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:04:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:04:44 INFO - (blobuploader) - INFO - Open directory for files ... 11:04:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:04:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:04:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:04:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:04:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:04:45 INFO - (blobuploader) - INFO - Done attempting. 11:04:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:04:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:04:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:05:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:05:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:05:06 INFO - (blobuploader) - INFO - Done attempting. 11:05:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:05:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:05:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:05:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:05:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:05:07 INFO - (blobuploader) - INFO - Done attempting. 11:05:07 INFO - (blobuploader) - INFO - Iteration through files over. 11:05:07 INFO - Return code: 0 11:05:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:05:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:05:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e6c71387017bdd894d310d25f4b706b9452b97eb78305ef3fe56b9e66bc8c824de7747a6561e011e44a5f156b12f2e608b3076d4ead1b86ab57e788c7ae0cb0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d9a9fd94f2b4f302e24b0d60de6dcda7d06b885a522a1554e8f2016ef54c187ada0acbda5c902ea9985b81953bef4d12dcb305831d079575c83e60157e9673c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/89a402eca215677ee311d9c226a8ebc2acab167e70516c58c57974400f46bbaf80bf922877f3ae2d3872668592d73973391c18ffc368d52cd3f71334d264112b"} 11:05:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:05:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:05:07 INFO - Contents: 11:05:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e6c71387017bdd894d310d25f4b706b9452b97eb78305ef3fe56b9e66bc8c824de7747a6561e011e44a5f156b12f2e608b3076d4ead1b86ab57e788c7ae0cb0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d9a9fd94f2b4f302e24b0d60de6dcda7d06b885a522a1554e8f2016ef54c187ada0acbda5c902ea9985b81953bef4d12dcb305831d079575c83e60157e9673c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/89a402eca215677ee311d9c226a8ebc2acab167e70516c58c57974400f46bbaf80bf922877f3ae2d3872668592d73973391c18ffc368d52cd3f71334d264112b"} 11:05:07 INFO - Running post-run listener: copy_logs_to_upload_dir 11:05:07 INFO - Copying logs to upload dir... 11:05:07 INFO - mkdir: /builds/slave/test/build/upload/logs 11:05:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.717271 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-07-21 11:05:07.104982) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 11:05:07.108540) ========= 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=8783db0840cc980e80bb0bd400000236-1469122922.939821-1982516718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e6c71387017bdd894d310d25f4b706b9452b97eb78305ef3fe56b9e66bc8c824de7747a6561e011e44a5f156b12f2e608b3076d4ead1b86ab57e788c7ae0cb0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d9a9fd94f2b4f302e24b0d60de6dcda7d06b885a522a1554e8f2016ef54c187ada0acbda5c902ea9985b81953bef4d12dcb305831d079575c83e60157e9673c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/89a402eca215677ee311d9c226a8ebc2acab167e70516c58c57974400f46bbaf80bf922877f3ae2d3872668592d73973391c18ffc368d52cd3f71334d264112b"} build_url:https://queue.taskcluster.net/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011444 build_url: 'https://queue.taskcluster.net/v1/task/WEcHBpMpReWq3m7XaJ352Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e6c71387017bdd894d310d25f4b706b9452b97eb78305ef3fe56b9e66bc8c824de7747a6561e011e44a5f156b12f2e608b3076d4ead1b86ab57e788c7ae0cb0a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d9a9fd94f2b4f302e24b0d60de6dcda7d06b885a522a1554e8f2016ef54c187ada0acbda5c902ea9985b81953bef4d12dcb305831d079575c83e60157e9673c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/89a402eca215677ee311d9c226a8ebc2acab167e70516c58c57974400f46bbaf80bf922877f3ae2d3872668592d73973391c18ffc368d52cd3f71334d264112b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 11:05:07.134664) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 11:05:07.134974) ========= 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=8783db0840cc980e80bb0bd400000236-1469122922.939821-1982516718 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 11:05:07.217950) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 11:05:07.218264) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 11:05:07.218554) ========= ========= Total master_lag: 0.21 =========