builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1471879247.44 results: success (0) buildid: 20160822064220 builduid: f13a8455ecd24782bc55d6436cef10f3 revision: 194fe275b4e60ded2af6b25173eec421f0dba8ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 08:20:47.437186) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 08:20:47.437745) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 08:20:47.438036) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 08:20:47.452839) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:20:47.453150) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1471879247.330752-969403225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-22 08:20:48-- 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% 212M=0s 2016-08-22 08:20:48 (212 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125661 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:20:47.593241) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:20:47.593561) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1471879247.330752-969403225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021042 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:20:47.643228) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:20:47.643585) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 194fe275b4e60ded2af6b25173eec421f0dba8ad --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 194fe275b4e60ded2af6b25173eec421f0dba8ad --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=74d6aec007b0fa31a864ebd7000001f8-1471879247.330752-969403225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-22 08:20:48,528 truncating revision to first 12 chars 2016-08-22 08:20:48,528 Setting DEBUG logging. 2016-08-22 08:20:48,528 attempt 1/10 2016-08-22 08:20:48,528 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/194fe275b4e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 08:20:48,776 unpacking tar archive at: fx-team-194fe275b4e6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.528977 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:20:48.186240) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 08:20:48.186619) ========= script_repo_revision: 194fe275b4e60ded2af6b25173eec421f0dba8ad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 08:20:48.187060) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 08:20:48.187353) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 08:20:48.196960) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-22 08:20:48.197359) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1471879247.330752-969403225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:20:49 INFO - MultiFileLogger online at 20160822 08:20:49 in /builds/slave/test 08:20:49 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 08:20:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:20:49 INFO - {'append_to_log': False, 08:20:49 INFO - 'base_work_dir': '/builds/slave/test', 08:20:49 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:20:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:20:49 INFO - 'branch': 'Fx-Team-Non-PGO', 08:20:49 INFO - 'buildbot_json_path': 'buildprops.json', 08:20:49 INFO - 'config_files': ('talos/linux_config.py',), 08:20:49 INFO - 'default_actions': ('clobber', 08:20:49 INFO - 'read-buildbot-config', 08:20:49 INFO - 'download-and-extract', 08:20:49 INFO - 'populate-webroot', 08:20:49 INFO - 'create-virtualenv', 08:20:49 INFO - 'install', 08:20:49 INFO - 'run-tests'), 08:20:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:20:49 INFO - 'download_minidump_stackwalk': True, 08:20:49 INFO - 'download_symbols': 'ondemand', 08:20:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:20:49 INFO - 'tooltool.py': '/tools/tooltool.py', 08:20:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:20:49 INFO - '/tools/misc-python/virtualenv.py')}, 08:20:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:20:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:20:49 INFO - 'installer_path': 'installer.exe', 08:20:49 INFO - 'log_level': 'info', 08:20:49 INFO - 'log_name': 'talos', 08:20:49 INFO - 'log_to_console': True, 08:20:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:20:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:20:49 INFO - 'opt_config_files': (), 08:20:49 INFO - 'pip_index': False, 08:20:49 INFO - 'sps_profile': False, 08:20:49 INFO - 'sps_profile_interval': 0, 08:20:49 INFO - 'suite': 'dromaeojs', 08:20:49 INFO - 'system_bits': '32', 08:20:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:20:49 INFO - 'title': 'talos-linux64-ix-042', 08:20:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:20:49 INFO - 'use_talos_json': True, 08:20:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:20:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:20:49 INFO - 'work_dir': 'build'} 08:20:49 INFO - [mozharness: 2016-08-22 15:20:49.170973Z] Running clobber step. 08:20:49 INFO - Running pre-action listener: _resource_record_pre_action 08:20:49 INFO - Running main action method: clobber 08:20:49 INFO - rmtree: /builds/slave/test/build 08:20:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:20:49 INFO - Running post-action listener: _resource_record_post_action 08:20:49 INFO - [mozharness: 2016-08-22 15:20:49.625907Z] Finished clobber step (success) 08:20:49 INFO - [mozharness: 2016-08-22 15:20:49.626010Z] Running read-buildbot-config step. 08:20:49 INFO - Running pre-action listener: _resource_record_pre_action 08:20:49 INFO - Running main action method: read_buildbot_config 08:20:49 INFO - Using buildbot properties: 08:20:49 INFO - { 08:20:49 INFO - "project": "", 08:20:49 INFO - "product": "firefox", 08:20:49 INFO - "script_repo_revision": "production", 08:20:49 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:20:49 INFO - "repository": "", 08:20:49 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:20:49 INFO - "buildid": "20160822064220", 08:20:49 INFO - "pgo_build": "False", 08:20:49 INFO - "basedir": "/builds/slave/test", 08:20:49 INFO - "buildnumber": 2108, 08:20:49 INFO - "slavename": "talos-linux64-ix-042", 08:20:49 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:20:49 INFO - "platform": "ubuntu64_hw", 08:20:49 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:20:49 INFO - "branch": "fx-team", 08:20:49 INFO - "repo_path": "integration/fx-team", 08:20:49 INFO - "revision": "194fe275b4e60ded2af6b25173eec421f0dba8ad", 08:20:49 INFO - "stage_platform": "linux64", 08:20:49 INFO - "builduid": "f13a8455ecd24782bc55d6436cef10f3", 08:20:49 INFO - "slavebuilddir": "test" 08:20:49 INFO - } 08:20:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/R21o6kFWQ2Gfx004Uia7bg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:20:49 INFO - Running post-action listener: _resource_record_post_action 08:20:49 INFO - [mozharness: 2016-08-22 15:20:49.628441Z] Finished read-buildbot-config step (success) 08:20:49 INFO - [mozharness: 2016-08-22 15:20:49.628528Z] Running download-and-extract step. 08:20:49 INFO - Running pre-action listener: _resource_record_pre_action 08:20:49 INFO - Running main action method: download_and_extract 08:20:49 INFO - mkdir: /builds/slave/test/build/tests 08:20:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:49 INFO - trying https://queue.taskcluster.net/v1/task/R21o6kFWQ2Gfx004Uia7bg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:20:49 INFO - Downloading https://queue.taskcluster.net/v1/task/R21o6kFWQ2Gfx004Uia7bg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:20:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R21o6kFWQ2Gfx004Uia7bg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:20:50 INFO - Downloaded 1361 bytes. 08:20:50 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:20:50 INFO - Using the following test package requirements: 08:20:50 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:20:50 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:20:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:20:50 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:20:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:20:50 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:20:50 INFO - u'jsshell-linux-x86_64.zip'], 08:20:50 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:20:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:20:50 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:20:50 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:20:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:20:50 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:20:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:20:50 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:20:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:20:50 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:20:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:20:50 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:50 INFO - trying https://queue.taskcluster.net/v1/task/R21o6kFWQ2Gfx004Uia7bg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:20:50 INFO - Downloading https://queue.taskcluster.net/v1/task/R21o6kFWQ2Gfx004Uia7bg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:20:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R21o6kFWQ2Gfx004Uia7bg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:20:51 INFO - Downloaded 20330902 bytes. 08:20:51 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:20:55 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:55 INFO - trying https://queue.taskcluster.net/v1/task/R21o6kFWQ2Gfx004Uia7bg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:20:55 INFO - Downloading https://queue.taskcluster.net/v1/task/R21o6kFWQ2Gfx004Uia7bg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:20:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R21o6kFWQ2Gfx004Uia7bg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:20:56 INFO - Downloaded 20330902 bytes. 08:20:56 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:00 INFO - trying https://queue.taskcluster.net/v1/task/R21o6kFWQ2Gfx004Uia7bg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:21:00 INFO - Downloading https://queue.taskcluster.net/v1/task/R21o6kFWQ2Gfx004Uia7bg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:21:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R21o6kFWQ2Gfx004Uia7bg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:21:01 INFO - Downloaded 14413981 bytes. 08:21:01 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 08:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:01 INFO - trying https://queue.taskcluster.net/v1/task/R21o6kFWQ2Gfx004Uia7bg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:21:01 INFO - Downloading https://queue.taskcluster.net/v1/task/R21o6kFWQ2Gfx004Uia7bg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:21:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R21o6kFWQ2Gfx004Uia7bg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:21:03 INFO - Downloaded 55764121 bytes. 08:21:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R21o6kFWQ2Gfx004Uia7bg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:21:03 INFO - mkdir: /builds/slave/test/properties 08:21:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:21:03 INFO - Writing to file /builds/slave/test/properties/build_url 08:21:03 INFO - Contents: 08:21:03 INFO - build_url:https://queue.taskcluster.net/v1/task/R21o6kFWQ2Gfx004Uia7bg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:21:03 INFO - Running post-action listener: _resource_record_post_action 08:21:03 INFO - Running post-action listener: set_extra_try_arguments 08:21:03 INFO - [mozharness: 2016-08-22 15:21:03.768867Z] Finished download-and-extract step (success) 08:21:03 INFO - [mozharness: 2016-08-22 15:21:03.769092Z] Running populate-webroot step. 08:21:03 INFO - Running pre-action listener: _resource_record_pre_action 08:21:03 INFO - Running main action method: populate_webroot 08:21:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:21:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:21:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:21:03 INFO - '--tppagecycles', 08:21:03 INFO - '7'], 08:21:03 INFO - 'tests': ['tsvgm']}}, 08:21:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:21:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:21:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:21:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:21:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:21:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:21:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:03 INFO - 'talos_options': ['--disable-e10s'], 08:21:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:21:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:21:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:03 INFO - 'talos_options': ['--disable-e10s'], 08:21:03 INFO - 'tests': ['damp', 'tps']}, 08:21:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:03 INFO - 'tests': ['damp', 'tps']}, 08:21:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:21:03 INFO - 'tests': ['dromaeo_dom']}, 08:21:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:21:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:21:03 INFO - 'tests': ['basic_compositor_video']}, 08:21:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:21:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:21:03 INFO - 'tests': ['a11yr', 08:21:03 INFO - 'ts_paint', 08:21:03 INFO - 'tpaint', 08:21:03 INFO - 'sessionrestore', 08:21:03 INFO - 'sessionrestore_no_auto_restore', 08:21:03 INFO - 'tabpaint']}, 08:21:03 INFO - 'other-e10s': {'tests': ['a11yr', 08:21:03 INFO - 'ts_paint', 08:21:03 INFO - 'tpaint', 08:21:03 INFO - 'sessionrestore', 08:21:03 INFO - 'sessionrestore_no_auto_restore', 08:21:03 INFO - 'tabpaint']}, 08:21:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:21:03 INFO - 'ts_paint', 08:21:03 INFO - 'tpaint', 08:21:03 INFO - 'sessionrestore', 08:21:03 INFO - 'sessionrestore_no_auto_restore', 08:21:03 INFO - 'tabpaint']}, 08:21:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:21:03 INFO - 'ts_paint', 08:21:03 INFO - 'tpaint', 08:21:03 INFO - 'sessionrestore', 08:21:03 INFO - 'sessionrestore_no_auto_restore', 08:21:03 INFO - 'tabpaint']}, 08:21:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:21:03 INFO - 'tests': ['a11yr', 08:21:03 INFO - 'ts_paint', 08:21:03 INFO - 'tpaint', 08:21:03 INFO - 'sessionrestore', 08:21:03 INFO - 'sessionrestore_no_auto_restore', 08:21:03 INFO - 'tabpaint']}, 08:21:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:21:03 INFO - 'tests': ['a11yr', 08:21:03 INFO - 'ts_paint', 08:21:03 INFO - 'tpaint', 08:21:03 INFO - 'sessionrestore', 08:21:03 INFO - 'sessionrestore_no_auto_restore', 08:21:03 INFO - 'tabpaint']}, 08:21:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:21:03 INFO - 'tests': ['tsvgx', 08:21:03 INFO - 'tsvgr_opacity', 08:21:03 INFO - 'tart', 08:21:03 INFO - 'tscrollx', 08:21:03 INFO - 'cart']}, 08:21:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:21:03 INFO - 'tsvgr_opacity', 08:21:03 INFO - 'tart', 08:21:03 INFO - 'tscrollx', 08:21:03 INFO - 'cart']}, 08:21:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:03 INFO - 'talos_options': ['--disable-e10s'], 08:21:03 INFO - 'tests': ['tp5o']}, 08:21:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:03 INFO - 'tests': ['tp5o']}, 08:21:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:03 INFO - 'talos_options': ['--disable-e10s', 08:21:03 INFO - '--xperf_path', 08:21:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:21:03 INFO - 'tests': ['tp5n']}, 08:21:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:03 INFO - 'talos_options': ['--xperf_path', 08:21:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:21:03 INFO - 'tests': ['tp5n']}}, 08:21:03 INFO - 'talos.zip': {'path': '', 08:21:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:21:03 INFO - Running post-action listener: _resource_record_post_action 08:21:03 INFO - [mozharness: 2016-08-22 15:21:03.785383Z] Finished populate-webroot step (success) 08:21:03 INFO - [mozharness: 2016-08-22 15:21:03.785471Z] Running create-virtualenv step. 08:21:03 INFO - Running pre-action listener: _resource_record_pre_action 08:21:03 INFO - Running main action method: create_virtualenv 08:21:03 INFO - Creating virtualenv /builds/slave/test/build/venv 08:21:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:21:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:21:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:21:03 INFO - Using real prefix '/usr' 08:21:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:21:04 INFO - Installing distribute.............................................................................................................................................................................................done. 08:21:06 INFO - Installing pip.................done. 08:21:06 INFO - Return code: 0 08:21:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:06 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 0x7ff68d398f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da090>, '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 0x10dd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dde40>, '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': '74d6aec007b0fa31a864ebd7000001f8-1471879247.330752-969403225', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:21:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:21:06 INFO - Using env: {'DISPLAY': ':0', 08:21:06 INFO - 'HOME': '/home/cltbld', 08:21:06 INFO - 'LANG': 'en_US.UTF-8', 08:21:06 INFO - 'LANGUAGE': 'en_US:en', 08:21:06 INFO - 'LOGNAME': 'cltbld', 08:21:06 INFO - 'MAIL': '/var/mail/cltbld', 08:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:06 INFO - 'MOZ_NO_REMOTE': '1', 08:21:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:06 INFO - 'NO_EM_RESTART': '1', 08:21:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:06 INFO - 'PWD': '/builds/slave/test', 08:21:06 INFO - 'SHELL': '/bin/bash', 08:21:06 INFO - 'SHLVL': '1', 08:21:06 INFO - 'TERM': 'linux', 08:21:06 INFO - 'TMOUT': '86400', 08:21:06 INFO - 'USER': 'cltbld', 08:21:06 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1471879247.330752-969403225', 08:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:06 INFO - '_': '/tools/buildbot/bin/python'} 08:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:21:06 INFO - Cleaning up... 08:21:06 INFO - Return code: 0 08:21:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:06 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 0x7ff68d398f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da090>, '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 0x10dd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dde40>, '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': '74d6aec007b0fa31a864ebd7000001f8-1471879247.330752-969403225', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:21:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:21:06 INFO - Using env: {'DISPLAY': ':0', 08:21:06 INFO - 'HOME': '/home/cltbld', 08:21:06 INFO - 'LANG': 'en_US.UTF-8', 08:21:06 INFO - 'LANGUAGE': 'en_US:en', 08:21:06 INFO - 'LOGNAME': 'cltbld', 08:21:06 INFO - 'MAIL': '/var/mail/cltbld', 08:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:06 INFO - 'MOZ_NO_REMOTE': '1', 08:21:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:06 INFO - 'NO_EM_RESTART': '1', 08:21:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:06 INFO - 'PWD': '/builds/slave/test', 08:21:06 INFO - 'SHELL': '/bin/bash', 08:21:06 INFO - 'SHLVL': '1', 08:21:06 INFO - 'TERM': 'linux', 08:21:06 INFO - 'TMOUT': '86400', 08:21:06 INFO - 'USER': 'cltbld', 08:21:06 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1471879247.330752-969403225', 08:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:06 INFO - '_': '/tools/buildbot/bin/python'} 08:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:06 INFO - Downloading/unpacking psutil>=3.1.1 08:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:21:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:21:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:21:08 INFO - Installing collected packages: psutil 08:21:08 INFO - Running setup.py install for psutil 08:21:08 INFO - building 'psutil._psutil_linux' extension 08:21:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:21:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:21:09 INFO - building 'psutil._psutil_posix' extension 08:21:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:21:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:21:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:21:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:21:09 INFO - Successfully installed psutil 08:21:09 INFO - Cleaning up... 08:21:09 INFO - Return code: 0 08:21:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff68d398f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da090>, '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 0x10dd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dde40>, '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': '74d6aec007b0fa31a864ebd7000001f8-1471879247.330752-969403225', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:21:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:21:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:21:09 INFO - Using env: {'DISPLAY': ':0', 08:21:09 INFO - 'HOME': '/home/cltbld', 08:21:09 INFO - 'LANG': 'en_US.UTF-8', 08:21:09 INFO - 'LANGUAGE': 'en_US:en', 08:21:09 INFO - 'LOGNAME': 'cltbld', 08:21:09 INFO - 'MAIL': '/var/mail/cltbld', 08:21:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:09 INFO - 'MOZ_NO_REMOTE': '1', 08:21:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:09 INFO - 'NO_EM_RESTART': '1', 08:21:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:09 INFO - 'PWD': '/builds/slave/test', 08:21:09 INFO - 'SHELL': '/bin/bash', 08:21:09 INFO - 'SHLVL': '1', 08:21:09 INFO - 'TERM': 'linux', 08:21:09 INFO - 'TMOUT': '86400', 08:21:09 INFO - 'USER': 'cltbld', 08:21:09 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1471879247.330752-969403225', 08:21:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:09 INFO - '_': '/tools/buildbot/bin/python'} 08:21:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:21:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:21:11 INFO - Installing collected packages: mozsystemmonitor 08:21:11 INFO - Running setup.py install for mozsystemmonitor 08:21:11 INFO - Successfully installed mozsystemmonitor 08:21:11 INFO - Cleaning up... 08:21:11 INFO - Return code: 0 08:21:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:11 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 0x7ff68d398f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da090>, '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 0x10dd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dde40>, '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': '74d6aec007b0fa31a864ebd7000001f8-1471879247.330752-969403225', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:21:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:21:11 INFO - Using env: {'DISPLAY': ':0', 08:21:11 INFO - 'HOME': '/home/cltbld', 08:21:11 INFO - 'LANG': 'en_US.UTF-8', 08:21:11 INFO - 'LANGUAGE': 'en_US:en', 08:21:11 INFO - 'LOGNAME': 'cltbld', 08:21:11 INFO - 'MAIL': '/var/mail/cltbld', 08:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:11 INFO - 'MOZ_NO_REMOTE': '1', 08:21:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:11 INFO - 'NO_EM_RESTART': '1', 08:21:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:11 INFO - 'PWD': '/builds/slave/test', 08:21:11 INFO - 'SHELL': '/bin/bash', 08:21:11 INFO - 'SHLVL': '1', 08:21:11 INFO - 'TERM': 'linux', 08:21:11 INFO - 'TMOUT': '86400', 08:21:11 INFO - 'USER': 'cltbld', 08:21:11 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1471879247.330752-969403225', 08:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:11 INFO - '_': '/tools/buildbot/bin/python'} 08:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:11 INFO - Downloading/unpacking jsonschema==2.5.1 08:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:21:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:13 INFO - Downloading functools32-3.2.3-2.tar.gz 08:21:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:21:14 INFO - warning: no files found matching '*.txt' 08:21:14 INFO - no previously-included directories found matching 'build' 08:21:14 INFO - no previously-included directories found matching 'dist' 08:21:14 INFO - no previously-included directories found matching '.git*' 08:21:14 INFO - Installing collected packages: jsonschema, functools32 08:21:14 INFO - Running setup.py install for functools32 08:21:14 INFO - warning: no files found matching '*.txt' 08:21:14 INFO - no previously-included directories found matching 'build' 08:21:14 INFO - no previously-included directories found matching 'dist' 08:21:14 INFO - no previously-included directories found matching '.git*' 08:21:14 INFO - Successfully installed jsonschema functools32 08:21:14 INFO - Cleaning up... 08:21:14 INFO - Return code: 0 08:21:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:21: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff68d398f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da090>, '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 0x10dd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dde40>, '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': '74d6aec007b0fa31a864ebd7000001f8-1471879247.330752-969403225', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:21:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:21:14 INFO - Using env: {'DISPLAY': ':0', 08:21:14 INFO - 'HOME': '/home/cltbld', 08:21:14 INFO - 'LANG': 'en_US.UTF-8', 08:21:14 INFO - 'LANGUAGE': 'en_US:en', 08:21:14 INFO - 'LOGNAME': 'cltbld', 08:21:14 INFO - 'MAIL': '/var/mail/cltbld', 08:21:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:14 INFO - 'MOZ_NO_REMOTE': '1', 08:21:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:14 INFO - 'NO_EM_RESTART': '1', 08:21:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:14 INFO - 'PWD': '/builds/slave/test', 08:21:14 INFO - 'SHELL': '/bin/bash', 08:21:14 INFO - 'SHLVL': '1', 08:21:14 INFO - 'TERM': 'linux', 08:21:14 INFO - 'TMOUT': '86400', 08:21:14 INFO - 'USER': 'cltbld', 08:21:14 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1471879247.330752-969403225', 08:21:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:14 INFO - '_': '/tools/buildbot/bin/python'} 08:21:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:21:14 INFO - Cleaning up... 08:21:14 INFO - Return code: 0 08:21:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:21: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:14 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 0x7ff68d398f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da090>, '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 0x10dd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dde40>, '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': '74d6aec007b0fa31a864ebd7000001f8-1471879247.330752-969403225', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:21:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:21:14 INFO - Using env: {'DISPLAY': ':0', 08:21:14 INFO - 'HOME': '/home/cltbld', 08:21:14 INFO - 'LANG': 'en_US.UTF-8', 08:21:14 INFO - 'LANGUAGE': 'en_US:en', 08:21:14 INFO - 'LOGNAME': 'cltbld', 08:21:14 INFO - 'MAIL': '/var/mail/cltbld', 08:21:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:14 INFO - 'MOZ_NO_REMOTE': '1', 08:21:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:14 INFO - 'NO_EM_RESTART': '1', 08:21:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:14 INFO - 'PWD': '/builds/slave/test', 08:21:14 INFO - 'SHELL': '/bin/bash', 08:21:14 INFO - 'SHLVL': '1', 08:21:14 INFO - 'TERM': 'linux', 08:21:14 INFO - 'TMOUT': '86400', 08:21:14 INFO - 'USER': 'cltbld', 08:21:14 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1471879247.330752-969403225', 08:21:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:14 INFO - '_': '/tools/buildbot/bin/python'} 08:21:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:14 INFO - Downloading/unpacking blobuploader==1.2.4 08:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:16 INFO - Downloading blobuploader-1.2.4.tar.gz 08:21:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:21:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:21:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:17 INFO - Downloading docopt-0.6.1.tar.gz 08:21:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:21:17 INFO - Installing collected packages: blobuploader, requests, docopt 08:21:17 INFO - Running setup.py install for blobuploader 08:21:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:21:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:21:17 INFO - Running setup.py install for requests 08:21:17 INFO - Running setup.py install for docopt 08:21:17 INFO - Successfully installed blobuploader requests docopt 08:21:17 INFO - Cleaning up... 08:21:17 INFO - Return code: 0 08:21:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:17 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 0x7ff68d398f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da090>, '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 0x10dd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dde40>, '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': '74d6aec007b0fa31a864ebd7000001f8-1471879247.330752-969403225', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:21:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:21:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:21:17 INFO - Using env: {'DISPLAY': ':0', 08:21:17 INFO - 'HOME': '/home/cltbld', 08:21:17 INFO - 'LANG': 'en_US.UTF-8', 08:21:17 INFO - 'LANGUAGE': 'en_US:en', 08:21:17 INFO - 'LOGNAME': 'cltbld', 08:21:17 INFO - 'MAIL': '/var/mail/cltbld', 08:21:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:17 INFO - 'MOZ_NO_REMOTE': '1', 08:21:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:17 INFO - 'NO_EM_RESTART': '1', 08:21:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:17 INFO - 'PWD': '/builds/slave/test', 08:21:17 INFO - 'SHELL': '/bin/bash', 08:21:17 INFO - 'SHLVL': '1', 08:21:17 INFO - 'TERM': 'linux', 08:21:17 INFO - 'TMOUT': '86400', 08:21:17 INFO - 'USER': 'cltbld', 08:21:17 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1471879247.330752-969403225', 08:21:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:17 INFO - '_': '/tools/buildbot/bin/python'} 08:21:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:21:18 INFO - Running setup.py (path:/tmp/pip-p3V5lq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:21:18 INFO - Running setup.py (path:/tmp/pip-n5FFoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:21:18 INFO - Running setup.py (path:/tmp/pip-GIdGzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:21:18 INFO - Running setup.py (path:/tmp/pip-03IQWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:21:18 INFO - Running setup.py (path:/tmp/pip-fsPWdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:21:18 INFO - Running setup.py (path:/tmp/pip-9h7yJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:21:18 INFO - Running setup.py (path:/tmp/pip-MXD1Sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:21:18 INFO - Running setup.py (path:/tmp/pip-F9RNpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:21:18 INFO - Running setup.py (path:/tmp/pip-EXqhao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:21:18 INFO - Running setup.py (path:/tmp/pip-mssIWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:21:18 INFO - Running setup.py (path:/tmp/pip-14JD0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:21:18 INFO - Running setup.py (path:/tmp/pip-B6p4nB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:21:18 INFO - Running setup.py (path:/tmp/pip-JTpxM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:21:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:21:19 INFO - Running setup.py (path:/tmp/pip-2t3OGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:21:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:19 INFO - Running setup.py (path:/tmp/pip-fOXoH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:21:19 INFO - Running setup.py (path:/tmp/pip-eua3TT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:21:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:21:19 INFO - Running setup.py (path:/tmp/pip-GyBBSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:21:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:21:19 INFO - Running setup.py install for manifestparser 08:21:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:21:19 INFO - Running setup.py install for mozcrash 08:21:19 INFO - Running setup.py install for mozdebug 08:21:19 INFO - Running setup.py install for mozdevice 08:21:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:21:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:21:19 INFO - Running setup.py install for mozfile 08:21:19 INFO - Running setup.py install for mozhttpd 08:21:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:21:19 INFO - Running setup.py install for mozinfo 08:21:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:21:20 INFO - Running setup.py install for mozInstall 08:21:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:21:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:21:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:21:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:21:20 INFO - Running setup.py install for mozleak 08:21:20 INFO - Running setup.py install for mozlog 08:21:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:21:20 INFO - Running setup.py install for moznetwork 08:21:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:21:20 INFO - Running setup.py install for mozprocess 08:21:20 INFO - Running setup.py install for mozprofile 08:21:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:21:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:21:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:21:20 INFO - Running setup.py install for mozrunner 08:21:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:21:20 INFO - Running setup.py install for mozscreenshot 08:21:20 INFO - Running setup.py install for moztest 08:21:21 INFO - Running setup.py install for mozversion 08:21:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:21:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:21:21 INFO - Cleaning up... 08:21:21 INFO - Return code: 0 08:21:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:21 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 0x7ff68d398f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da090>, '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 0x10dd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dde40>, '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': '74d6aec007b0fa31a864ebd7000001f8-1471879247.330752-969403225', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:21:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:21:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:21:21 INFO - Using env: {'DISPLAY': ':0', 08:21:21 INFO - 'HOME': '/home/cltbld', 08:21:21 INFO - 'LANG': 'en_US.UTF-8', 08:21:21 INFO - 'LANGUAGE': 'en_US:en', 08:21:21 INFO - 'LOGNAME': 'cltbld', 08:21:21 INFO - 'MAIL': '/var/mail/cltbld', 08:21:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:21 INFO - 'MOZ_NO_REMOTE': '1', 08:21:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:21 INFO - 'NO_EM_RESTART': '1', 08:21:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:21 INFO - 'PWD': '/builds/slave/test', 08:21:21 INFO - 'SHELL': '/bin/bash', 08:21:21 INFO - 'SHLVL': '1', 08:21:21 INFO - 'TERM': 'linux', 08:21:21 INFO - 'TMOUT': '86400', 08:21:21 INFO - 'USER': 'cltbld', 08:21:21 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1471879247.330752-969403225', 08:21:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:21 INFO - '_': '/tools/buildbot/bin/python'} 08:21:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:21:21 INFO - Running setup.py (path:/tmp/pip-3M3nhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:21:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:21:21 INFO - Running setup.py (path:/tmp/pip-eElmD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:21:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:21:21 INFO - Running setup.py (path:/tmp/pip-q4Kdig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:21:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:21:21 INFO - Running setup.py (path:/tmp/pip-sdk6j0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:21:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:21:21 INFO - Running setup.py (path:/tmp/pip-V5OlrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:21:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:21:21 INFO - Running setup.py (path:/tmp/pip-3IH5_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:21:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:21:21 INFO - Running setup.py (path:/tmp/pip-KO0gcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:21:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:21:21 INFO - Running setup.py (path:/tmp/pip-zwWOPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:21:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:21:21 INFO - Running setup.py (path:/tmp/pip-qOoIAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:21:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:21:22 INFO - Running setup.py (path:/tmp/pip-fzVZmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:21:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:21:22 INFO - Running setup.py (path:/tmp/pip-eOlJJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:21:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:21:22 INFO - Running setup.py (path:/tmp/pip-6RhpDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:21:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:21:22 INFO - Running setup.py (path:/tmp/pip-rye_2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:21:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:21:22 INFO - Running setup.py (path:/tmp/pip-5R4zEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:21:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:22 INFO - Running setup.py (path:/tmp/pip-SkNwEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:21:22 INFO - Running setup.py (path:/tmp/pip-G4cIHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:21:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:21:22 INFO - Running setup.py (path:/tmp/pip-Xjk4Ox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:21:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:21:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:21:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:21:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:21:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:21:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:21:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:24 INFO - Downloading blessings-1.6.tar.gz 08:21:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:21:24 INFO - Installing collected packages: blessings 08:21:24 INFO - Running setup.py install for blessings 08:21:24 INFO - Successfully installed blessings 08:21:24 INFO - Cleaning up... 08:21:24 INFO - Return code: 0 08:21:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:21:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:21:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:21:24 INFO - Reading from file tmpfile_stdout 08:21:24 INFO - Current package versions: 08:21:24 INFO - argparse == 1.2.1 08:21:24 INFO - blessings == 1.6 08:21:24 INFO - blobuploader == 1.2.4 08:21:24 INFO - docopt == 0.6.1 08:21:24 INFO - functools32 == 3.2.3-2 08:21:24 INFO - jsonschema == 2.5.1 08:21:24 INFO - manifestparser == 1.1 08:21:24 INFO - mozInstall == 1.12 08:21:24 INFO - mozcrash == 0.17 08:21:24 INFO - mozdebug == 0.1 08:21:24 INFO - mozdevice == 0.48 08:21:24 INFO - mozfile == 1.2 08:21:24 INFO - mozhttpd == 0.7 08:21:24 INFO - mozinfo == 0.9 08:21:24 INFO - mozleak == 0.1 08:21:24 INFO - mozlog == 3.3 08:21:24 INFO - moznetwork == 0.27 08:21:24 INFO - mozprocess == 0.23 08:21:24 INFO - mozprofile == 0.28 08:21:24 INFO - mozrunner == 6.12 08:21:24 INFO - mozscreenshot == 0.1 08:21:24 INFO - mozsystemmonitor == 0.3 08:21:24 INFO - moztest == 0.7 08:21:24 INFO - mozversion == 1.4 08:21:24 INFO - psutil == 3.1.1 08:21:24 INFO - requests == 1.2.3 08:21:24 INFO - wsgiref == 0.1.2 08:21:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:24 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 0x7ff68d398f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da090>, '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 0x10dd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dde40>, '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': '74d6aec007b0fa31a864ebd7000001f8-1471879247.330752-969403225', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:21:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:21:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:21:24 INFO - Using env: {'DISPLAY': ':0', 08:21:24 INFO - 'HOME': '/home/cltbld', 08:21:24 INFO - 'LANG': 'en_US.UTF-8', 08:21:24 INFO - 'LANGUAGE': 'en_US:en', 08:21:24 INFO - 'LOGNAME': 'cltbld', 08:21:24 INFO - 'MAIL': '/var/mail/cltbld', 08:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:24 INFO - 'MOZ_NO_REMOTE': '1', 08:21:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:24 INFO - 'NO_EM_RESTART': '1', 08:21:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:24 INFO - 'PWD': '/builds/slave/test', 08:21:24 INFO - 'SHELL': '/bin/bash', 08:21:24 INFO - 'SHLVL': '1', 08:21:24 INFO - 'TERM': 'linux', 08:21:24 INFO - 'TMOUT': '86400', 08:21:24 INFO - 'USER': 'cltbld', 08:21:24 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1471879247.330752-969403225', 08:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:24 INFO - '_': '/tools/buildbot/bin/python'} 08:21:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:21:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:21:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:21:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:21:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:21:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:21:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:21:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:21:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:21:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:21:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:21:25 INFO - Cleaning up... 08:21:25 INFO - Return code: 0 08:21:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff68d398f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da090>, '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 0x10dd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dde40>, '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': '74d6aec007b0fa31a864ebd7000001f8-1471879247.330752-969403225', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:21: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'] in /builds/slave/test/build 08:21: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 08:21:25 INFO - Using env: {'DISPLAY': ':0', 08:21:25 INFO - 'HOME': '/home/cltbld', 08:21:25 INFO - 'LANG': 'en_US.UTF-8', 08:21:25 INFO - 'LANGUAGE': 'en_US:en', 08:21:25 INFO - 'LOGNAME': 'cltbld', 08:21:25 INFO - 'MAIL': '/var/mail/cltbld', 08:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:25 INFO - 'MOZ_NO_REMOTE': '1', 08:21:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:25 INFO - 'NO_EM_RESTART': '1', 08:21:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:25 INFO - 'PWD': '/builds/slave/test', 08:21:25 INFO - 'SHELL': '/bin/bash', 08:21:25 INFO - 'SHLVL': '1', 08:21:25 INFO - 'TERM': 'linux', 08:21:25 INFO - 'TMOUT': '86400', 08:21:25 INFO - 'USER': 'cltbld', 08:21:25 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1471879247.330752-969403225', 08:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:25 INFO - '_': '/tools/buildbot/bin/python'} 08:21:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:21:25 INFO - Cleaning up... 08:21:25 INFO - Return code: 0 08:21:25 INFO - Running post-action listener: _resource_record_post_action 08:21:25 INFO - Running post-action listener: _start_resource_monitoring 08:21:25 INFO - Starting resource monitoring. 08:21:25 INFO - [mozharness: 2016-08-22 15:21:25.391670Z] Finished create-virtualenv step (success) 08:21:25 INFO - [mozharness: 2016-08-22 15:21:25.392178Z] Running install step. 08:21:25 INFO - Running pre-action listener: _resource_record_pre_action 08:21:25 INFO - Running main action method: install 08:21:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:21:25 INFO - Reading from file tmpfile_stdout 08:21:25 INFO - Detecting whether we're running mozinstall >=1.0... 08:21:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:21:25 INFO - Reading from file tmpfile_stdout 08:21:25 INFO - Output received: 08:21:25 INFO - Usage: mozinstall [options] installer 08:21:25 INFO - Options: 08:21:25 INFO - -h, --help show this help message and exit 08:21:25 INFO - -d DEST, --destination=DEST 08:21:25 INFO - Directory to install application into. [default: 08:21:25 INFO - "/builds/slave/test"] 08:21:25 INFO - --app=APP Application being installed. [default: firefox] 08:21:25 INFO - mkdir: /builds/slave/test/build/application 08:21:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:21:41 INFO - Reading from file tmpfile_stdout 08:21:41 INFO - Output received: 08:21:41 INFO - /builds/slave/test/build/application/firefox/firefox 08:21:41 INFO - Running post-action listener: _resource_record_post_action 08:21:41 INFO - [mozharness: 2016-08-22 15:21:41.773180Z] Finished install step (success) 08:21:41 INFO - [mozharness: 2016-08-22 15:21:41.773430Z] Running run-tests step. 08:21:41 INFO - Running pre-action listener: _resource_record_pre_action 08:21:41 INFO - Running main action method: run_tests 08:21:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:21:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:21:41 INFO - Python 2.7.3 08:21:41 INFO - Return code: 0 08:21:41 INFO - grabbing minidump binary from tooltool 08:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:41 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 0x10da090>, '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 0x10dd9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dde40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:21:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:21:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:21:41 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:21:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:21:41 INFO - Return code: 0 08:21:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:21:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:21:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:21:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:21:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:21:41 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/R21o6kFWQ2Gfx004Uia7bg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:21:41 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/R21o6kFWQ2Gfx004Uia7bg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:21:41 INFO - Using env: {'DISPLAY': ':0', 08:21:41 INFO - 'HOME': '/home/cltbld', 08:21:41 INFO - 'LANG': 'en_US.UTF-8', 08:21:41 INFO - 'LANGUAGE': 'en_US:en', 08:21:41 INFO - 'LOGNAME': 'cltbld', 08:21:41 INFO - 'MAIL': '/var/mail/cltbld', 08:21:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:21:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:21:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:41 INFO - 'MOZ_NO_REMOTE': '1', 08:21:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:21:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:41 INFO - 'NO_EM_RESTART': '1', 08:21:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:41 INFO - 'PWD': '/builds/slave/test', 08:21:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:21:41 INFO - 'SHELL': '/bin/bash', 08:21:41 INFO - 'SHLVL': '1', 08:21:41 INFO - 'TERM': 'linux', 08:21:41 INFO - 'TMOUT': '86400', 08:21:41 INFO - 'USER': 'cltbld', 08:21:41 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1471879247.330752-969403225', 08:21:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:41 INFO - '_': '/tools/buildbot/bin/python'} 08:21:41 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/R21o6kFWQ2Gfx004Uia7bg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:21:42 INFO - mozversion application_buildid: 20160822064220 08:21:42 INFO - mozversion application_changeset: 194fe275b4e60ded2af6b25173eec421f0dba8ad 08:21:42 INFO - mozversion application_display_name: Nightly 08:21:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:21:42 INFO - mozversion application_name: Firefox 08:21:42 INFO - mozversion application_remotingname: firefox 08:21:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:21:42 INFO - mozversion application_vendor: Mozilla 08:21:42 INFO - mozversion application_version: 51.0a1 08:21:42 INFO - mozversion platform_buildid: 20160822064220 08:21:42 INFO - mozversion platform_changeset: 194fe275b4e60ded2af6b25173eec421f0dba8ad 08:21:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:21:42 INFO - mozversion platform_version: 51.0a1 08:21:42 INFO - using testdate: 1471879302 08:21:42 INFO - actual date: 1471879302 08:21:42 INFO - starting webserver on 'localhost:38073' 08:21:42 INFO - SUITE-START | Running 2 tests 08:21:42 INFO - TEST-START | dromaeo_css 08:21:42 INFO - operating with platform_type : linux_ 08:21:42 INFO - Initialising browser for dromaeo_css test... 08:21:42 INFO - TEST-INFO | started process 4654 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphB79x2/profile http://localhost:38073/getInfo.html) 08:21:46 INFO - PROCESS | 4654 | __metrics Screen width/height:1600/1200 08:21:46 INFO - PROCESS | 4654 | colorDepth:24 08:21:46 INFO - PROCESS | 4654 | Browser inner width/height: 1024/697 08:21:46 INFO - PROCESS | 4654 | __metrics 08:21:47 INFO - PROCESS | 4654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:21:47 INFO - PROCESS | 4654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:21:48 INFO - TEST-INFO | 4654: exit 0 08:21:48 INFO - Browser initialized. 08:21:48 INFO - Running cycle 1/1 for dromaeo_css test... 08:21:48 INFO - TEST-INFO | started process 4734 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphB79x2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:22:00 INFO - PROCESS | 4734 | RSS: Main: 175669248 08:22:00 INFO - PROCESS | 4734 | 08:22:52 INFO - PROCESS | 4734 | 1471879372110 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:25:04 INFO - PROCESS | 4734 | Cycle 1(1): loaded http://localhost:38073/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38073/tests/dromaeo/cssquery-ext.html) 08:25:05 INFO - PROCESS | 4734 | RSS: Main: 254337024 08:25:05 INFO - PROCESS | 4734 | 08:28:08 INFO - PROCESS | 4734 | Cycle 1(1): loaded http://localhost:38073/tests/dromaeo/cssquery-ext.html (next: http://localhost:38073/tests/dromaeo/cssquery-jquery.html) 08:28:08 INFO - PROCESS | 4734 | RSS: Main: 273256448 08:28:08 INFO - PROCESS | 4734 | 08:31:11 INFO - PROCESS | 4734 | Cycle 1(1): loaded http://localhost:38073/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38073/tests/dromaeo/cssquery-mootools.html) 08:31:11 INFO - PROCESS | 4734 | RSS: Main: 260493312 08:31:11 INFO - PROCESS | 4734 | 08:34:14 INFO - PROCESS | 4734 | Cycle 1(1): loaded http://localhost:38073/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38073/tests/dromaeo/cssquery-prototype.html) 08:34:14 INFO - PROCESS | 4734 | RSS: Main: 219402240 08:34:14 INFO - PROCESS | 4734 | 08:37:17 INFO - PROCESS | 4734 | Cycle 1(1): loaded http://localhost:38073/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38073/tests/dromaeo/cssquery-yui.html) 08:37:18 INFO - PROCESS | 4734 | RSS: Main: 218501120 08:37:18 INFO - PROCESS | 4734 | 08:40:21 INFO - PROCESS | 4734 | Cycle 1(1): loaded http://localhost:38073/tests/dromaeo/cssquery-yui.html (next: http://localhost:38073/tests/dromaeo/cssquery-dojo.html) 08:40:21 INFO - PROCESS | 4734 | RSS: Main: 311865344 08:40:21 INFO - PROCESS | 4734 | 08:40:21 INFO - PROCESS | 4734 | __start_tp_report 08:40:21 INFO - PROCESS | 4734 | _x_x_mozilla_page_load 08:40:21 INFO - PROCESS | 4734 | _x_x_mozilla_page_load_details 08:40:21 INFO - PROCESS | 4734 | |i|pagename|runs| 08:40:21 INFO - PROCESS | 4734 | |0;dojo.html;2566.7818235449986;2606.0878692457636;2609.556375416179;2616.0582190411446;2627.710951795302;4507.549245075491;4573.931391029138;4590.517995610463;4656.580907718305;4663.743494107823;4618.792154353054;4633.837815676452;4635;4708.576228139466;4741.502142275054;4038.6163314485225;4252.468441444819;4308.892277693067;4332.220200363933;4350.15172041452;4310.612044915957;4342.3052311630145;4357.346398040288;4359;4361;4087.4073259377224;4131.194417088669;4284.036091879302;4289.871303860889;4307.6123148916595;4164.56272091429;4180.435641188462;4182.686298527623;4208.684348673862;4244.0663054128045;4169.4162817205615;4202.432671589327;4220.831166753326;4250.4899412070445;4263.829446822124;4633.9304910426035;4647.697899636512;4653.0228651983125;4660.184467718136;4665.486796452387;4756.07256584966;4858.489858564835;4865.34317867087;4990.4011518617635;4992.675476094042;4945.431275403339;4956.578690811285;4964;4970.925436118461;4972.701637901701;4590.059037897223;4614.5385461453925;4627.9768601156775;4632.096741135446;4632.768361581908;4899.608031357483;4971.527704868032;5001.149804533238;5017.623678224148;5057.089723849669;4857.757112144379;4876.975615121902;4883.8290659826735;4885.1450996076255;4885.389326334208;4952.678075925053;4962.8759281018265;4967.155583550805;4969.776360063805;4970;4676.415448068991;4784.593309568656;4855.295982082649;4859.878503037452;4916.508349165127;4902.313676085351;4908.730019848871;4915.827946021944;4916.016796640686;4929.556339929351;4274.636655884223;4291.270484017725;4292.420523229386;4297.935530967038;4308.74147551148;3651.6165802590876;3690.206605579813;3714.9071273217846;3740.8129593520216;3772.434134879735;4288.356746488052;4337.891552711208;4357.9564204358185;4359.215341238608;4369.3227549729845;4995.275685025724;5002.449730529639;5006.6495345325475;5008.223725322581;5016.824411145592;4140.37894315849;4192.81132349045;4327.675424343124;4328.11273688893;4343.04453020335;4413.742083506186;4461.018575913294;4479.574440428154;4480.4623445186135;4505.842295519707;4682.086993036325;4683.297505374221;4689.507601701772;4692.061587682409;4695.85912422621;4805.975970120127;4806.158922188673;4912.45962944083;4921.8523444296725;4924;4634.814607415666;4702.576768090888;4718.480967093548;4719.929201061918;4726.1020406122725;4858.684185527929;4870.561649451566;4878.121938051185;4878.926816097833;4881.29221262922;4776.8566942991765;4840.782164802522;4899.191633380595;4903.681260718042;4904.288878112725;4731.4558825735485;4827.372441582572;4836.12949669063;4860.805567777249;4876.4392094909535;4865.440474345495;4869.9026019480125;4873.269009648581;4880.46314905353;4882.023595281029;4605.792739326671;4618.237990731492;4767.6662633615315;4794.352762377034;4799.832005879777;4709.7174169549935;4796.400449943757;4810.6632535722165;4817.9165334185445;4818.084563932842;4691.577758001797;4693.389859318403;4694.483606803317;4697.060587882505;4734.786934588021 08:40:21 INFO - PROCESS | 4734 | |1;ext.html;552.7264004317861;570.3668927490486;570.4808624152017;589.7847285740703;593.5489028338461;29077.41845163098;31769;38482.42276365857;39630.405543916866;39836.402453963216;40462.59537404632;40719.38920916188;40754.18491630166;40787.18425631485;40831.183376332454;7500.5874676892745;7640.083190017206;7643.541387516739;7651.961740191319;7655.464117511777;7459.515131516461;7536.434767392468;9559.56981935811;9766.169875560587;9792.265580081486;10012.499375031255;10033.799324013515;10083.596656133783;10094.44480553573;10097.19222462205;9761.170300524464;9780.706578802647;9802.117809397118;9805.803883922354;9811.901880981206;9671.90328096717;9699.272554558365;9744.220462362993;9745.074217949283;9749.853752193723;38127.61872381269;38481.23037539233;38498.230035399414;38533.229335413416;38665.613343866484;2938.76489880809;3007.8646460909094;3059.265776213715;3192.2817366092677;3208.3262514871903;28793.712062879313;28997.165555511223;29084.70915290841;29587.11238662822;31191.376172476652;3277;3292.93414131716;3391.118309239591;3419.760616756828;3498.1954150545516;254269;256426;256624;256936;257378;54294.18558721623;54687.72656136694;54713.452865471634;54741;54823.72588137034;34044.65955340464;35000;35039.82480087634;35073.42169602374;35142.297154056774;12764.872351276554;13086.280254586089;13513.594592162252;13602.455901764017;13807.17156970585;9656.71029869105;10295;10340.793184136426;10404.635837745642;10457.372557646566;17716.114194290232;18195.26996965619;18233;18676.719849202273;18707.90646046761;5813.593048486566;5928.8814223716145;5997.190379298826;6000.309964354068;6043.859955930202;803.1005274092936;868.5092922498768;871.1506281375608;901.0718959471754;975.6048800235916;27429.45141097167;28201.57697634537;28425.43149137047;28578.142655719945;28738.71261287402;917.4862077236769;933.206774241889;952.6903756279098;954.7899462118323;997.6059456514781;14233.572992810232;14904.925475372771;14940.626484337978;15118.470853520073;15316.463923762614;420778;423524;425336;425792;426171;48611.27083093757;49013;49047.754761225966;49075.50924490781;49096;1147.1339138950207;1188.3226560860226;1190.8630507491575;1200.867904530501;1202.6331968749616;26354.86822565875;27401.86299068492;27741.44517109606;27894.401402139254;28268.43463130767;42042.57957420387;42831.785841070596;42865.78567107145;42923.78538107289;42954;267356;267889;268270;268406;268459;22211.111555537598;22496;23394.883025584764;23615.173468928504;23669.763302366755;39478.802605986784;40942.79528602338;41172;44391.77804110959;44460.22159113599;29540.261493462836;29751.851240743657;30550.847245763627;30779.4245858762;31471.842640787567;35013.29973400467;35072.824635876656;35085.824570878;35911.461328079575;35915.28169436649;35718.107047324025;35819;36099.097522562144;37579;37633.81183094067;33603.26702569558;36929.26141477102;37071.258574827814;37118.44322335221;37499.43750843685;28253.43493130167;29339.706602933697;30067;30302.84848575743;30311.848440757654 08:40:21 INFO - PROCESS | 4734 | |2;jquery.html;346.04664150266046;366.9467927150564;372.2201986837574;377.39993410477337;394.3571977676387;12802.359882005909;16237.512874613765;16761.66476670466;17140.914295428505;17838.10809459528;16413;16628.33486660532;16648.33406663735;16789.832101678978;16916.74624880625;4885.633577481685;4915.262710593403;4939.20972644377;4941.382327209108;4954.207326827708;3685.318216130011;4966.50334966504;4980.452150263468;5520.144377621455;5824.825255242328;5835.795747148851;5836.270466191726;5844.211031510734;5845.5908086433965;5846.88306233875;5629.902169077011;5748.770049198027;5788.8842223155725;5802.796902108406;5819.243498345209;5077.771500282459;5080.212567052113;5089.312942752718;5094.5160209780015;5108.6168537359845;20126.89936550308;20541.79458205429;20611.69082463764;20794.27220047306;20888.164473421046;1988.6321030609383;2021.676531754912;2112.3979665795327;2158.5035441848304;2406.7713567211085;12992.740145197044;13157.276349800757;13293;13543;13624.591262262147;1736.6353065856185;1749;1750.6586215687946;1764.514758441426;1792.4264235444664;67781;67936.66031669859;68660;69139.3086069138;70201.64899175522;9712.368696034735;9718.854217186748;9842.212622990286;9931.702048938543;10099.34354266985;13603.251821149932;13609.52366667162;13626.523071692642;13628.386722597308;13638.522651707142;6990.930090699129;7011.859308396327;7163.570185788765;7268.200497945222;7286.672099755524;6634.535582509178;6657.53397262187;6800.625965571941;6857.588544687235;6867.793966181022;6048.092786082035;6063.302720187146;6114.633122012693;6194.845128871724;6261.843453913689;1758.2175931710522;1785.8571314294825;1797.748315235868;1801.6216594515035;1829.5974885525163;886.9201771840566;920.2959735802117;930.6742640075919;975.8292298847673;984.7439665686973;16102.194890255674;17166.05586692719;17212.913935430493;17453.21460534279;17990.01054941991;814.4444111746536;831.6507067031861;868.7914900423852;888.6623083228332;953.3707752883064;7795.844083118306;9158.741915759836;9614.230861531061;9904.851427228597;9963;438990;441509;445315;469327;474175;76617.61691191509;79646.20353796503;79755.60122199469;81106;81945.59027204826;890.875277461156;891.9777005574913;937.4609599480326;947.280067148958;948.2745699539857;15524.37902483888;15872.92063539675;16191.595210119842;16367.832593102105;16405.507834764976;36831.44752828656;36837.26325473422;38296;38989.610103898594;39371.606283936795;49481.50518494913;50124.498755011984;50303.49696503134;51490.48509515007;52017;6832.214295356098;6835.965820170867;7079.893801592877;7106.5736055836815;7163.677634506564;10017.298789084694;10079.496025198858;10115.494225288854;10329.276950613385;10779.568817247537;9073;9304.116108969638;9342.53287335644;9432.434053956784;10151.289409741246;9256;9619;9661.420314780855;9718.9028109718;9842.261830362895;9536.189423899046;9771.706848794547;9937.751556210864;10056.094951454405;10230.795384092426;6965;7184.497085203986;7288.271172882669;7355.190928997699;7448.702051917862;8493.235608795238;9550.808983820145;9645.758856028375;9883.85174222373;9898.356606820533 08:40:21 INFO - PROCESS | 4734 | |3;mootools.html;1241.5840693367722;1351.3851197705046;1394.4004078246355;1449.9637509062272;1669.0653234188846;6591.406773390394;7310.926890731091;7647.311741943224;7650.923490765091;7863.724769633064;7673.884891726629;7744.148143704188;7746.38028957682;7747.92252077479;7749.961250193755;2170.9565808683815;2202.9559408811815;2203.3500117465387;2204.889755512218;2206.3160420269687;2148.581026699794;2184.6176919039185;2223.2329846203033;2224.7552769195377;2225.899834507443;2194.5281764420647;2212.65703815908;2214.944626384337;2215.6233440315186;2221.31139346803;1882.0401595186554;1895.8578106641987;1905.2188602672907;1907.7901430842596;1909.8949557774317;2131.6802479628027;2180.705604743371;2182.3234797212913;2187.267265466071;2187.628103222456;7433.070866141732;7525.360344370735;7695.192004839467;7700.576468294242;7703.959965404655;4341.630961368288;4450.310201918708;4481.058977614704;4482.327650852366;4482.327650852399;2741.9862900685566;2900.1154647832404;2907.6656184538624;2938.296766974389;2966.1842993176833;931.329442801182;943.2831048403194;945.664289177346;952.2001518724236;965.748905284624;10914.072303854182;10953.890461095367;11006.669799906016;11032.944835275852;11036.724081897937;3978.920421591552;4086.3666131749033;4100.323446631332;4148.066684995852;4191.97904010478;8201.466904651179;8275.95862020698;8332.250097491255;8342.958285208535;8345.41582089248;4601.102784956901;4603.769811509478;4609.170349337084;4611.792469338888;4612.86161415158;3636.127329440915;4069.1861627673993;4258.467691538558;4264.189803937242;4269.743815371087;3547.396942519778;3561.465780132949;3667.541557305337;3674.614165512636;3718.6095459976855;1035.4512108582464;1078.2883297024084;1082.6210826210763;1090.5256213547132;1099.290957332516;782.4522834016211;794.7099308752379;847.5719761520393;851.6125163050797;861.7027125641644;5112.079825631347;5230.97384513075;5232.058229518723;5242.18746094356;5309.46905309466;891.6700820696254;894.821035792844;920.4090485283905;925.2242480076469;929.7117893453051;3395.3209358128474;3405.0806282304134;3499.177693242086;3560.359135355661;3565.94651080234;9522.85715714265;9941.850872236922;9959.153471954965;9960.153386962045;10017.549210285555;9783.657571985088;9790;9893.802123957481;9896.356736812228;9912;6962.268961759044;7253.419726421874;7267.38227250679;7435;7438.293362130589;5189.351331083614;5277.498637629419;5387.353517577916;5429.647072940246;5468.425815289337;8850.291976641724;9013.098690130935;9089.045650206897;9109.134632209929;9140.954295228747;8896.243819275434;9195.126462986005;9347.672831450867;9378.531073446164;9395.671151509665;5814.505767009851;6433.292337842927;6561.442277406283;6571.310012448624;7077.115360579927;7501.474896757175;7573.659185336784;7719.035120609924;7720.613969301625;7723.150453450228;6769.830754231184;6784.864302714017;6831.795046148623;6834.794956151323;6872.278410766998;6309.305976342507;6342.112104305309;6451.935480645134;6636.004599310142;6872.62200578973;6054.576179667381;6161.291451483136;6176.073588961692;6188.040853667689;6188.783392581238;4421.513633500376;4627.583517483443;4640.443146822268;4648.907021859476;4660.6970546914345;4502.459704835441;4507.752073635981;4595.0350426409495;4631.4905360411;4726.385569875894 08:40:21 INFO - PROCESS | 4734 | |4;prototype.html;302.0726370043965;307.9168624471393;309.7599360495616;313.39201948220466;315.4952076677318;4678.111158879815;4684.695494792836;4696.17816882046;4703.753505321089;4741.502142275063;4651.348811166431;4662.836800711976;4664.766761661912;4671.672982891199;4690.97654511727;3548.556430446194;3645.8359373828243;3648.361536731075;3668.6514781095752;3682.2819550187724;3690.6713583110195;3697.611750766171;3700.3524383232825;3716.8513259469723;3726.4969229154126;3672.2288319452946;3677.848458651692;3683.0976410779263;3687.3731465650903;3706.0734816295926;3505.298940211968;3546.7517273790586;3666.5966743658178;3675.8897233082785;3708.8887333379907;3266.379387916288;3270.1824543864036;3272.2473831018997;3275.279438523521;3277.4100661880852;4445;4516.638668906512;4523.864284071483;4525.547445255481;4532.5240849710635;3908.7654740715648;4182.519010313822;4186.623203911662;4186.790660466964;4188.916221675549;4821.204501257288;4825.131476334259;4837.346958160673;4842.44311904132;4857.319975203474;3506.8772592959126;3510.4558793387064;3512.1570823002553;3515.8769443069627;3519.8768043118366;5051.747412629391;5078.492150784966;5079.6952182869145;5083.491650834924;5088.821891233789;3479.408500554912;3573.4103872861206;3584.856605735741;3622.3841946869097;3629.6007439181667;3663.139162296858;3670.8436842394563;3674.3202507536193;3674.797886116289;3679.392900171442;4148.56440073794;4174.08170202555;4176.164767046542;4177.498700156001;4182.477190351206;4796.841421360402;4849.151398505247;4867.853964381075;4919.631027672867;4925.87685307863;1237.2761934268553;1252.6179515247754;1254.0970501239094;1254.6298841841678;1263;776.3168411797582;794.1819925476768;815.808285053012;816.3387655998661;825.9793505162419;4173.040200753843;4255.170241802819;4339.500957389878;4382.255016647177;4398.296272596369;5029.497050294941;5043;5044.798208071709;5049.444561098277;5053.545180933734;4282.186384586981;4319.352097185448;4368.344748287782;4381.671374646914;4386.780660966939;2538.149719843836;2642.65645466092;2662.188032650022;2662.9467410651678;2663.961055188478;4787.760611969387;4789.688670236424;4801.159797035505;4813.566778989908;4826.276058591239;5137.948620513822;5144.736316020939;5158.7955816009835;5165.896682066337;5178.145605974972;4587.79354929029;4763.404574428197;4764.618830493552;4814.325994360793;4824.614030877591;5002.699838009731;5003.824866129668;5016.423111342242;5030.798768049237;5049.803335549048;4966.726830024383;4969.726665033313;4994.750262486788;5000.774965126505;5011.874703132305;4572.954270457253;4802.271182374273;4830.613550915848;4833.444153922203;4838.298446725134;3608.2242317900727;3632.7275454341557;3634.2186429917697;3635.4546817977516;3647.1246900744163;5094.083065048327;5098.847034588968;5110.66780659256;5128.820491282787;5130.333056702605;4803.207470767285;4891.755412229303;4922.581580565692;4964.758810297426;4976.552110310089;4908.950910490849;4910.607151427948;4911.656184067081;4913.533214344631;4915.655904086822;4843.539863712942;4858.17411040117;4865.635077369141;4871.63462740303;4884.853454396374;4664.930026049544;4766.356541866942;4803.543663351976;4871.56378990133;4882.658213924991;4778.617710583215;4784.30627558995;4796.496367881462;4800.5199480051715;4813.638977076804 08:40:21 INFO - PROCESS | 4734 | |5;yui.html;602.551099430924;649.8407890066934;676.7766637009785;685.8285428642839;688.390774164864;11454.599089031886;11682.47428865701;12206.816897746541;12326.198797078183;12450.505939287275;13589.660258493543;13700;13726.176429414218;13741.175529468239;13749.037567370287;630.262592766462;756.5990025286593;779.5050143159078;783.5807842804101;784.3098073695169;750.2460027672182;767.1906139023329;770.8265640230959;779.6374685771116;779.7426849139798;822.2558584481054;824.6412810427453;825.0305890578576;825.6243409248807;833.4957350802767;649.7530938243484;821.0434843407423;825.5789547330844;827.2967977219375;827.6317038917684;570.8858228354346;589.979350722727;592.8043745563954;596.4870211618048;596.7523477756769;12016.819747703792;12034.458449369798;12056.517739290417;12061.095417843697;12067.637970860887;12137.271763694207;12332.300827664527;12837.229766213964;12935.094543381967;13441.596752097452;10707.78584428315;10730.517126729237;10756.19328550362;10993.780124397466;11001.17491188156;3994.7003974702016;4015.678745700337;4022.597740225983;4056.5740597237454;4062.106336605942;65259.67370163166;69020.6548967257;70380.99999999949;70615.29384706139;71205.6439717798;9855.408675479493;9957.352772069793;9970.800583988424;9997.150242229493;10104;19850.404487865388;19852.900735496518;19856.404307870787;19862.50343741418;19863;6544.7382104716235;6679.298673639295;6705.530612857053;6882.174139103339;6976;3697.4453831925425;3712.925741485155;3760.4923335349376;3761.774293542396;3830.6209764484765;2622.6983896851725;2639.2082375287337;2703.337682267857;2715.91852244433;2716.5246081935584;477.17925168709763;482.46205480888557;483.82824097445604;498.0810404803132;505.0883155903629;463.4693276198801;481.08833760024555;486.7006790823618;514.8095204774257;542.5822116969911;6760.425363844129;6863.313668633196;7121.394681452135;7551.811204719926;7561.546307221584;420.2540490629158;469.40385710148604;486.31186870578443;496.3200415430883;535.9785608575692;3522.682958533693;3583.6416358363954;3598.514200582888;3654.543182102237;3800.410936304877;56984;98215;100900.99099009062;105160;105540.47229763801;88449;89339.55330223308;89971;90821.79866305561;92331;76994;78622;79633;79750;80316;6870.931290687229;6925.238223795278;7197.712091516491;7278.417726581966;7338.119425668954;46030.76984615056;46667.299990499494;47264;47453;48466;60837.391626084944;66158.66920665366;66381;67616.66191669011;67832.3216767826;9043.773905652411;9153.816923661623;9169.220616247694;9385.15533601979;9511.809763804547;9961.551730172305;10157.542910568895;10187.235957303084;10279.434631095362;10420.374777513374;9639.132478077006;9735.367201131903;9875.308728388944;10010.249231307535;10038.799224015625;9067.501287429255;9079.182873541413;9085.863712044193;9475.526223688927;9506.714798556055;8993.955030224806;9216.723498295061;9252.95373523128;9404.059594040542;9465.810683786423;7895.486793358414;8085.838283234185;8146.307563856902;8255.876161857697;9068.22920051803;7827.373810095065;8270.338372930031;8516.233538981522;8735.519546424754;8739.431936924333 08:40:21 INFO - PROCESS | 4734 | __end_tp_report 08:40:21 INFO - PROCESS | 4734 | __start_cc_report 08:40:21 INFO - PROCESS | 4734 | _x_x_mozilla_cycle_collect,977 08:40:21 INFO - PROCESS | 4734 | __end_cc_report 08:40:21 INFO - PROCESS | 4734 | __startTimestamp1471880421799__endTimestamp 08:40:21 INFO - PROCESS | 4734 | 08:40:21 INFO - PROCESS | 4734 | ------- Summary: start ------- 08:40:21 INFO - PROCESS | 4734 | Number of tests: 6 08:40:21 INFO - PROCESS | 4734 | 08:40:21 INFO - PROCESS | 4734 | [#0] dojo.html Cycles:165 Average:4569.82 Median:4693.39 stddev:463.83 (9.9%) stddev-sans-first:437.83 08:40:21 INFO - PROCESS | 4734 | Values: 2566.8 2606.1 2609.6 2616.1 2627.7 4507.5 4573.9 4590.5 4656.6 4663.7 4618.8 4633.8 4635.0 4708.6 4741.5 4038.6 4252.5 4308.9 4332.2 4350.2 4310.6 4342.3 4357.3 4359.0 4361.0 4087.4 4131.2 4284.0 4289.9 4307.6 4164.6 4180.4 4182.7 4208.7 4244.1 4169.4 4202.4 4220.8 4250.5 4263.8 4633.9 4647.7 4653.0 4660.2 4665.5 4756.1 4858.5 4865.3 4990.4 4992.7 4945.4 4956.6 4964.0 4970.9 4972.7 4590.1 4614.5 4628.0 4632.1 4632.8 4899.6 4971.5 5001.1 5017.6 5057.1 4857.8 4877.0 4883.8 4885.1 4885.4 4952.7 4962.9 4967.2 4969.8 4970.0 4676.4 4784.6 4855.3 4859.9 4916.5 4902.3 4908.7 4915.8 4916.0 4929.6 4274.6 4291.3 4292.4 4297.9 4308.7 3651.6 3690.2 3714.9 3740.8 3772.4 4288.4 4337.9 4358.0 4359.2 4369.3 4995.3 5002.4 5006.6 5008.2 5016.8 4140.4 4192.8 4327.7 4328.1 4343.0 4413.7 4461.0 4479.6 4480.5 4505.8 4682.1 4683.3 4689.5 4692.1 4695.9 4806.0 4806.2 4912.5 4921.9 4924.0 4634.8 4702.6 4718.5 4719.9 4726.1 4858.7 4870.6 4878.1 4878.9 4881.3 4776.9 4840.8 4899.2 4903.7 4904.3 4731.5 4827.4 4836.1 4860.8 4876.4 4865.4 4869.9 4873.3 4880.5 4882.0 4605.8 4618.2 4767.7 4794.4 4799.8 4709.7 4796.4 4810.7 4817.9 4818.1 4691.6 4693.4 4694.5 4697.1 4734.8 08:40:21 INFO - PROCESS | 4734 | 08:40:21 INFO - PROCESS | 4734 | [#1] ext.html Cycles:180 Average:46740.96 Median:35768.55 stddev:85813.27 (239.9%) stddev-sans-first:85983.93 08:40:21 INFO - PROCESS | 4734 | Values: 552.7 570.4 570.5 589.8 593.5 29077.4 31769.0 38482.4 39630.4 39836.4 40462.6 40719.4 40754.2 40787.2 40831.2 7500.6 7640.1 7643.5 7652.0 7655.5 7459.5 7536.4 9559.6 9766.2 9792.3 10012.5 10033.8 10083.6 10094.4 10097.2 9761.2 9780.7 9802.1 9805.8 9811.9 9671.9 9699.3 9744.2 9745.1 9749.9 38127.6 38481.2 38498.2 38533.2 38665.6 2938.8 3007.9 3059.3 3192.3 3208.3 28793.7 28997.2 29084.7 29587.1 31191.4 3277.0 3292.9 3391.1 3419.8 3498.2 254269.0 256426.0 256624.0 256936.0 257378.0 54294.2 54687.7 54713.5 54741.0 54823.7 34044.7 35000.0 35039.8 35073.4 35142.3 12764.9 13086.3 13513.6 13602.5 13807.2 9656.7 10295.0 10340.8 10404.6 10457.4 17716.1 18195.3 18233.0 18676.7 18707.9 5813.6 5928.9 5997.2 6000.3 6043.9 803.1 868.5 871.2 901.1 975.6 27429.5 28201.6 28425.4 28578.1 28738.7 917.5 933.2 952.7 954.8 997.6 14233.6 14904.9 14940.6 15118.5 15316.5 420778.0 423524.0 425336.0 425792.0 426171.0 48611.3 49013.0 49047.8 49075.5 49096.0 1147.1 1188.3 1190.9 1200.9 1202.6 26354.9 27401.9 27741.4 27894.4 28268.4 42042.6 42831.8 42865.8 42923.8 42954.0 267356.0 267889.0 268270.0 268406.0 268459.0 22211.1 22496.0 23394.9 23615.2 23669.8 39478.8 40942.8 41172.0 44391.8 44460.2 29540.3 29751.9 30550.8 30779.4 31471.8 35013.3 35072.8 35085.8 35911.5 35915.3 35718.1 35819.0 36099.1 37579.0 37633.8 33603.3 36929.3 37071.3 37118.4 37499.4 28253.4 29339.7 30067.0 30302.8 30311.8 08:40:21 INFO - PROCESS | 4734 | 08:40:21 INFO - PROCESS | 4734 | [#2] jquery.html Cycles:180 Average:26177.70 Median:51753.74 stddev:74668.40 (144.3%) stddev-sans-first:74852.67 08:40:21 INFO - PROCESS | 4734 | Values: 346.0 366.9 372.2 377.4 394.4 12802.4 16237.5 16761.7 17140.9 17838.1 16413.0 16628.3 16648.3 16789.8 16916.7 4885.6 4915.3 4939.2 4941.4 4954.2 3685.3 4966.5 4980.5 5520.1 5824.8 5835.8 5836.3 5844.2 5845.6 5846.9 5629.9 5748.8 5788.9 5802.8 5819.2 5077.8 5080.2 5089.3 5094.5 5108.6 20126.9 20541.8 20611.7 20794.3 20888.2 1988.6 2021.7 2112.4 2158.5 2406.8 12992.7 13157.3 13293.0 13543.0 13624.6 1736.6 1749.0 1750.7 1764.5 1792.4 67781.0 67936.7 68660.0 69139.3 70201.6 9712.4 9718.9 9842.2 9931.7 10099.3 13603.3 13609.5 13626.5 13628.4 13638.5 6990.9 7011.9 7163.6 7268.2 7286.7 6634.5 6657.5 6800.6 6857.6 6867.8 6048.1 6063.3 6114.6 6194.8 6261.8 1758.2 1785.9 1797.7 1801.6 1829.6 886.9 920.3 930.7 975.8 984.7 16102.2 17166.1 17212.9 17453.2 17990.0 814.4 831.7 868.8 888.7 953.4 7795.8 9158.7 9614.2 9904.9 9963.0 438990.0 441509.0 445315.0 469327.0 474175.0 76617.6 79646.2 79755.6 81106.0 81945.6 890.9 892.0 937.5 947.3 948.3 15524.4 15872.9 16191.6 16367.8 16405.5 36831.4 36837.3 38296.0 38989.6 39371.6 49481.5 50124.5 50303.5 51490.5 52017.0 6832.2 6836.0 7079.9 7106.6 7163.7 10017.3 10079.5 10115.5 10329.3 10779.6 9073.0 9304.1 9342.5 9432.4 10151.3 9256.0 9619.0 9661.4 9718.9 9842.3 9536.2 9771.7 9937.8 10056.1 10230.8 6965.0 7184.5 7288.3 7355.2 7448.7 8493.2 9550.8 9645.8 9883.9 9898.4 08:40:21 INFO - PROCESS | 4734 | 08:40:21 INFO - PROCESS | 4734 | [#3] mootools.html Cycles:180 Average:5107.63 Median:5259.84 stddev:2900.46 (55.1%) stddev-sans-first:2894.05 08:40:21 INFO - PROCESS | 4734 | Values: 1241.6 1351.4 1394.4 1450.0 1669.1 6591.4 7310.9 7647.3 7650.9 7863.7 7673.9 7744.1 7746.4 7747.9 7750.0 2171.0 2203.0 2203.4 2204.9 2206.3 2148.6 2184.6 2223.2 2224.8 2225.9 2194.5 2212.7 2214.9 2215.6 2221.3 1882.0 1895.9 1905.2 1907.8 1909.9 2131.7 2180.7 2182.3 2187.3 2187.6 7433.1 7525.4 7695.2 7700.6 7704.0 4341.6 4450.3 4481.1 4482.3 4482.3 2742.0 2900.1 2907.7 2938.3 2966.2 931.3 943.3 945.7 952.2 965.7 10914.1 10953.9 11006.7 11032.9 11036.7 3978.9 4086.4 4100.3 4148.1 4192.0 8201.5 8276.0 8332.3 8343.0 8345.4 4601.1 4603.8 4609.2 4611.8 4612.9 3636.1 4069.2 4258.5 4264.2 4269.7 3547.4 3561.5 3667.5 3674.6 3718.6 1035.5 1078.3 1082.6 1090.5 1099.3 782.5 794.7 847.6 851.6 861.7 5112.1 5231.0 5232.1 5242.2 5309.5 891.7 894.8 920.4 925.2 929.7 3395.3 3405.1 3499.2 3560.4 3565.9 9522.9 9941.9 9959.2 9960.2 10017.5 9783.7 9790.0 9893.8 9896.4 9912.0 6962.3 7253.4 7267.4 7435.0 7438.3 5189.4 5277.5 5387.4 5429.6 5468.4 8850.3 9013.1 9089.0 9109.1 9141.0 8896.2 9195.1 9347.7 9378.5 9395.7 5814.5 6433.3 6561.4 6571.3 7077.1 7501.5 7573.7 7719.0 7720.6 7723.2 6769.8 6784.9 6831.8 6834.8 6872.3 6309.3 6342.1 6451.9 6636.0 6872.6 6054.6 6161.3 6176.1 6188.0 6188.8 4421.5 4627.6 4640.4 4648.9 4660.7 4502.5 4507.8 4595.0 4631.5 4726.4 08:40:21 INFO - PROCESS | 4734 | 08:40:21 INFO - PROCESS | 4734 | [#4] prototype.html Cycles:180 Average:4079.93 Median:4668.30 stddev:1181.56 (25.3%) stddev-sans-first:1150.35 08:40:21 INFO - PROCESS | 4734 | Values: 302.1 307.9 309.8 313.4 315.5 4678.1 4684.7 4696.2 4703.8 4741.5 4651.3 4662.8 4664.8 4671.7 4691.0 3548.6 3645.8 3648.4 3668.7 3682.3 3690.7 3697.6 3700.4 3716.9 3726.5 3672.2 3677.8 3683.1 3687.4 3706.1 3505.3 3546.8 3666.6 3675.9 3708.9 3266.4 3270.2 3272.2 3275.3 3277.4 4445.0 4516.6 4523.9 4525.5 4532.5 3908.8 4182.5 4186.6 4186.8 4188.9 4821.2 4825.1 4837.3 4842.4 4857.3 3506.9 3510.5 3512.2 3515.9 3519.9 5051.7 5078.5 5079.7 5083.5 5088.8 3479.4 3573.4 3584.9 3622.4 3629.6 3663.1 3670.8 3674.3 3674.8 3679.4 4148.6 4174.1 4176.2 4177.5 4182.5 4796.8 4849.2 4867.9 4919.6 4925.9 1237.3 1252.6 1254.1 1254.6 1263.0 776.3 794.2 815.8 816.3 826.0 4173.0 4255.2 4339.5 4382.3 4398.3 5029.5 5043.0 5044.8 5049.4 5053.5 4282.2 4319.4 4368.3 4381.7 4386.8 2538.1 2642.7 2662.2 2662.9 2664.0 4787.8 4789.7 4801.2 4813.6 4826.3 5137.9 5144.7 5158.8 5165.9 5178.1 4587.8 4763.4 4764.6 4814.3 4824.6 5002.7 5003.8 5016.4 5030.8 5049.8 4966.7 4969.7 4994.8 5000.8 5011.9 4573.0 4802.3 4830.6 4833.4 4838.3 3608.2 3632.7 3634.2 3635.5 3647.1 5094.1 5098.8 5110.7 5128.8 5130.3 4803.2 4891.8 4922.6 4964.8 4976.6 4909.0 4910.6 4911.7 4913.5 4915.7 4843.5 4858.2 4865.6 4871.6 4884.9 4664.9 4766.4 4803.5 4871.6 4882.7 4778.6 4784.3 4796.5 4800.5 4813.6 08:40:21 INFO - PROCESS | 4734 | 08:40:21 INFO - PROCESS | 4734 | [#5] yui.html Cycles:180 Average:17820.93 Median:32954.76 stddev:26649.44 (80.9%) stddev-sans-first:26692.83 08:40:21 INFO - PROCESS | 4734 | Values: 602.6 649.8 676.8 685.8 688.4 11454.6 11682.5 12206.8 12326.2 12450.5 13589.7 13700.0 13726.2 13741.2 13749.0 630.3 756.6 779.5 783.6 784.3 750.2 767.2 770.8 779.6 779.7 822.3 824.6 825.0 825.6 833.5 649.8 821.0 825.6 827.3 827.6 570.9 590.0 592.8 596.5 596.8 12016.8 12034.5 12056.5 12061.1 12067.6 12137.3 12332.3 12837.2 12935.1 13441.6 10707.8 10730.5 10756.2 10993.8 11001.2 3994.7 4015.7 4022.6 4056.6 4062.1 65259.7 69020.7 70381.0 70615.3 71205.6 9855.4 9957.4 9970.8 9997.2 10104.0 19850.4 19852.9 19856.4 19862.5 19863.0 6544.7 6679.3 6705.5 6882.2 6976.0 3697.4 3712.9 3760.5 3761.8 3830.6 2622.7 2639.2 2703.3 2715.9 2716.5 477.2 482.5 483.8 498.1 505.1 463.5 481.1 486.7 514.8 542.6 6760.4 6863.3 7121.4 7551.8 7561.5 420.3 469.4 486.3 496.3 536.0 3522.7 3583.6 3598.5 3654.5 3800.4 56984.0 98215.0 100901.0 105160.0 105540.5 88449.0 89339.6 89971.0 90821.8 92331.0 76994.0 78622.0 79633.0 79750.0 80316.0 6870.9 6925.2 7197.7 7278.4 7338.1 46030.8 46667.3 47264.0 47453.0 48466.0 60837.4 66158.7 66381.0 67616.7 67832.3 9043.8 9153.8 9169.2 9385.2 9511.8 9961.6 10157.5 10187.2 10279.4 10420.4 9639.1 9735.4 9875.3 10010.2 10038.8 9067.5 9079.2 9085.9 9475.5 9506.7 8994.0 9216.7 9253.0 9404.1 9465.8 7895.5 8085.8 8146.3 8255.9 9068.2 7827.4 8270.3 8516.2 8735.5 8739.4 08:40:21 INFO - PROCESS | 4734 | -------- Summary: end -------- 08:40:21 INFO - PROCESS | 4734 | 08:40:22 INFO - TEST-INFO | 4734: exit 0 08:40:22 INFO - TEST-OK | dromaeo_css | took 1120728ms 08:40:22 INFO - TEST-START | kraken 08:40:22 INFO - operating with platform_type : linux_ 08:40:22 INFO - Initialising browser for kraken test... 08:40:22 INFO - TEST-INFO | started process 5039 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprpbxAS/profile http://localhost:38073/getInfo.html) 08:40:27 INFO - PROCESS | 5039 | __metrics Screen width/height:1600/1200 08:40:27 INFO - PROCESS | 5039 | colorDepth:24 08:40:27 INFO - PROCESS | 5039 | Browser inner width/height: 1024/697 08:40:27 INFO - PROCESS | 5039 | __metrics 08:40:27 INFO - PROCESS | 5039 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:40:27 INFO - PROCESS | 5039 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:40:28 INFO - PROCESS | 5039 | console.error: PushService: 08:40:28 INFO - PROCESS | 5039 | stateChangeProcessEnqueue: Error transitioning state 08:40:28 INFO - PROCESS | 5039 | UnknownError 08:40:29 INFO - TEST-INFO | 5039: exit 0 08:40:29 INFO - Browser initialized. 08:40:29 INFO - Running cycle 1/1 for kraken test... 08:40:29 INFO - TEST-INFO | started process 5119 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprpbxAS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:40:41 INFO - PROCESS | 5119 | RSS: Main: 175759360 08:40:41 INFO - PROCESS | 5119 | 08:40:43 INFO - PROCESS | 5119 | Cycle 1(1): loaded http://localhost:38073/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38073/tests/kraken/driver.html?testName=audio-beat-detection) 08:40:44 INFO - PROCESS | 5119 | RSS: Main: 235888640 08:40:44 INFO - PROCESS | 5119 | 08:40:47 INFO - PROCESS | 5119 | Cycle 1(1): loaded http://localhost:38073/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38073/tests/kraken/driver.html?testName=audio-dft) 08:40:48 INFO - PROCESS | 5119 | RSS: Main: 227442688 08:40:48 INFO - PROCESS | 5119 | 08:40:51 INFO - PROCESS | 5119 | Cycle 1(1): loaded http://localhost:38073/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38073/tests/kraken/driver.html?testName=audio-fft) 08:40:52 INFO - PROCESS | 5119 | RSS: Main: 302448640 08:40:52 INFO - PROCESS | 5119 | 08:40:54 INFO - PROCESS | 5119 | Cycle 1(1): loaded http://localhost:38073/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38073/tests/kraken/driver.html?testName=audio-oscillator) 08:40:54 INFO - PROCESS | 5119 | RSS: Main: 210800640 08:40:54 INFO - PROCESS | 5119 | 08:40:57 INFO - PROCESS | 5119 | Cycle 1(1): loaded http://localhost:38073/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38073/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:40:57 INFO - PROCESS | 5119 | RSS: Main: 213745664 08:40:57 INFO - PROCESS | 5119 | 08:41:01 INFO - PROCESS | 5119 | Cycle 1(1): loaded http://localhost:38073/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38073/tests/kraken/driver.html?testName=imaging-darkroom) 08:41:01 INFO - PROCESS | 5119 | RSS: Main: 250855424 08:41:01 INFO - PROCESS | 5119 | 08:41:05 INFO - PROCESS | 5119 | Cycle 1(1): loaded http://localhost:38073/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38073/tests/kraken/driver.html?testName=imaging-desaturate) 08:41:05 INFO - PROCESS | 5119 | RSS: Main: 244924416 08:41:05 INFO - PROCESS | 5119 | 08:41:08 INFO - PROCESS | 5119 | Cycle 1(1): loaded http://localhost:38073/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38073/tests/kraken/driver.html?testName=json-parse-financial) 08:41:09 INFO - PROCESS | 5119 | RSS: Main: 248229888 08:41:09 INFO - PROCESS | 5119 | 08:41:11 INFO - PROCESS | 5119 | Cycle 1(1): loaded http://localhost:38073/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38073/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:41:11 INFO - PROCESS | 5119 | RSS: Main: 212029440 08:41:11 INFO - PROCESS | 5119 | 08:41:13 INFO - PROCESS | 5119 | Cycle 1(1): loaded http://localhost:38073/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38073/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:41:14 INFO - PROCESS | 5119 | RSS: Main: 218828800 08:41:14 INFO - PROCESS | 5119 | 08:41:16 INFO - PROCESS | 5119 | Cycle 1(1): loaded http://localhost:38073/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38073/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:41:17 INFO - PROCESS | 5119 | RSS: Main: 223944704 08:41:17 INFO - PROCESS | 5119 | 08:41:19 INFO - PROCESS | 5119 | Cycle 1(1): loaded http://localhost:38073/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38073/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:41:20 INFO - PROCESS | 5119 | RSS: Main: 218644480 08:41:20 INFO - PROCESS | 5119 | 08:41:23 INFO - PROCESS | 5119 | Cycle 1(1): loaded http://localhost:38073/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38073/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:41:24 INFO - PROCESS | 5119 | RSS: Main: 221642752 08:41:24 INFO - PROCESS | 5119 | 08:41:26 INFO - PROCESS | 5119 | Cycle 1(1): loaded http://localhost:38073/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38073/tests/kraken/driver.html?testName=ai-astar) 08:41:26 INFO - PROCESS | 5119 | RSS: Main: 271994880 08:41:26 INFO - PROCESS | 5119 | 08:41:26 INFO - PROCESS | 5119 | __start_tp_report 08:41:26 INFO - PROCESS | 5119 | _x_x_mozilla_page_load 08:41:26 INFO - PROCESS | 5119 | _x_x_mozilla_page_load_details 08:41:26 INFO - PROCESS | 5119 | |i|pagename|runs| 08:41:26 INFO - PROCESS | 5119 | |0;ai-astar;100;114;113;116;114;114;121;114;114;115 08:41:26 INFO - PROCESS | 5119 | |1;audio-beat-detection;155;122;143;189;123;153;156;123;184;128 08:41:26 INFO - PROCESS | 5119 | |2;audio-dft;162;162;162;159;159;161;162;162;160;160 08:41:26 INFO - PROCESS | 5119 | |3;audio-fft;75;76;76;163;77;80;76;129;120;75 08:41:26 INFO - PROCESS | 5119 | |4;audio-oscillator;87;86;148;87;86;87;127;86;86;139 08:41:26 INFO - PROCESS | 5119 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;117;116 08:41:26 INFO - PROCESS | 5119 | |6;imaging-darkroom;146;146;146;147;146;146;146;145;146;145 08:41:26 INFO - PROCESS | 5119 | |7;imaging-desaturate;95;95;95;94;94;95;94;95;95;95 08:41:26 INFO - PROCESS | 5119 | |8;json-parse-financial;65;65;66;66;69;66;67;65;66;66 08:41:26 INFO - PROCESS | 5119 | |9;json-stringify-tinderbox;66;71;66;67;66;66;66;66;66;66 08:41:26 INFO - PROCESS | 5119 | |10;stanford-crypto-aes;84;84;84;86;86;83;85;84;83;84 08:41:26 INFO - PROCESS | 5119 | |11;stanford-crypto-ccm;134;134;134;134;133;134;138;133;154;142 08:41:26 INFO - PROCESS | 5119 | |12;stanford-crypto-pbkdf2;176;178;174;171;175;171;174;176;176;174 08:41:26 INFO - PROCESS | 5119 | |13;stanford-crypto-sha256-iterative;71;70;72;70;70;71;69;69;69;69 08:41:26 INFO - PROCESS | 5119 | __end_tp_report 08:41:26 INFO - PROCESS | 5119 | __start_cc_report 08:41:26 INFO - PROCESS | 5119 | _x_x_mozilla_cycle_collect,2009 08:41:26 INFO - PROCESS | 5119 | __end_cc_report 08:41:26 INFO - PROCESS | 5119 | __startTimestamp1471880486327__endTimestamp 08:41:26 INFO - PROCESS | 5119 | 08:41:26 INFO - PROCESS | 5119 | ------- Summary: start ------- 08:41:26 INFO - PROCESS | 5119 | Number of tests: 14 08:41:26 INFO - PROCESS | 5119 | 08:41:26 INFO - PROCESS | 5119 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:5.25 (4.6%) stddev-sans-first:2.40 08:41:26 INFO - PROCESS | 5119 | Values: 100.0 114.0 113.0 116.0 114.0 114.0 121.0 114.0 114.0 115.0 08:41:26 INFO - PROCESS | 5119 | 08:41:26 INFO - PROCESS | 5119 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:154.00 stddev:24.64 (16.0%) stddev-sans-first:25.99 08:41:26 INFO - PROCESS | 5119 | Values: 155.0 122.0 143.0 189.0 123.0 153.0 156.0 123.0 184.0 128.0 08:41:26 INFO - PROCESS | 5119 | 08:41:26 INFO - PROCESS | 5119 | [#2] audio-dft Cycles:10 Average:160.90 Median:162.00 stddev:1.29 (0.8%) stddev-sans-first:1.30 08:41:26 INFO - PROCESS | 5119 | Values: 162.0 162.0 162.0 159.0 159.0 161.0 162.0 162.0 160.0 160.0 08:41:26 INFO - PROCESS | 5119 | 08:41:26 INFO - PROCESS | 5119 | [#3] audio-fft Cycles:10 Average:94.70 Median:76.00 stddev:31.33 (41.2%) stddev-sans-first:32.41 08:41:26 INFO - PROCESS | 5119 | Values: 75.0 76.0 76.0 163.0 77.0 80.0 76.0 129.0 120.0 75.0 08:41:26 INFO - PROCESS | 5119 | 08:41:26 INFO - PROCESS | 5119 | [#4] audio-oscillator Cycles:10 Average:101.90 Median:86.00 stddev:25.41 (29.5%) stddev-sans-first:26.37 08:41:26 INFO - PROCESS | 5119 | Values: 87.0 86.0 148.0 87.0 86.0 87.0 127.0 86.0 86.0 139.0 08:41:26 INFO - PROCESS | 5119 | 08:41:26 INFO - PROCESS | 5119 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:41:26 INFO - PROCESS | 5119 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 08:41:26 INFO - PROCESS | 5119 | 08:41:26 INFO - PROCESS | 5119 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 08:41:26 INFO - PROCESS | 5119 | Values: 146.0 146.0 146.0 147.0 146.0 146.0 146.0 145.0 146.0 145.0 08:41:26 INFO - PROCESS | 5119 | 08:41:26 INFO - PROCESS | 5119 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 08:41:26 INFO - PROCESS | 5119 | Values: 95.0 95.0 95.0 94.0 94.0 95.0 94.0 95.0 95.0 95.0 08:41:26 INFO - PROCESS | 5119 | 08:41:26 INFO - PROCESS | 5119 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:66.00 stddev:1.20 (1.8%) stddev-sans-first:1.20 08:41:26 INFO - PROCESS | 5119 | Values: 65.0 65.0 66.0 66.0 69.0 66.0 67.0 65.0 66.0 66.0 08:41:26 INFO - PROCESS | 5119 | 08:41:26 INFO - PROCESS | 5119 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:66.00 stddev:1.58 (2.4%) stddev-sans-first:1.66 08:41:26 INFO - PROCESS | 5119 | Values: 66.0 71.0 66.0 67.0 66.0 66.0 66.0 66.0 66.0 66.0 08:41:26 INFO - PROCESS | 5119 | 08:41:26 INFO - PROCESS | 5119 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.00 stddev:1.06 (1.3%) stddev-sans-first:1.12 08:41:26 INFO - PROCESS | 5119 | Values: 84.0 84.0 84.0 86.0 86.0 83.0 85.0 84.0 83.0 84.0 08:41:26 INFO - PROCESS | 5119 | 08:41:26 INFO - PROCESS | 5119 | [#11] stanford-crypto-ccm Cycles:10 Average:137.00 Median:134.00 stddev:6.60 (4.9%) stddev-sans-first:6.91 08:41:26 INFO - PROCESS | 5119 | Values: 134.0 134.0 134.0 134.0 133.0 134.0 138.0 133.0 154.0 142.0 08:41:26 INFO - PROCESS | 5119 | 08:41:26 INFO - PROCESS | 5119 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.50 Median:175.50 stddev:2.22 (1.3%) stddev-sans-first:2.29 08:41:26 INFO - PROCESS | 5119 | Values: 176.0 178.0 174.0 171.0 175.0 171.0 174.0 176.0 176.0 174.0 08:41:26 INFO - PROCESS | 5119 | 08:41:26 INFO - PROCESS | 5119 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:1.05 (1.5%) stddev-sans-first:1.05 08:41:26 INFO - PROCESS | 5119 | Values: 71.0 70.0 72.0 70.0 70.0 71.0 69.0 69.0 69.0 69.0 08:41:26 INFO - PROCESS | 5119 | -------- Summary: end -------- 08:41:26 INFO - PROCESS | 5119 | 08:41:27 INFO - TEST-INFO | 5119: exit 0 08:41:27 INFO - TEST-OK | kraken | took 64906ms 08:41:27 INFO - SUITE-END | took 1185s 08:41:27 INFO - Completed test suite (00:19:45) 08:41:27 INFO - javascript benchmark 08:41:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2566.7818235449986, 2606.0878692457636, 2609.556375416179, 2616.0582190411446, 2627.710951795302, 4507.549245075491, 4573.931391029138, 4590.517995610463, 4656.580907718305, 4663.743494107823, 4618.792154353054, 4633.837815676452, 4635.0, 4708.576228139466, 4741.502142275054, 4038.6163314485225, 4252.468441444819, 4308.892277693067, 4332.220200363933, 4350.15172041452, 4310.612044915957, 4342.3052311630145, 4357.346398040288, 4359.0, 4361.0, 4087.4073259377224, 4131.194417088669, 4284.036091879302, 4289.871303860889, 4307.6123148916595, 4164.56272091429, 4180.435641188462, 4182.686298527623, 4208.684348673862, 4244.0663054128045, 4169.4162817205615, 4202.432671589327, 4220.831166753326, 4250.4899412070445, 4263.829446822124, 4633.9304910426035, 4647.697899636512, 4653.0228651983125, 4660.184467718136, 4665.486796452387, 4756.07256584966, 4858.489858564835, 4865.34317867087, 4990.4011518617635, 4992.675476094042, 4945.431275403339, 4956.578690811285, 4964.0, 4970.925436118461, 4972.701637901701, 4590.059037897223, 4614.5385461453925, 4627.9768601156775, 4632.096741135446, 4632.768361581908, 4899.608031357483, 4971.527704868032, 5001.149804533238, 5017.623678224148, 5057.089723849669, 4857.757112144379, 4876.975615121902, 4883.8290659826735, 4885.1450996076255, 4885.389326334208, 4952.678075925053, 4962.8759281018265, 4967.155583550805, 4969.776360063805, 4970.0, 4676.415448068991, 4784.593309568656, 4855.295982082649, 4859.878503037452, 4916.508349165127, 4902.313676085351, 4908.730019848871, 4915.827946021944, 4916.016796640686, 4929.556339929351, 4274.636655884223, 4291.270484017725, 4292.420523229386, 4297.935530967038, 4308.74147551148, 3651.6165802590876, 3690.206605579813, 3714.9071273217846, 3740.8129593520216, 3772.434134879735, 4288.356746488052, 4337.891552711208, 4357.9564204358185, 4359.215341238608, 4369.3227549729845, 4995.275685025724, 5002.449730529639, 5006.6495345325475, 5008.223725322581, 5016.824411145592, 4140.37894315849, 4192.81132349045, 4327.675424343124, 4328.11273688893, 4343.04453020335, 4413.742083506186, 4461.018575913294, 4479.574440428154, 4480.4623445186135, 4505.842295519707, 4682.086993036325, 4683.297505374221, 4689.507601701772, 4692.061587682409, 4695.85912422621, 4805.975970120127, 4806.158922188673, 4912.45962944083, 4921.8523444296725, 4924.0, 4634.814607415666, 4702.576768090888, 4718.480967093548, 4719.929201061918, 4726.1020406122725, 4858.684185527929, 4870.561649451566, 4878.121938051185, 4878.926816097833, 4881.29221262922, 4776.8566942991765, 4840.782164802522, 4899.191633380595, 4903.681260718042, 4904.288878112725, 4731.4558825735485, 4827.372441582572, 4836.12949669063, 4860.805567777249, 4876.4392094909535, 4865.440474345495, 4869.9026019480125, 4873.269009648581, 4880.46314905353, 4882.023595281029, 4605.792739326671, 4618.237990731492, 4767.6662633615315, 4794.352762377034, 4799.832005879777, 4709.7174169549935, 4796.400449943757, 4810.6632535722165, 4817.9165334185445, 4818.084563932842, 4691.577758001797, 4693.389859318403, 4694.483606803317, 4697.060587882505, 4734.786934588021], "value": 4541.069021889385, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.7264004317861, 570.3668927490486, 570.4808624152017, 589.7847285740703, 593.5489028338461, 29077.41845163098, 31769.0, 38482.42276365857, 39630.405543916866, 39836.402453963216, 40462.59537404632, 40719.38920916188, 40754.18491630166, 40787.18425631485, 40831.183376332454, 7500.5874676892745, 7640.083190017206, 7643.541387516739, 7651.961740191319, 7655.464117511777, 7459.515131516461, 7536.434767392468, 9559.56981935811, 9766.169875560587, 9792.265580081486, 10012.499375031255, 10033.799324013515, 10083.596656133783, 10094.44480553573, 10097.19222462205, 9761.170300524464, 9780.706578802647, 9802.117809397118, 9805.803883922354, 9811.901880981206, 9671.90328096717, 9699.272554558365, 9744.220462362993, 9745.074217949283, 9749.853752193723, 38127.61872381269, 38481.23037539233, 38498.230035399414, 38533.229335413416, 38665.613343866484, 2938.76489880809, 3007.8646460909094, 3059.265776213715, 3192.2817366092677, 3208.3262514871903, 28793.712062879313, 28997.165555511223, 29084.70915290841, 29587.11238662822, 31191.376172476652, 3277.0, 3292.93414131716, 3391.118309239591, 3419.760616756828, 3498.1954150545516, 254269.0, 256426.0, 256624.0, 256936.0, 257378.0, 54294.18558721623, 54687.72656136694, 54713.452865471634, 54741.0, 54823.72588137034, 34044.65955340464, 35000.0, 35039.82480087634, 35073.42169602374, 35142.297154056774, 12764.872351276554, 13086.280254586089, 13513.594592162252, 13602.455901764017, 13807.17156970585, 9656.71029869105, 10295.0, 10340.793184136426, 10404.635837745642, 10457.372557646566, 17716.114194290232, 18195.26996965619, 18233.0, 18676.719849202273, 18707.90646046761, 5813.593048486566, 5928.8814223716145, 5997.190379298826, 6000.309964354068, 6043.859955930202, 803.1005274092936, 868.5092922498768, 871.1506281375608, 901.0718959471754, 975.6048800235916, 27429.45141097167, 28201.57697634537, 28425.43149137047, 28578.142655719945, 28738.71261287402, 917.4862077236769, 933.206774241889, 952.6903756279098, 954.7899462118323, 997.6059456514781, 14233.572992810232, 14904.925475372771, 14940.626484337978, 15118.470853520073, 15316.463923762614, 420778.0, 423524.0, 425336.0, 425792.0, 426171.0, 48611.27083093757, 49013.0, 49047.754761225966, 49075.50924490781, 49096.0, 1147.1339138950207, 1188.3226560860226, 1190.8630507491575, 1200.867904530501, 1202.6331968749616, 26354.86822565875, 27401.86299068492, 27741.44517109606, 27894.401402139254, 28268.43463130767, 42042.57957420387, 42831.785841070596, 42865.78567107145, 42923.78538107289, 42954.0, 267356.0, 267889.0, 268270.0, 268406.0, 268459.0, 22211.111555537598, 22496.0, 23394.883025584764, 23615.173468928504, 23669.763302366755, 39478.802605986784, 40942.79528602338, 41172.0, 44391.77804110959, 44460.22159113599, 29540.261493462836, 29751.851240743657, 30550.847245763627, 30779.4245858762, 31471.842640787567, 35013.29973400467, 35072.824635876656, 35085.824570878, 35911.461328079575, 35915.28169436649, 35718.107047324025, 35819.0, 36099.097522562144, 37579.0, 37633.81183094067, 33603.26702569558, 36929.26141477102, 37071.258574827814, 37118.44322335221, 37499.43750843685, 28253.43493130167, 29339.706602933697, 30067.0, 30302.84848575743, 30311.848440757654], "value": 17472.13103219151, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.04664150266046, 366.9467927150564, 372.2201986837574, 377.39993410477337, 394.3571977676387, 12802.359882005909, 16237.512874613765, 16761.66476670466, 17140.914295428505, 17838.10809459528, 16413.0, 16628.33486660532, 16648.33406663735, 16789.832101678978, 16916.74624880625, 4885.633577481685, 4915.262710593403, 4939.20972644377, 4941.382327209108, 4954.207326827708, 3685.318216130011, 4966.50334966504, 4980.452150263468, 5520.144377621455, 5824.825255242328, 5835.795747148851, 5836.270466191726, 5844.211031510734, 5845.5908086433965, 5846.88306233875, 5629.902169077011, 5748.770049198027, 5788.8842223155725, 5802.796902108406, 5819.243498345209, 5077.771500282459, 5080.212567052113, 5089.312942752718, 5094.5160209780015, 5108.6168537359845, 20126.89936550308, 20541.79458205429, 20611.69082463764, 20794.27220047306, 20888.164473421046, 1988.6321030609383, 2021.676531754912, 2112.3979665795327, 2158.5035441848304, 2406.7713567211085, 12992.740145197044, 13157.276349800757, 13293.0, 13543.0, 13624.591262262147, 1736.6353065856185, 1749.0, 1750.6586215687946, 1764.514758441426, 1792.4264235444664, 67781.0, 67936.66031669859, 68660.0, 69139.3086069138, 70201.64899175522, 9712.368696034735, 9718.854217186748, 9842.212622990286, 9931.702048938543, 10099.34354266985, 13603.251821149932, 13609.52366667162, 13626.523071692642, 13628.386722597308, 13638.522651707142, 6990.930090699129, 7011.859308396327, 7163.570185788765, 7268.200497945222, 7286.672099755524, 6634.535582509178, 6657.53397262187, 6800.625965571941, 6857.588544687235, 6867.793966181022, 6048.092786082035, 6063.302720187146, 6114.633122012693, 6194.845128871724, 6261.843453913689, 1758.2175931710522, 1785.8571314294825, 1797.748315235868, 1801.6216594515035, 1829.5974885525163, 886.9201771840566, 920.2959735802117, 930.6742640075919, 975.8292298847673, 984.7439665686973, 16102.194890255674, 17166.05586692719, 17212.913935430493, 17453.21460534279, 17990.01054941991, 814.4444111746536, 831.6507067031861, 868.7914900423852, 888.6623083228332, 953.3707752883064, 7795.844083118306, 9158.741915759836, 9614.230861531061, 9904.851427228597, 9963.0, 438990.0, 441509.0, 445315.0, 469327.0, 474175.0, 76617.61691191509, 79646.20353796503, 79755.60122199469, 81106.0, 81945.59027204826, 890.875277461156, 891.9777005574913, 937.4609599480326, 947.280067148958, 948.2745699539857, 15524.37902483888, 15872.92063539675, 16191.595210119842, 16367.832593102105, 16405.507834764976, 36831.44752828656, 36837.26325473422, 38296.0, 38989.610103898594, 39371.606283936795, 49481.50518494913, 50124.498755011984, 50303.49696503134, 51490.48509515007, 52017.0, 6832.214295356098, 6835.965820170867, 7079.893801592877, 7106.5736055836815, 7163.677634506564, 10017.298789084694, 10079.496025198858, 10115.494225288854, 10329.276950613385, 10779.568817247537, 9073.0, 9304.116108969638, 9342.53287335644, 9432.434053956784, 10151.289409741246, 9256.0, 9619.0, 9661.420314780855, 9718.9028109718, 9842.261830362895, 9536.189423899046, 9771.706848794547, 9937.751556210864, 10056.094951454405, 10230.795384092426, 6965.0, 7184.497085203986, 7288.271172882669, 7355.190928997699, 7448.702051917862, 8493.235608795238, 9550.808983820145, 9645.758856028375, 9883.85174222373, 9898.356606820533], "value": 8314.371700922728, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1241.5840693367722, 1351.3851197705046, 1394.4004078246355, 1449.9637509062272, 1669.0653234188846, 6591.406773390394, 7310.926890731091, 7647.311741943224, 7650.923490765091, 7863.724769633064, 7673.884891726629, 7744.148143704188, 7746.38028957682, 7747.92252077479, 7749.961250193755, 2170.9565808683815, 2202.9559408811815, 2203.3500117465387, 2204.889755512218, 2206.3160420269687, 2148.581026699794, 2184.6176919039185, 2223.2329846203033, 2224.7552769195377, 2225.899834507443, 2194.5281764420647, 2212.65703815908, 2214.944626384337, 2215.6233440315186, 2221.31139346803, 1882.0401595186554, 1895.8578106641987, 1905.2188602672907, 1907.7901430842596, 1909.8949557774317, 2131.6802479628027, 2180.705604743371, 2182.3234797212913, 2187.267265466071, 2187.628103222456, 7433.070866141732, 7525.360344370735, 7695.192004839467, 7700.576468294242, 7703.959965404655, 4341.630961368288, 4450.310201918708, 4481.058977614704, 4482.327650852366, 4482.327650852399, 2741.9862900685566, 2900.1154647832404, 2907.6656184538624, 2938.296766974389, 2966.1842993176833, 931.329442801182, 943.2831048403194, 945.664289177346, 952.2001518724236, 965.748905284624, 10914.072303854182, 10953.890461095367, 11006.669799906016, 11032.944835275852, 11036.724081897937, 3978.920421591552, 4086.3666131749033, 4100.323446631332, 4148.066684995852, 4191.97904010478, 8201.466904651179, 8275.95862020698, 8332.250097491255, 8342.958285208535, 8345.41582089248, 4601.102784956901, 4603.769811509478, 4609.170349337084, 4611.792469338888, 4612.86161415158, 3636.127329440915, 4069.1861627673993, 4258.467691538558, 4264.189803937242, 4269.743815371087, 3547.396942519778, 3561.465780132949, 3667.541557305337, 3674.614165512636, 3718.6095459976855, 1035.4512108582464, 1078.2883297024084, 1082.6210826210763, 1090.5256213547132, 1099.290957332516, 782.4522834016211, 794.7099308752379, 847.5719761520393, 851.6125163050797, 861.7027125641644, 5112.079825631347, 5230.97384513075, 5232.058229518723, 5242.18746094356, 5309.46905309466, 891.6700820696254, 894.821035792844, 920.4090485283905, 925.2242480076469, 929.7117893453051, 3395.3209358128474, 3405.0806282304134, 3499.177693242086, 3560.359135355661, 3565.94651080234, 9522.85715714265, 9941.850872236922, 9959.153471954965, 9960.153386962045, 10017.549210285555, 9783.657571985088, 9790.0, 9893.802123957481, 9896.356736812228, 9912.0, 6962.268961759044, 7253.419726421874, 7267.38227250679, 7435.0, 7438.293362130589, 5189.351331083614, 5277.498637629419, 5387.353517577916, 5429.647072940246, 5468.425815289337, 8850.291976641724, 9013.098690130935, 9089.045650206897, 9109.134632209929, 9140.954295228747, 8896.243819275434, 9195.126462986005, 9347.672831450867, 9378.531073446164, 9395.671151509665, 5814.505767009851, 6433.292337842927, 6561.442277406283, 6571.310012448624, 7077.115360579927, 7501.474896757175, 7573.659185336784, 7719.035120609924, 7720.613969301625, 7723.150453450228, 6769.830754231184, 6784.864302714017, 6831.795046148623, 6834.794956151323, 6872.278410766998, 6309.305976342507, 6342.112104305309, 6451.935480645134, 6636.004599310142, 6872.62200578973, 6054.576179667381, 6161.291451483136, 6176.073588961692, 6188.040853667689, 6188.783392581238, 4421.513633500376, 4627.583517483443, 4640.443146822268, 4648.907021859476, 4660.6970546914345, 4502.459704835441, 4507.752073635981, 4595.0350426409495, 4631.4905360411, 4726.385569875894], "value": 4100.878294111631, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.0726370043965, 307.9168624471393, 309.7599360495616, 313.39201948220466, 315.4952076677318, 4678.111158879815, 4684.695494792836, 4696.17816882046, 4703.753505321089, 4741.502142275063, 4651.348811166431, 4662.836800711976, 4664.766761661912, 4671.672982891199, 4690.97654511727, 3548.556430446194, 3645.8359373828243, 3648.361536731075, 3668.6514781095752, 3682.2819550187724, 3690.6713583110195, 3697.611750766171, 3700.3524383232825, 3716.8513259469723, 3726.4969229154126, 3672.2288319452946, 3677.848458651692, 3683.0976410779263, 3687.3731465650903, 3706.0734816295926, 3505.298940211968, 3546.7517273790586, 3666.5966743658178, 3675.8897233082785, 3708.8887333379907, 3266.379387916288, 3270.1824543864036, 3272.2473831018997, 3275.279438523521, 3277.4100661880852, 4445.0, 4516.638668906512, 4523.864284071483, 4525.547445255481, 4532.5240849710635, 3908.7654740715648, 4182.519010313822, 4186.623203911662, 4186.790660466964, 4188.916221675549, 4821.204501257288, 4825.131476334259, 4837.346958160673, 4842.44311904132, 4857.319975203474, 3506.8772592959126, 3510.4558793387064, 3512.1570823002553, 3515.8769443069627, 3519.8768043118366, 5051.747412629391, 5078.492150784966, 5079.6952182869145, 5083.491650834924, 5088.821891233789, 3479.408500554912, 3573.4103872861206, 3584.856605735741, 3622.3841946869097, 3629.6007439181667, 3663.139162296858, 3670.8436842394563, 3674.3202507536193, 3674.797886116289, 3679.392900171442, 4148.56440073794, 4174.08170202555, 4176.164767046542, 4177.498700156001, 4182.477190351206, 4796.841421360402, 4849.151398505247, 4867.853964381075, 4919.631027672867, 4925.87685307863, 1237.2761934268553, 1252.6179515247754, 1254.0970501239094, 1254.6298841841678, 1263.0, 776.3168411797582, 794.1819925476768, 815.808285053012, 816.3387655998661, 825.9793505162419, 4173.040200753843, 4255.170241802819, 4339.500957389878, 4382.255016647177, 4398.296272596369, 5029.497050294941, 5043.0, 5044.798208071709, 5049.444561098277, 5053.545180933734, 4282.186384586981, 4319.352097185448, 4368.344748287782, 4381.671374646914, 4386.780660966939, 2538.149719843836, 2642.65645466092, 2662.188032650022, 2662.9467410651678, 2663.961055188478, 4787.760611969387, 4789.688670236424, 4801.159797035505, 4813.566778989908, 4826.276058591239, 5137.948620513822, 5144.736316020939, 5158.7955816009835, 5165.896682066337, 5178.145605974972, 4587.79354929029, 4763.404574428197, 4764.618830493552, 4814.325994360793, 4824.614030877591, 5002.699838009731, 5003.824866129668, 5016.423111342242, 5030.798768049237, 5049.803335549048, 4966.726830024383, 4969.726665033313, 4994.750262486788, 5000.774965126505, 5011.874703132305, 4572.954270457253, 4802.271182374273, 4830.613550915848, 4833.444153922203, 4838.298446725134, 3608.2242317900727, 3632.7275454341557, 3634.2186429917697, 3635.4546817977516, 3647.1246900744163, 5094.083065048327, 5098.847034588968, 5110.66780659256, 5128.820491282787, 5130.333056702605, 4803.207470767285, 4891.755412229303, 4922.581580565692, 4964.758810297426, 4976.552110310089, 4908.950910490849, 4910.607151427948, 4911.656184067081, 4913.533214344631, 4915.655904086822, 4843.539863712942, 4858.17411040117, 4865.635077369141, 4871.63462740303, 4884.853454396374, 4664.930026049544, 4766.356541866942, 4803.543663351976, 4871.56378990133, 4882.658213924991, 4778.617710583215, 4784.30627558995, 4796.496367881462, 4800.5199480051715, 4813.638977076804], "value": 3707.016450565207, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.551099430924, 649.8407890066934, 676.7766637009785, 685.8285428642839, 688.390774164864, 11454.599089031886, 11682.47428865701, 12206.816897746541, 12326.198797078183, 12450.505939287275, 13589.660258493543, 13700.0, 13726.176429414218, 13741.175529468239, 13749.037567370287, 630.262592766462, 756.5990025286593, 779.5050143159078, 783.5807842804101, 784.3098073695169, 750.2460027672182, 767.1906139023329, 770.8265640230959, 779.6374685771116, 779.7426849139798, 822.2558584481054, 824.6412810427453, 825.0305890578576, 825.6243409248807, 833.4957350802767, 649.7530938243484, 821.0434843407423, 825.5789547330844, 827.2967977219375, 827.6317038917684, 570.8858228354346, 589.979350722727, 592.8043745563954, 596.4870211618048, 596.7523477756769, 12016.819747703792, 12034.458449369798, 12056.517739290417, 12061.095417843697, 12067.637970860887, 12137.271763694207, 12332.300827664527, 12837.229766213964, 12935.094543381967, 13441.596752097452, 10707.78584428315, 10730.517126729237, 10756.19328550362, 10993.780124397466, 11001.17491188156, 3994.7003974702016, 4015.678745700337, 4022.597740225983, 4056.5740597237454, 4062.106336605942, 65259.67370163166, 69020.6548967257, 70380.99999999949, 70615.29384706139, 71205.6439717798, 9855.408675479493, 9957.352772069793, 9970.800583988424, 9997.150242229493, 10104.0, 19850.404487865388, 19852.900735496518, 19856.404307870787, 19862.50343741418, 19863.0, 6544.7382104716235, 6679.298673639295, 6705.530612857053, 6882.174139103339, 6976.0, 3697.4453831925425, 3712.925741485155, 3760.4923335349376, 3761.774293542396, 3830.6209764484765, 2622.6983896851725, 2639.2082375287337, 2703.337682267857, 2715.91852244433, 2716.5246081935584, 477.17925168709763, 482.46205480888557, 483.82824097445604, 498.0810404803132, 505.0883155903629, 463.4693276198801, 481.08833760024555, 486.7006790823618, 514.8095204774257, 542.5822116969911, 6760.425363844129, 6863.313668633196, 7121.394681452135, 7551.811204719926, 7561.546307221584, 420.2540490629158, 469.40385710148604, 486.31186870578443, 496.3200415430883, 535.9785608575692, 3522.682958533693, 3583.6416358363954, 3598.514200582888, 3654.543182102237, 3800.410936304877, 56984.0, 98215.0, 100900.99099009062, 105160.0, 105540.47229763801, 88449.0, 89339.55330223308, 89971.0, 90821.79866305561, 92331.0, 76994.0, 78622.0, 79633.0, 79750.0, 80316.0, 6870.931290687229, 6925.238223795278, 7197.712091516491, 7278.417726581966, 7338.119425668954, 46030.76984615056, 46667.299990499494, 47264.0, 47453.0, 48466.0, 60837.391626084944, 66158.66920665366, 66381.0, 67616.66191669011, 67832.3216767826, 9043.773905652411, 9153.816923661623, 9169.220616247694, 9385.15533601979, 9511.809763804547, 9961.551730172305, 10157.542910568895, 10187.235957303084, 10279.434631095362, 10420.374777513374, 9639.132478077006, 9735.367201131903, 9875.308728388944, 10010.249231307535, 10038.799224015625, 9067.501287429255, 9079.182873541413, 9085.863712044193, 9475.526223688927, 9506.714798556055, 8993.955030224806, 9216.723498295061, 9252.95373523128, 9404.059594040542, 9465.810683786423, 7895.486793358414, 8085.838283234185, 8146.307563856902, 8255.876161857697, 9068.22920051803, 7827.373810095065, 8270.338372930031, 8516.233538981522, 8735.519546424754, 8739.431936924333], "value": 6221.64723737117, "unit": "score"}], "name": "dromaeo_css", "value": 6297.942188296338, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 114.0, 113.0, 116.0, 114.0, 114.0, 121.0, 114.0, 114.0, 115.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 122.0, 143.0, 189.0, 123.0, 153.0, 156.0, 123.0, 184.0, 128.0], "value": 147.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 159.0, 159.0, 161.0, 162.0, 162.0, 160.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 163.0, 77.0, 80.0, 76.0, 129.0, 120.0, 75.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 148.0, 87.0, 86.0, 87.0, 127.0, 86.0, 86.0, 139.0], "value": 101.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 66.0, 69.0, 66.0, 67.0, 65.0, 66.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 71.0, 66.0, 67.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 86.0, 86.0, 83.0, 85.0, 84.0, 83.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 134.0, 134.0, 134.0, 133.0, 134.0, 138.0, 133.0, 154.0, 142.0], "value": 137.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 178.0, 174.0, 171.0, 175.0, 171.0, 174.0, 176.0, 176.0, 174.0], "value": 174.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 72.0, 70.0, 70.0, 71.0, 69.0, 69.0, 69.0, 69.0], "value": 70.0, "unit": "score"}], "name": "kraken", "value": 1574.4999999999998, "alertThreshold": 2.0}]} 08:41:28 INFO - Return code: 0 08:41:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:41:28 INFO - # TBPL SUCCESS # 08:41:28 INFO - Running post-action listener: _resource_record_post_action 08:41:28 INFO - [mozharness: 2016-08-22 15:41:28.099991Z] Finished run-tests step (success) 08:41:28 INFO - Running post-run listener: _resource_record_post_run 08:41:28 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 415760384; Read time: 8; Write time: 340136 08:41:28 INFO - TinderboxPrint: CPU usage
13.2% 08:41:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 08:41:28 INFO - TinderboxPrint: I/O write bytes / time
415,760,384 / 340,136 08:41:28 INFO - TinderboxPrint: CPU idle
8,320.6 (86.7%) 08:41:28 INFO - TinderboxPrint: CPU user
1,202.8 (12.5%) 08:41:28 INFO - TinderboxPrint: Swap in / out
0 / 0 08:41:28 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 123420672; Read time: 0; Write time: 125972 08:41:28 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 291803136; Read time: 0; Write time: 214164 08:41:28 INFO - Running post-run listener: _upload_blobber_files 08:41:28 INFO - Blob upload gear active. 08:41:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:41:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:41:28 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'] 08:41:28 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 08:41:29 INFO - (blobuploader) - INFO - Open directory for files ... 08:41:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:41:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:41:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:41:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:41:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:41:29 INFO - (blobuploader) - INFO - Done attempting. 08:41:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:41:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:41:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:41:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:41:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:41:30 INFO - (blobuploader) - INFO - Done attempting. 08:41:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:41:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:41:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:41:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:41:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:41:34 INFO - (blobuploader) - INFO - Done attempting. 08:41:34 INFO - (blobuploader) - INFO - Iteration through files over. 08:41:34 INFO - Return code: 0 08:41:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:41:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:41:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ce52761bd8a2dd7c60f95bb59f8a25e51bd037fa8b84a8d5a70807b3075bc8cb84e917441228379f96e0855905fa29ecf70884357588cd6ea42d351a1271ae79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/543957898fcdd9c2a4128f24051c1bdf684fb5719c6fc18c860c580406e07f5b9a18145f250ea290cab37220ff5d0ed775c63315255ba169033f44a01014227d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c29898336b09b62f5b1a29db17f7afe45233b0b62c692bcdc813d51a218369bef25c49cb927ddaa937b29733f0dfe0649bb8b48080d317b39cee5dcd2cd18d5a"} 08:41:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:41:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:41:34 INFO - Contents: 08:41:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ce52761bd8a2dd7c60f95bb59f8a25e51bd037fa8b84a8d5a70807b3075bc8cb84e917441228379f96e0855905fa29ecf70884357588cd6ea42d351a1271ae79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/543957898fcdd9c2a4128f24051c1bdf684fb5719c6fc18c860c580406e07f5b9a18145f250ea290cab37220ff5d0ed775c63315255ba169033f44a01014227d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c29898336b09b62f5b1a29db17f7afe45233b0b62c692bcdc813d51a218369bef25c49cb927ddaa937b29733f0dfe0649bb8b48080d317b39cee5dcd2cd18d5a"} 08:41:34 INFO - Running post-run listener: copy_logs_to_upload_dir 08:41:34 INFO - Copying logs to upload dir... 08:41:34 INFO - mkdir: /builds/slave/test/build/upload/logs 08:41:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.918422 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-22 08:41:34.139570) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 08:41:34.143674) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1471879247.330752-969403225 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/ce52761bd8a2dd7c60f95bb59f8a25e51bd037fa8b84a8d5a70807b3075bc8cb84e917441228379f96e0855905fa29ecf70884357588cd6ea42d351a1271ae79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/543957898fcdd9c2a4128f24051c1bdf684fb5719c6fc18c860c580406e07f5b9a18145f250ea290cab37220ff5d0ed775c63315255ba169033f44a01014227d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c29898336b09b62f5b1a29db17f7afe45233b0b62c692bcdc813d51a218369bef25c49cb927ddaa937b29733f0dfe0649bb8b48080d317b39cee5dcd2cd18d5a"} build_url:https://queue.taskcluster.net/v1/task/R21o6kFWQ2Gfx004Uia7bg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011201 build_url: 'https://queue.taskcluster.net/v1/task/R21o6kFWQ2Gfx004Uia7bg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ce52761bd8a2dd7c60f95bb59f8a25e51bd037fa8b84a8d5a70807b3075bc8cb84e917441228379f96e0855905fa29ecf70884357588cd6ea42d351a1271ae79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/543957898fcdd9c2a4128f24051c1bdf684fb5719c6fc18c860c580406e07f5b9a18145f250ea290cab37220ff5d0ed775c63315255ba169033f44a01014227d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c29898336b09b62f5b1a29db17f7afe45233b0b62c692bcdc813d51a218369bef25c49cb927ddaa937b29733f0dfe0649bb8b48080d317b39cee5dcd2cd18d5a"}' ========= master_lag: 0.17 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 08:41:34.322416) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:41:34.323251) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1471879247.330752-969403225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004544 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:41:34.349083) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 08:41:34.349428) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 08:41:34.349761) ========= ========= Total master_lag: 0.27 =========