builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-005 starttime: 1472244889.59 results: success (0) buildid: 20160826130713 builduid: 7c87127ad6cb4ee98e8f56e3c44a311a revision: f1c8f78cd6f6e49a5f67b37567888473b898cb90 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 13:54:49.590916) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 13:54:49.591422) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 13:54:49.591734) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 13:54:49.689894) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 13:54:49.690278) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1472244814.696315-1226244341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-26 13:54:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 59.7M=0s 2016-08-26 13:54:50 (59.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108874 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 13:54:49.813734) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 13:54:49.814029) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1472244814.696315-1226244341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018529 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 13:54:49.865825) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-26 13:54:49.866156) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f1c8f78cd6f6e49a5f67b37567888473b898cb90 --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 f1c8f78cd6f6e49a5f67b37567888473b898cb90 --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=7fc86f70bae03e018da0b1d8000001c4-1472244814.696315-1226244341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-26 13:54:50,362 truncating revision to first 12 chars 2016-08-26 13:54:50,362 Setting DEBUG logging. 2016-08-26 13:54:50,362 attempt 1/10 2016-08-26 13:54:50,362 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f1c8f78cd6f6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-26 13:54:51,217 unpacking tar archive at: fx-team-f1c8f78cd6f6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.202892 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-26 13:54:51.158749) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 13:54:51.159152) ========= script_repo_revision: f1c8f78cd6f6e49a5f67b37567888473b898cb90 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 13:54:51.159595) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 13:54:51.159924) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 13:54:51.196666) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-26 13:54:51.196935) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1472244814.696315-1226244341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:54:51 INFO - MultiFileLogger online at 20160826 13:54:51 in /builds/slave/test 13:54:51 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 13:54:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:54:51 INFO - {'append_to_log': False, 13:54:51 INFO - 'base_work_dir': '/builds/slave/test', 13:54:51 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:54:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:54:51 INFO - 'branch': 'Fx-Team-Non-PGO', 13:54:51 INFO - 'buildbot_json_path': 'buildprops.json', 13:54:51 INFO - 'config_files': ('talos/linux_config.py',), 13:54:51 INFO - 'default_actions': ('clobber', 13:54:51 INFO - 'read-buildbot-config', 13:54:51 INFO - 'download-and-extract', 13:54:51 INFO - 'populate-webroot', 13:54:51 INFO - 'create-virtualenv', 13:54:51 INFO - 'install', 13:54:51 INFO - 'run-tests'), 13:54:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:54:51 INFO - 'download_minidump_stackwalk': True, 13:54:51 INFO - 'download_symbols': 'ondemand', 13:54:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:54:51 INFO - 'tooltool.py': '/tools/tooltool.py', 13:54:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:54:51 INFO - '/tools/misc-python/virtualenv.py')}, 13:54:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:54:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:54:51 INFO - 'installer_path': 'installer.exe', 13:54:51 INFO - 'log_level': 'info', 13:54:51 INFO - 'log_name': 'talos', 13:54:51 INFO - 'log_to_console': True, 13:54:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:54:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:54:51 INFO - 'opt_config_files': (), 13:54:51 INFO - 'pip_index': False, 13:54:51 INFO - 'sps_profile': False, 13:54:51 INFO - 'sps_profile_interval': 0, 13:54:51 INFO - 'suite': 'dromaeojs', 13:54:51 INFO - 'system_bits': '32', 13:54:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:54:51 INFO - 'title': 'talos-linux64-ix-005', 13:54:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:54:51 INFO - 'use_talos_json': True, 13:54:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:54:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:54:51 INFO - 'work_dir': 'build'} 13:54:51 INFO - [mozharness: 2016-08-26 20:54:51.801031Z] Running clobber step. 13:54:51 INFO - Running pre-action listener: _resource_record_pre_action 13:54:51 INFO - Running main action method: clobber 13:54:51 INFO - rmtree: /builds/slave/test/build 13:54:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:54:52 INFO - Running post-action listener: _resource_record_post_action 13:54:52 INFO - [mozharness: 2016-08-26 20:54:52.267426Z] Finished clobber step (success) 13:54:52 INFO - [mozharness: 2016-08-26 20:54:52.267529Z] Running read-buildbot-config step. 13:54:52 INFO - Running pre-action listener: _resource_record_pre_action 13:54:52 INFO - Running main action method: read_buildbot_config 13:54:52 INFO - Using buildbot properties: 13:54:52 INFO - { 13:54:52 INFO - "project": "", 13:54:52 INFO - "product": "firefox", 13:54:52 INFO - "script_repo_revision": "production", 13:54:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:54:52 INFO - "repository": "", 13:54:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 13:54:52 INFO - "buildid": "20160826130713", 13:54:52 INFO - "pgo_build": "False", 13:54:52 INFO - "basedir": "/builds/slave/test", 13:54:52 INFO - "buildnumber": 1888, 13:54:52 INFO - "slavename": "talos-linux64-ix-005", 13:54:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:54:52 INFO - "platform": "ubuntu64_hw", 13:54:52 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:54:52 INFO - "branch": "fx-team", 13:54:52 INFO - "repo_path": "integration/fx-team", 13:54:52 INFO - "revision": "f1c8f78cd6f6e49a5f67b37567888473b898cb90", 13:54:52 INFO - "stage_platform": "linux64", 13:54:52 INFO - "builduid": "7c87127ad6cb4ee98e8f56e3c44a311a", 13:54:52 INFO - "slavebuilddir": "test" 13:54:52 INFO - } 13:54:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/LWT-ZgAmRC6hdEigjkvnOg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 13:54:52 INFO - Running post-action listener: _resource_record_post_action 13:54:52 INFO - [mozharness: 2016-08-26 20:54:52.270023Z] Finished read-buildbot-config step (success) 13:54:52 INFO - [mozharness: 2016-08-26 20:54:52.270113Z] Running download-and-extract step. 13:54:52 INFO - Running pre-action listener: _resource_record_pre_action 13:54:52 INFO - Running main action method: download_and_extract 13:54:52 INFO - mkdir: /builds/slave/test/build/tests 13:54:52 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')]} 13:54:52 INFO - trying https://queue.taskcluster.net/v1/task/LWT-ZgAmRC6hdEigjkvnOg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:54:52 INFO - Downloading https://queue.taskcluster.net/v1/task/LWT-ZgAmRC6hdEigjkvnOg/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 13:54:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LWT-ZgAmRC6hdEigjkvnOg/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 13:54:52 INFO - Downloaded 1361 bytes. 13:54:52 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:54:52 INFO - Using the following test package requirements: 13:54:52 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 13:54:52 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:54:52 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:54:52 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:54:52 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:54:52 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:54:52 INFO - u'jsshell-linux-x86_64.zip'], 13:54:52 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:54:52 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:54:52 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 13:54:52 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:54:52 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:54:52 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:54:52 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:54:52 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:54:52 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:54:52 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:54:52 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:54:52 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:54:52 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')]} 13:54:52 INFO - trying https://queue.taskcluster.net/v1/task/LWT-ZgAmRC6hdEigjkvnOg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:54:52 INFO - Downloading https://queue.taskcluster.net/v1/task/LWT-ZgAmRC6hdEigjkvnOg/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 13:54:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LWT-ZgAmRC6hdEigjkvnOg/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 13:54:54 INFO - Downloaded 20303367 bytes. 13:54:54 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 13:54:58 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 13:54:58 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')]} 13:54:58 INFO - trying https://queue.taskcluster.net/v1/task/LWT-ZgAmRC6hdEigjkvnOg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:54:58 INFO - Downloading https://queue.taskcluster.net/v1/task/LWT-ZgAmRC6hdEigjkvnOg/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 13:54:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LWT-ZgAmRC6hdEigjkvnOg/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 13:54:59 INFO - Downloaded 20303367 bytes. 13:54:59 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 13:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:04 INFO - trying https://queue.taskcluster.net/v1/task/LWT-ZgAmRC6hdEigjkvnOg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 13:55:04 INFO - Downloading https://queue.taskcluster.net/v1/task/LWT-ZgAmRC6hdEigjkvnOg/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 13:55:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LWT-ZgAmRC6hdEigjkvnOg/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 13:55:05 INFO - Downloaded 14413998 bytes. 13:55:05 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 13:55: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')]} 13:55:06 INFO - trying https://queue.taskcluster.net/v1/task/LWT-ZgAmRC6hdEigjkvnOg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:55:06 INFO - Downloading https://queue.taskcluster.net/v1/task/LWT-ZgAmRC6hdEigjkvnOg/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 13:55:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LWT-ZgAmRC6hdEigjkvnOg/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 13:55:08 INFO - Downloaded 55856482 bytes. 13:55:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LWT-ZgAmRC6hdEigjkvnOg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:55:08 INFO - mkdir: /builds/slave/test/properties 13:55:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:55:08 INFO - Writing to file /builds/slave/test/properties/build_url 13:55:08 INFO - Contents: 13:55:08 INFO - build_url:https://queue.taskcluster.net/v1/task/LWT-ZgAmRC6hdEigjkvnOg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:55:09 INFO - Running post-action listener: _resource_record_post_action 13:55:09 INFO - Running post-action listener: set_extra_try_arguments 13:55:09 INFO - [mozharness: 2016-08-26 20:55:09.182104Z] Finished download-and-extract step (success) 13:55:09 INFO - [mozharness: 2016-08-26 20:55:09.182331Z] Running populate-webroot step. 13:55:09 INFO - Running pre-action listener: _resource_record_pre_action 13:55:09 INFO - Running main action method: populate_webroot 13:55:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:55:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:55:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:55:09 INFO - '--tppagecycles', 13:55:09 INFO - '7'], 13:55:09 INFO - 'tests': ['tsvgm']}}, 13:55:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:55:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:55:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:55:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:55:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:55:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:55:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:09 INFO - 'talos_options': ['--disable-e10s'], 13:55:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:55:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:55:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:09 INFO - 'talos_options': ['--disable-e10s'], 13:55:09 INFO - 'tests': ['damp', 'tps']}, 13:55:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:09 INFO - 'tests': ['damp', 'tps']}, 13:55:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:55:09 INFO - 'tests': ['dromaeo_dom']}, 13:55:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:55:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:55:09 INFO - 'tests': ['basic_compositor_video']}, 13:55:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:55:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:55:09 INFO - 'tests': ['a11yr', 13:55:09 INFO - 'ts_paint', 13:55:09 INFO - 'tpaint', 13:55:09 INFO - 'sessionrestore', 13:55:09 INFO - 'sessionrestore_no_auto_restore', 13:55:09 INFO - 'tabpaint']}, 13:55:09 INFO - 'other-e10s': {'tests': ['a11yr', 13:55:09 INFO - 'ts_paint', 13:55:09 INFO - 'tpaint', 13:55:09 INFO - 'sessionrestore', 13:55:09 INFO - 'sessionrestore_no_auto_restore', 13:55:09 INFO - 'tabpaint']}, 13:55:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:55:09 INFO - 'ts_paint', 13:55:09 INFO - 'tpaint', 13:55:09 INFO - 'sessionrestore', 13:55:09 INFO - 'sessionrestore_no_auto_restore', 13:55:09 INFO - 'tabpaint']}, 13:55:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:55:09 INFO - 'ts_paint', 13:55:09 INFO - 'tpaint', 13:55:09 INFO - 'sessionrestore', 13:55:09 INFO - 'sessionrestore_no_auto_restore', 13:55:09 INFO - 'tabpaint']}, 13:55:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:55:09 INFO - 'tests': ['a11yr', 13:55:09 INFO - 'ts_paint', 13:55:09 INFO - 'tpaint', 13:55:09 INFO - 'sessionrestore', 13:55:09 INFO - 'sessionrestore_no_auto_restore', 13:55:09 INFO - 'tabpaint']}, 13:55:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:55:09 INFO - 'tests': ['a11yr', 13:55:09 INFO - 'ts_paint', 13:55:09 INFO - 'tpaint', 13:55:09 INFO - 'sessionrestore', 13:55:09 INFO - 'sessionrestore_no_auto_restore', 13:55:09 INFO - 'tabpaint']}, 13:55:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:55:09 INFO - 'tests': ['tsvgx', 13:55:09 INFO - 'tsvgr_opacity', 13:55:09 INFO - 'tart', 13:55:09 INFO - 'tscrollx', 13:55:09 INFO - 'cart']}, 13:55:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:55:09 INFO - 'tsvgr_opacity', 13:55:09 INFO - 'tart', 13:55:09 INFO - 'tscrollx', 13:55:09 INFO - 'cart']}, 13:55:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:09 INFO - 'talos_options': ['--disable-e10s'], 13:55:09 INFO - 'tests': ['tp5o']}, 13:55:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:09 INFO - 'tests': ['tp5o']}, 13:55:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:09 INFO - 'talos_options': ['--disable-e10s', 13:55:09 INFO - '--xperf_path', 13:55:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:55:09 INFO - 'tests': ['tp5n']}, 13:55:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:55:09 INFO - 'talos_options': ['--xperf_path', 13:55:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:55:09 INFO - 'tests': ['tp5n']}}, 13:55:09 INFO - 'talos.zip': {'path': '', 13:55:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:55:09 INFO - Running post-action listener: _resource_record_post_action 13:55:09 INFO - [mozharness: 2016-08-26 20:55:09.200128Z] Finished populate-webroot step (success) 13:55:09 INFO - [mozharness: 2016-08-26 20:55:09.200218Z] Running create-virtualenv step. 13:55:09 INFO - Running pre-action listener: _resource_record_pre_action 13:55:09 INFO - Running main action method: create_virtualenv 13:55:09 INFO - Creating virtualenv /builds/slave/test/build/venv 13:55:09 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 13:55:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:55:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:55:09 INFO - Using real prefix '/usr' 13:55:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:55:09 INFO - Installing distribute.............................................................................................................................................................................................done. 13:55:11 INFO - Installing pip.................done. 13:55:11 INFO - Return code: 0 13:55:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:55: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')]} 13:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55: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')]} 13:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa974cc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2556090>, '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 0x25599b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2559e40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472244814.696315-1226244341', '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 13:55: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', 'pip>=1.5'] in /builds/slave/test/build 13:55: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 pip>=1.5 13:55:11 INFO - Using env: {'DISPLAY': ':0', 13:55:11 INFO - 'HOME': '/home/cltbld', 13:55:11 INFO - 'LANG': 'en_US.UTF-8', 13:55:11 INFO - 'LANGUAGE': 'en_US:en', 13:55:11 INFO - 'LOGNAME': 'cltbld', 13:55:11 INFO - 'MAIL': '/var/mail/cltbld', 13:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:11 INFO - 'MOZ_NO_REMOTE': '1', 13:55:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:55:11 INFO - 'NO_EM_RESTART': '1', 13:55:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:11 INFO - 'PWD': '/builds/slave/test', 13:55:11 INFO - 'SHELL': '/bin/bash', 13:55:11 INFO - 'SHLVL': '1', 13:55:11 INFO - 'TERM': 'linux', 13:55:11 INFO - 'TMOUT': '86400', 13:55:11 INFO - 'USER': 'cltbld', 13:55:11 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472244814.696315-1226244341', 13:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:11 INFO - '_': '/tools/buildbot/bin/python'} 13:55:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:11 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 13:55:11 INFO - Cleaning up... 13:55:11 INFO - Return code: 0 13:55:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:55: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')]} 13:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55: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')]} 13:55:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55: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', '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 0x7fa974cc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2556090>, '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 0x25599b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2559e40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472244814.696315-1226244341', '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 13:55: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', 'psutil>=3.1.1'] in /builds/slave/test/build 13:55: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 psutil>=3.1.1 13:55:11 INFO - Using env: {'DISPLAY': ':0', 13:55:11 INFO - 'HOME': '/home/cltbld', 13:55:11 INFO - 'LANG': 'en_US.UTF-8', 13:55:11 INFO - 'LANGUAGE': 'en_US:en', 13:55:12 INFO - 'LOGNAME': 'cltbld', 13:55:12 INFO - 'MAIL': '/var/mail/cltbld', 13:55:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:12 INFO - 'MOZ_NO_REMOTE': '1', 13:55:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:55:12 INFO - 'NO_EM_RESTART': '1', 13:55:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:55:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:12 INFO - 'PWD': '/builds/slave/test', 13:55:12 INFO - 'SHELL': '/bin/bash', 13:55:12 INFO - 'SHLVL': '1', 13:55:12 INFO - 'TERM': 'linux', 13:55:12 INFO - 'TMOUT': '86400', 13:55:12 INFO - 'USER': 'cltbld', 13:55:12 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472244814.696315-1226244341', 13:55:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:12 INFO - '_': '/tools/buildbot/bin/python'} 13:55:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:12 INFO - Downloading/unpacking psutil>=3.1.1 13:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:55:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:55:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:55:14 INFO - Installing collected packages: psutil 13:55:14 INFO - Running setup.py install for psutil 13:55:14 INFO - building 'psutil._psutil_linux' extension 13:55:14 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 13:55:14 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 13:55:14 INFO - building 'psutil._psutil_posix' extension 13:55:14 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 13:55:14 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 13:55:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:55:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:55:14 INFO - Successfully installed psutil 13:55:14 INFO - Cleaning up... 13:55:14 INFO - Return code: 0 13:55:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:55: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')]} 13:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55: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')]} 13:55:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa974cc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2556090>, '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 0x25599b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2559e40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472244814.696315-1226244341', '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 13:55: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:55: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 mozsystemmonitor==0.3 13:55:14 INFO - Using env: {'DISPLAY': ':0', 13:55:14 INFO - 'HOME': '/home/cltbld', 13:55:14 INFO - 'LANG': 'en_US.UTF-8', 13:55:14 INFO - 'LANGUAGE': 'en_US:en', 13:55:14 INFO - 'LOGNAME': 'cltbld', 13:55:14 INFO - 'MAIL': '/var/mail/cltbld', 13:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:14 INFO - 'MOZ_NO_REMOTE': '1', 13:55:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:55:14 INFO - 'NO_EM_RESTART': '1', 13:55:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:14 INFO - 'PWD': '/builds/slave/test', 13:55:14 INFO - 'SHELL': '/bin/bash', 13:55:14 INFO - 'SHLVL': '1', 13:55:14 INFO - 'TERM': 'linux', 13:55:14 INFO - 'TMOUT': '86400', 13:55:14 INFO - 'USER': 'cltbld', 13:55:14 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472244814.696315-1226244341', 13:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:14 INFO - '_': '/tools/buildbot/bin/python'} 13:55:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:55:15 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 13:55:15 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 13:55:15 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 13:55:15 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 13:55:15 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 13:55:15 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 13:55:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:55:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:55:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:55:16 INFO - Installing collected packages: mozsystemmonitor 13:55:16 INFO - Running setup.py install for mozsystemmonitor 13:55:17 INFO - Successfully installed mozsystemmonitor 13:55:17 INFO - Cleaning up... 13:55:17 INFO - Return code: 0 13:55:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:55: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')]} 13:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55: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')]} 13:55:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:17 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 0x7fa974cc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2556090>, '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 0x25599b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2559e40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472244814.696315-1226244341', '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 13:55:17 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 13:55:17 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 13:55:17 INFO - Using env: {'DISPLAY': ':0', 13:55:17 INFO - 'HOME': '/home/cltbld', 13:55:17 INFO - 'LANG': 'en_US.UTF-8', 13:55:17 INFO - 'LANGUAGE': 'en_US:en', 13:55:17 INFO - 'LOGNAME': 'cltbld', 13:55:17 INFO - 'MAIL': '/var/mail/cltbld', 13:55:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:17 INFO - 'MOZ_NO_REMOTE': '1', 13:55:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:55:17 INFO - 'NO_EM_RESTART': '1', 13:55:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:55:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:17 INFO - 'PWD': '/builds/slave/test', 13:55:17 INFO - 'SHELL': '/bin/bash', 13:55:17 INFO - 'SHLVL': '1', 13:55:17 INFO - 'TERM': 'linux', 13:55:17 INFO - 'TMOUT': '86400', 13:55:17 INFO - 'USER': 'cltbld', 13:55:17 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472244814.696315-1226244341', 13:55:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:17 INFO - '_': '/tools/buildbot/bin/python'} 13:55:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:17 INFO - Downloading/unpacking jsonschema==2.5.1 13:55:17 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 13:55:17 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 13:55:17 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 13:55:17 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 13:55:17 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 13:55:17 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 13:55:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:55:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:55:19 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 13:55:19 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 13:55:19 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 13:55:19 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 13:55:19 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 13:55:19 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 13:55:19 INFO - Downloading functools32-3.2.3-2.tar.gz 13:55:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:55:19 INFO - warning: no files found matching '*.txt' 13:55:19 INFO - no previously-included directories found matching 'build' 13:55:19 INFO - no previously-included directories found matching 'dist' 13:55:19 INFO - no previously-included directories found matching '.git*' 13:55:19 INFO - Installing collected packages: jsonschema, functools32 13:55:19 INFO - Running setup.py install for functools32 13:55:19 INFO - warning: no files found matching '*.txt' 13:55:19 INFO - no previously-included directories found matching 'build' 13:55:19 INFO - no previously-included directories found matching 'dist' 13:55:19 INFO - no previously-included directories found matching '.git*' 13:55:19 INFO - Successfully installed jsonschema functools32 13:55:19 INFO - Cleaning up... 13:55:19 INFO - Return code: 0 13:55:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:19 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 0x7fa974cc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2556090>, '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 0x25599b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2559e40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472244814.696315-1226244341', '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 13:55:19 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 13:55:19 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 13:55:19 INFO - Using env: {'DISPLAY': ':0', 13:55:19 INFO - 'HOME': '/home/cltbld', 13:55:19 INFO - 'LANG': 'en_US.UTF-8', 13:55:19 INFO - 'LANGUAGE': 'en_US:en', 13:55:19 INFO - 'LOGNAME': 'cltbld', 13:55:19 INFO - 'MAIL': '/var/mail/cltbld', 13:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:19 INFO - 'MOZ_NO_REMOTE': '1', 13:55:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:55:19 INFO - 'NO_EM_RESTART': '1', 13:55:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:19 INFO - 'PWD': '/builds/slave/test', 13:55:19 INFO - 'SHELL': '/bin/bash', 13:55:19 INFO - 'SHLVL': '1', 13:55:19 INFO - 'TERM': 'linux', 13:55:19 INFO - 'TMOUT': '86400', 13:55:19 INFO - 'USER': 'cltbld', 13:55:19 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472244814.696315-1226244341', 13:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:19 INFO - '_': '/tools/buildbot/bin/python'} 13:55:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:55:19 INFO - Cleaning up... 13:55:19 INFO - Return code: 0 13:55:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:19 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 0x7fa974cc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2556090>, '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 0x25599b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2559e40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472244814.696315-1226244341', '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 13:55:19 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 13:55:19 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 13:55:19 INFO - Using env: {'DISPLAY': ':0', 13:55:19 INFO - 'HOME': '/home/cltbld', 13:55:19 INFO - 'LANG': 'en_US.UTF-8', 13:55:19 INFO - 'LANGUAGE': 'en_US:en', 13:55:19 INFO - 'LOGNAME': 'cltbld', 13:55:19 INFO - 'MAIL': '/var/mail/cltbld', 13:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:19 INFO - 'MOZ_NO_REMOTE': '1', 13:55:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:55:19 INFO - 'NO_EM_RESTART': '1', 13:55:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:19 INFO - 'PWD': '/builds/slave/test', 13:55:19 INFO - 'SHELL': '/bin/bash', 13:55:19 INFO - 'SHLVL': '1', 13:55:19 INFO - 'TERM': 'linux', 13:55:19 INFO - 'TMOUT': '86400', 13:55:19 INFO - 'USER': 'cltbld', 13:55:19 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472244814.696315-1226244341', 13:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:19 INFO - '_': '/tools/buildbot/bin/python'} 13:55:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:20 INFO - Downloading/unpacking blobuploader==1.2.4 13:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:21 INFO - Downloading blobuploader-1.2.4.tar.gz 13:55:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:55:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:55: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 13:55: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 13:55: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 13:55: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 13:55: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 13:55: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 13:55:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:55:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:55: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 13:55: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 13:55: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 13:55: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 13:55: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 13:55: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 13:55:22 INFO - Downloading docopt-0.6.1.tar.gz 13:55:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:55:22 INFO - Installing collected packages: blobuploader, requests, docopt 13:55:22 INFO - Running setup.py install for blobuploader 13:55:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:55:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:55:22 INFO - Running setup.py install for requests 13:55:23 INFO - Running setup.py install for docopt 13:55:23 INFO - Successfully installed blobuploader requests docopt 13:55:23 INFO - Cleaning up... 13:55:23 INFO - Return code: 0 13:55:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:55:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:23 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 0x7fa974cc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2556090>, '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 0x25599b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2559e40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472244814.696315-1226244341', '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 13:55:23 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 13:55:23 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 13:55:23 INFO - Using env: {'DISPLAY': ':0', 13:55:23 INFO - 'HOME': '/home/cltbld', 13:55:23 INFO - 'LANG': 'en_US.UTF-8', 13:55:23 INFO - 'LANGUAGE': 'en_US:en', 13:55:23 INFO - 'LOGNAME': 'cltbld', 13:55:23 INFO - 'MAIL': '/var/mail/cltbld', 13:55:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:23 INFO - 'MOZ_NO_REMOTE': '1', 13:55:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:55:23 INFO - 'NO_EM_RESTART': '1', 13:55:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:55:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:23 INFO - 'PWD': '/builds/slave/test', 13:55:23 INFO - 'SHELL': '/bin/bash', 13:55:23 INFO - 'SHLVL': '1', 13:55:23 INFO - 'TERM': 'linux', 13:55:23 INFO - 'TMOUT': '86400', 13:55:23 INFO - 'USER': 'cltbld', 13:55:23 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472244814.696315-1226244341', 13:55:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:23 INFO - '_': '/tools/buildbot/bin/python'} 13:55:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:55:23 INFO - Running setup.py (path:/tmp/pip-ZzBQAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:55:23 INFO - Running setup.py (path:/tmp/pip-NnCQ7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:55:23 INFO - Running setup.py (path:/tmp/pip-sZsUdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:55:23 INFO - Running setup.py (path:/tmp/pip-T7ljXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:55:23 INFO - Running setup.py (path:/tmp/pip-enj3wt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:55:23 INFO - Running setup.py (path:/tmp/pip-x6m_J_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:55:24 INFO - Running setup.py (path:/tmp/pip-PygR90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:55:24 INFO - Running setup.py (path:/tmp/pip-8eawOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:55:24 INFO - Running setup.py (path:/tmp/pip-9gIeEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:55:24 INFO - Running setup.py (path:/tmp/pip-3MGHwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:55:24 INFO - Running setup.py (path:/tmp/pip-GipVWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:55:24 INFO - Running setup.py (path:/tmp/pip-bhycaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:55:24 INFO - Running setup.py (path:/tmp/pip-otsYdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:55:24 INFO - Running setup.py (path:/tmp/pip-6N7xtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:55:24 INFO - Running setup.py (path:/tmp/pip-S3PxMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:55:24 INFO - Running setup.py (path:/tmp/pip-1tgWFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:55:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:55:24 INFO - Running setup.py (path:/tmp/pip-OUNOaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:55:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:55:24 INFO - Running setup.py install for manifestparser 13:55:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:55:24 INFO - Running setup.py install for mozcrash 13:55:25 INFO - Running setup.py install for mozdebug 13:55:25 INFO - Running setup.py install for mozdevice 13:55:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:55:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:55:25 INFO - Running setup.py install for mozfile 13:55:25 INFO - Running setup.py install for mozhttpd 13:55:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:55:25 INFO - Running setup.py install for mozinfo 13:55:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:55:25 INFO - Running setup.py install for mozInstall 13:55:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:55:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:55:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:55:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:55:25 INFO - Running setup.py install for mozleak 13:55:25 INFO - Running setup.py install for mozlog 13:55:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:55:25 INFO - Running setup.py install for moznetwork 13:55:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:55:25 INFO - Running setup.py install for mozprocess 13:55:26 INFO - Running setup.py install for mozprofile 13:55:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:55:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:55:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:55:26 INFO - Running setup.py install for mozrunner 13:55:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:55:26 INFO - Running setup.py install for mozscreenshot 13:55:26 INFO - Running setup.py install for moztest 13:55:26 INFO - Running setup.py install for mozversion 13:55:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:55:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:55:26 INFO - Cleaning up... 13:55:26 INFO - Return code: 0 13:55:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:55:26 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')]} 13:55:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:26 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')]} 13:55:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:26 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 0x7fa974cc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2556090>, '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 0x25599b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2559e40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472244814.696315-1226244341', '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 13:55:26 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 13:55:26 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 13:55:26 INFO - Using env: {'DISPLAY': ':0', 13:55:26 INFO - 'HOME': '/home/cltbld', 13:55:26 INFO - 'LANG': 'en_US.UTF-8', 13:55:26 INFO - 'LANGUAGE': 'en_US:en', 13:55:26 INFO - 'LOGNAME': 'cltbld', 13:55:26 INFO - 'MAIL': '/var/mail/cltbld', 13:55:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:26 INFO - 'MOZ_NO_REMOTE': '1', 13:55:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:55:26 INFO - 'NO_EM_RESTART': '1', 13:55:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:55:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:26 INFO - 'PWD': '/builds/slave/test', 13:55:26 INFO - 'SHELL': '/bin/bash', 13:55:26 INFO - 'SHLVL': '1', 13:55:26 INFO - 'TERM': 'linux', 13:55:26 INFO - 'TMOUT': '86400', 13:55:26 INFO - 'USER': 'cltbld', 13:55:26 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472244814.696315-1226244341', 13:55:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:26 INFO - '_': '/tools/buildbot/bin/python'} 13:55:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:55:26 INFO - Running setup.py (path:/tmp/pip-363NLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:55:26 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)) 13:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:55:26 INFO - Running setup.py (path:/tmp/pip-qoQoZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:55:27 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)) 13:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:55:27 INFO - Running setup.py (path:/tmp/pip-QuflUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:55:27 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)) 13:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:55:27 INFO - Running setup.py (path:/tmp/pip-HHRFrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:55:27 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)) 13:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:55:27 INFO - Running setup.py (path:/tmp/pip-ewD86z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:55:27 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)) 13:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:55:27 INFO - Running setup.py (path:/tmp/pip-6LO0YW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:55:27 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)) 13:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:55:27 INFO - Running setup.py (path:/tmp/pip-y3sZq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:55:27 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)) 13:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:55:27 INFO - Running setup.py (path:/tmp/pip-_YXIIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:55:27 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)) 13:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:55:27 INFO - Running setup.py (path:/tmp/pip-e_agyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:55:27 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)) 13:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:55:27 INFO - Running setup.py (path:/tmp/pip-oO6P8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:55:27 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)) 13:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:55:27 INFO - Running setup.py (path:/tmp/pip-hqA6vt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:55:27 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)) 13:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:55:27 INFO - Running setup.py (path:/tmp/pip-GeiJSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:55:27 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)) 13:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:55:27 INFO - Running setup.py (path:/tmp/pip-Dpze8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:55:27 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)) 13:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:55:27 INFO - Running setup.py (path:/tmp/pip-qAGCkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:55:27 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)) 13:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:55:27 INFO - Running setup.py (path:/tmp/pip-R5scky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:55:27 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)) 13:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:55:27 INFO - Running setup.py (path:/tmp/pip-_LN5JS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:55:28 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)) 13:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:55:28 INFO - Running setup.py (path:/tmp/pip-Js08yR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:55:28 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)) 13:55:28 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)) 13:55:28 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)) 13:55:28 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)) 13:55:28 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)) 13:55:28 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)) 13:55:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:55:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:55:29 INFO - Downloading blessings-1.6.tar.gz 13:55:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:55:30 INFO - Installing collected packages: blessings 13:55:30 INFO - Running setup.py install for blessings 13:55:30 INFO - Successfully installed blessings 13:55:30 INFO - Cleaning up... 13:55:30 INFO - Return code: 0 13:55:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:55:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:55:30 INFO - Reading from file tmpfile_stdout 13:55:30 INFO - Current package versions: 13:55:30 INFO - argparse == 1.2.1 13:55:30 INFO - blessings == 1.6 13:55:30 INFO - blobuploader == 1.2.4 13:55:30 INFO - docopt == 0.6.1 13:55:30 INFO - functools32 == 3.2.3-2 13:55:30 INFO - jsonschema == 2.5.1 13:55:30 INFO - manifestparser == 1.1 13:55:30 INFO - mozInstall == 1.12 13:55:30 INFO - mozcrash == 0.17 13:55:30 INFO - mozdebug == 0.1 13:55:30 INFO - mozdevice == 0.48 13:55:30 INFO - mozfile == 1.2 13:55:30 INFO - mozhttpd == 0.7 13:55:30 INFO - mozinfo == 0.9 13:55:30 INFO - mozleak == 0.1 13:55:30 INFO - mozlog == 3.3 13:55:30 INFO - moznetwork == 0.27 13:55:30 INFO - mozprocess == 0.23 13:55:30 INFO - mozprofile == 0.28 13:55:30 INFO - mozrunner == 6.12 13:55:30 INFO - mozscreenshot == 0.1 13:55:30 INFO - mozsystemmonitor == 0.3 13:55:30 INFO - moztest == 0.7 13:55:30 INFO - mozversion == 1.4 13:55:30 INFO - psutil == 3.1.1 13:55:30 INFO - requests == 1.2.3 13:55:30 INFO - wsgiref == 0.1.2 13:55:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:55:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:30 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 0x7fa974cc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2556090>, '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 0x25599b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2559e40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472244814.696315-1226244341', '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 13:55:30 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 13:55:30 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 13:55:30 INFO - Using env: {'DISPLAY': ':0', 13:55:30 INFO - 'HOME': '/home/cltbld', 13:55:30 INFO - 'LANG': 'en_US.UTF-8', 13:55:30 INFO - 'LANGUAGE': 'en_US:en', 13:55:30 INFO - 'LOGNAME': 'cltbld', 13:55:30 INFO - 'MAIL': '/var/mail/cltbld', 13:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:30 INFO - 'MOZ_NO_REMOTE': '1', 13:55:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:55:30 INFO - 'NO_EM_RESTART': '1', 13:55:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:30 INFO - 'PWD': '/builds/slave/test', 13:55:30 INFO - 'SHELL': '/bin/bash', 13:55:30 INFO - 'SHLVL': '1', 13:55:30 INFO - 'TERM': 'linux', 13:55:30 INFO - 'TMOUT': '86400', 13:55:30 INFO - 'USER': 'cltbld', 13:55:30 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472244814.696315-1226244341', 13:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:30 INFO - '_': '/tools/buildbot/bin/python'} 13:55:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:30 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)) 13:55:30 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)) 13:55:30 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)) 13:55:30 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)) 13:55:30 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)) 13:55:30 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)) 13:55:30 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)) 13:55:30 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)) 13:55:30 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)) 13:55:30 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)) 13:55:30 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)) 13:55:30 INFO - Cleaning up... 13:55:30 INFO - Return code: 0 13:55:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:55:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:55:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:55:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:55:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:55:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa974cc6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x248d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2556090>, '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 0x25599b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2559e40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472244814.696315-1226244341', '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 13:55:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:55:30 INFO - Using env: {'DISPLAY': ':0', 13:55:30 INFO - 'HOME': '/home/cltbld', 13:55:30 INFO - 'LANG': 'en_US.UTF-8', 13:55:30 INFO - 'LANGUAGE': 'en_US:en', 13:55:30 INFO - 'LOGNAME': 'cltbld', 13:55:30 INFO - 'MAIL': '/var/mail/cltbld', 13:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:30 INFO - 'MOZ_NO_REMOTE': '1', 13:55:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:55:30 INFO - 'NO_EM_RESTART': '1', 13:55:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:30 INFO - 'PWD': '/builds/slave/test', 13:55:30 INFO - 'SHELL': '/bin/bash', 13:55:30 INFO - 'SHLVL': '1', 13:55:30 INFO - 'TERM': 'linux', 13:55:30 INFO - 'TMOUT': '86400', 13:55:30 INFO - 'USER': 'cltbld', 13:55:30 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472244814.696315-1226244341', 13:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:30 INFO - '_': '/tools/buildbot/bin/python'} 13:55:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:55:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:55:30 INFO - Cleaning up... 13:55:30 INFO - Return code: 0 13:55:30 INFO - Running post-action listener: _resource_record_post_action 13:55:30 INFO - Running post-action listener: _start_resource_monitoring 13:55:30 INFO - Starting resource monitoring. 13:55:30 INFO - [mozharness: 2016-08-26 20:55:30.982983Z] Finished create-virtualenv step (success) 13:55:30 INFO - [mozharness: 2016-08-26 20:55:30.983488Z] Running install step. 13:55:30 INFO - Running pre-action listener: _resource_record_pre_action 13:55:30 INFO - Running main action method: install 13:55:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:55:31 INFO - Reading from file tmpfile_stdout 13:55:31 INFO - Detecting whether we're running mozinstall >=1.0... 13:55:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:55:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:55:31 INFO - Reading from file tmpfile_stdout 13:55:31 INFO - Output received: 13:55:31 INFO - Usage: mozinstall [options] installer 13:55:31 INFO - Options: 13:55:31 INFO - -h, --help show this help message and exit 13:55:31 INFO - -d DEST, --destination=DEST 13:55:31 INFO - Directory to install application into. [default: 13:55:31 INFO - "/builds/slave/test"] 13:55:31 INFO - --app=APP Application being installed. [default: firefox] 13:55:31 INFO - mkdir: /builds/slave/test/build/application 13:55:31 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'] 13:55:31 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 13:55:47 INFO - Reading from file tmpfile_stdout 13:55:47 INFO - Output received: 13:55:47 INFO - /builds/slave/test/build/application/firefox/firefox 13:55:47 INFO - Running post-action listener: _resource_record_post_action 13:55:47 INFO - [mozharness: 2016-08-26 20:55:47.436311Z] Finished install step (success) 13:55:47 INFO - [mozharness: 2016-08-26 20:55:47.436593Z] Running run-tests step. 13:55:47 INFO - Running pre-action listener: _resource_record_pre_action 13:55:47 INFO - Running main action method: run_tests 13:55:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:55:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:55:47 INFO - Python 2.7.3 13:55:47 INFO - Return code: 0 13:55:47 INFO - grabbing minidump binary from tooltool 13:55:47 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')]} 13:55:47 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 0x2556090>, '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 0x25599b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2559e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:55:47 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 13:55:47 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 13:55:47 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 13:55:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:55:47 INFO - Return code: 0 13:55:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:55:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:55:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:55:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:55:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:55:47 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/LWT-ZgAmRC6hdEigjkvnOg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 13:55:47 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/LWT-ZgAmRC6hdEigjkvnOg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 13:55:47 INFO - Using env: {'DISPLAY': ':0', 13:55:47 INFO - 'HOME': '/home/cltbld', 13:55:47 INFO - 'LANG': 'en_US.UTF-8', 13:55:47 INFO - 'LANGUAGE': 'en_US:en', 13:55:47 INFO - 'LOGNAME': 'cltbld', 13:55:47 INFO - 'MAIL': '/var/mail/cltbld', 13:55:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:55:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:55:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:47 INFO - 'MOZ_NO_REMOTE': '1', 13:55:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:55:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:55:47 INFO - 'NO_EM_RESTART': '1', 13:55:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:55:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:47 INFO - 'PWD': '/builds/slave/test', 13:55:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:55:47 INFO - 'SHELL': '/bin/bash', 13:55:47 INFO - 'SHLVL': '1', 13:55:47 INFO - 'TERM': 'linux', 13:55:47 INFO - 'TMOUT': '86400', 13:55:47 INFO - 'USER': 'cltbld', 13:55:47 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472244814.696315-1226244341', 13:55:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:47 INFO - '_': '/tools/buildbot/bin/python'} 13:55:47 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/LWT-ZgAmRC6hdEigjkvnOg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 13:55:47 INFO - mozversion application_buildid: 20160826130713 13:55:47 INFO - mozversion application_changeset: f1c8f78cd6f6e49a5f67b37567888473b898cb90 13:55:47 INFO - mozversion application_display_name: Nightly 13:55:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:55:47 INFO - mozversion application_name: Firefox 13:55:47 INFO - mozversion application_remotingname: firefox 13:55:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:55:47 INFO - mozversion application_vendor: Mozilla 13:55:47 INFO - mozversion application_version: 51.0a1 13:55:47 INFO - mozversion platform_buildid: 20160826130713 13:55:47 INFO - mozversion platform_changeset: f1c8f78cd6f6e49a5f67b37567888473b898cb90 13:55:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:55:47 INFO - mozversion platform_version: 51.0a1 13:55:47 INFO - using testdate: 1472244947 13:55:47 INFO - actual date: 1472244947 13:55:47 INFO - starting webserver on 'localhost:48918' 13:55:47 INFO - SUITE-START | Running 2 tests 13:55:47 INFO - TEST-START | dromaeo_css 13:55:47 INFO - operating with platform_type : linux_ 13:55:47 INFO - Initialising browser for dromaeo_css test... 13:55:47 INFO - TEST-INFO | started process 10446 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppmdMoZ/profile http://localhost:48918/getInfo.html) 13:55:52 INFO - PROCESS | 10446 | __metrics Screen width/height:1600/1200 13:55:52 INFO - PROCESS | 10446 | colorDepth:24 13:55:52 INFO - PROCESS | 10446 | Browser inner width/height: 1024/697 13:55:52 INFO - PROCESS | 10446 | __metrics 13:55:52 INFO - PROCESS | 10446 | 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" 13:55:52 INFO - PROCESS | 10446 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:55:53 INFO - PROCESS | 10446 | console.error: PushService: 13:55:53 INFO - PROCESS | 10446 | stateChangeProcessEnqueue: Error transitioning state 13:55:53 INFO - PROCESS | 10446 | UnknownError 13:55:53 INFO - TEST-INFO | 10446: exit 0 13:55:53 INFO - Browser initialized. 13:55:53 INFO - Running cycle 1/1 for dromaeo_css test... 13:55:53 INFO - TEST-INFO | started process 10526 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppmdMoZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:56:06 INFO - PROCESS | 10526 | RSS: Main: 180715520 13:56:06 INFO - PROCESS | 10526 | 13:56:57 INFO - PROCESS | 10526 | 1472245017047 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] 13:59:10 INFO - PROCESS | 10526 | Cycle 1(1): loaded http://localhost:48918/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48918/tests/dromaeo/cssquery-ext.html) 13:59:11 INFO - PROCESS | 10526 | RSS: Main: 285900800 13:59:11 INFO - PROCESS | 10526 | 14:02:14 INFO - PROCESS | 10526 | Cycle 1(1): loaded http://localhost:48918/tests/dromaeo/cssquery-ext.html (next: http://localhost:48918/tests/dromaeo/cssquery-jquery.html) 14:02:14 INFO - PROCESS | 10526 | RSS: Main: 268894208 14:02:14 INFO - PROCESS | 10526 | 14:05:16 INFO - PROCESS | 10526 | Cycle 1(1): loaded http://localhost:48918/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48918/tests/dromaeo/cssquery-mootools.html) 14:05:17 INFO - PROCESS | 10526 | RSS: Main: 258031616 14:05:17 INFO - PROCESS | 10526 | 14:08:19 INFO - PROCESS | 10526 | Cycle 1(1): loaded http://localhost:48918/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48918/tests/dromaeo/cssquery-prototype.html) 14:08:20 INFO - PROCESS | 10526 | RSS: Main: 218628096 14:08:20 INFO - PROCESS | 10526 | 14:11:23 INFO - PROCESS | 10526 | Cycle 1(1): loaded http://localhost:48918/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48918/tests/dromaeo/cssquery-yui.html) 14:11:24 INFO - PROCESS | 10526 | RSS: Main: 218910720 14:11:24 INFO - PROCESS | 10526 | 14:14:27 INFO - PROCESS | 10526 | Cycle 1(1): loaded http://localhost:48918/tests/dromaeo/cssquery-yui.html (next: http://localhost:48918/tests/dromaeo/cssquery-dojo.html) 14:14:27 INFO - PROCESS | 10526 | RSS: Main: 292642816 14:14:27 INFO - PROCESS | 10526 | 14:14:27 INFO - PROCESS | 10526 | __start_tp_report 14:14:27 INFO - PROCESS | 10526 | _x_x_mozilla_page_load 14:14:27 INFO - PROCESS | 10526 | _x_x_mozilla_page_load_details 14:14:27 INFO - PROCESS | 10526 | |i|pagename|runs| 14:14:27 INFO - PROCESS | 10526 | |0;dojo.html;2593.6412992092683;2601.089618633478;2605.2444791010607;2643.2202500262433;2655.548556745353;4510.774461276939;4622.260438329868;4685.508021657728;4756.524347565241;4841.128596852565;4661.37071495348;4691.765411729417;4749.620030397568;4758.238681810911;4818.831340903069;4315.223259813232;4324.416203812477;4333.046729719473;4351.738895666254;4472.351509031205;4430.534793846648;4434.578715022068;4436.733795972236;4438;4461.308497182942;4245.87262382129;4345.13097380522;4378.452693413324;4431.667624928111;4446.110777844444;4315.223259813232;4334.826606935719;4457.153140903218;4478.820847166109;4478.820847166109;4348.326009468537;4356.803943822536;4360.454943132108;4399.1641588098155;4412.205802955466;4596.310553416981;4772.141014617368;4774.092922344744;4778.450478194983;4783.593394561466;5033.144365457881;5077.390713114413;5087.364079490064;5108.208227724672;5119.257707632372;5119.436861945183;5127.3847138343635;5137.537621614073;5153.56194723449;5170.431252562215;4602.309653551994;4705.6470764692785;4766.356541866839;4771.904561908812;4780.402449693788;5177.741112944338;5210.687358758487;5231.686098834006;5294.311739473844;5294.391145018295;4990.476000019946;4997.200447928314;4998.700077995332;5011.123053465629;5061.190209566452;4896.167651499253;4996.525330093636;5093.617978651616;5096.592272618182;5112.693238405634;4989;4993.051320249141;4999.075171093359;5024.171011783015;5050.6464547482055;4938.678985865908;4947.282644016597;4948.480409556944;4960.0575890581395;5015.974920125376;4169.60388763067;4204.789760511962;4284.207421626947;4292.3561465780385;4356.281213599784;3705.925881482355;3741.794201318899;3763;3772.038130276762;3854.997700597865;4346.2828633275785;4346.500152482505;4348.108637729258;4389.890252743643;4402.207602631493;4908.631852611068;5087.3386459759995;5095.464976177522;5096.847094587169;5105.948940510547;4283.807228674717;4310.396544483775;4318.870433886988;4334.718243314174;4390.2317094508335;4528.592426681615;4556.681032327771;4556.749378784199;4558.794854231567;4618.561236682577;4626.1210370029585;4791.065742180381;4793.520647935178;4794.30482580017;4845.200541910545;5048.545630893237;5104.259882317117;5104.438511763778;5115.462876397924;5191.740412979411;4789.9042019160115;4821.059893320909;4838.637102217277;4839.975800120977;4893.608511319015;4820.204666230033;5038.269450929522;5047.167217409086;5049.343585333883;5118.9744051280995;4982.501749824988;5004.1492946198505;5034.0686972910125;5060.418051924076;5099.23511473282;4853.708777473363;4900.730459824601;4908.9754551227015;4918;4973.079980203674;4710.387649605529;4844.588210002189;4862.854114376574;4863.683860549053;4918.114739346952;4788.664793464424;4822.373091498223;4856.514348565256;4872.731999740048;4931.556159945622;4952.628552858478;4954.232094025432;4972.825951091694;4977.402711674622;5035.59715222774;4670.743109129031;4883.731394773322;4897.289892965571;4899.485554016777;4960.379952505937 14:14:27 INFO - PROCESS | 10526 | |1;ext.html;572;573.3864764701768;581.4418158567775;581.9505342045926;583.5885700581091;29623.259418514546;37806.621933780654;39131.99999999996;39158.608413915856;42972.78513607435;40531;40932.79533602328;40947;40958.38562421566;41027.38458923119;7624.123225829017;7751.689932402697;7758.14660387357;7764.611769411506;7766.339861111784;7642.656080476392;7713.884291735629;7723.845523089535;7733.149353571102;7736.883946740803;7743.6128193590375;7789.182135875736;7791.805204869867;7795.532268063906;7796.727114550992;7706.152323244439;7743.070831500256;7758.185390533969;7767.495112817649;7772.455928085064;7664.425168112414;7740.342070923978;7746.612669366509;7756.069271687434;7766.184550622216;37345.626543734485;37785.24429511422;37808;37849.243015139815;37857;3072.078376487045;3096.9535456968165;3179.459491886362;3298.422776014188;3395.1851555626718;28570.428591428263;28956.855215723997;29030.564541531894;30025.699743002726;30160.396792064035;3262.21706790371;3306.470964645645;3311.089450401135;3333.1500467380906;3355.027042157771;252859;253255;253573;253824;253922.99999999817;31285.217869552987;50616;50999.09514025332;51039.74480127576;51070.48929510657;31265.531017034762;33368.833155834065;33377.3324533508;33449.49825752616;33454.498182527284;13437.462501500026;13603.523876664269;13607;13608.591742247749;13613.183209007491;10987.39569323695;11057.50241239146;11143.387113708824;11146.721331966766;11155;7735.3424958878;7739.690412383554;7828.491148075357;7880.684772609032;7892.4869883457395;3022.2293315204483;3048.6646468888403;3090.737287330557;3091.5826363440647;3098.2254436390904;824.9051359093661;890.4879694175875;958.3866325551653;985.6599473181741;987.2398253344884;26354.73645263561;26630.733692662827;26874.865625672137;27051.1884643461;28057.859710701316;901.4411065139656;903.6475774447971;970.3013830042358;995.1441760086465;1012.2964539644876;14348.210848403229;14521.273936303143;14594.48919287841;14658.853411465749;15046.398144074334;390679;395700;396013;396385;396808;46428.767856160506;47123.52876471191;47173.29240061402;47216;47302.763486182346;1041.3231399590175;1117.2905205194597;1134.8638163420278;1161.105948419729;1162.4187906046977;27454.588181177696;29078.563821543117;29085;29363.853180734815;29844.552331715477;41297.25081615533;41799.7910010448;41807.37288940729;41833.79083104565;41871.37192942169;290595;290938;291780;292325;294206;22159.889200553895;24348.634770478104;24814.875925620257;25071;25429.364265893502;41562.37656435216;41723;41824.79087604542;41889.58110418979;42598.78700606477;34943.475847861795;35039.12402189965;35312.82343588266;35593;35798.8210058948;34963.65036349706;35238.47142292817;35438.46842297419;35869.282614347045;35892.282154356246;34151.487727683605;34664.653353467154;34747.65252347444;34808.30383392267;35456.64543354533;30256;32230.83884580562;32349.838250808596;32387.676123238467;32745;24559.631605525574;24961.87519062393;24975.750242497343;25079.24762257135;25167 14:14:27 INFO - PROCESS | 10526 | |2;jquery.html;345.6422602606303;346.8161874206671;349.2891964851527;349.3659008898848;362.05864751645726;13401.865981340183;13929.164250144999;15882.523524294274;16806.915965420172;17721.291148354052;14088.436462541511;14229.146251224935;14562.271886405664;14910.329035193416;15191.772123418157;4967.726775027381;5191.5846732261325;5192.92210616841;5194.376674799029;5200.6099542534275;6222.719977600997;6551.868962620745;6586.736530538797;6707.932920670804;6711.6979735911755;6453.161089058416;6546.050822630716;6609.801705948829;6680.0981867448;6694.330566943316;6632.104665870094;6656.8668626627195;6664.533482656216;6676.165479315086;6679.599224046524;6394.424501794814;6763.932360676379;6785;6793.728250869959;6910.136232970879;22089.12242459393;22528.43678908024;23071.1925082623;23119.190828320927;23146.305610831532;1964.2830366916116;2057.120229668858;2079.2618620389844;2081.98959005204;2140.389988853185;13392.799108013387;14659.48691795782;14786.556403307917;14879.925600372037;15550.222488875512;1788.5171003829023;1845.796962334142;1860.7674040744907;1872.7471791308271;1904.5048287445225;78631;79963.6001819993;80352;80967;84232.57883710664;16643.974987993905;17100.401485947932;17441.389551365894;17487;17577.912110439367;22814.771852281596;28386.43227135487;28569.57145642817;28657.57013644797;28904;8421.578921053922;8581;8829.867551986725;8893.4663920165;9274.30442716799;7271.818204544928;7341.210340070739;7411.518251313647;7458.925410745932;7547.05661792276;8098.392620553364;8483.915160848435;8515;8609.182127697859;8612.224899759052;3261.1031966209484;3263.4125857345907;3283.1792051987004;3330.9008027350915;3364.360771453416;776.7203806629609;811.8701007838717;827.6813426830713;883.911608839111;933.3992203371251;16316.42892498757;16735.91632041832;17341.56646083858;17800.643987120446;17821.465356039338;794.364508393283;814.1288820961514;834.7161964931952;838.3586556284447;886.2201262888746;9198.540072996324;9806.607735690492;9856.605735770489;9876.555555000043;9968.739145536701;359035;362078;364147;370124;371157;70868.2913170872;72935.90596141062;75556;77170.61414693003;77374.61312693513;879.8372301124313;892.4868200784575;894.0969620683156;895.4000819450853;895.9328050396247;14603.269836508345;14842.18367989771;15215.923920380328;15511.22443877779;15690.372385104469;34084.31831363408;34621.65378346184;36019.63980360268;36118.27763444664;36281.64169328985;48804.755976219894;49116.263256051905;49731.50268497413;49763.253551197486;49779.75110124426;7666.19504951972;7832.490888092484;7957.880631790644;8085.716999904975;8144.796380090545;11762;12182.878171218528;12348;12456.75086498283;12613.432395542406;9764.9023509764;10241.18070554339;10264.841095342734;10474.633387831389;10856.022957933825;9215.249102670472;10707.411092389993;10794.622188223375;11141.944290278496;11166.162537809534;10414.687559373231;10665.626703065356;10796.784064318512;11419.60031398897;11547.942260288644;7606.581638009741;7715.839564921831;7955.363570914429;8020.0375954885785;8068.919310806817;10246.23153263523;10402.635907743193;10408.843867341844;10413.271071024956;10822.837657435302 14:14:27 INFO - PROCESS | 10526 | |3;mootools.html;1249.3253643032763;1346.6197147923374;1379.696466777309;1408.852070532594;1660.6097567071743;6526.445252153567;7284.672189751461;7615;7616.885746713804;7623.237676232374;7168.4265258779305;7247.492675512716;7259.927400725991;7452.217517160701;7457.14242862071;2107.388857231401;2142.72144621199;2150.8817015064164;2151.139544182332;2152.881591512466;2059.155746144081;2093.8534302598823;2119.0570196262593;2123.0340195211143;2123.3205374280237;2067.9586408271903;2079.9584008319825;2083.6978638097467;2090.9268175613856;2093.9267125650604;2083.0418007716466;2085.9478513037143;2090.278853795438;2091.121728873869;2091.173986275428;2007.518195633052;2117.385958072173;2118.1209797933993;2120.194326156051;2121.713568668241;7458.477906546544;7504.249575042452;7542.396608271325;7549.396048316122;7550.886736698954;4410.16206920684;4597.2184728595885;4601.585857272828;4604.746738929358;4611.677182597219;2750;2867.498187817124;2903.941921161586;2905.5932169496286;2919.284775230061;969.1471505075559;973.3964941736098;981.219930155521;993.5429702336861;994.3139233928566;10525.210609204263;10703.090237329758;10717.35695858251;10733.785324293549;10742.409167495785;4017.678585713136;4118.279301122351;4149.398337241144;4239.558550092983;4264.829406823692;8379.120192379713;8441.409101362968;8462.238398544037;8474.1102184271;8480.915190848136;4565.223911934912;4570.200214962435;4570.748608826547;4575.153596584642;4577.107464044546;3700.796456194881;3787.0153760022595;4089.2230476209425;4248.596383343577;4249.405083288342;3404.2340473393288;3470.4273794824076;3528.7177025837873;3543.858245670196;3554.1470047189005;1016.4561959351711;1042.338115296792;1048.4757621189406;1051.6476980211562;1056.5615269663003;723.0058669329671;732.6959311885614;790.2926880441972;797.6388303281285;818.0755746006975;5015.974920125376;5130.87172820675;5168.198929165986;5288.153895376721;5326.600504962066;399.2095650611805;401.54224184429773;402.0952856073834;408.6485622364764;411.90320274735416;3457.101153700056;3478.5825700915548;3562.625924277965;3568.57177138745;3572.356975744339;9273.67542136022;9617.086376794194;9663.082007209305;9686.467244301632;9714.951425242829;9583.233341332676;9590.472524011246;9605.279604029585;9620.75948101303;9638.132568068908;6800;6983.546069505466;7089.92910070903;7256.2743725627015;7320.377767889789;5344.679319240858;5430.126606320813;5471.124620060771;5561.499465048165;5722.7710891563875;8843.60203790818;8973.910260897308;8999.55002249898;9021.729348119567;9062.139096785795;8156.184381561797;8964.91035089667;9015.14356136166;9249.907500925174;9253.306002050007;6849.520533562602;7069.752558660422;7155.998160257464;7176.497645164788;7306.452016098708;7191.42468602521;7302.269773022867;7406.14829294638;7411.184769675439;7463.776086717407;6458.483321334188;6520.7391704333195;6645.900311495235;6656.068150459037;6737.258901520927;6255.96872015637;6257.624542527463;6523.739050437929;6684.966575167093;6762.96618516924;5844.912326315194;5942.31663358702;6001.4298641628975;6055.848603784941;6127.295361033538;4299.1831552005015;4424.247877860836;4436.201483732959;4504.594586487232;4586.8165273388695;4431.689781715378;4434.490033646043;4641.883952901205;4718.339432479387;4720.032393359422 14:14:27 INFO - PROCESS | 10526 | |4;prototype.html;276.60445562845126;284.164556204758;289.76673777609017;290.82550469718166;291.45643375105436;4843.636727245457;4849.612031037517;4864.562189402953;4867.318575399442;4895.902081958358;4735.337052812601;4783.617310615151;4808.927866082012;4825.975870120653;4836.6856154350035;3551.449525323579;3643.8542458301636;3656.3235801376695;3657.2685462907393;3665.8533658653623;3641.435577485494;3679.35611268027;3766.7551609145453;3773.735838491307;3783.9810800945957;3742.7941463219513;3744.3447396705606;3746.6815320697774;3763.2473505298913;3771.528558930134;3517.314123745871;3683.521142251517;3747.9625203747887;3748.5314335708035;3761.22894806564;3227.2577307219235;3236.2556611979376;3249.366373557157;3250.5774249347432;3259.5273685315733;4635.605973492257;4672.602828759559;4679.303350353217;4698.788554515021;4707.152712511746;4135.731177473454;4163.687723420725;4259.212045771542;4260.531341552427;4260.8721738347585;4927.6304277179;4952.755944856125;4964.379452568429;4978.7012779233;4988.975055124701;3595.928081438383;3612.7290453216115;3645.2138452158515;3647.379945409287;3652.867611040586;5090.261912022736;5171.844844654704;5188.247704082924;5199.948000519984;5236.895262094737;3684.176332715323;3686.972165309069;3688.188598508324;3691.8892433227047;3696.963030369716;3738.6635202831876;3767.434884767307;3788.2802267569623;3789.9242015159543;3794.9430758538642;4292.399064131024;4294.806733696991;4298.118885628439;4314.309710446313;4324.827006919688;4834.815470209821;4957.256411538298;4977.502249774993;4977.975110124498;5038.2190760432195;1288.916220445668;1303.9087263891627;1305.9869401306055;1309.1817613991254;1309.4369421148997;819.2708489444399;843.6035063520136;847.7329641163014;859.6604341285282;863.2791618998207;4215.325547912319;4314.956850431456;4379.824807007684;4421.2262854001065;4430.291153415438;5129.846104616868;5133.972081027973;5141;5146.378890649434;5151.5363617274625;4399.560043995575;4418.453541260533;4419.9723189615215;4422.823087076546;4431.781260153483;2609.8042646801564;2682.9877591806144;2725.9591106133425;2729.959050614242;2730.8289909521977;4849.515048495193;4853.174960256765;4865.56209941107;4870.975645121823;4879.658423910363;5024.701472158046;5190.558802501754;5193.766280517386;5233.095631924319;5249;4782.473927868002;4786.210275304606;4796.736179510091;4801.423829140385;4801.831935882227;5076.416212135652;5082.593392528663;5136.768845402041;5145.430643653572;5174.301469301596;4787.88178803035;5039.420466646236;5049.722265275445;5061.645684802176;5070.264811602371;4824.565789079;4837.903241935212;4838.975805121093;4844.15227335222;4849.472416188889;3668.1379875729717;3677.816109194583;3682.6317368262958;3698.6301369863877;3712;5099.36257967754;5116.897662046813;5120.6159538035545;5126.307948426915;5128.692278463304;4720.409948756405;4908.263760435821;4968.776405061853;4973;4988.5260900214425;4954.430240522386;4975.825846095369;4978.32792572998;4994.150994331045;4996.60027197816;4896.216605343128;4905.264210368473;4907.184341793559;4908.828191013297;4921.27557544761;4768.332433459388;4775.5463230993;4901.3383193268455;4950.401039454316;4965.4289756677;4871;4876.951230487792;4898.305931737459;4900.8774780630765;4901.58336541398 14:14:27 INFO - PROCESS | 10526 | |5;yui.html;611.0376157551857;620.0544170140535;667.7262322447795;673.8248055505567;681.1900908751401;12127.090468214887;13138.277394743285;13168.473261069557;13169.604911852635;13180.077394582384;12720.93639531801;12872.871271287284;12891.80662290064;12909.031822613319;12917.160384574996;600.372610621899;717.5802155738899;731.6085894046686;732.150705181989;741.417986880299;747.4468893019153;749.8125468632842;750.6922161913617;750.9849803003937;751.8721817291074;795.3676826922582;797.832455184412;798.6925033861976;799.168864381043;799.4683535448919;627.244170774216;763.5456903142622;776.813564744463;785.701433455289;788.7830846517196;578.4735890339813;578.5689661202389;579.1602176843552;579.6029719642058;579.6985567504915;12168.756624867454;12255.448504817216;12260.325682087481;12281.69295767604;12282.631521054383;12241.143119981605;12345.197562158432;12573.874261257453;12876.098673092887;13221.338933053308;11308.491117899632;11459.484323205475;11523.308601483937;11604.825927611093;11630.534778608846;4011.5988401159943;4055.959440405617;4087.346024636044;4108.979455102735;4153.210889930933;63998.68000660014;64688.676556617385;64727;65623;65677.3432265676;9152.771180720401;9414.905850941539;9569.425834449956;9626.66306679263;9708.174805141642;16969.915150424167;17183.914080429517;17234.65530689404;17247.137643117792;17263.39578114785;6178.5366097542865;6274.2784579773;6451.3548645135115;6540.05169250456;6591.769288074895;3692.759970601956;3716.4239542870896;3762.172322089136;3836.3478208704587;3995.400689896481;2693.676758788958;2806.719328067177;2808.873600687974;2812.4093940272364;2815.42283831814;474.8670372295763;511.8797082685566;514.8018013064997;516.0994065355978;530.6338626347807;549.3286257415216;578.2800413485154;583.8861422022665;588.832182827892;606.7724603273772;7498.137714162941;7666;8117.8376432472205;8438.312337532518;8565.015023272279;525.8422473258007;564.4242872270344;575.1631376347405;588.2969851027981;591.6745789815584;3832.693384529231;3835.2137811748526;3854.6338097880657;3955.7033222508426;4025.2150830587752;59420;59564.40435595675;59718.40281597216;60819.391806081374;77711.61144194356;46864.76567617209;47628.7618561905;70469.2953070473;78406.60796696095;80104;61895;68658;70643.29356706367;72523.63738181275;72705.6364718173;7805.765827025199;7924.460467578222;7977.880331795144;7979.820683799152;8099.716509922125;42777.1444571113;43944.34083488814;44399.778001109786;44687;45538.54461455343;56513;58626.70686646539;61126.694366529664;62340;65313.67343163444;10377.63678271287;10466.162706983576;10616.84074738864;10688.25182237236;11152.665420037412;12010.519579216734;12074.39628018578;12124.757504849676;12619.74760504803;13263.933680331536;11574.18980671345;11692;11701.473433695674;12407.44166512491;12638.2417054977;10642.41466719338;10876.12990960737;11318.943405283251;11337.319760814047;11534.884651153381;10834.67495975122;10880.347179169275;10978.286411383235;11227;11970.640880773592;9290.62837486493;9368.906310936803;9633.181179599813;9846.507674616098;9977.850332245167;9598.616055357708;10117.241206909364;10895.182861285593;11075.5569777208;11084.334939903632 14:14:27 INFO - PROCESS | 10526 | __end_tp_report 14:14:27 INFO - PROCESS | 10526 | __start_cc_report 14:14:27 INFO - PROCESS | 10526 | _x_x_mozilla_cycle_collect,948 14:14:27 INFO - PROCESS | 10526 | __end_cc_report 14:14:27 INFO - PROCESS | 10526 | __startTimestamp1472246067533__endTimestamp 14:14:27 INFO - PROCESS | 10526 | 14:14:27 INFO - PROCESS | 10526 | ------- Summary: start ------- 14:14:27 INFO - PROCESS | 10526 | Number of tests: 6 14:14:27 INFO - PROCESS | 10526 | 14:14:27 INFO - PROCESS | 10526 | [#0] dojo.html Cycles:165 Average:4682.35 Median:4820.20 stddev:493.28 (10.2%) stddev-sans-first:466.79 14:14:27 INFO - PROCESS | 10526 | Values: 2593.6 2601.1 2605.2 2643.2 2655.5 4510.8 4622.3 4685.5 4756.5 4841.1 4661.4 4691.8 4749.6 4758.2 4818.8 4315.2 4324.4 4333.0 4351.7 4472.4 4430.5 4434.6 4436.7 4438.0 4461.3 4245.9 4345.1 4378.5 4431.7 4446.1 4315.2 4334.8 4457.2 4478.8 4478.8 4348.3 4356.8 4360.5 4399.2 4412.2 4596.3 4772.1 4774.1 4778.5 4783.6 5033.1 5077.4 5087.4 5108.2 5119.3 5119.4 5127.4 5137.5 5153.6 5170.4 4602.3 4705.6 4766.4 4771.9 4780.4 5177.7 5210.7 5231.7 5294.3 5294.4 4990.5 4997.2 4998.7 5011.1 5061.2 4896.2 4996.5 5093.6 5096.6 5112.7 4989.0 4993.1 4999.1 5024.2 5050.6 4938.7 4947.3 4948.5 4960.1 5016.0 4169.6 4204.8 4284.2 4292.4 4356.3 3705.9 3741.8 3763.0 3772.0 3855.0 4346.3 4346.5 4348.1 4389.9 4402.2 4908.6 5087.3 5095.5 5096.8 5105.9 4283.8 4310.4 4318.9 4334.7 4390.2 4528.6 4556.7 4556.7 4558.8 4618.6 4626.1 4791.1 4793.5 4794.3 4845.2 5048.5 5104.3 5104.4 5115.5 5191.7 4789.9 4821.1 4838.6 4840.0 4893.6 4820.2 5038.3 5047.2 5049.3 5119.0 4982.5 5004.1 5034.1 5060.4 5099.2 4853.7 4900.7 4909.0 4918.0 4973.1 4710.4 4844.6 4862.9 4863.7 4918.1 4788.7 4822.4 4856.5 4872.7 4931.6 4952.6 4954.2 4972.8 4977.4 5035.6 4670.7 4883.7 4897.3 4899.5 4960.4 14:14:27 INFO - PROCESS | 10526 | 14:14:27 INFO - PROCESS | 10526 | [#1] ext.html Cycles:180 Average:45522.39 Median:35275.65 stddev:84221.45 (238.8%) stddev-sans-first:84390.09 14:14:27 INFO - PROCESS | 10526 | Values: 572.0 573.4 581.4 582.0 583.6 29623.3 37806.6 39132.0 39158.6 42972.8 40531.0 40932.8 40947.0 40958.4 41027.4 7624.1 7751.7 7758.1 7764.6 7766.3 7642.7 7713.9 7723.8 7733.1 7736.9 7743.6 7789.2 7791.8 7795.5 7796.7 7706.2 7743.1 7758.2 7767.5 7772.5 7664.4 7740.3 7746.6 7756.1 7766.2 37345.6 37785.2 37808.0 37849.2 37857.0 3072.1 3097.0 3179.5 3298.4 3395.2 28570.4 28956.9 29030.6 30025.7 30160.4 3262.2 3306.5 3311.1 3333.2 3355.0 252859.0 253255.0 253573.0 253824.0 253923.0 31285.2 50616.0 50999.1 51039.7 51070.5 31265.5 33368.8 33377.3 33449.5 33454.5 13437.5 13603.5 13607.0 13608.6 13613.2 10987.4 11057.5 11143.4 11146.7 11155.0 7735.3 7739.7 7828.5 7880.7 7892.5 3022.2 3048.7 3090.7 3091.6 3098.2 824.9 890.5 958.4 985.7 987.2 26354.7 26630.7 26874.9 27051.2 28057.9 901.4 903.6 970.3 995.1 1012.3 14348.2 14521.3 14594.5 14658.9 15046.4 390679.0 395700.0 396013.0 396385.0 396808.0 46428.8 47123.5 47173.3 47216.0 47302.8 1041.3 1117.3 1134.9 1161.1 1162.4 27454.6 29078.6 29085.0 29363.9 29844.6 41297.3 41799.8 41807.4 41833.8 41871.4 290595.0 290938.0 291780.0 292325.0 294206.0 22159.9 24348.6 24814.9 25071.0 25429.4 41562.4 41723.0 41824.8 41889.6 42598.8 34943.5 35039.1 35312.8 35593.0 35798.8 34963.7 35238.5 35438.5 35869.3 35892.3 34151.5 34664.7 34747.7 34808.3 35456.6 30256.0 32230.8 32349.8 32387.7 32745.0 24559.6 24961.9 24975.8 25079.2 25167.0 14:14:27 INFO - PROCESS | 10526 | 14:14:27 INFO - PROCESS | 10526 | [#2] jquery.html Cycles:180 Average:24920.78 Median:367135.50 stddev:60485.57 (16.5%) stddev-sans-first:60627.11 14:14:27 INFO - PROCESS | 10526 | Values: 345.6 346.8 349.3 349.4 362.1 13401.9 13929.2 15882.5 16806.9 17721.3 14088.4 14229.1 14562.3 14910.3 15191.8 4967.7 5191.6 5192.9 5194.4 5200.6 6222.7 6551.9 6586.7 6707.9 6711.7 6453.2 6546.1 6609.8 6680.1 6694.3 6632.1 6656.9 6664.5 6676.2 6679.6 6394.4 6763.9 6785.0 6793.7 6910.1 22089.1 22528.4 23071.2 23119.2 23146.3 1964.3 2057.1 2079.3 2082.0 2140.4 13392.8 14659.5 14786.6 14879.9 15550.2 1788.5 1845.8 1860.8 1872.7 1904.5 78631.0 79963.6 80352.0 80967.0 84232.6 16644.0 17100.4 17441.4 17487.0 17577.9 22814.8 28386.4 28569.6 28657.6 28904.0 8421.6 8581.0 8829.9 8893.5 9274.3 7271.8 7341.2 7411.5 7458.9 7547.1 8098.4 8483.9 8515.0 8609.2 8612.2 3261.1 3263.4 3283.2 3330.9 3364.4 776.7 811.9 827.7 883.9 933.4 16316.4 16735.9 17341.6 17800.6 17821.5 794.4 814.1 834.7 838.4 886.2 9198.5 9806.6 9856.6 9876.6 9968.7 359035.0 362078.0 364147.0 370124.0 371157.0 70868.3 72935.9 75556.0 77170.6 77374.6 879.8 892.5 894.1 895.4 895.9 14603.3 14842.2 15215.9 15511.2 15690.4 34084.3 34621.7 36019.6 36118.3 36281.6 48804.8 49116.3 49731.5 49763.3 49779.8 7666.2 7832.5 7957.9 8085.7 8144.8 11762.0 12182.9 12348.0 12456.8 12613.4 9764.9 10241.2 10264.8 10474.6 10856.0 9215.2 10707.4 10794.6 11141.9 11166.2 10414.7 10665.6 10796.8 11419.6 11547.9 7606.6 7715.8 7955.4 8020.0 8068.9 10246.2 10402.6 10408.8 10413.3 10822.8 14:14:27 INFO - PROCESS | 10526 | 14:14:27 INFO - PROCESS | 10526 | [#3] mootools.html Cycles:180 Average:5031.25 Median:5073.42 stddev:2861.79 (56.4%) stddev-sans-first:2855.71 14:14:27 INFO - PROCESS | 10526 | Values: 1249.3 1346.6 1379.7 1408.9 1660.6 6526.4 7284.7 7615.0 7616.9 7623.2 7168.4 7247.5 7259.9 7452.2 7457.1 2107.4 2142.7 2150.9 2151.1 2152.9 2059.2 2093.9 2119.1 2123.0 2123.3 2068.0 2080.0 2083.7 2090.9 2093.9 2083.0 2085.9 2090.3 2091.1 2091.2 2007.5 2117.4 2118.1 2120.2 2121.7 7458.5 7504.2 7542.4 7549.4 7550.9 4410.2 4597.2 4601.6 4604.7 4611.7 2750.0 2867.5 2903.9 2905.6 2919.3 969.1 973.4 981.2 993.5 994.3 10525.2 10703.1 10717.4 10733.8 10742.4 4017.7 4118.3 4149.4 4239.6 4264.8 8379.1 8441.4 8462.2 8474.1 8480.9 4565.2 4570.2 4570.7 4575.2 4577.1 3700.8 3787.0 4089.2 4248.6 4249.4 3404.2 3470.4 3528.7 3543.9 3554.1 1016.5 1042.3 1048.5 1051.6 1056.6 723.0 732.7 790.3 797.6 818.1 5016.0 5130.9 5168.2 5288.2 5326.6 399.2 401.5 402.1 408.6 411.9 3457.1 3478.6 3562.6 3568.6 3572.4 9273.7 9617.1 9663.1 9686.5 9715.0 9583.2 9590.5 9605.3 9620.8 9638.1 6800.0 6983.5 7089.9 7256.3 7320.4 5344.7 5430.1 5471.1 5561.5 5722.8 8843.6 8973.9 8999.6 9021.7 9062.1 8156.2 8964.9 9015.1 9249.9 9253.3 6849.5 7069.8 7156.0 7176.5 7306.5 7191.4 7302.3 7406.1 7411.2 7463.8 6458.5 6520.7 6645.9 6656.1 6737.3 6256.0 6257.6 6523.7 6685.0 6763.0 5844.9 5942.3 6001.4 6055.8 6127.3 4299.2 4424.2 4436.2 4504.6 4586.8 4431.7 4434.5 4641.9 4718.3 4720.0 14:14:27 INFO - PROCESS | 10526 | 14:14:27 INFO - PROCESS | 10526 | [#4] prototype.html Cycles:180 Average:4147.79 Median:4784.91 stddev:1196.72 (25.0%) stddev-sans-first:1164.27 14:14:27 INFO - PROCESS | 10526 | Values: 276.6 284.2 289.8 290.8 291.5 4843.6 4849.6 4864.6 4867.3 4895.9 4735.3 4783.6 4808.9 4826.0 4836.7 3551.4 3643.9 3656.3 3657.3 3665.9 3641.4 3679.4 3766.8 3773.7 3784.0 3742.8 3744.3 3746.7 3763.2 3771.5 3517.3 3683.5 3748.0 3748.5 3761.2 3227.3 3236.3 3249.4 3250.6 3259.5 4635.6 4672.6 4679.3 4698.8 4707.2 4135.7 4163.7 4259.2 4260.5 4260.9 4927.6 4952.8 4964.4 4978.7 4989.0 3595.9 3612.7 3645.2 3647.4 3652.9 5090.3 5171.8 5188.2 5199.9 5236.9 3684.2 3687.0 3688.2 3691.9 3697.0 3738.7 3767.4 3788.3 3789.9 3794.9 4292.4 4294.8 4298.1 4314.3 4324.8 4834.8 4957.3 4977.5 4978.0 5038.2 1288.9 1303.9 1306.0 1309.2 1309.4 819.3 843.6 847.7 859.7 863.3 4215.3 4315.0 4379.8 4421.2 4430.3 5129.8 5134.0 5141.0 5146.4 5151.5 4399.6 4418.5 4420.0 4422.8 4431.8 2609.8 2683.0 2726.0 2730.0 2730.8 4849.5 4853.2 4865.6 4871.0 4879.7 5024.7 5190.6 5193.8 5233.1 5249.0 4782.5 4786.2 4796.7 4801.4 4801.8 5076.4 5082.6 5136.8 5145.4 5174.3 4787.9 5039.4 5049.7 5061.6 5070.3 4824.6 4837.9 4839.0 4844.2 4849.5 3668.1 3677.8 3682.6 3698.6 3712.0 5099.4 5116.9 5120.6 5126.3 5128.7 4720.4 4908.3 4968.8 4973.0 4988.5 4954.4 4975.8 4978.3 4994.2 4996.6 4896.2 4905.3 4907.2 4908.8 4921.3 4768.3 4775.5 4901.3 4950.4 4965.4 4871.0 4877.0 4898.3 4900.9 4901.6 14:14:27 INFO - PROCESS | 10526 | 14:14:27 INFO - PROCESS | 10526 | [#5] yui.html Cycles:180 Average:16021.87 Median:528.24 stddev:21264.73 (4025.6%) stddev-sans-first:21292.90 14:14:27 INFO - PROCESS | 10526 | Values: 611.0 620.1 667.7 673.8 681.2 12127.1 13138.3 13168.5 13169.6 13180.1 12720.9 12872.9 12891.8 12909.0 12917.2 600.4 717.6 731.6 732.2 741.4 747.4 749.8 750.7 751.0 751.9 795.4 797.8 798.7 799.2 799.5 627.2 763.5 776.8 785.7 788.8 578.5 578.6 579.2 579.6 579.7 12168.8 12255.4 12260.3 12281.7 12282.6 12241.1 12345.2 12573.9 12876.1 13221.3 11308.5 11459.5 11523.3 11604.8 11630.5 4011.6 4056.0 4087.3 4109.0 4153.2 63998.7 64688.7 64727.0 65623.0 65677.3 9152.8 9414.9 9569.4 9626.7 9708.2 16969.9 17183.9 17234.7 17247.1 17263.4 6178.5 6274.3 6451.4 6540.1 6591.8 3692.8 3716.4 3762.2 3836.3 3995.4 2693.7 2806.7 2808.9 2812.4 2815.4 474.9 511.9 514.8 516.1 530.6 549.3 578.3 583.9 588.8 606.8 7498.1 7666.0 8117.8 8438.3 8565.0 525.8 564.4 575.2 588.3 591.7 3832.7 3835.2 3854.6 3955.7 4025.2 59420.0 59564.4 59718.4 60819.4 77711.6 46864.8 47628.8 70469.3 78406.6 80104.0 61895.0 68658.0 70643.3 72523.6 72705.6 7805.8 7924.5 7977.9 7979.8 8099.7 42777.1 43944.3 44399.8 44687.0 45538.5 56513.0 58626.7 61126.7 62340.0 65313.7 10377.6 10466.2 10616.8 10688.3 11152.7 12010.5 12074.4 12124.8 12619.7 13263.9 11574.2 11692.0 11701.5 12407.4 12638.2 10642.4 10876.1 11318.9 11337.3 11534.9 10834.7 10880.3 10978.3 11227.0 11970.6 9290.6 9368.9 9633.2 9846.5 9977.9 9598.6 10117.2 10895.2 11075.6 11084.3 14:14:27 INFO - PROCESS | 10526 | -------- Summary: end -------- 14:14:27 INFO - PROCESS | 10526 | 14:14:28 INFO - TEST-INFO | 10526: exit 0 14:14:28 INFO - TEST-OK | dromaeo_css | took 1120687ms 14:14:28 INFO - TEST-START | kraken 14:14:28 INFO - operating with platform_type : linux_ 14:14:28 INFO - Initialising browser for kraken test... 14:14:28 INFO - TEST-INFO | started process 10830 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptg2VmA/profile http://localhost:48918/getInfo.html) 14:14:32 INFO - PROCESS | 10830 | __metrics Screen width/height:1600/1200 14:14:32 INFO - PROCESS | 10830 | colorDepth:24 14:14:32 INFO - PROCESS | 10830 | Browser inner width/height: 1024/697 14:14:32 INFO - PROCESS | 10830 | __metrics 14:14:33 INFO - PROCESS | 10830 | 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" 14:14:33 INFO - PROCESS | 10830 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:14:34 INFO - TEST-INFO | 10830: exit 0 14:14:34 INFO - Browser initialized. 14:14:34 INFO - Running cycle 1/1 for kraken test... 14:14:34 INFO - TEST-INFO | started process 10910 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptg2VmA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:14:46 INFO - PROCESS | 10910 | RSS: Main: 180756480 14:14:46 INFO - PROCESS | 10910 | 14:14:49 INFO - PROCESS | 10910 | Cycle 1(1): loaded http://localhost:48918/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48918/tests/kraken/driver.html?testName=audio-beat-detection) 14:14:50 INFO - PROCESS | 10910 | RSS: Main: 234401792 14:14:50 INFO - PROCESS | 10910 | 14:14:52 INFO - PROCESS | 10910 | Cycle 1(1): loaded http://localhost:48918/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48918/tests/kraken/driver.html?testName=audio-dft) 14:14:53 INFO - PROCESS | 10910 | RSS: Main: 224948224 14:14:53 INFO - PROCESS | 10910 | 14:14:56 INFO - PROCESS | 10910 | Cycle 1(1): loaded http://localhost:48918/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48918/tests/kraken/driver.html?testName=audio-fft) 14:14:57 INFO - PROCESS | 10910 | RSS: Main: 303734784 14:14:57 INFO - PROCESS | 10910 | 14:14:59 INFO - PROCESS | 10910 | Cycle 1(1): loaded http://localhost:48918/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48918/tests/kraken/driver.html?testName=audio-oscillator) 14:15:00 INFO - PROCESS | 10910 | RSS: Main: 213110784 14:15:00 INFO - PROCESS | 10910 | 14:15:02 INFO - PROCESS | 10910 | Cycle 1(1): loaded http://localhost:48918/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48918/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:15:02 INFO - PROCESS | 10910 | RSS: Main: 214630400 14:15:02 INFO - PROCESS | 10910 | 14:15:06 INFO - PROCESS | 10910 | Cycle 1(1): loaded http://localhost:48918/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48918/tests/kraken/driver.html?testName=imaging-darkroom) 14:15:06 INFO - PROCESS | 10910 | RSS: Main: 253177856 14:15:06 INFO - PROCESS | 10910 | 14:15:10 INFO - PROCESS | 10910 | Cycle 1(1): loaded http://localhost:48918/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48918/tests/kraken/driver.html?testName=imaging-desaturate) 14:15:10 INFO - PROCESS | 10910 | RSS: Main: 247066624 14:15:10 INFO - PROCESS | 10910 | 14:15:13 INFO - PROCESS | 10910 | Cycle 1(1): loaded http://localhost:48918/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48918/tests/kraken/driver.html?testName=json-parse-financial) 14:15:14 INFO - PROCESS | 10910 | RSS: Main: 250826752 14:15:14 INFO - PROCESS | 10910 | 14:15:16 INFO - PROCESS | 10910 | Cycle 1(1): loaded http://localhost:48918/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48918/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:15:16 INFO - PROCESS | 10910 | RSS: Main: 214224896 14:15:16 INFO - PROCESS | 10910 | 14:15:18 INFO - PROCESS | 10910 | Cycle 1(1): loaded http://localhost:48918/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48918/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:15:19 INFO - PROCESS | 10910 | RSS: Main: 220811264 14:15:19 INFO - PROCESS | 10910 | 14:15:21 INFO - PROCESS | 10910 | Cycle 1(1): loaded http://localhost:48918/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48918/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:15:22 INFO - PROCESS | 10910 | RSS: Main: 221282304 14:15:22 INFO - PROCESS | 10910 | 14:15:24 INFO - PROCESS | 10910 | Cycle 1(1): loaded http://localhost:48918/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48918/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:15:25 INFO - PROCESS | 10910 | RSS: Main: 222941184 14:15:25 INFO - PROCESS | 10910 | 14:15:28 INFO - PROCESS | 10910 | Cycle 1(1): loaded http://localhost:48918/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48918/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:15:29 INFO - PROCESS | 10910 | RSS: Main: 221532160 14:15:29 INFO - PROCESS | 10910 | 14:15:30 INFO - PROCESS | 10910 | Cycle 1(1): loaded http://localhost:48918/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48918/tests/kraken/driver.html?testName=ai-astar) 14:15:31 INFO - PROCESS | 10910 | RSS: Main: 271527936 14:15:31 INFO - PROCESS | 10910 | 14:15:31 INFO - PROCESS | 10910 | __start_tp_report 14:15:31 INFO - PROCESS | 10910 | _x_x_mozilla_page_load 14:15:31 INFO - PROCESS | 10910 | _x_x_mozilla_page_load_details 14:15:31 INFO - PROCESS | 10910 | |i|pagename|runs| 14:15:31 INFO - PROCESS | 10910 | |0;ai-astar;114;114;131;114;112;113;114;114;114;113 14:15:31 INFO - PROCESS | 10910 | |1;audio-beat-detection;157;122;153;181;122;157;148;123;179;128 14:15:31 INFO - PROCESS | 10910 | |2;audio-dft;161;164;163;161;161;161;163;161;161;163 14:15:31 INFO - PROCESS | 10910 | |3;audio-fft;77;76;76;160;77;75;76;75;160;76 14:15:31 INFO - PROCESS | 10910 | |4;audio-oscillator;85;84;137;85;83;84;141;84;84;133 14:15:31 INFO - PROCESS | 10910 | |5;imaging-gaussian-blur;117;117;117;116;117;117;116;117;116;117 14:15:31 INFO - PROCESS | 10910 | |6;imaging-darkroom;147;147;146;146;147;146;146;146;146;146 14:15:31 INFO - PROCESS | 10910 | |7;imaging-desaturate;95;95;95;96;96;95;96;95;96;95 14:15:31 INFO - PROCESS | 10910 | |8;json-parse-financial;63;62;63;64;63;63;72;64;64;64 14:15:31 INFO - PROCESS | 10910 | |9;json-stringify-tinderbox;65;66;66;66;67;65;65;66;67;66 14:15:31 INFO - PROCESS | 10910 | |10;stanford-crypto-aes;82;83;82;91;84;82;82;84;83;83 14:15:31 INFO - PROCESS | 10910 | |11;stanford-crypto-ccm;143;131;133;132;142;131;142;134;181;133 14:15:31 INFO - PROCESS | 10910 | |12;stanford-crypto-pbkdf2;175;174;173;173;172;172;173;173;170;168 14:15:31 INFO - PROCESS | 10910 | |13;stanford-crypto-sha256-iterative;71;69;69;71;70;69;73;68;72;73 14:15:31 INFO - PROCESS | 10910 | __end_tp_report 14:15:31 INFO - PROCESS | 10910 | __start_cc_report 14:15:31 INFO - PROCESS | 10910 | _x_x_mozilla_cycle_collect,2015 14:15:31 INFO - PROCESS | 10910 | __end_cc_report 14:15:31 INFO - PROCESS | 10910 | __startTimestamp1472246131172__endTimestamp 14:15:31 INFO - PROCESS | 10910 | 14:15:31 INFO - PROCESS | 10910 | ------- Summary: start ------- 14:15:31 INFO - PROCESS | 10910 | Number of tests: 14 14:15:31 INFO - PROCESS | 10910 | 14:15:31 INFO - PROCESS | 10910 | [#0] ai-astar Cycles:10 Average:115.30 Median:114.00 stddev:5.56 (4.9%) stddev-sans-first:5.88 14:15:31 INFO - PROCESS | 10910 | Values: 114.0 114.0 131.0 114.0 112.0 113.0 114.0 114.0 114.0 113.0 14:15:31 INFO - PROCESS | 10910 | 14:15:31 INFO - PROCESS | 10910 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:155.00 stddev:22.62 (14.6%) stddev-sans-first:23.70 14:15:31 INFO - PROCESS | 10910 | Values: 157.0 122.0 153.0 181.0 122.0 157.0 148.0 123.0 179.0 128.0 14:15:31 INFO - PROCESS | 10910 | 14:15:31 INFO - PROCESS | 10910 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.20 (0.7%) stddev-sans-first:1.22 14:15:31 INFO - PROCESS | 10910 | Values: 161.0 164.0 163.0 161.0 161.0 161.0 163.0 161.0 161.0 163.0 14:15:31 INFO - PROCESS | 10910 | 14:15:31 INFO - PROCESS | 10910 | [#3] audio-fft Cycles:10 Average:92.80 Median:76.00 stddev:35.42 (46.6%) stddev-sans-first:37.11 14:15:31 INFO - PROCESS | 10910 | Values: 77.0 76.0 76.0 160.0 77.0 75.0 76.0 75.0 160.0 76.0 14:15:31 INFO - PROCESS | 10910 | 14:15:31 INFO - PROCESS | 10910 | [#4] audio-oscillator Cycles:10 Average:100.00 Median:84.00 stddev:25.61 (30.5%) stddev-sans-first:26.58 14:15:31 INFO - PROCESS | 10910 | Values: 85.0 84.0 137.0 85.0 83.0 84.0 141.0 84.0 84.0 133.0 14:15:31 INFO - PROCESS | 10910 | 14:15:31 INFO - PROCESS | 10910 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 14:15:31 INFO - PROCESS | 10910 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 116.0 117.0 14:15:31 INFO - PROCESS | 10910 | 14:15:31 INFO - PROCESS | 10910 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 14:15:31 INFO - PROCESS | 10910 | Values: 147.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 14:15:31 INFO - PROCESS | 10910 | 14:15:31 INFO - PROCESS | 10910 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:15:31 INFO - PROCESS | 10910 | Values: 95.0 95.0 95.0 96.0 96.0 95.0 96.0 95.0 96.0 95.0 14:15:31 INFO - PROCESS | 10910 | 14:15:31 INFO - PROCESS | 10910 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:64.00 stddev:2.82 (4.4%) stddev-sans-first:2.96 14:15:31 INFO - PROCESS | 10910 | Values: 63.0 62.0 63.0 64.0 63.0 63.0 72.0 64.0 64.0 64.0 14:15:31 INFO - PROCESS | 10910 | 14:15:31 INFO - PROCESS | 10910 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 14:15:31 INFO - PROCESS | 10910 | Values: 65.0 66.0 66.0 66.0 67.0 65.0 65.0 66.0 67.0 66.0 14:15:31 INFO - PROCESS | 10910 | 14:15:31 INFO - PROCESS | 10910 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.00 stddev:2.72 (3.3%) stddev-sans-first:2.82 14:15:31 INFO - PROCESS | 10910 | Values: 82.0 83.0 82.0 91.0 84.0 82.0 82.0 84.0 83.0 83.0 14:15:31 INFO - PROCESS | 10910 | 14:15:31 INFO - PROCESS | 10910 | [#11] stanford-crypto-ccm Cycles:10 Average:140.20 Median:138.00 stddev:15.12 (11.0%) stddev-sans-first:16.00 14:15:31 INFO - PROCESS | 10910 | Values: 143.0 131.0 133.0 132.0 142.0 131.0 142.0 134.0 181.0 133.0 14:15:31 INFO - PROCESS | 10910 | 14:15:31 INFO - PROCESS | 10910 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.30 Median:173.00 stddev:2.00 (1.2%) stddev-sans-first:1.87 14:15:31 INFO - PROCESS | 10910 | Values: 175.0 174.0 173.0 173.0 172.0 172.0 173.0 173.0 170.0 168.0 14:15:31 INFO - PROCESS | 10910 | 14:15:31 INFO - PROCESS | 10910 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:71.00 stddev:1.78 (2.5%) stddev-sans-first:1.88 14:15:31 INFO - PROCESS | 10910 | Values: 71.0 69.0 69.0 71.0 70.0 69.0 73.0 68.0 72.0 73.0 14:15:31 INFO - PROCESS | 10910 | -------- Summary: end -------- 14:15:31 INFO - PROCESS | 10910 | 14:15:32 INFO - TEST-INFO | 10910: exit 0 14:15:32 INFO - TEST-OK | kraken | took 64067ms 14:15:32 INFO - SUITE-END | took 1184s 14:15:32 INFO - Completed test suite (00:19:45) 14:15:32 INFO - javascript benchmark 14:15:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2593.6412992092683, 2601.089618633478, 2605.2444791010607, 2643.2202500262433, 2655.548556745353, 4510.774461276939, 4622.260438329868, 4685.508021657728, 4756.524347565241, 4841.128596852565, 4661.37071495348, 4691.765411729417, 4749.620030397568, 4758.238681810911, 4818.831340903069, 4315.223259813232, 4324.416203812477, 4333.046729719473, 4351.738895666254, 4472.351509031205, 4430.534793846648, 4434.578715022068, 4436.733795972236, 4438.0, 4461.308497182942, 4245.87262382129, 4345.13097380522, 4378.452693413324, 4431.667624928111, 4446.110777844444, 4315.223259813232, 4334.826606935719, 4457.153140903218, 4478.820847166109, 4478.820847166109, 4348.326009468537, 4356.803943822536, 4360.454943132108, 4399.1641588098155, 4412.205802955466, 4596.310553416981, 4772.141014617368, 4774.092922344744, 4778.450478194983, 4783.593394561466, 5033.144365457881, 5077.390713114413, 5087.364079490064, 5108.208227724672, 5119.257707632372, 5119.436861945183, 5127.3847138343635, 5137.537621614073, 5153.56194723449, 5170.431252562215, 4602.309653551994, 4705.6470764692785, 4766.356541866839, 4771.904561908812, 4780.402449693788, 5177.741112944338, 5210.687358758487, 5231.686098834006, 5294.311739473844, 5294.391145018295, 4990.476000019946, 4997.200447928314, 4998.700077995332, 5011.123053465629, 5061.190209566452, 4896.167651499253, 4996.525330093636, 5093.617978651616, 5096.592272618182, 5112.693238405634, 4989.0, 4993.051320249141, 4999.075171093359, 5024.171011783015, 5050.6464547482055, 4938.678985865908, 4947.282644016597, 4948.480409556944, 4960.0575890581395, 5015.974920125376, 4169.60388763067, 4204.789760511962, 4284.207421626947, 4292.3561465780385, 4356.281213599784, 3705.925881482355, 3741.794201318899, 3763.0, 3772.038130276762, 3854.997700597865, 4346.2828633275785, 4346.500152482505, 4348.108637729258, 4389.890252743643, 4402.207602631493, 4908.631852611068, 5087.3386459759995, 5095.464976177522, 5096.847094587169, 5105.948940510547, 4283.807228674717, 4310.396544483775, 4318.870433886988, 4334.718243314174, 4390.2317094508335, 4528.592426681615, 4556.681032327771, 4556.749378784199, 4558.794854231567, 4618.561236682577, 4626.1210370029585, 4791.065742180381, 4793.520647935178, 4794.30482580017, 4845.200541910545, 5048.545630893237, 5104.259882317117, 5104.438511763778, 5115.462876397924, 5191.740412979411, 4789.9042019160115, 4821.059893320909, 4838.637102217277, 4839.975800120977, 4893.608511319015, 4820.204666230033, 5038.269450929522, 5047.167217409086, 5049.343585333883, 5118.9744051280995, 4982.501749824988, 5004.1492946198505, 5034.0686972910125, 5060.418051924076, 5099.23511473282, 4853.708777473363, 4900.730459824601, 4908.9754551227015, 4918.0, 4973.079980203674, 4710.387649605529, 4844.588210002189, 4862.854114376574, 4863.683860549053, 4918.114739346952, 4788.664793464424, 4822.373091498223, 4856.514348565256, 4872.731999740048, 4931.556159945622, 4952.628552858478, 4954.232094025432, 4972.825951091694, 4977.402711674622, 5035.59715222774, 4670.743109129031, 4883.731394773322, 4897.289892965571, 4899.485554016777, 4960.379952505937], "value": 4650.637852980149, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.0, 573.3864764701768, 581.4418158567775, 581.9505342045926, 583.5885700581091, 29623.259418514546, 37806.621933780654, 39131.99999999996, 39158.608413915856, 42972.78513607435, 40531.0, 40932.79533602328, 40947.0, 40958.38562421566, 41027.38458923119, 7624.123225829017, 7751.689932402697, 7758.14660387357, 7764.611769411506, 7766.339861111784, 7642.656080476392, 7713.884291735629, 7723.845523089535, 7733.149353571102, 7736.883946740803, 7743.6128193590375, 7789.182135875736, 7791.805204869867, 7795.532268063906, 7796.727114550992, 7706.152323244439, 7743.070831500256, 7758.185390533969, 7767.495112817649, 7772.455928085064, 7664.425168112414, 7740.342070923978, 7746.612669366509, 7756.069271687434, 7766.184550622216, 37345.626543734485, 37785.24429511422, 37808.0, 37849.243015139815, 37857.0, 3072.078376487045, 3096.9535456968165, 3179.459491886362, 3298.422776014188, 3395.1851555626718, 28570.428591428263, 28956.855215723997, 29030.564541531894, 30025.699743002726, 30160.396792064035, 3262.21706790371, 3306.470964645645, 3311.089450401135, 3333.1500467380906, 3355.027042157771, 252859.0, 253255.0, 253573.0, 253824.0, 253922.99999999817, 31285.217869552987, 50616.0, 50999.09514025332, 51039.74480127576, 51070.48929510657, 31265.531017034762, 33368.833155834065, 33377.3324533508, 33449.49825752616, 33454.498182527284, 13437.462501500026, 13603.523876664269, 13607.0, 13608.591742247749, 13613.183209007491, 10987.39569323695, 11057.50241239146, 11143.387113708824, 11146.721331966766, 11155.0, 7735.3424958878, 7739.690412383554, 7828.491148075357, 7880.684772609032, 7892.4869883457395, 3022.2293315204483, 3048.6646468888403, 3090.737287330557, 3091.5826363440647, 3098.2254436390904, 824.9051359093661, 890.4879694175875, 958.3866325551653, 985.6599473181741, 987.2398253344884, 26354.73645263561, 26630.733692662827, 26874.865625672137, 27051.1884643461, 28057.859710701316, 901.4411065139656, 903.6475774447971, 970.3013830042358, 995.1441760086465, 1012.2964539644876, 14348.210848403229, 14521.273936303143, 14594.48919287841, 14658.853411465749, 15046.398144074334, 390679.0, 395700.0, 396013.0, 396385.0, 396808.0, 46428.767856160506, 47123.52876471191, 47173.29240061402, 47216.0, 47302.763486182346, 1041.3231399590175, 1117.2905205194597, 1134.8638163420278, 1161.105948419729, 1162.4187906046977, 27454.588181177696, 29078.563821543117, 29085.0, 29363.853180734815, 29844.552331715477, 41297.25081615533, 41799.7910010448, 41807.37288940729, 41833.79083104565, 41871.37192942169, 290595.0, 290938.0, 291780.0, 292325.0, 294206.0, 22159.889200553895, 24348.634770478104, 24814.875925620257, 25071.0, 25429.364265893502, 41562.37656435216, 41723.0, 41824.79087604542, 41889.58110418979, 42598.78700606477, 34943.475847861795, 35039.12402189965, 35312.82343588266, 35593.0, 35798.8210058948, 34963.65036349706, 35238.47142292817, 35438.46842297419, 35869.282614347045, 35892.282154356246, 34151.487727683605, 34664.653353467154, 34747.65252347444, 34808.30383392267, 35456.64543354533, 30256.0, 32230.83884580562, 32349.838250808596, 32387.676123238467, 32745.0, 24559.631605525574, 24961.87519062393, 24975.750242497343, 25079.24762257135, 25167.0], "value": 16242.906688019464, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.6422602606303, 346.8161874206671, 349.2891964851527, 349.3659008898848, 362.05864751645726, 13401.865981340183, 13929.164250144999, 15882.523524294274, 16806.915965420172, 17721.291148354052, 14088.436462541511, 14229.146251224935, 14562.271886405664, 14910.329035193416, 15191.772123418157, 4967.726775027381, 5191.5846732261325, 5192.92210616841, 5194.376674799029, 5200.6099542534275, 6222.719977600997, 6551.868962620745, 6586.736530538797, 6707.932920670804, 6711.6979735911755, 6453.161089058416, 6546.050822630716, 6609.801705948829, 6680.0981867448, 6694.330566943316, 6632.104665870094, 6656.8668626627195, 6664.533482656216, 6676.165479315086, 6679.599224046524, 6394.424501794814, 6763.932360676379, 6785.0, 6793.728250869959, 6910.136232970879, 22089.12242459393, 22528.43678908024, 23071.1925082623, 23119.190828320927, 23146.305610831532, 1964.2830366916116, 2057.120229668858, 2079.2618620389844, 2081.98959005204, 2140.389988853185, 13392.799108013387, 14659.48691795782, 14786.556403307917, 14879.925600372037, 15550.222488875512, 1788.5171003829023, 1845.796962334142, 1860.7674040744907, 1872.7471791308271, 1904.5048287445225, 78631.0, 79963.6001819993, 80352.0, 80967.0, 84232.57883710664, 16643.974987993905, 17100.401485947932, 17441.389551365894, 17487.0, 17577.912110439367, 22814.771852281596, 28386.43227135487, 28569.57145642817, 28657.57013644797, 28904.0, 8421.578921053922, 8581.0, 8829.867551986725, 8893.4663920165, 9274.30442716799, 7271.818204544928, 7341.210340070739, 7411.518251313647, 7458.925410745932, 7547.05661792276, 8098.392620553364, 8483.915160848435, 8515.0, 8609.182127697859, 8612.224899759052, 3261.1031966209484, 3263.4125857345907, 3283.1792051987004, 3330.9008027350915, 3364.360771453416, 776.7203806629609, 811.8701007838717, 827.6813426830713, 883.911608839111, 933.3992203371251, 16316.42892498757, 16735.91632041832, 17341.56646083858, 17800.643987120446, 17821.465356039338, 794.364508393283, 814.1288820961514, 834.7161964931952, 838.3586556284447, 886.2201262888746, 9198.540072996324, 9806.607735690492, 9856.605735770489, 9876.555555000043, 9968.739145536701, 359035.0, 362078.0, 364147.0, 370124.0, 371157.0, 70868.2913170872, 72935.90596141062, 75556.0, 77170.61414693003, 77374.61312693513, 879.8372301124313, 892.4868200784575, 894.0969620683156, 895.4000819450853, 895.9328050396247, 14603.269836508345, 14842.18367989771, 15215.923920380328, 15511.22443877779, 15690.372385104469, 34084.31831363408, 34621.65378346184, 36019.63980360268, 36118.27763444664, 36281.64169328985, 48804.755976219894, 49116.263256051905, 49731.50268497413, 49763.253551197486, 49779.75110124426, 7666.19504951972, 7832.490888092484, 7957.880631790644, 8085.716999904975, 8144.796380090545, 11762.0, 12182.878171218528, 12348.0, 12456.75086498283, 12613.432395542406, 9764.9023509764, 10241.18070554339, 10264.841095342734, 10474.633387831389, 10856.022957933825, 9215.249102670472, 10707.411092389993, 10794.622188223375, 11141.944290278496, 11166.162537809534, 10414.687559373231, 10665.626703065356, 10796.784064318512, 11419.60031398897, 11547.942260288644, 7606.581638009741, 7715.839564921831, 7955.363570914429, 8020.0375954885785, 8068.919310806817, 10246.23153263523, 10402.635907743193, 10408.843867341844, 10413.271071024956, 10822.837657435302], "value": 9214.249060082608, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1249.3253643032763, 1346.6197147923374, 1379.696466777309, 1408.852070532594, 1660.6097567071743, 6526.445252153567, 7284.672189751461, 7615.0, 7616.885746713804, 7623.237676232374, 7168.4265258779305, 7247.492675512716, 7259.927400725991, 7452.217517160701, 7457.14242862071, 2107.388857231401, 2142.72144621199, 2150.8817015064164, 2151.139544182332, 2152.881591512466, 2059.155746144081, 2093.8534302598823, 2119.0570196262593, 2123.0340195211143, 2123.3205374280237, 2067.9586408271903, 2079.9584008319825, 2083.6978638097467, 2090.9268175613856, 2093.9267125650604, 2083.0418007716466, 2085.9478513037143, 2090.278853795438, 2091.121728873869, 2091.173986275428, 2007.518195633052, 2117.385958072173, 2118.1209797933993, 2120.194326156051, 2121.713568668241, 7458.477906546544, 7504.249575042452, 7542.396608271325, 7549.396048316122, 7550.886736698954, 4410.16206920684, 4597.2184728595885, 4601.585857272828, 4604.746738929358, 4611.677182597219, 2750.0, 2867.498187817124, 2903.941921161586, 2905.5932169496286, 2919.284775230061, 969.1471505075559, 973.3964941736098, 981.219930155521, 993.5429702336861, 994.3139233928566, 10525.210609204263, 10703.090237329758, 10717.35695858251, 10733.785324293549, 10742.409167495785, 4017.678585713136, 4118.279301122351, 4149.398337241144, 4239.558550092983, 4264.829406823692, 8379.120192379713, 8441.409101362968, 8462.238398544037, 8474.1102184271, 8480.915190848136, 4565.223911934912, 4570.200214962435, 4570.748608826547, 4575.153596584642, 4577.107464044546, 3700.796456194881, 3787.0153760022595, 4089.2230476209425, 4248.596383343577, 4249.405083288342, 3404.2340473393288, 3470.4273794824076, 3528.7177025837873, 3543.858245670196, 3554.1470047189005, 1016.4561959351711, 1042.338115296792, 1048.4757621189406, 1051.6476980211562, 1056.5615269663003, 723.0058669329671, 732.6959311885614, 790.2926880441972, 797.6388303281285, 818.0755746006975, 5015.974920125376, 5130.87172820675, 5168.198929165986, 5288.153895376721, 5326.600504962066, 399.2095650611805, 401.54224184429773, 402.0952856073834, 408.6485622364764, 411.90320274735416, 3457.101153700056, 3478.5825700915548, 3562.625924277965, 3568.57177138745, 3572.356975744339, 9273.67542136022, 9617.086376794194, 9663.082007209305, 9686.467244301632, 9714.951425242829, 9583.233341332676, 9590.472524011246, 9605.279604029585, 9620.75948101303, 9638.132568068908, 6800.0, 6983.546069505466, 7089.92910070903, 7256.2743725627015, 7320.377767889789, 5344.679319240858, 5430.126606320813, 5471.124620060771, 5561.499465048165, 5722.7710891563875, 8843.60203790818, 8973.910260897308, 8999.55002249898, 9021.729348119567, 9062.139096785795, 8156.184381561797, 8964.91035089667, 9015.14356136166, 9249.907500925174, 9253.306002050007, 6849.520533562602, 7069.752558660422, 7155.998160257464, 7176.497645164788, 7306.452016098708, 7191.42468602521, 7302.269773022867, 7406.14829294638, 7411.184769675439, 7463.776086717407, 6458.483321334188, 6520.7391704333195, 6645.900311495235, 6656.068150459037, 6737.258901520927, 6255.96872015637, 6257.624542527463, 6523.739050437929, 6684.966575167093, 6762.96618516924, 5844.912326315194, 5942.31663358702, 6001.4298641628975, 6055.848603784941, 6127.295361033538, 4299.1831552005015, 4424.247877860836, 4436.201483732959, 4504.594586487232, 4586.8165273388695, 4431.689781715378, 4434.490033646043, 4641.883952901205, 4718.339432479387, 4720.032393359422], "value": 3964.976600125656, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.60445562845126, 284.164556204758, 289.76673777609017, 290.82550469718166, 291.45643375105436, 4843.636727245457, 4849.612031037517, 4864.562189402953, 4867.318575399442, 4895.902081958358, 4735.337052812601, 4783.617310615151, 4808.927866082012, 4825.975870120653, 4836.6856154350035, 3551.449525323579, 3643.8542458301636, 3656.3235801376695, 3657.2685462907393, 3665.8533658653623, 3641.435577485494, 3679.35611268027, 3766.7551609145453, 3773.735838491307, 3783.9810800945957, 3742.7941463219513, 3744.3447396705606, 3746.6815320697774, 3763.2473505298913, 3771.528558930134, 3517.314123745871, 3683.521142251517, 3747.9625203747887, 3748.5314335708035, 3761.22894806564, 3227.2577307219235, 3236.2556611979376, 3249.366373557157, 3250.5774249347432, 3259.5273685315733, 4635.605973492257, 4672.602828759559, 4679.303350353217, 4698.788554515021, 4707.152712511746, 4135.731177473454, 4163.687723420725, 4259.212045771542, 4260.531341552427, 4260.8721738347585, 4927.6304277179, 4952.755944856125, 4964.379452568429, 4978.7012779233, 4988.975055124701, 3595.928081438383, 3612.7290453216115, 3645.2138452158515, 3647.379945409287, 3652.867611040586, 5090.261912022736, 5171.844844654704, 5188.247704082924, 5199.948000519984, 5236.895262094737, 3684.176332715323, 3686.972165309069, 3688.188598508324, 3691.8892433227047, 3696.963030369716, 3738.6635202831876, 3767.434884767307, 3788.2802267569623, 3789.9242015159543, 3794.9430758538642, 4292.399064131024, 4294.806733696991, 4298.118885628439, 4314.309710446313, 4324.827006919688, 4834.815470209821, 4957.256411538298, 4977.502249774993, 4977.975110124498, 5038.2190760432195, 1288.916220445668, 1303.9087263891627, 1305.9869401306055, 1309.1817613991254, 1309.4369421148997, 819.2708489444399, 843.6035063520136, 847.7329641163014, 859.6604341285282, 863.2791618998207, 4215.325547912319, 4314.956850431456, 4379.824807007684, 4421.2262854001065, 4430.291153415438, 5129.846104616868, 5133.972081027973, 5141.0, 5146.378890649434, 5151.5363617274625, 4399.560043995575, 4418.453541260533, 4419.9723189615215, 4422.823087076546, 4431.781260153483, 2609.8042646801564, 2682.9877591806144, 2725.9591106133425, 2729.959050614242, 2730.8289909521977, 4849.515048495193, 4853.174960256765, 4865.56209941107, 4870.975645121823, 4879.658423910363, 5024.701472158046, 5190.558802501754, 5193.766280517386, 5233.095631924319, 5249.0, 4782.473927868002, 4786.210275304606, 4796.736179510091, 4801.423829140385, 4801.831935882227, 5076.416212135652, 5082.593392528663, 5136.768845402041, 5145.430643653572, 5174.301469301596, 4787.88178803035, 5039.420466646236, 5049.722265275445, 5061.645684802176, 5070.264811602371, 4824.565789079, 4837.903241935212, 4838.975805121093, 4844.15227335222, 4849.472416188889, 3668.1379875729717, 3677.816109194583, 3682.6317368262958, 3698.6301369863877, 3712.0, 5099.36257967754, 5116.897662046813, 5120.6159538035545, 5126.307948426915, 5128.692278463304, 4720.409948756405, 4908.263760435821, 4968.776405061853, 4973.0, 4988.5260900214425, 4954.430240522386, 4975.825846095369, 4978.32792572998, 4994.150994331045, 4996.60027197816, 4896.216605343128, 4905.264210368473, 4907.184341793559, 4908.828191013297, 4921.27557544761, 4768.332433459388, 4775.5463230993, 4901.3383193268455, 4950.401039454316, 4965.4289756677, 4871.0, 4876.951230487792, 4898.305931737459, 4900.8774780630765, 4901.58336541398], "value": 3764.593910823, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.0376157551857, 620.0544170140535, 667.7262322447795, 673.8248055505567, 681.1900908751401, 12127.090468214887, 13138.277394743285, 13168.473261069557, 13169.604911852635, 13180.077394582384, 12720.93639531801, 12872.871271287284, 12891.80662290064, 12909.031822613319, 12917.160384574996, 600.372610621899, 717.5802155738899, 731.6085894046686, 732.150705181989, 741.417986880299, 747.4468893019153, 749.8125468632842, 750.6922161913617, 750.9849803003937, 751.8721817291074, 795.3676826922582, 797.832455184412, 798.6925033861976, 799.168864381043, 799.4683535448919, 627.244170774216, 763.5456903142622, 776.813564744463, 785.701433455289, 788.7830846517196, 578.4735890339813, 578.5689661202389, 579.1602176843552, 579.6029719642058, 579.6985567504915, 12168.756624867454, 12255.448504817216, 12260.325682087481, 12281.69295767604, 12282.631521054383, 12241.143119981605, 12345.197562158432, 12573.874261257453, 12876.098673092887, 13221.338933053308, 11308.491117899632, 11459.484323205475, 11523.308601483937, 11604.825927611093, 11630.534778608846, 4011.5988401159943, 4055.959440405617, 4087.346024636044, 4108.979455102735, 4153.210889930933, 63998.68000660014, 64688.676556617385, 64727.0, 65623.0, 65677.3432265676, 9152.771180720401, 9414.905850941539, 9569.425834449956, 9626.66306679263, 9708.174805141642, 16969.915150424167, 17183.914080429517, 17234.65530689404, 17247.137643117792, 17263.39578114785, 6178.5366097542865, 6274.2784579773, 6451.3548645135115, 6540.05169250456, 6591.769288074895, 3692.759970601956, 3716.4239542870896, 3762.172322089136, 3836.3478208704587, 3995.400689896481, 2693.676758788958, 2806.719328067177, 2808.873600687974, 2812.4093940272364, 2815.42283831814, 474.8670372295763, 511.8797082685566, 514.8018013064997, 516.0994065355978, 530.6338626347807, 549.3286257415216, 578.2800413485154, 583.8861422022665, 588.832182827892, 606.7724603273772, 7498.137714162941, 7666.0, 8117.8376432472205, 8438.312337532518, 8565.015023272279, 525.8422473258007, 564.4242872270344, 575.1631376347405, 588.2969851027981, 591.6745789815584, 3832.693384529231, 3835.2137811748526, 3854.6338097880657, 3955.7033222508426, 4025.2150830587752, 59420.0, 59564.40435595675, 59718.40281597216, 60819.391806081374, 77711.61144194356, 46864.76567617209, 47628.7618561905, 70469.2953070473, 78406.60796696095, 80104.0, 61895.0, 68658.0, 70643.29356706367, 72523.63738181275, 72705.6364718173, 7805.765827025199, 7924.460467578222, 7977.880331795144, 7979.820683799152, 8099.716509922125, 42777.1444571113, 43944.34083488814, 44399.778001109786, 44687.0, 45538.54461455343, 56513.0, 58626.70686646539, 61126.694366529664, 62340.0, 65313.67343163444, 10377.63678271287, 10466.162706983576, 10616.84074738864, 10688.25182237236, 11152.665420037412, 12010.519579216734, 12074.39628018578, 12124.757504849676, 12619.74760504803, 13263.933680331536, 11574.18980671345, 11692.0, 11701.473433695674, 12407.44166512491, 12638.2417054977, 10642.41466719338, 10876.12990960737, 11318.943405283251, 11337.319760814047, 11534.884651153381, 10834.67495975122, 10880.347179169275, 10978.286411383235, 11227.0, 11970.640880773592, 9290.62837486493, 9368.906310936803, 9633.181179599813, 9846.507674616098, 9977.850332245167, 9598.616055357708, 10117.241206909364, 10895.182861285593, 11075.5569777208, 11084.334939903632], "value": 6322.968814742606, "unit": "score"}], "name": "dromaeo_css", "value": 6352.2527763525195, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 131.0, 114.0, 112.0, 113.0, 114.0, 114.0, 114.0, 113.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 122.0, 153.0, 181.0, 122.0, 157.0, 148.0, 123.0, 179.0, 128.0], "value": 147.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 163.0, 161.0, 161.0, 161.0, 163.0, 161.0, 161.0, 163.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 160.0, 77.0, 75.0, 76.0, 75.0, 160.0, 76.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 137.0, 85.0, 83.0, 84.0, 141.0, 84.0, 84.0, 133.0], "value": 100.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 64.0, 63.0, 63.0, 72.0, 64.0, 64.0, 64.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 67.0, 65.0, 65.0, 66.0, 67.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 82.0, 91.0, 84.0, 82.0, 82.0, 84.0, 83.0, 83.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 131.0, 133.0, 132.0, 142.0, 131.0, 142.0, 134.0, 181.0, 133.0], "value": 140.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 174.0, 173.0, 173.0, 172.0, 172.0, 173.0, 173.0, 170.0, 168.0], "value": 172.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 69.0, 71.0, 70.0, 69.0, 73.0, 68.0, 72.0, 73.0], "value": 70.5, "unit": "score"}], "name": "kraken", "value": 1572.1, "alertThreshold": 2.0}]} 14:15:32 INFO - Return code: 0 14:15:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:15:32 INFO - # TBPL SUCCESS # 14:15:32 INFO - Running post-action listener: _resource_record_post_action 14:15:32 INFO - [mozharness: 2016-08-26 21:15:32.969472Z] Finished run-tests step (success) 14:15:32 INFO - Running post-run listener: _resource_record_post_run 14:15:33 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 396771328; Read time: 8; Write time: 240624 14:15:33 INFO - TinderboxPrint: CPU usage
13.0% 14:15:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 14:15:33 INFO - TinderboxPrint: I/O write bytes / time
396,771,328 / 240,624 14:15:33 INFO - TinderboxPrint: CPU idle
8,333.9 (87.0%) 14:15:33 INFO - TinderboxPrint: CPU user
1,201.9 (12.5%) 14:15:33 INFO - TinderboxPrint: Swap in / out
0 / 0 14:15:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114286592; Read time: 0; Write time: 86980 14:15:33 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 282484736; Read time: 0; Write time: 153644 14:15:33 INFO - Running post-run listener: _upload_blobber_files 14:15:33 INFO - Blob upload gear active. 14:15:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:15:33 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 14:15:33 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'] 14:15:33 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 14:15:34 INFO - (blobuploader) - INFO - Open directory for files ... 14:15:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:15:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:15:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:15:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:15:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:15:34 INFO - (blobuploader) - INFO - Done attempting. 14:15:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:15:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:15:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:15:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:15:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:15:35 INFO - (blobuploader) - INFO - Done attempting. 14:15:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:15:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:15:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:15:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:15:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:15:40 INFO - (blobuploader) - INFO - Done attempting. 14:15:40 INFO - (blobuploader) - INFO - Iteration through files over. 14:15:40 INFO - Return code: 0 14:15:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:15:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:15:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33963a9cce1974eac8c386cd863aa53e1c748c5a66d57e9ab8d97f20d76264646170380ffa50487d411e1ad9cca45e36e051a16a4363c90328a44c356bc076e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f2cebb8e728610a51ba638eea1641ff6744e3c703d938b2ed7b1f8a907eb2328a38b95f6bef2cdb4a5ffead363849a87b644da775c5ee9c84f39b4ac2f1dab3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/97be7c6912d7f025e45e57e991ef89e8baa7b60bf012c97d78275ab89b003f2ff87c9d9a45da2de46951777e165754ee35f68bf9304abf9f6bd7de4d2cfe0f75"} 14:15:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:15:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:15:40 INFO - Contents: 14:15:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33963a9cce1974eac8c386cd863aa53e1c748c5a66d57e9ab8d97f20d76264646170380ffa50487d411e1ad9cca45e36e051a16a4363c90328a44c356bc076e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f2cebb8e728610a51ba638eea1641ff6744e3c703d938b2ed7b1f8a907eb2328a38b95f6bef2cdb4a5ffead363849a87b644da775c5ee9c84f39b4ac2f1dab3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/97be7c6912d7f025e45e57e991ef89e8baa7b60bf012c97d78275ab89b003f2ff87c9d9a45da2de46951777e165754ee35f68bf9304abf9f6bd7de4d2cfe0f75"} 14:15:40 INFO - Running post-run listener: copy_logs_to_upload_dir 14:15:40 INFO - Copying logs to upload dir... 14:15:40 INFO - mkdir: /builds/slave/test/build/upload/logs 14:15:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.706082 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-26 14:15:39.920366) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 14:15:39.924422) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1472244814.696315-1226244341 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/33963a9cce1974eac8c386cd863aa53e1c748c5a66d57e9ab8d97f20d76264646170380ffa50487d411e1ad9cca45e36e051a16a4363c90328a44c356bc076e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f2cebb8e728610a51ba638eea1641ff6744e3c703d938b2ed7b1f8a907eb2328a38b95f6bef2cdb4a5ffead363849a87b644da775c5ee9c84f39b4ac2f1dab3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/97be7c6912d7f025e45e57e991ef89e8baa7b60bf012c97d78275ab89b003f2ff87c9d9a45da2de46951777e165754ee35f68bf9304abf9f6bd7de4d2cfe0f75"} build_url:https://queue.taskcluster.net/v1/task/LWT-ZgAmRC6hdEigjkvnOg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011357 build_url: 'https://queue.taskcluster.net/v1/task/LWT-ZgAmRC6hdEigjkvnOg/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/33963a9cce1974eac8c386cd863aa53e1c748c5a66d57e9ab8d97f20d76264646170380ffa50487d411e1ad9cca45e36e051a16a4363c90328a44c356bc076e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f2cebb8e728610a51ba638eea1641ff6744e3c703d938b2ed7b1f8a907eb2328a38b95f6bef2cdb4a5ffead363849a87b644da775c5ee9c84f39b4ac2f1dab3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/97be7c6912d7f025e45e57e991ef89e8baa7b60bf012c97d78275ab89b003f2ff87c9d9a45da2de46951777e165754ee35f68bf9304abf9f6bd7de4d2cfe0f75"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 14:15:39.950040) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 14:15:39.950421) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1472244814.696315-1226244341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 14:15:40.033810) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 14:15:40.034130) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 14:15:40.034466) ========= ========= Total master_lag: 0.25 =========