builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-025 starttime: 1470572210.8 results: success (0) buildid: 20160807023002 builduid: 840ade826a1546f3b431076252a4bace revision: d42aacfe34af25e2f5110e2ca3d24a210eabeb33 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 05:16:50.797235) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 05:16:50.797619) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 05:16:50.797885) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 05:16:50.815093) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 05:16:50.815356) ========= 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=232498196343f89f466a4a9a000001c8-1470572163.998294-1223643947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-07 05:16:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-08-07 05:16:51 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096712 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 05:16:50.925480) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 05:16:50.925794) ========= 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=232498196343f89f466a4a9a000001c8-1470572163.998294-1223643947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016070 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 05:16:50.974771) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-07 05:16:50.975114) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d42aacfe34af25e2f5110e2ca3d24a210eabeb33 --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 d42aacfe34af25e2f5110e2ca3d24a210eabeb33 --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=232498196343f89f466a4a9a000001c8-1470572163.998294-1223643947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-07 05:16:51,284 truncating revision to first 12 chars 2016-08-07 05:16:51,284 Setting DEBUG logging. 2016-08-07 05:16:51,284 attempt 1/10 2016-08-07 05:16:51,284 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d42aacfe34af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-07 05:16:52,115 unpacking tar archive at: fx-team-d42aacfe34af/testing/mozharness/ program finished with exit code 0 elapsedTime=1.187997 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-07 05:16:52.176935) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 05:16:52.177245) ========= script_repo_revision: d42aacfe34af25e2f5110e2ca3d24a210eabeb33 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 05:16:52.177608) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 05:16:52.177873) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 05:16:52.186267) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-08-07 05:16:52.186526) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1470572163.998294-1223643947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:16:52 INFO - MultiFileLogger online at 20160807 05:16:52 in /builds/slave/test 05:16:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:16:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:16:52 INFO - {'append_to_log': False, 05:16:52 INFO - 'base_work_dir': '/builds/slave/test', 05:16:52 INFO - 'blob_upload_branch': 'Fx-Team', 05:16:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:16:52 INFO - 'branch': 'Fx-Team', 05:16:52 INFO - 'buildbot_json_path': 'buildprops.json', 05:16:52 INFO - 'config_files': ('talos/linux_config.py',), 05:16:52 INFO - 'default_actions': ('clobber', 05:16:52 INFO - 'read-buildbot-config', 05:16:52 INFO - 'download-and-extract', 05:16:52 INFO - 'populate-webroot', 05:16:52 INFO - 'create-virtualenv', 05:16:52 INFO - 'install', 05:16:52 INFO - 'run-tests'), 05:16:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:16:52 INFO - 'download_minidump_stackwalk': True, 05:16:52 INFO - 'download_symbols': 'ondemand', 05:16:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:16:52 INFO - 'tooltool.py': '/tools/tooltool.py', 05:16:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:16:52 INFO - '/tools/misc-python/virtualenv.py')}, 05:16:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:16:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:16:52 INFO - 'installer_path': 'installer.exe', 05:16:52 INFO - 'log_level': 'info', 05:16:52 INFO - 'log_name': 'talos', 05:16:52 INFO - 'log_to_console': True, 05:16:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:16:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:16:52 INFO - 'opt_config_files': (), 05:16:52 INFO - 'pip_index': False, 05:16:52 INFO - 'sps_profile': False, 05:16:52 INFO - 'sps_profile_interval': 0, 05:16:52 INFO - 'suite': 'dromaeojs', 05:16:52 INFO - 'system_bits': '32', 05:16:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:16:52 INFO - 'title': 'talos-linux64-ix-025', 05:16:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:16:52 INFO - 'use_talos_json': True, 05:16:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:16:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:16:52 INFO - 'work_dir': 'build'} 05:16:52 INFO - [mozharness: 2016-08-07 12:16:52.590841Z] Running clobber step. 05:16:52 INFO - Running pre-action listener: _resource_record_pre_action 05:16:52 INFO - Running main action method: clobber 05:16:52 INFO - rmtree: /builds/slave/test/build 05:16:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:16:53 INFO - Running post-action listener: _resource_record_post_action 05:16:53 INFO - [mozharness: 2016-08-07 12:16:53.049063Z] Finished clobber step (success) 05:16:53 INFO - [mozharness: 2016-08-07 12:16:53.049163Z] Running read-buildbot-config step. 05:16:53 INFO - Running pre-action listener: _resource_record_pre_action 05:16:53 INFO - Running main action method: read_buildbot_config 05:16:53 INFO - Using buildbot properties: 05:16:53 INFO - { 05:16:53 INFO - "project": "", 05:16:53 INFO - "product": "firefox", 05:16:53 INFO - "script_repo_revision": "production", 05:16:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:16:53 INFO - "repository": "", 05:16:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:16:53 INFO - "buildid": "20160807023002", 05:16:53 INFO - "pgo_build": "True", 05:16:53 INFO - "basedir": "/builds/slave/test", 05:16:53 INFO - "buildnumber": 958, 05:16:53 INFO - "slavename": "talos-linux64-ix-025", 05:16:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:16:53 INFO - "platform": "ubuntu64_hw", 05:16:53 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:16:53 INFO - "branch": "fx-team", 05:16:53 INFO - "repo_path": "integration/fx-team", 05:16:53 INFO - "revision": "d42aacfe34af25e2f5110e2ca3d24a210eabeb33", 05:16:53 INFO - "stage_platform": "linux64-pgo", 05:16:53 INFO - "builduid": "840ade826a1546f3b431076252a4bace", 05:16:53 INFO - "slavebuilddir": "test" 05:16:53 INFO - } 05:16:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/aaplzBjPQSiANfbcdQOeqg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:16:53 INFO - Running post-action listener: _resource_record_post_action 05:16:53 INFO - [mozharness: 2016-08-07 12:16:53.051682Z] Finished read-buildbot-config step (success) 05:16:53 INFO - [mozharness: 2016-08-07 12:16:53.051772Z] Running download-and-extract step. 05:16:53 INFO - Running pre-action listener: _resource_record_pre_action 05:16:53 INFO - Running main action method: download_and_extract 05:16:53 INFO - mkdir: /builds/slave/test/build/tests 05:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:53 INFO - trying https://queue.taskcluster.net/v1/task/aaplzBjPQSiANfbcdQOeqg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:16:53 INFO - Downloading https://queue.taskcluster.net/v1/task/aaplzBjPQSiANfbcdQOeqg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:16:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aaplzBjPQSiANfbcdQOeqg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:16:53 INFO - Downloaded 1361 bytes. 05:16:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:16:53 INFO - Using the following test package requirements: 05:16:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:16:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:16:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:16:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:53 INFO - u'jsshell-linux-x86_64.zip'], 05:16:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:16:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:16:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:16:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:16:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:16:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:16:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:53 INFO - trying https://queue.taskcluster.net/v1/task/aaplzBjPQSiANfbcdQOeqg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:16:53 INFO - Downloading https://queue.taskcluster.net/v1/task/aaplzBjPQSiANfbcdQOeqg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:16:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aaplzBjPQSiANfbcdQOeqg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:16:54 INFO - Downloaded 21829331 bytes. 05:16:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:16:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:16:55 INFO - Return code: 0 05:16:55 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:16:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:55 INFO - trying https://queue.taskcluster.net/v1/task/aaplzBjPQSiANfbcdQOeqg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:16:55 INFO - Downloading https://queue.taskcluster.net/v1/task/aaplzBjPQSiANfbcdQOeqg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:16:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aaplzBjPQSiANfbcdQOeqg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:16:56 INFO - Downloaded 21829331 bytes. 05:16:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:16:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:16:58 INFO - Return code: 0 05:16: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')]} 05:16:58 INFO - trying https://queue.taskcluster.net/v1/task/aaplzBjPQSiANfbcdQOeqg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:16:58 INFO - Downloading https://queue.taskcluster.net/v1/task/aaplzBjPQSiANfbcdQOeqg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:16:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aaplzBjPQSiANfbcdQOeqg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:16:58 INFO - Downloaded 14413723 bytes. 05:16:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:16:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:16:59 INFO - Return code: 0 05:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:59 INFO - trying https://queue.taskcluster.net/v1/task/aaplzBjPQSiANfbcdQOeqg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:16:59 INFO - Downloading https://queue.taskcluster.net/v1/task/aaplzBjPQSiANfbcdQOeqg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:16:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aaplzBjPQSiANfbcdQOeqg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:17:00 INFO - Downloaded 59969141 bytes. 05:17:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aaplzBjPQSiANfbcdQOeqg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:17:00 INFO - mkdir: /builds/slave/test/properties 05:17:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:17:00 INFO - Writing to file /builds/slave/test/properties/build_url 05:17:00 INFO - Contents: 05:17:00 INFO - build_url:https://queue.taskcluster.net/v1/task/aaplzBjPQSiANfbcdQOeqg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:17:01 INFO - Running post-action listener: _resource_record_post_action 05:17:01 INFO - Running post-action listener: set_extra_try_arguments 05:17:01 INFO - [mozharness: 2016-08-07 12:17:01.573347Z] Finished download-and-extract step (success) 05:17:01 INFO - [mozharness: 2016-08-07 12:17:01.573667Z] Running populate-webroot step. 05:17:01 INFO - Running pre-action listener: _resource_record_pre_action 05:17:01 INFO - Running main action method: populate_webroot 05:17:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:17:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:17:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:17:01 INFO - '--tppagecycles', 05:17:01 INFO - '7'], 05:17:01 INFO - 'tests': ['tsvgm']}}, 05:17:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:17:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:17:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:17:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:17:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:17:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:17:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:01 INFO - 'talos_options': ['--disable-e10s'], 05:17:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:17:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:17:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:01 INFO - 'talos_options': ['--disable-e10s'], 05:17:01 INFO - 'tests': ['damp', 'tps']}, 05:17:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:01 INFO - 'tests': ['damp', 'tps']}, 05:17:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:17:01 INFO - 'tests': ['dromaeo_dom']}, 05:17:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:17:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:17:01 INFO - 'tests': ['basic_compositor_video']}, 05:17:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:17:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:17:01 INFO - 'tests': ['a11yr', 05:17:01 INFO - 'ts_paint', 05:17:01 INFO - 'tpaint', 05:17:01 INFO - 'sessionrestore', 05:17:01 INFO - 'sessionrestore_no_auto_restore', 05:17:01 INFO - 'tabpaint']}, 05:17:01 INFO - 'other-e10s': {'tests': ['a11yr', 05:17:01 INFO - 'ts_paint', 05:17:01 INFO - 'tpaint', 05:17:01 INFO - 'sessionrestore', 05:17:01 INFO - 'sessionrestore_no_auto_restore', 05:17:01 INFO - 'tabpaint']}, 05:17:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:17:01 INFO - 'ts_paint', 05:17:01 INFO - 'tpaint', 05:17:01 INFO - 'sessionrestore', 05:17:01 INFO - 'sessionrestore_no_auto_restore', 05:17:01 INFO - 'tabpaint']}, 05:17:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:17:01 INFO - 'ts_paint', 05:17:01 INFO - 'tpaint', 05:17:01 INFO - 'sessionrestore', 05:17:01 INFO - 'sessionrestore_no_auto_restore', 05:17:01 INFO - 'tabpaint']}, 05:17:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:17:01 INFO - 'tests': ['a11yr', 05:17:01 INFO - 'ts_paint', 05:17:01 INFO - 'tpaint', 05:17:01 INFO - 'sessionrestore', 05:17:01 INFO - 'sessionrestore_no_auto_restore', 05:17:01 INFO - 'tabpaint']}, 05:17:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:17:01 INFO - 'tests': ['a11yr', 05:17:01 INFO - 'ts_paint', 05:17:01 INFO - 'tpaint', 05:17:01 INFO - 'sessionrestore', 05:17:01 INFO - 'sessionrestore_no_auto_restore', 05:17:01 INFO - 'tabpaint']}, 05:17:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:17:01 INFO - 'tests': ['tsvgx', 05:17:01 INFO - 'tsvgr_opacity', 05:17:01 INFO - 'tart', 05:17:01 INFO - 'tscrollx', 05:17:01 INFO - 'cart']}, 05:17:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:17:01 INFO - 'tsvgr_opacity', 05:17:01 INFO - 'tart', 05:17:01 INFO - 'tscrollx', 05:17:01 INFO - 'cart']}, 05:17:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:01 INFO - 'talos_options': ['--disable-e10s'], 05:17:01 INFO - 'tests': ['tp5o']}, 05:17:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:01 INFO - 'tests': ['tp5o']}, 05:17:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:01 INFO - 'talos_options': ['--disable-e10s', 05:17:01 INFO - '--xperf_path', 05:17:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:17:01 INFO - 'tests': ['tp5n']}, 05:17:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:01 INFO - 'talos_options': ['--xperf_path', 05:17:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:17:01 INFO - 'tests': ['tp5n']}}, 05:17:01 INFO - 'talos.zip': {'path': '', 05:17:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:17:01 INFO - Running post-action listener: _resource_record_post_action 05:17:01 INFO - [mozharness: 2016-08-07 12:17:01.592587Z] Finished populate-webroot step (success) 05:17:01 INFO - [mozharness: 2016-08-07 12:17:01.592676Z] Running create-virtualenv step. 05:17:01 INFO - Running pre-action listener: _resource_record_pre_action 05:17:01 INFO - Running main action method: create_virtualenv 05:17:01 INFO - Creating virtualenv /builds/slave/test/build/venv 05:17:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:17:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:17:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:17:01 INFO - Using real prefix '/usr' 05:17:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:17:02 INFO - Installing distribute.............................................................................................................................................................................................done. 05:17:04 INFO - Installing pip.................done. 05:17:04 INFO - Return code: 0 05:17:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a3b0>, '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 0x1c6b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b740>, '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': '232498196343f89f466a4a9a000001c8-1470572163.998294-1223643947', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:17:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:17:04 INFO - Using env: {'DISPLAY': ':0', 05:17:04 INFO - 'HOME': '/home/cltbld', 05:17:04 INFO - 'LANG': 'en_US.UTF-8', 05:17:04 INFO - 'LANGUAGE': 'en_US:en', 05:17:04 INFO - 'LOGNAME': 'cltbld', 05:17:04 INFO - 'MAIL': '/var/mail/cltbld', 05:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:04 INFO - 'MOZ_NO_REMOTE': '1', 05:17:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:04 INFO - 'NO_EM_RESTART': '1', 05:17:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:04 INFO - 'PWD': '/builds/slave/test', 05:17:04 INFO - 'SHELL': '/bin/bash', 05:17:04 INFO - 'SHLVL': '1', 05:17:04 INFO - 'TERM': 'linux', 05:17:04 INFO - 'TMOUT': '86400', 05:17:04 INFO - 'USER': 'cltbld', 05:17:04 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1470572163.998294-1223643947', 05:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:04 INFO - '_': '/tools/buildbot/bin/python'} 05:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:17:04 INFO - Cleaning up... 05:17:04 INFO - Return code: 0 05:17:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a3b0>, '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 0x1c6b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b740>, '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': '232498196343f89f466a4a9a000001c8-1470572163.998294-1223643947', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:17:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:17:04 INFO - Using env: {'DISPLAY': ':0', 05:17:04 INFO - 'HOME': '/home/cltbld', 05:17:04 INFO - 'LANG': 'en_US.UTF-8', 05:17:04 INFO - 'LANGUAGE': 'en_US:en', 05:17:04 INFO - 'LOGNAME': 'cltbld', 05:17:04 INFO - 'MAIL': '/var/mail/cltbld', 05:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:04 INFO - 'MOZ_NO_REMOTE': '1', 05:17:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:04 INFO - 'NO_EM_RESTART': '1', 05:17:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:04 INFO - 'PWD': '/builds/slave/test', 05:17:04 INFO - 'SHELL': '/bin/bash', 05:17:04 INFO - 'SHLVL': '1', 05:17:04 INFO - 'TERM': 'linux', 05:17:04 INFO - 'TMOUT': '86400', 05:17:04 INFO - 'USER': 'cltbld', 05:17:04 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1470572163.998294-1223643947', 05:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:04 INFO - '_': '/tools/buildbot/bin/python'} 05:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:04 INFO - Downloading/unpacking psutil>=3.1.1 05:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:17:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:17:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:17:06 INFO - Installing collected packages: psutil 05:17:06 INFO - Running setup.py install for psutil 05:17:06 INFO - building 'psutil._psutil_linux' extension 05:17:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:17:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:17:06 INFO - building 'psutil._psutil_posix' extension 05:17:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:17:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:17:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:17:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:17:07 INFO - Successfully installed psutil 05:17:07 INFO - Cleaning up... 05:17:07 INFO - Return code: 0 05:17:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:17:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a3b0>, '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 0x1c6b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b740>, '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': '232498196343f89f466a4a9a000001c8-1470572163.998294-1223643947', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:17:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:17:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:17:07 INFO - Using env: {'DISPLAY': ':0', 05:17:07 INFO - 'HOME': '/home/cltbld', 05:17:07 INFO - 'LANG': 'en_US.UTF-8', 05:17:07 INFO - 'LANGUAGE': 'en_US:en', 05:17:07 INFO - 'LOGNAME': 'cltbld', 05:17:07 INFO - 'MAIL': '/var/mail/cltbld', 05:17:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:07 INFO - 'MOZ_NO_REMOTE': '1', 05:17:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:07 INFO - 'NO_EM_RESTART': '1', 05:17:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:07 INFO - 'PWD': '/builds/slave/test', 05:17:07 INFO - 'SHELL': '/bin/bash', 05:17:07 INFO - 'SHLVL': '1', 05:17:07 INFO - 'TERM': 'linux', 05:17:07 INFO - 'TMOUT': '86400', 05:17:07 INFO - 'USER': 'cltbld', 05:17:07 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1470572163.998294-1223643947', 05:17:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:07 INFO - '_': '/tools/buildbot/bin/python'} 05:17:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:17:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:17:09 INFO - Installing collected packages: mozsystemmonitor 05:17:09 INFO - Running setup.py install for mozsystemmonitor 05:17:09 INFO - Successfully installed mozsystemmonitor 05:17:09 INFO - Cleaning up... 05:17:09 INFO - Return code: 0 05:17:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a3b0>, '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 0x1c6b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b740>, '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': '232498196343f89f466a4a9a000001c8-1470572163.998294-1223643947', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:17:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:17:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:17:09 INFO - Using env: {'DISPLAY': ':0', 05:17:09 INFO - 'HOME': '/home/cltbld', 05:17:09 INFO - 'LANG': 'en_US.UTF-8', 05:17:09 INFO - 'LANGUAGE': 'en_US:en', 05:17:09 INFO - 'LOGNAME': 'cltbld', 05:17:09 INFO - 'MAIL': '/var/mail/cltbld', 05:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:09 INFO - 'MOZ_NO_REMOTE': '1', 05:17:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:09 INFO - 'NO_EM_RESTART': '1', 05:17:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:09 INFO - 'PWD': '/builds/slave/test', 05:17:09 INFO - 'SHELL': '/bin/bash', 05:17:09 INFO - 'SHLVL': '1', 05:17:09 INFO - 'TERM': 'linux', 05:17:09 INFO - 'TMOUT': '86400', 05:17:09 INFO - 'USER': 'cltbld', 05:17:09 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1470572163.998294-1223643947', 05:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:09 INFO - '_': '/tools/buildbot/bin/python'} 05:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:09 INFO - Downloading/unpacking jsonschema==2.5.1 05:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:17:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:11 INFO - Downloading functools32-3.2.3-2.tar.gz 05:17:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:17:11 INFO - warning: no files found matching '*.txt' 05:17:11 INFO - no previously-included directories found matching 'build' 05:17:11 INFO - no previously-included directories found matching 'dist' 05:17:11 INFO - no previously-included directories found matching '.git*' 05:17:11 INFO - Installing collected packages: jsonschema, functools32 05:17:11 INFO - Running setup.py install for functools32 05:17:11 INFO - warning: no files found matching '*.txt' 05:17:11 INFO - no previously-included directories found matching 'build' 05:17:11 INFO - no previously-included directories found matching 'dist' 05:17:11 INFO - no previously-included directories found matching '.git*' 05:17:11 INFO - Successfully installed jsonschema functools32 05:17:11 INFO - Cleaning up... 05:17:11 INFO - Return code: 0 05:17:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:17: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')]} 05:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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')]} 05:17:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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', '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 0x19ab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a3b0>, '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 0x1c6b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b740>, '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': '232498196343f89f466a4a9a000001c8-1470572163.998294-1223643947', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:17: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:17: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 functools32==3.2.3-2 05:17:11 INFO - Using env: {'DISPLAY': ':0', 05:17:11 INFO - 'HOME': '/home/cltbld', 05:17:11 INFO - 'LANG': 'en_US.UTF-8', 05:17:11 INFO - 'LANGUAGE': 'en_US:en', 05:17:11 INFO - 'LOGNAME': 'cltbld', 05:17:11 INFO - 'MAIL': '/var/mail/cltbld', 05:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:11 INFO - 'MOZ_NO_REMOTE': '1', 05:17:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:11 INFO - 'NO_EM_RESTART': '1', 05:17:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:11 INFO - 'PWD': '/builds/slave/test', 05:17:11 INFO - 'SHELL': '/bin/bash', 05:17:11 INFO - 'SHLVL': '1', 05:17:11 INFO - 'TERM': 'linux', 05:17:11 INFO - 'TMOUT': '86400', 05:17:11 INFO - 'USER': 'cltbld', 05:17:11 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1470572163.998294-1223643947', 05:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:11 INFO - '_': '/tools/buildbot/bin/python'} 05:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:17:12 INFO - Cleaning up... 05:17:12 INFO - Return code: 0 05:17:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a3b0>, '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 0x1c6b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b740>, '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': '232498196343f89f466a4a9a000001c8-1470572163.998294-1223643947', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:17:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:17:12 INFO - Using env: {'DISPLAY': ':0', 05:17:12 INFO - 'HOME': '/home/cltbld', 05:17:12 INFO - 'LANG': 'en_US.UTF-8', 05:17:12 INFO - 'LANGUAGE': 'en_US:en', 05:17:12 INFO - 'LOGNAME': 'cltbld', 05:17:12 INFO - 'MAIL': '/var/mail/cltbld', 05:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:12 INFO - 'MOZ_NO_REMOTE': '1', 05:17:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:12 INFO - 'NO_EM_RESTART': '1', 05:17:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:12 INFO - 'PWD': '/builds/slave/test', 05:17:12 INFO - 'SHELL': '/bin/bash', 05:17:12 INFO - 'SHLVL': '1', 05:17:12 INFO - 'TERM': 'linux', 05:17:12 INFO - 'TMOUT': '86400', 05:17:12 INFO - 'USER': 'cltbld', 05:17:12 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1470572163.998294-1223643947', 05:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:12 INFO - '_': '/tools/buildbot/bin/python'} 05:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:12 INFO - Downloading/unpacking blobuploader==1.2.4 05:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:14 INFO - Downloading blobuploader-1.2.4.tar.gz 05:17:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:17:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:17:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:15 INFO - Downloading docopt-0.6.1.tar.gz 05:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:17:15 INFO - Installing collected packages: blobuploader, requests, docopt 05:17:15 INFO - Running setup.py install for blobuploader 05:17:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:17:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:17:15 INFO - Running setup.py install for requests 05:17:15 INFO - Running setup.py install for docopt 05:17:15 INFO - Successfully installed blobuploader requests docopt 05:17:15 INFO - Cleaning up... 05:17:15 INFO - Return code: 0 05:17:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a3b0>, '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 0x1c6b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b740>, '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': '232498196343f89f466a4a9a000001c8-1470572163.998294-1223643947', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:17:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:17:15 INFO - Using env: {'DISPLAY': ':0', 05:17:15 INFO - 'HOME': '/home/cltbld', 05:17:15 INFO - 'LANG': 'en_US.UTF-8', 05:17:15 INFO - 'LANGUAGE': 'en_US:en', 05:17:15 INFO - 'LOGNAME': 'cltbld', 05:17:15 INFO - 'MAIL': '/var/mail/cltbld', 05:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:15 INFO - 'MOZ_NO_REMOTE': '1', 05:17:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:15 INFO - 'NO_EM_RESTART': '1', 05:17:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:15 INFO - 'PWD': '/builds/slave/test', 05:17:15 INFO - 'SHELL': '/bin/bash', 05:17:15 INFO - 'SHLVL': '1', 05:17:15 INFO - 'TERM': 'linux', 05:17:15 INFO - 'TMOUT': '86400', 05:17:15 INFO - 'USER': 'cltbld', 05:17:15 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1470572163.998294-1223643947', 05:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:15 INFO - '_': '/tools/buildbot/bin/python'} 05:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:16 INFO - Running setup.py (path:/tmp/pip-UGFFZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:16 INFO - Running setup.py (path:/tmp/pip-f6T5Ia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:16 INFO - Running setup.py (path:/tmp/pip-Xiegax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:16 INFO - Running setup.py (path:/tmp/pip-EBSDli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:16 INFO - Running setup.py (path:/tmp/pip-RQTlPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:16 INFO - Running setup.py (path:/tmp/pip-fBxloN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:16 INFO - Running setup.py (path:/tmp/pip-qDTtBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:16 INFO - Running setup.py (path:/tmp/pip-xb46Jo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:16 INFO - Running setup.py (path:/tmp/pip-x7ONaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:16 INFO - Running setup.py (path:/tmp/pip-c9P_Jr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:16 INFO - Running setup.py (path:/tmp/pip-E_6s1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:16 INFO - Running setup.py (path:/tmp/pip-jdm7U2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:16 INFO - Running setup.py (path:/tmp/pip-BPJsB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:17 INFO - Running setup.py (path:/tmp/pip-bpmKPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:17 INFO - Running setup.py (path:/tmp/pip-r7qQob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:17 INFO - Running setup.py (path:/tmp/pip-2NSB1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:17 INFO - Running setup.py (path:/tmp/pip-WSvMbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:17:17 INFO - Running setup.py install for manifestparser 05:17:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:17:17 INFO - Running setup.py install for mozcrash 05:17:17 INFO - Running setup.py install for mozdebug 05:17:17 INFO - Running setup.py install for mozdevice 05:17:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:17:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:17:17 INFO - Running setup.py install for mozfile 05:17:17 INFO - Running setup.py install for mozhttpd 05:17:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:17:17 INFO - Running setup.py install for mozinfo 05:17:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:17:17 INFO - Running setup.py install for mozInstall 05:17:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:17:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:17:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:17:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:17:18 INFO - Running setup.py install for mozleak 05:17:18 INFO - Running setup.py install for mozlog 05:17:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:17:18 INFO - Running setup.py install for moznetwork 05:17:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:17:18 INFO - Running setup.py install for mozprocess 05:17:18 INFO - Running setup.py install for mozprofile 05:17:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:17:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:17:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:17:18 INFO - Running setup.py install for mozrunner 05:17:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:17:18 INFO - Running setup.py install for mozscreenshot 05:17:18 INFO - Running setup.py install for moztest 05:17:18 INFO - Running setup.py install for mozversion 05:17:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:17:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:17:19 INFO - Cleaning up... 05:17:19 INFO - Return code: 0 05:17:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a3b0>, '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 0x1c6b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b740>, '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': '232498196343f89f466a4a9a000001c8-1470572163.998294-1223643947', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:17:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:17:19 INFO - Using env: {'DISPLAY': ':0', 05:17:19 INFO - 'HOME': '/home/cltbld', 05:17:19 INFO - 'LANG': 'en_US.UTF-8', 05:17:19 INFO - 'LANGUAGE': 'en_US:en', 05:17:19 INFO - 'LOGNAME': 'cltbld', 05:17:19 INFO - 'MAIL': '/var/mail/cltbld', 05:17:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:19 INFO - 'MOZ_NO_REMOTE': '1', 05:17:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:19 INFO - 'NO_EM_RESTART': '1', 05:17:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:19 INFO - 'PWD': '/builds/slave/test', 05:17:19 INFO - 'SHELL': '/bin/bash', 05:17:19 INFO - 'SHLVL': '1', 05:17:19 INFO - 'TERM': 'linux', 05:17:19 INFO - 'TMOUT': '86400', 05:17:19 INFO - 'USER': 'cltbld', 05:17:19 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1470572163.998294-1223643947', 05:17:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:19 INFO - '_': '/tools/buildbot/bin/python'} 05:17:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:19 INFO - Running setup.py (path:/tmp/pip-jRGZt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:19 INFO - Running setup.py (path:/tmp/pip-luu6hB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:19 INFO - Running setup.py (path:/tmp/pip-pAZJbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:19 INFO - Running setup.py (path:/tmp/pip-XpxTMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:19 INFO - Running setup.py (path:/tmp/pip-IyoEue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:19 INFO - Running setup.py (path:/tmp/pip-dd04w6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:19 INFO - Running setup.py (path:/tmp/pip-AUBa85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:19 INFO - Running setup.py (path:/tmp/pip-Mf9wiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:19 INFO - Running setup.py (path:/tmp/pip-eqLle9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:19 INFO - Running setup.py (path:/tmp/pip-J3FrfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:20 INFO - Running setup.py (path:/tmp/pip-Pz9lGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:20 INFO - Running setup.py (path:/tmp/pip-Js8MrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:20 INFO - Running setup.py (path:/tmp/pip-orvYCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:20 INFO - Running setup.py (path:/tmp/pip-_XK4ML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:20 INFO - Running setup.py (path:/tmp/pip-DVq03o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:20 INFO - Running setup.py (path:/tmp/pip-dP0lqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:20 INFO - Running setup.py (path:/tmp/pip-0h2ade-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:17:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:22 INFO - Downloading blessings-1.6.tar.gz 05:17:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:17:22 INFO - Installing collected packages: blessings 05:17:22 INFO - Running setup.py install for blessings 05:17:22 INFO - Successfully installed blessings 05:17:22 INFO - Cleaning up... 05:17:22 INFO - Return code: 0 05:17:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:17:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:22 INFO - Reading from file tmpfile_stdout 05:17:22 INFO - Current package versions: 05:17:22 INFO - argparse == 1.2.1 05:17:22 INFO - blessings == 1.6 05:17:22 INFO - blobuploader == 1.2.4 05:17:22 INFO - docopt == 0.6.1 05:17:22 INFO - functools32 == 3.2.3-2 05:17:22 INFO - jsonschema == 2.5.1 05:17:22 INFO - manifestparser == 1.1 05:17:22 INFO - mozInstall == 1.12 05:17:22 INFO - mozcrash == 0.17 05:17:22 INFO - mozdebug == 0.1 05:17:22 INFO - mozdevice == 0.48 05:17:22 INFO - mozfile == 1.2 05:17:22 INFO - mozhttpd == 0.7 05:17:22 INFO - mozinfo == 0.9 05:17:22 INFO - mozleak == 0.1 05:17:22 INFO - mozlog == 3.3 05:17:22 INFO - moznetwork == 0.27 05:17:22 INFO - mozprocess == 0.23 05:17:22 INFO - mozprofile == 0.28 05:17:22 INFO - mozrunner == 6.12 05:17:22 INFO - mozscreenshot == 0.1 05:17:22 INFO - mozsystemmonitor == 0.3 05:17:22 INFO - moztest == 0.7 05:17:22 INFO - mozversion == 1.4 05:17:22 INFO - psutil == 3.1.1 05:17:22 INFO - requests == 1.2.3 05:17:22 INFO - wsgiref == 0.1.2 05:17:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a3b0>, '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 0x1c6b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b740>, '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': '232498196343f89f466a4a9a000001c8-1470572163.998294-1223643947', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:17:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:17:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:17:22 INFO - Using env: {'DISPLAY': ':0', 05:17:22 INFO - 'HOME': '/home/cltbld', 05:17:22 INFO - 'LANG': 'en_US.UTF-8', 05:17:22 INFO - 'LANGUAGE': 'en_US:en', 05:17:22 INFO - 'LOGNAME': 'cltbld', 05:17:22 INFO - 'MAIL': '/var/mail/cltbld', 05:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:22 INFO - 'MOZ_NO_REMOTE': '1', 05:17:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:22 INFO - 'NO_EM_RESTART': '1', 05:17:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:22 INFO - 'PWD': '/builds/slave/test', 05:17:22 INFO - 'SHELL': '/bin/bash', 05:17:22 INFO - 'SHLVL': '1', 05:17:22 INFO - 'TERM': 'linux', 05:17:22 INFO - 'TMOUT': '86400', 05:17:22 INFO - 'USER': 'cltbld', 05:17:22 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1470572163.998294-1223643947', 05:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:22 INFO - '_': '/tools/buildbot/bin/python'} 05:17:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:17:23 INFO - Cleaning up... 05:17:23 INFO - Return code: 0 05:17:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:17:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a3b0>, '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 0x1c6b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b740>, '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': '232498196343f89f466a4a9a000001c8-1470572163.998294-1223643947', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:17:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:17:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:17:23 INFO - Using env: {'DISPLAY': ':0', 05:17:23 INFO - 'HOME': '/home/cltbld', 05:17:23 INFO - 'LANG': 'en_US.UTF-8', 05:17:23 INFO - 'LANGUAGE': 'en_US:en', 05:17:23 INFO - 'LOGNAME': 'cltbld', 05:17:23 INFO - 'MAIL': '/var/mail/cltbld', 05:17:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:23 INFO - 'MOZ_NO_REMOTE': '1', 05:17:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:23 INFO - 'NO_EM_RESTART': '1', 05:17:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:23 INFO - 'PWD': '/builds/slave/test', 05:17:23 INFO - 'SHELL': '/bin/bash', 05:17:23 INFO - 'SHLVL': '1', 05:17:23 INFO - 'TERM': 'linux', 05:17:23 INFO - 'TMOUT': '86400', 05:17:23 INFO - 'USER': 'cltbld', 05:17:23 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1470572163.998294-1223643947', 05:17:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:23 INFO - '_': '/tools/buildbot/bin/python'} 05:17:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:17:23 INFO - Cleaning up... 05:17:23 INFO - Return code: 0 05:17:23 INFO - Running post-action listener: _resource_record_post_action 05:17:23 INFO - Running post-action listener: _start_resource_monitoring 05:17:23 INFO - Starting resource monitoring. 05:17:23 INFO - [mozharness: 2016-08-07 12:17:23.342297Z] Finished create-virtualenv step (success) 05:17:23 INFO - [mozharness: 2016-08-07 12:17:23.342788Z] Running install step. 05:17:23 INFO - Running pre-action listener: _resource_record_pre_action 05:17:23 INFO - Running main action method: install 05:17:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:23 INFO - Reading from file tmpfile_stdout 05:17:23 INFO - Detecting whether we're running mozinstall >=1.0... 05:17:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:17:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:17:23 INFO - Reading from file tmpfile_stdout 05:17:23 INFO - Output received: 05:17:23 INFO - Usage: mozinstall [options] installer 05:17:23 INFO - Options: 05:17:23 INFO - -h, --help show this help message and exit 05:17:23 INFO - -d DEST, --destination=DEST 05:17:23 INFO - Directory to install application into. [default: 05:17:23 INFO - "/builds/slave/test"] 05:17:23 INFO - --app=APP Application being installed. [default: firefox] 05:17:23 INFO - mkdir: /builds/slave/test/build/application 05:17:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:17:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:17:41 INFO - Reading from file tmpfile_stdout 05:17:41 INFO - Output received: 05:17:41 INFO - /builds/slave/test/build/application/firefox/firefox 05:17:41 INFO - Running post-action listener: _resource_record_post_action 05:17:41 INFO - [mozharness: 2016-08-07 12:17:41.035351Z] Finished install step (success) 05:17:41 INFO - [mozharness: 2016-08-07 12:17:41.035597Z] Running run-tests step. 05:17:41 INFO - Running pre-action listener: _resource_record_pre_action 05:17:41 INFO - Running main action method: run_tests 05:17:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:17:41 INFO - Python 2.7.3 05:17:41 INFO - Return code: 0 05:17:41 INFO - grabbing minidump binary from tooltool 05:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:41 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a3b0>, '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 0x1c6b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:17:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:17:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:17:41 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:17:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:17:41 INFO - Return code: 0 05:17:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:17:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:17:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:17:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:17:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:17:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aaplzBjPQSiANfbcdQOeqg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 05:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aaplzBjPQSiANfbcdQOeqg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 05:17:41 INFO - Using env: {'DISPLAY': ':0', 05:17:41 INFO - 'HOME': '/home/cltbld', 05:17:41 INFO - 'LANG': 'en_US.UTF-8', 05:17:41 INFO - 'LANGUAGE': 'en_US:en', 05:17:41 INFO - 'LOGNAME': 'cltbld', 05:17:41 INFO - 'MAIL': '/var/mail/cltbld', 05:17:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:17:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:41 INFO - 'MOZ_NO_REMOTE': '1', 05:17:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:41 INFO - 'NO_EM_RESTART': '1', 05:17:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:41 INFO - 'PWD': '/builds/slave/test', 05:17:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:17:41 INFO - 'SHELL': '/bin/bash', 05:17:41 INFO - 'SHLVL': '1', 05:17:41 INFO - 'TERM': 'linux', 05:17:41 INFO - 'TMOUT': '86400', 05:17:41 INFO - 'USER': 'cltbld', 05:17:41 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1470572163.998294-1223643947', 05:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:41 INFO - '_': '/tools/buildbot/bin/python'} 05:17:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aaplzBjPQSiANfbcdQOeqg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 05:17:41 INFO - mozversion application_buildid: 20160807023002 05:17:41 INFO - mozversion application_changeset: d42aacfe34af25e2f5110e2ca3d24a210eabeb33 05:17:41 INFO - mozversion application_display_name: Nightly 05:17:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:17:41 INFO - mozversion application_name: Firefox 05:17:41 INFO - mozversion application_remotingname: firefox 05:17:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:17:41 INFO - mozversion application_vendor: Mozilla 05:17:41 INFO - mozversion application_version: 51.0a1 05:17:41 INFO - mozversion platform_buildid: 20160807023002 05:17:41 INFO - mozversion platform_changeset: d42aacfe34af25e2f5110e2ca3d24a210eabeb33 05:17:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:17:41 INFO - mozversion platform_version: 51.0a1 05:17:41 INFO - using testdate: 1470572261 05:17:41 INFO - actual date: 1470572261 05:17:41 INFO - starting webserver on 'localhost:54608' 05:17:41 INFO - SUITE-START | Running 2 tests 05:17:41 INFO - TEST-START | dromaeo_css 05:17:41 INFO - operating with platform_type : linux_ 05:17:41 INFO - Initialising browser for dromaeo_css test... 05:17:41 INFO - TEST-INFO | started process 19511 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0EWtIZ/profile http://localhost:54608/getInfo.html) 05:17:45 INFO - PROCESS | 19511 | __metrics Screen width/height:1600/1200 05:17:45 INFO - PROCESS | 19511 | colorDepth:24 05:17:45 INFO - PROCESS | 19511 | Browser inner width/height: 1024/697 05:17:45 INFO - PROCESS | 19511 | __metrics 05:17:46 INFO - PROCESS | 19511 | 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" 05:17:46 INFO - PROCESS | 19511 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:17:47 INFO - TEST-INFO | 19511: exit 0 05:17:47 INFO - Browser initialized. 05:17:47 INFO - Running cycle 1/1 for dromaeo_css test... 05:17:47 INFO - TEST-INFO | started process 19594 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0EWtIZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:58 INFO - PROCESS | 19594 | RSS: Main: 156192768 05:17:58 INFO - PROCESS | 19594 | 05:18:49 INFO - PROCESS | 19594 | 1470572329911 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:21:00 INFO - PROCESS | 19594 | Cycle 1(1): loaded http://localhost:54608/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54608/tests/dromaeo/cssquery-ext.html) 05:21:01 INFO - PROCESS | 19594 | RSS: Main: 265515008 05:21:01 INFO - PROCESS | 19594 | 05:24:03 INFO - PROCESS | 19594 | Cycle 1(1): loaded http://localhost:54608/tests/dromaeo/cssquery-ext.html (next: http://localhost:54608/tests/dromaeo/cssquery-jquery.html) 05:24:04 INFO - PROCESS | 19594 | RSS: Main: 252534784 05:24:04 INFO - PROCESS | 19594 | 05:27:06 INFO - PROCESS | 19594 | Cycle 1(1): loaded http://localhost:54608/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54608/tests/dromaeo/cssquery-mootools.html) 05:27:07 INFO - PROCESS | 19594 | RSS: Main: 186220544 05:27:07 INFO - PROCESS | 19594 | 05:30:09 INFO - PROCESS | 19594 | Cycle 1(1): loaded http://localhost:54608/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54608/tests/dromaeo/cssquery-prototype.html) 05:30:09 INFO - PROCESS | 19594 | RSS: Main: 184516608 05:30:09 INFO - PROCESS | 19594 | 05:33:12 INFO - PROCESS | 19594 | Cycle 1(1): loaded http://localhost:54608/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54608/tests/dromaeo/cssquery-yui.html) 05:33:12 INFO - PROCESS | 19594 | RSS: Main: 186417152 05:33:12 INFO - PROCESS | 19594 | 05:36:15 INFO - PROCESS | 19594 | Cycle 1(1): loaded http://localhost:54608/tests/dromaeo/cssquery-yui.html (next: http://localhost:54608/tests/dromaeo/cssquery-dojo.html) 05:36:16 INFO - PROCESS | 19594 | RSS: Main: 274747392 05:36:16 INFO - PROCESS | 19594 | 05:36:16 INFO - PROCESS | 19594 | __start_tp_report 05:36:16 INFO - PROCESS | 19594 | _x_x_mozilla_page_load 05:36:16 INFO - PROCESS | 19594 | _x_x_mozilla_page_load_details 05:36:16 INFO - PROCESS | 19594 | |i|pagename|runs| 05:36:16 INFO - PROCESS | 19594 | |0;dojo.html;3055.5722198892154;3064.233941514621;3094.8916787912426;3100.658927517974;3110.3934732727125;5161.612879034069;5183.196604526304;5217.947820521794;5305.734713264335;5319.095753721872;5259.421463638997;5284.973575132119;5342.332208473941;5342.412334643196;5376.838694839161;4820.987592605557;4840.201366774478;4852.830150944717;4876.122297986361;4981.5516603505675;4915.139850526161;4942.728149951751;4955.430125535556;4972.179590367585;4976.925346119811;4778.665493415462;4814.7833347499445;4831.1062453445875;4912.680675756083;4939.629527785412;4872.098661747588;4884.096442158212;4886.144924638174;4886.389201349832;4889.3643826302705;4829.058333624945;4840.564349208588;4849.490803465621;4852.636052296057;4853.635977301717;5254.448282930275;5321.255024296563;5335.653182543122;5386.569074474032;5406.243125962368;5548.805791797308;5559.416261292587;5569.526590239834;5622.746976386073;5628.409017053233;5633.15502674598;5645.689487078209;5667.461591148875;5671.914921276184;5696.886062278772;5162.767675454614;5225.372955245395;5266.34170728659;5277.683338999673;5278.023565640369;5790.507806836382;5827.7668893244645;5850.180974663551;5853.853653658693;5854.531637469077;5570.275864137717;5608.439156084359;5620.353659329147;5623;5625.634333768292;5486.533644640171;5642.351129620146;5685.800996965169;5687.914681279784;5760.049591817303;5692.203091567184;5694.373618901917;5695.686737229492;5705.258316418922;5707.229524014205;5702.572307076985;5707.6290041147195;5709.857253568611;5710;5710.685912274782;4279.16556271524;4302.7848607569495;4306.870793876189;4326.718763280377;4356.411884395629;3906.1797022625565;3911.2959667260166;3936.5472970608175;3946.8026598670526;3957.109650328653;5330.280412144389;5375.462453754593;5383.273258110184;5385.353757549119;5439.782408703687;5496.038193316233;5624.437556244425;5677.971610141923;5711.7144142792695;5721.656700597894;5363.973180134074;5371.865703357447;5372.973135134299;5405.702686352289;5411.458854114636;4882.487338829443;4921.409430868319;4923.335349727741;4933.802647894044;4967.950320496821;5755.3381361144;5823.272090988627;5853.1220316952795;5859.355470898197;5876.3536011039605;5754.9424505754405;5761.91357129635;5771.134329850556;5800.6809625471005;5822.592418530662;5869.618474799125;5906.557008224315;5910.734016969161;5918.822435326947;5922.052471604523;5435.456454354533;5572.387037425961;5580.079286917776;5650.717464126859;5657.547396208376;5731.942680573141;5736.971315143398;5742.1673857289625;5765.279340082489;5778.826635200782;5568.276124103841;5597.188407680945;5597.468240517144;5603.915941260966;5611.130274807411;5335.6265061446875;5553.777848886161;5580.86047848807;5603.8879222416135;5606.131049687305;5552.611317207919;5553.222548843084;5566.109422492382;5609.747561359667;5611.551075913999;5664.660120392789;5666.631668941505;5669.20631111653;5710.8001219957105;5711.8857622848145;5282.339707536558;5287.154055351125;5314.601404894725;5527.391986881359;5533.197686335539 05:36:16 INFO - PROCESS | 19594 | |1;ext.html;574.6040898291101;582.3623132669727;605.657803341112;607.0105727663907;608.9299730530985;44904.32643510346;46365.76817115918;46395.76802115989;46536.30195547069;50729.49270507294;46514.53485465153;46761.532384676146;47037.29444058342;47075.293870591966;47171.52828471714;9096.77258068547;9244;9244.306676999218;9257.861132083024;9259.398139120969;9043.186113249807;9117.72646820593;9138.908610913906;9141.680041198559;9146.176844084031;9167.908320916773;9192.35653504255;9204.309676774235;9205.263578913704;9208.309376796733;9121.635134594608;9144.994050654455;9149.817003659957;9156.496392698398;9164.8625270621;9030.819383612357;9058.864117038249;9067.501287429188;9075.818483630357;9094.49980251086;44056.77971610153;44288;44498;44632.55367446349;44664;3625.5649322081254;3637.672609465161;3665.596784353719;3686.5760437549757;3889.2804831106337;34001;34235;34765.6523434765;34831.303373932635;35425.822870885735;4372.584604462571;4379.211741886459;4458.665600080007;4525.524819893897;4629.837955671535;373628;374320;377069;377710;378060.10969945247;64152.679236604454;64408.35591644117;64637.67681161564;64682;64705;67419;67483;67547.66226168838;67612.66193669;67854;16486.17569121539;16579.50261492157;16687.33250669984;16724.993000839735;16726.330946761995;12355.567555135527;12387.504499820086;12389.318587477595;12389.62831115068;12399.318037507843;17724.12439628;19815.811051336965;20040.398788036382;20129.39611811648;20184.495387615134;6998.335158159966;7160.892586611205;7232.674529646073;7246.746363877344;7249.238829922782;945.7730144765206;1031.1029404418055;1117.9161562882653;1124.3703526025452;1126.9718257043476;33601.15997100092;33820.154496137795;34414.48378274328;34454;34688.479672804926;1060.8355704865758;1081.6160263106642;1086.7935092332589;1115.130198445214;1166.7762699029568;17589.912050439667;17859.642807143784;17951.281948722168;18008.279668813102;18067.27730890776;592912;594438;598208;598670;600039;62181.37818621756;62687;62850.37149628536;62910.68544657339;63047.36952630507;1208.6434501821984;1228.1648479034343;1324.8079028541001;1334.1794796200268;1394.4143459746729;31479.52780708337;33419.832900836314;35338;35756.28487430185;35776;55785;56726.14910776259;56765.148522773015;56801;56843.715781420826;550011;561953;562611;562865;566278;47111.76444117758;47310.344137955006;48195.27707084467;48502;48547;50833;51566.22650660318;51569;51840;52412.21381679354;42219.36670949877;44122.117557648024;45217.54782452133;45232.32151517664;46007.76996114998;44161;44856.551434485234;44969.55030449654;45527.806988253025;46065.53934460613;43460.78269608758;43569.56430435782;43994.560054399044;44077.55922440735;45085;36826;38930.80534597309;39104.41343379908;39380.62167824112;39704.80147599243;28551.18102376993;29392.26519337034;29414.264643384086;29818.254543636584;29945.850270748506 05:36:16 INFO - PROCESS | 19594 | |2;jquery.html;381.9427085937111;394.11521135051805;398.18968399307397;406.6380920980327;418.3118769623967;14294.28528573571;18679.71980420293;19670.803291967077;20147.39557813268;20154.093065812038;12950.093493455439;13192.406341714623;13209.075364724473;13284.601461956132;13313.267770272656;4086.652634526069;5341.893162136755;5486.423925487826;5500.80747173849;5501.202325662776;5792.333881603607;5999.040153575429;6002.2197114375285;6109.3890610939;6121.908171377433;6065.727042283086;6110.450059494645;6117.724702388381;6587.0119482077835;6630.336966303379;6580.078788969548;6584.308647591982;6595.472362211011;6615.073889655428;6627.403533681968;5116.872078198037;5333;5372.462753724635;5452.073147564924;5460.863478413072;13883.652908677263;14108.224047677373;19109.522261943424;24163;24326.39184020396;2251.6509940959177;2320.6286994081033;2376.0614557249964;2845.9430811383863;2924.049683852735;13024.088313818036;14473.927630361886;14611.123332600078;14617.342219600037;15408.3836646534;1888.537308359447;1910.2645481489587;1998.2306811877386;2055.465578949484;2070.8032736889973;77706.61146694286;84469.57765211134;85321.57339213326;85773;86947.13052869454;11177.21759476845;11364;11483.77032459346;11557.306561606163;11640.476178571984;16038.75941860873;16177.514674559781;16182.109983950995;16187.919060404623;16208.51374458768;8079.232472915063;8170.509769413854;8202.26179643835;8304.916950830415;8334.874976875351;7710.074791025113;7736.7292144774665;7785.299323060952;7993;8001.679932802623;4820.638452116105;4861.7326047067045;4875.122477953932;4995.900081998339;5038.370203724535;1952.5997170579997;2020.8787472751387;2021.3935819254166;2026.9797302027087;2039.877607343564;861.9353548483889;951.6859436385976;997.5411310796969;1023.0127926550914;1061.7239517725293;20695.689564656543;20922.37232883016;20961.68557471639;21010.894945525175;21088.156473740877;984.2372161574837;1007.8840933292619;1015.3248090020202;1069.3637285814928;1094.2559059839386;10756.139508839275;11495.942520287512;11506.884931150582;11657.708557286136;11688;472371;479164;479787;479953;501120;76653.61673191599;95282.52358738301;96153.51923240339;98117.5094124539;99576;958.1424624960621;1014.4015031131668;1014.6651604970342;1035.4201647077662;1043.0820877627639;17571.385001524886;17754.467365979042;18259;18424.17091230871;18552.536186595444;43258;43806;44775;44784;45550.31674524819;62682.68658656678;63110;63263;63832.36167638264;64082.3591764095;8681.91318086811;9036.728898133066;9059.637614495346;9079.863802043106;9169.724908252763;11742.354170520703;12830.588635250302;13804.861951380759;13848.169109853441;13913.860861391257;11189.664310070712;11453.828192577284;11930.76138477243;11971.580994665494;12506.374681266083;11775.99904008169;11781.587644432404;12026.939865300617;12274.75450491003;12276.386180691108;11944.163908526667;11961.282323060645;12244.326562038817;12339.568115115928;12434.25394476298;7781.688732450639;7793.532388056735;8034.758957231293;8175.550344730859;8464.111268316738;10166.694999150037;11525.769484610428;11772.293662380285;12016.399180041139;12349.073819463396 05:36:16 INFO - PROCESS | 19594 | |3;mootools.html;1311.082242430299;1470.69115485748;1519.8708109810664;1650.7441346591274;1787.9463616091523;8470.703525376613;8904.51025193614;8930.508822014795;9159.084091590854;9159.496227707474;8931.106889311066;9044.54777261136;9048.411853229552;9057.184853363196;9058.501782401981;2386.4630458146908;2434.671319371889;2434.7686969737847;2435.6833611630464;2435.7077150741848;2332.0438620165737;2386;2389.7132344118645;2393.018862266471;2405.398650337416;2353.329301149173;2377.619580867062;2386.260259319608;2416.069813121952;2419.8548087114827;2258.977410225893;2262.73978492473;2264.083046366224;2270.863748175115;2355.364051706047;2278.236790675126;2281.498070424504;2321.570509455756;2324.6048171810835;2328.196772113618;8881.600327985256;8891.510966896818;9024.909750902472;9028.052054534244;9034.728958131202;5330.147176451749;5550.69471179085;5555.250041244421;5556.499915007628;5564.10974244123;3469.6530346965355;3507.8772242971627;3510.9824450877836;3557.1680584499004;3565.841101641951;1075.569772091162;1085.5711993762498;1133.2463911498844;1157.2477889371892;1159.8633339327423;12461.626151215478;12504.31226282554;12532.686682832911;12587.685307867285;12591.181573197713;4424.6902716810155;4527.750973696412;4606.953930460652;4659.767011649404;4662.090892276042;9801.852972205423;9808.21534277256;9818.75453113678;9823.705288841345;9828.508574571242;5264.289320941701;5267.367915850046;5275.155975043975;5275.762590683428;5288.7091209983055;4368.956310436918;4796.664233503621;4940.283658869444;4945;4978.701277923336;3895.2014836958356;3950.802459876995;4029.8992525187105;4040.313146765057;4065.308897487434;1184.1710802438329;1196.7726132034886;1200.6278053803348;1202.428846298019;1218.1716432825763;928.5960607135918;976.1068622210739;981.1316984468797;985.6895078050392;1005.8088963096989;5864;5868.2664666916635;5890.087036509348;5926.703664816742;5981.880362392728;452.79624169124025;455.521702212682;457.0767050557921;469.5421963585545;470.15841643457827;3827.3684842001317;3975.562688104364;4024.7786371749835;4026.4765580474937;4029.6373326400767;11111.611093611846;11421.486033128529;11509.251898626562;11525.077993760648;11529.827052594217;11396.658100257006;11431.428428578703;11447.942760286145;11461.942690286662;11477.368744718953;8440.746777596682;8487.787805304917;8523.318134549345;8531.74404767858;8537.701180458655;5630.74661640219;5775.306963164448;5791.160281759206;5820.126980952891;6114.296855861455;9976.15202707778;10082.344647597884;10218.978102190018;10418.218633602359;10480.895191047992;10635.787284254426;10668.946655266984;10672.413017283814;10685.412302323446;10714.464276785973;7647.082350118021;8235.547044912348;8467.83064338722;8522.91477085246;8657.480551166951;8618.353623478139;8770.429922055046;8778.56107194625;8781.20969112783;8805.603747831492;7740.961295193488;7763.767086987174;7926.207379262028;8021.398395120506;8107.14874938123;7515;7567.167611562833;7592.202818703957;7610.505317154367;7625.046869141357;6943.895841562482;7061.082059332254;7062.611556364243;7066.152061752623;7074.469414793808;4944.752762361795;4964.131277026434;5013.874653133555;5041.4454410015605;5206.297149884868;5200.349956255468;5237.3453318335205;5238.659487133325;5264.052470555337;5308.601854860824 05:36:16 INFO - PROCESS | 19594 | |4;prototype.html;338.5936875749101;344.1911507956302;344.2375139066966;348.30339321357286;354.5568039950061;5229.764660590273;5238.6332956692995;5240.973795131019;5250.868728281795;5283.313169287992;5106.77019534121;5186.974065129679;5200.687958722479;5202.92195617066;5210.843674689756;3874.6319099685484;3916.4125381192766;4048.858289959852;4052.2705912935658;4074.816633251496;4035.9304784232204;4041.8585349512773;4054.614811592894;4066.6340029397347;4083.2650122977852;3983.900402489932;3995.2009598080353;3996.4604778354988;4009.117994041321;4013.2374848778786;3867.4198870169416;3946.1121247719175;4038.7980600970127;4045.8583949561626;4068.857589984366;3604.855805767766;3608.5308909841815;3616.2948225096115;3620.7827530348;3623.710103191738;4952.900941981176;4962.602991760687;4983.6760610560195;4999.575036121934;5037.697738135724;4478.686491945565;4619.8219454039345;4635.142498637762;4645.303204519315;4672.906541869178;5305.495977882095;5309.654872433318;5313.273186214496;5321.201819727034;5332.653377530448;3972;3992.920141597152;4015.1166743316426;4017.15211002939;4019.256437559032;5493.285872836545;5494.450554944514;5517.282753242052;5559.416261292587;5572.916406253909;4074.490688663917;4074.9185016299507;4078.2659121357847;4087.2234275487563;4087.6919385796855;4138.551506972596;4153.875383738493;4155.501339839238;4159.750414975111;4186.958130418718;4396.1867054595;4630.421197350332;4675.719456832601;4714.481407045222;4720.126776546282;5414.648047876875;5422.376426710979;5428.5385742211565;5433.1850222466155;5475.780968761205;1388.3058470764618;1410.605030591436;1413.1662319231702;1414.816073910385;1419.176877411099;837.3719710217337;899.4648184330313;910.0671811393242;913.917747402737;914.8581969794559;5060.873478163002;5169.586433085344;5178.404483484373;5201.349831271091;5221.269022336875;5480.424555421703;5494.917576236359;5520.66875987442;5524.033294173503;5526.696031718294;4993.550580447777;5206.349206349207;5207.947920520822;5213.113770658997;5217.0870097733505;2872.9138125856257;2875.3099256178784;2895.7104289571294;2897.3770639312647;2911.4177164567172;5656.547476201894;5667.744951477193;5675.659460432387;5696.974544582015;5733.512651424592;5353.678779273256;5598.468145526169;5611.158326251013;5632.155176723524;5644.520215781622;5640.746166422438;5643.830685079454;5644.689542075225;5661.46216109469;5675.262215911987;5278.868028299324;5520.254765606753;5524.596800391842;5532.889342213052;5534.39121696605;5398.676079435247;5432.320959880015;5436.646617969819;5447.972760136174;5478.726063696879;5676.7161641918565;5687.317521897398;5719.885602287848;5777.526730683649;5789.363170051375;3810.695144388387;3971.3050216212623;3995.900102497461;4002.0995276062654;4005.7796821175116;5466.180072989084;5486.780528778804;5491.670499769867;5519.199716041071;5529.557635389078;5401.540869026177;5423.972880135732;5496.367917689357;5507.642003269774;5508.779648814003;5330.946690533045;5345.465453454779;5351.625386222927;5379.946200538101;5493.121100623881;5284.894302114013;5295.602829787705;5309.787608495617;5349.662584353911;5358.892822143614;5239.580833533384;5305.416404195458;5409.350148204678;5440.564754819526;5447.264619276347;5304;5305.549028332481;5314.070037743457;5315.6279060465395;5320.9467905322 05:36:16 INFO - PROCESS | 19594 | |5;yui.html;752.582316814168;763.7746864674924;796.34699546372;803.5700900018492;859.2395729779143;15099.773503397444;16724.080175590338;16724.66550668986;16749.246283917222;16819.074950877697;14991.175485348329;15254.389824407039;15259.92370038151;15274;15293.235338233071;659.2221179008768;790.9406794490408;814.2590242878966;816.4081041245109;817.9182081791803;814.4176913506841;814.8696208606624;816.7141500474846;816.8039670479072;820.7783898347443;864.3862857371274;866.7789713623017;867.0982178534348;867.319154463746;867.453504292295;862.5514732339179;864.1401805203831;864.6584599083327;864.7059999600135;865.1564724393729;506.45050120619175;613.349849159892;626.8495561065312;629.238621268266;638.6232123047424;14267.286635668279;14276.714465710731;14360;14366.138031718026;14370.856291437056;14253.358598862973;14781.199351701784;14973;14979.550613481613;15233.390664373412;13544.59366219015;13571.1857288563;13831.861681383158;14237.644058898506;14293.356798943969;4501.7974191161475;4522.129251903254;4553.165163247403;4623.8150473981;4714.957141289066;82006.17993820045;83939;84128.57935710343;84636.57681711613;84739.57630211872;10698.197635177392;10786.892131078588;11144.777104458028;11303.660890173307;11995.220310679779;22844.715528447356;23186.536269274857;24251.151209707576;24296.757032429803;24303.51392972166;8991.55042247885;9090.636374545076;9273.536323183815;9275.72172834816;9383.108604682544;4596.931046034312;4617.58441740245;4668.159731248408;4694.178518759203;4882.194437917704;3652.178259891556;3786.734928554975;3819.809009549567;3823.8279277432584;3825.1202223488754;656.4617014048434;657.8980258060009;658.0622612776774;666.3436515032689;688.4905170174135;651.5243871973391;690.1159833654052;694.6804469943781;716.8279612892868;767.3285874859498;9656.806863862683;9976.351537150062;10124.493775311204;10271.486425678835;10439.634612788515;691.5539477037383;700.3276854220006;707.3775077931388;732.8497657980101;745.4185735126609;4845.442774081026;5073.543381095646;5089.262057001714;5091.949080509147;5159.7678104485385;73718;74095;74303.62848185725;94935;96278.0372196269;62545;100381.49809251053;105568.79913242071;106209;109563;59099.40900591025;60900;76107.61946190345;95887.28788984843;99678;9667.323287369816;9667.854982175133;9674.322797404115;9728.173105285847;9734.707958761248;57597;57772;57900.710496447246;57965.710171448874;60554.697226513585;70181;78755;82591.5870420644;84958.57520712356;85480;11711.531538738354;12066.276023438622;12133.635990920286;12200.81698774537;12251.509939602316;14308;14685;14763.630909227355;14835.851641483447;15873.365065397255;13538;13690.726185476435;14139.634865425782;14381.209033502839;14728.410863565337;11199.60801371948;13432.462701491831;13709;13710.65723356924;13829.340479142567;13607.455701771818;14123;14552.708945821236;14837;14992.700145997238;11949.236565536317;12495.687607809878;12498.875011249771;12510.18683785551;12943.5469758558;12678.239305641691;13052.804207936699;13115.475380984653;13189.9648740613;13222.537211197561 05:36:16 INFO - PROCESS | 19594 | __end_tp_report 05:36:16 INFO - PROCESS | 19594 | __start_cc_report 05:36:16 INFO - PROCESS | 19594 | _x_x_mozilla_cycle_collect,1071 05:36:16 INFO - PROCESS | 19594 | __end_cc_report 05:36:16 INFO - PROCESS | 19594 | __startTimestamp1470573376021__endTimestamp 05:36:16 INFO - PROCESS | 19594 | 05:36:16 INFO - PROCESS | 19594 | ------- Summary: start ------- 05:36:16 INFO - PROCESS | 19594 | Number of tests: 6 05:36:16 INFO - PROCESS | 19594 | 05:36:16 INFO - PROCESS | 19594 | [#0] dojo.html Cycles:165 Average:5291.29 Median:5527.39 stddev:594.00 (10.7%) stddev-sans-first:569.34 05:36:16 INFO - PROCESS | 19594 | Values: 3055.6 3064.2 3094.9 3100.7 3110.4 5161.6 5183.2 5217.9 5305.7 5319.1 5259.4 5285.0 5342.3 5342.4 5376.8 4821.0 4840.2 4852.8 4876.1 4981.6 4915.1 4942.7 4955.4 4972.2 4976.9 4778.7 4814.8 4831.1 4912.7 4939.6 4872.1 4884.1 4886.1 4886.4 4889.4 4829.1 4840.6 4849.5 4852.6 4853.6 5254.4 5321.3 5335.7 5386.6 5406.2 5548.8 5559.4 5569.5 5622.7 5628.4 5633.2 5645.7 5667.5 5671.9 5696.9 5162.8 5225.4 5266.3 5277.7 5278.0 5790.5 5827.8 5850.2 5853.9 5854.5 5570.3 5608.4 5620.4 5623.0 5625.6 5486.5 5642.4 5685.8 5687.9 5760.0 5692.2 5694.4 5695.7 5705.3 5707.2 5702.6 5707.6 5709.9 5710.0 5710.7 4279.2 4302.8 4306.9 4326.7 4356.4 3906.2 3911.3 3936.5 3946.8 3957.1 5330.3 5375.5 5383.3 5385.4 5439.8 5496.0 5624.4 5678.0 5711.7 5721.7 5364.0 5371.9 5373.0 5405.7 5411.5 4882.5 4921.4 4923.3 4933.8 4968.0 5755.3 5823.3 5853.1 5859.4 5876.4 5754.9 5761.9 5771.1 5800.7 5822.6 5869.6 5906.6 5910.7 5918.8 5922.1 5435.5 5572.4 5580.1 5650.7 5657.5 5731.9 5737.0 5742.2 5765.3 5778.8 5568.3 5597.2 5597.5 5603.9 5611.1 5335.6 5553.8 5580.9 5603.9 5606.1 5552.6 5553.2 5566.1 5609.7 5611.6 5664.7 5666.6 5669.2 5710.8 5711.9 5282.3 5287.2 5314.6 5527.4 5533.2 05:36:16 INFO - PROCESS | 19594 | 05:36:16 INFO - PROCESS | 19594 | [#1] ext.html Cycles:180 Average:68329.70 Median:25026.67 stddev:138313.03 (552.7%) stddev-sans-first:138607.49 05:36:16 INFO - PROCESS | 19594 | Values: 574.6 582.4 605.7 607.0 608.9 44904.3 46365.8 46395.8 46536.3 50729.5 46514.5 46761.5 47037.3 47075.3 47171.5 9096.8 9244.0 9244.3 9257.9 9259.4 9043.2 9117.7 9138.9 9141.7 9146.2 9167.9 9192.4 9204.3 9205.3 9208.3 9121.6 9145.0 9149.8 9156.5 9164.9 9030.8 9058.9 9067.5 9075.8 9094.5 44056.8 44288.0 44498.0 44632.6 44664.0 3625.6 3637.7 3665.6 3686.6 3889.3 34001.0 34235.0 34765.7 34831.3 35425.8 4372.6 4379.2 4458.7 4525.5 4629.8 373628.0 374320.0 377069.0 377710.0 378060.1 64152.7 64408.4 64637.7 64682.0 64705.0 67419.0 67483.0 67547.7 67612.7 67854.0 16486.2 16579.5 16687.3 16725.0 16726.3 12355.6 12387.5 12389.3 12389.6 12399.3 17724.1 19815.8 20040.4 20129.4 20184.5 6998.3 7160.9 7232.7 7246.7 7249.2 945.8 1031.1 1117.9 1124.4 1127.0 33601.2 33820.2 34414.5 34454.0 34688.5 1060.8 1081.6 1086.8 1115.1 1166.8 17589.9 17859.6 17951.3 18008.3 18067.3 592912.0 594438.0 598208.0 598670.0 600039.0 62181.4 62687.0 62850.4 62910.7 63047.4 1208.6 1228.2 1324.8 1334.2 1394.4 31479.5 33419.8 35338.0 35756.3 35776.0 55785.0 56726.1 56765.1 56801.0 56843.7 550011.0 561953.0 562611.0 562865.0 566278.0 47111.8 47310.3 48195.3 48502.0 48547.0 50833.0 51566.2 51569.0 51840.0 52412.2 42219.4 44122.1 45217.5 45232.3 46007.8 44161.0 44856.6 44969.6 45527.8 46065.5 43460.8 43569.6 43994.6 44077.6 45085.0 36826.0 38930.8 39104.4 39380.6 39704.8 28551.2 29392.3 29414.3 29818.3 29945.9 05:36:16 INFO - PROCESS | 19594 | 05:36:16 INFO - PROCESS | 19594 | [#2] jquery.html Cycles:180 Average:29143.44 Median:13269.53 stddev:79763.15 (601.1%) stddev-sans-first:79957.68 05:36:16 INFO - PROCESS | 19594 | Values: 381.9 394.1 398.2 406.6 418.3 14294.3 18679.7 19670.8 20147.4 20154.1 12950.1 13192.4 13209.1 13284.6 13313.3 4086.7 5341.9 5486.4 5500.8 5501.2 5792.3 5999.0 6002.2 6109.4 6121.9 6065.7 6110.5 6117.7 6587.0 6630.3 6580.1 6584.3 6595.5 6615.1 6627.4 5116.9 5333.0 5372.5 5452.1 5460.9 13883.7 14108.2 19109.5 24163.0 24326.4 2251.7 2320.6 2376.1 2845.9 2924.0 13024.1 14473.9 14611.1 14617.3 15408.4 1888.5 1910.3 1998.2 2055.5 2070.8 77706.6 84469.6 85321.6 85773.0 86947.1 11177.2 11364.0 11483.8 11557.3 11640.5 16038.8 16177.5 16182.1 16187.9 16208.5 8079.2 8170.5 8202.3 8304.9 8334.9 7710.1 7736.7 7785.3 7993.0 8001.7 4820.6 4861.7 4875.1 4995.9 5038.4 1952.6 2020.9 2021.4 2027.0 2039.9 861.9 951.7 997.5 1023.0 1061.7 20695.7 20922.4 20961.7 21010.9 21088.2 984.2 1007.9 1015.3 1069.4 1094.3 10756.1 11495.9 11506.9 11657.7 11688.0 472371.0 479164.0 479787.0 479953.0 501120.0 76653.6 95282.5 96153.5 98117.5 99576.0 958.1 1014.4 1014.7 1035.4 1043.1 17571.4 17754.5 18259.0 18424.2 18552.5 43258.0 43806.0 44775.0 44784.0 45550.3 62682.7 63110.0 63263.0 63832.4 64082.4 8681.9 9036.7 9059.6 9079.9 9169.7 11742.4 12830.6 13804.9 13848.2 13913.9 11189.7 11453.8 11930.8 11971.6 12506.4 11776.0 11781.6 12026.9 12274.8 12276.4 11944.2 11961.3 12244.3 12339.6 12434.3 7781.7 7793.5 8034.8 8175.6 8464.1 10166.7 11525.8 11772.3 12016.4 12349.1 05:36:16 INFO - PROCESS | 19594 | 05:36:16 INFO - PROCESS | 19594 | [#3] mootools.html Cycles:180 Average:5886.67 Median:2633.41 stddev:3416.78 (129.7%) stddev-sans-first:3409.06 05:36:16 INFO - PROCESS | 19594 | Values: 1311.1 1470.7 1519.9 1650.7 1787.9 8470.7 8904.5 8930.5 9159.1 9159.5 8931.1 9044.5 9048.4 9057.2 9058.5 2386.5 2434.7 2434.8 2435.7 2435.7 2332.0 2386.0 2389.7 2393.0 2405.4 2353.3 2377.6 2386.3 2416.1 2419.9 2259.0 2262.7 2264.1 2270.9 2355.4 2278.2 2281.5 2321.6 2324.6 2328.2 8881.6 8891.5 9024.9 9028.1 9034.7 5330.1 5550.7 5555.3 5556.5 5564.1 3469.7 3507.9 3511.0 3557.2 3565.8 1075.6 1085.6 1133.2 1157.2 1159.9 12461.6 12504.3 12532.7 12587.7 12591.2 4424.7 4527.8 4607.0 4659.8 4662.1 9801.9 9808.2 9818.8 9823.7 9828.5 5264.3 5267.4 5275.2 5275.8 5288.7 4369.0 4796.7 4940.3 4945.0 4978.7 3895.2 3950.8 4029.9 4040.3 4065.3 1184.2 1196.8 1200.6 1202.4 1218.2 928.6 976.1 981.1 985.7 1005.8 5864.0 5868.3 5890.1 5926.7 5981.9 452.8 455.5 457.1 469.5 470.2 3827.4 3975.6 4024.8 4026.5 4029.6 11111.6 11421.5 11509.3 11525.1 11529.8 11396.7 11431.4 11447.9 11461.9 11477.4 8440.7 8487.8 8523.3 8531.7 8537.7 5630.7 5775.3 5791.2 5820.1 6114.3 9976.2 10082.3 10219.0 10418.2 10480.9 10635.8 10668.9 10672.4 10685.4 10714.5 7647.1 8235.5 8467.8 8522.9 8657.5 8618.4 8770.4 8778.6 8781.2 8805.6 7741.0 7763.8 7926.2 8021.4 8107.1 7515.0 7567.2 7592.2 7610.5 7625.0 6943.9 7061.1 7062.6 7066.2 7074.5 4944.8 4964.1 5013.9 5041.4 5206.3 5200.3 5237.3 5238.7 5264.1 5308.6 05:36:16 INFO - PROCESS | 19594 | 05:36:16 INFO - PROCESS | 19594 | [#4] prototype.html Cycles:180 Average:4557.70 Median:5234.20 stddev:1324.08 (25.3%) stddev-sans-first:1289.37 05:36:16 INFO - PROCESS | 19594 | Values: 338.6 344.2 344.2 348.3 354.6 5229.8 5238.6 5241.0 5250.9 5283.3 5106.8 5187.0 5200.7 5202.9 5210.8 3874.6 3916.4 4048.9 4052.3 4074.8 4035.9 4041.9 4054.6 4066.6 4083.3 3983.9 3995.2 3996.5 4009.1 4013.2 3867.4 3946.1 4038.8 4045.9 4068.9 3604.9 3608.5 3616.3 3620.8 3623.7 4952.9 4962.6 4983.7 4999.6 5037.7 4478.7 4619.8 4635.1 4645.3 4672.9 5305.5 5309.7 5313.3 5321.2 5332.7 3972.0 3992.9 4015.1 4017.2 4019.3 5493.3 5494.5 5517.3 5559.4 5572.9 4074.5 4074.9 4078.3 4087.2 4087.7 4138.6 4153.9 4155.5 4159.8 4187.0 4396.2 4630.4 4675.7 4714.5 4720.1 5414.6 5422.4 5428.5 5433.2 5475.8 1388.3 1410.6 1413.2 1414.8 1419.2 837.4 899.5 910.1 913.9 914.9 5060.9 5169.6 5178.4 5201.3 5221.3 5480.4 5494.9 5520.7 5524.0 5526.7 4993.6 5206.3 5207.9 5213.1 5217.1 2872.9 2875.3 2895.7 2897.4 2911.4 5656.5 5667.7 5675.7 5697.0 5733.5 5353.7 5598.5 5611.2 5632.2 5644.5 5640.7 5643.8 5644.7 5661.5 5675.3 5278.9 5520.3 5524.6 5532.9 5534.4 5398.7 5432.3 5436.6 5448.0 5478.7 5676.7 5687.3 5719.9 5777.5 5789.4 3810.7 3971.3 3995.9 4002.1 4005.8 5466.2 5486.8 5491.7 5519.2 5529.6 5401.5 5424.0 5496.4 5507.6 5508.8 5330.9 5345.5 5351.6 5379.9 5493.1 5284.9 5295.6 5309.8 5349.7 5358.9 5239.6 5305.4 5409.4 5440.6 5447.3 5304.0 5305.5 5314.1 5315.6 5320.9 05:36:16 INFO - PROCESS | 19594 | 05:36:16 INFO - PROCESS | 19594 | [#5] yui.html Cycles:180 Average:20507.36 Median:4780.20 stddev:28121.03 (588.3%) stddev-sans-first:28160.80 05:36:16 INFO - PROCESS | 19594 | Values: 752.6 763.8 796.3 803.6 859.2 15099.8 16724.1 16724.7 16749.2 16819.1 14991.2 15254.4 15259.9 15274.0 15293.2 659.2 790.9 814.3 816.4 817.9 814.4 814.9 816.7 816.8 820.8 864.4 866.8 867.1 867.3 867.5 862.6 864.1 864.7 864.7 865.2 506.5 613.3 626.8 629.2 638.6 14267.3 14276.7 14360.0 14366.1 14370.9 14253.4 14781.2 14973.0 14979.6 15233.4 13544.6 13571.2 13831.9 14237.6 14293.4 4501.8 4522.1 4553.2 4623.8 4715.0 82006.2 83939.0 84128.6 84636.6 84739.6 10698.2 10786.9 11144.8 11303.7 11995.2 22844.7 23186.5 24251.2 24296.8 24303.5 8991.6 9090.6 9273.5 9275.7 9383.1 4596.9 4617.6 4668.2 4694.2 4882.2 3652.2 3786.7 3819.8 3823.8 3825.1 656.5 657.9 658.1 666.3 688.5 651.5 690.1 694.7 716.8 767.3 9656.8 9976.4 10124.5 10271.5 10439.6 691.6 700.3 707.4 732.8 745.4 4845.4 5073.5 5089.3 5091.9 5159.8 73718.0 74095.0 74303.6 94935.0 96278.0 62545.0 100381.5 105568.8 106209.0 109563.0 59099.4 60900.0 76107.6 95887.3 99678.0 9667.3 9667.9 9674.3 9728.2 9734.7 57597.0 57772.0 57900.7 57965.7 60554.7 70181.0 78755.0 82591.6 84958.6 85480.0 11711.5 12066.3 12133.6 12200.8 12251.5 14308.0 14685.0 14763.6 14835.9 15873.4 13538.0 13690.7 14139.6 14381.2 14728.4 11199.6 13432.5 13709.0 13710.7 13829.3 13607.5 14123.0 14552.7 14837.0 14992.7 11949.2 12495.7 12498.9 12510.2 12943.5 12678.2 13052.8 13115.5 13190.0 13222.5 05:36:16 INFO - PROCESS | 19594 | -------- Summary: end -------- 05:36:16 INFO - PROCESS | 19594 | 05:36:16 INFO - TEST-INFO | 19594: exit 0 05:36:16 INFO - TEST-OK | dromaeo_css | took 1115545ms 05:36:16 INFO - TEST-START | kraken 05:36:16 INFO - operating with platform_type : linux_ 05:36:16 INFO - Initialising browser for kraken test... 05:36:16 INFO - TEST-INFO | started process 19785 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZqy9gB/profile http://localhost:54608/getInfo.html) 05:36:20 INFO - PROCESS | 19785 | __metrics Screen width/height:1600/1200 05:36:20 INFO - PROCESS | 19785 | colorDepth:24 05:36:20 INFO - PROCESS | 19785 | Browser inner width/height: 1024/697 05:36:20 INFO - PROCESS | 19785 | __metrics 05:36:21 INFO - PROCESS | 19785 | 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" 05:36:21 INFO - PROCESS | 19785 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:36:22 INFO - TEST-INFO | 19785: exit 0 05:36:22 INFO - Browser initialized. 05:36:22 INFO - Running cycle 1/1 for kraken test... 05:36:22 INFO - TEST-INFO | started process 19867 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZqy9gB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:34 INFO - PROCESS | 19867 | RSS: Main: 156717056 05:36:34 INFO - PROCESS | 19867 | 05:36:36 INFO - PROCESS | 19867 | Cycle 1(1): loaded http://localhost:54608/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54608/tests/kraken/driver.html?testName=audio-beat-detection) 05:36:37 INFO - PROCESS | 19867 | RSS: Main: 213274624 05:36:37 INFO - PROCESS | 19867 | 05:36:40 INFO - PROCESS | 19867 | Cycle 1(1): loaded http://localhost:54608/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54608/tests/kraken/driver.html?testName=audio-dft) 05:36:40 INFO - PROCESS | 19867 | RSS: Main: 192929792 05:36:40 INFO - PROCESS | 19867 | 05:36:43 INFO - PROCESS | 19867 | Cycle 1(1): loaded http://localhost:54608/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54608/tests/kraken/driver.html?testName=audio-fft) 05:36:44 INFO - PROCESS | 19867 | RSS: Main: 269250560 05:36:44 INFO - PROCESS | 19867 | 05:36:46 INFO - PROCESS | 19867 | Cycle 1(1): loaded http://localhost:54608/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54608/tests/kraken/driver.html?testName=audio-oscillator) 05:36:47 INFO - PROCESS | 19867 | RSS: Main: 179589120 05:36:47 INFO - PROCESS | 19867 | 05:36:49 INFO - PROCESS | 19867 | Cycle 1(1): loaded http://localhost:54608/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54608/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:36:49 INFO - PROCESS | 19867 | RSS: Main: 184377344 05:36:49 INFO - PROCESS | 19867 | 05:36:52 INFO - PROCESS | 19867 | Cycle 1(1): loaded http://localhost:54608/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54608/tests/kraken/driver.html?testName=imaging-darkroom) 05:36:53 INFO - PROCESS | 19867 | RSS: Main: 219688960 05:36:53 INFO - PROCESS | 19867 | 05:36:56 INFO - PROCESS | 19867 | Cycle 1(1): loaded http://localhost:54608/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54608/tests/kraken/driver.html?testName=imaging-desaturate) 05:36:57 INFO - PROCESS | 19867 | RSS: Main: 219353088 05:36:57 INFO - PROCESS | 19867 | 05:37:00 INFO - PROCESS | 19867 | Cycle 1(1): loaded http://localhost:54608/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54608/tests/kraken/driver.html?testName=json-parse-financial) 05:37:00 INFO - PROCESS | 19867 | RSS: Main: 219660288 05:37:00 INFO - PROCESS | 19867 | 05:37:02 INFO - PROCESS | 19867 | Cycle 1(1): loaded http://localhost:54608/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54608/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:37:03 INFO - PROCESS | 19867 | RSS: Main: 183472128 05:37:03 INFO - PROCESS | 19867 | 05:37:04 INFO - PROCESS | 19867 | Cycle 1(1): loaded http://localhost:54608/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54608/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:37:05 INFO - PROCESS | 19867 | RSS: Main: 190312448 05:37:05 INFO - PROCESS | 19867 | 05:37:07 INFO - PROCESS | 19867 | Cycle 1(1): loaded http://localhost:54608/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54608/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:37:08 INFO - PROCESS | 19867 | RSS: Main: 194666496 05:37:08 INFO - PROCESS | 19867 | 05:37:10 INFO - PROCESS | 19867 | Cycle 1(1): loaded http://localhost:54608/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54608/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:37:11 INFO - PROCESS | 19867 | RSS: Main: 187551744 05:37:11 INFO - PROCESS | 19867 | 05:37:13 INFO - PROCESS | 19867 | Cycle 1(1): loaded http://localhost:54608/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54608/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:37:14 INFO - PROCESS | 19867 | RSS: Main: 193716224 05:37:14 INFO - PROCESS | 19867 | 05:37:16 INFO - PROCESS | 19867 | Cycle 1(1): loaded http://localhost:54608/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54608/tests/kraken/driver.html?testName=ai-astar) 05:37:16 INFO - PROCESS | 19867 | RSS: Main: 243441664 05:37:16 INFO - PROCESS | 19867 | 05:37:16 INFO - PROCESS | 19867 | __start_tp_report 05:37:16 INFO - PROCESS | 19867 | _x_x_mozilla_page_load 05:37:16 INFO - PROCESS | 19867 | _x_x_mozilla_page_load_details 05:37:16 INFO - PROCESS | 19867 | |i|pagename|runs| 05:37:16 INFO - PROCESS | 19867 | |0;ai-astar;104;112;112;112;114;112;113;112;112;111 05:37:16 INFO - PROCESS | 19867 | |1;audio-beat-detection;147;118;118;187;119;118;143;115;154;118 05:37:16 INFO - PROCESS | 19867 | |2;audio-dft;161;160;159;161;161;161;158;161;161;161 05:37:16 INFO - PROCESS | 19867 | |3;audio-fft;75;75;75;118;75;75;75;75;98;73 05:37:16 INFO - PROCESS | 19867 | |4;audio-oscillator;83;83;139;83;85;84;120;86;85;128 05:37:16 INFO - PROCESS | 19867 | |5;imaging-gaussian-blur;117;118;117;117;117;117;116;116;116;117 05:37:16 INFO - PROCESS | 19867 | |6;imaging-darkroom;146;145;146;147;146;146;146;148;148;147 05:37:16 INFO - PROCESS | 19867 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 05:37:16 INFO - PROCESS | 19867 | |8;json-parse-financial;49;49;50;49;49;50;49;48;49;50 05:37:16 INFO - PROCESS | 19867 | |9;json-stringify-tinderbox;59;59;59;60;59;59;59;61;58;58 05:37:16 INFO - PROCESS | 19867 | |10;stanford-crypto-aes;86;76;75;74;83;74;74;74;74;74 05:37:16 INFO - PROCESS | 19867 | |11;stanford-crypto-ccm;131;120;138;120;118;133;122;126;206;135 05:37:16 INFO - PROCESS | 19867 | |12;stanford-crypto-pbkdf2;168;159;162;164;163;165;169;162;161;158 05:37:16 INFO - PROCESS | 19867 | |13;stanford-crypto-sha256-iterative;63;64;63;65;65;64;63;64;61;62 05:37:16 INFO - PROCESS | 19867 | __end_tp_report 05:37:16 INFO - PROCESS | 19867 | __start_cc_report 05:37:16 INFO - PROCESS | 19867 | _x_x_mozilla_cycle_collect,1637 05:37:16 INFO - PROCESS | 19867 | __end_cc_report 05:37:16 INFO - PROCESS | 19867 | __startTimestamp1470573436460__endTimestamp 05:37:16 INFO - PROCESS | 19867 | 05:37:16 INFO - PROCESS | 19867 | ------- Summary: start ------- 05:37:16 INFO - PROCESS | 19867 | Number of tests: 14 05:37:16 INFO - PROCESS | 19867 | 05:37:16 INFO - PROCESS | 19867 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:2.72 (2.4%) stddev-sans-first:0.83 05:37:16 INFO - PROCESS | 19867 | Values: 104.0 112.0 112.0 112.0 114.0 112.0 113.0 112.0 112.0 111.0 05:37:16 INFO - PROCESS | 19867 | 05:37:16 INFO - PROCESS | 19867 | [#1] audio-beat-detection Cycles:10 Average:133.70 Median:131.00 stddev:23.73 (18.1%) stddev-sans-first:24.68 05:37:16 INFO - PROCESS | 19867 | Values: 147.0 118.0 118.0 187.0 119.0 118.0 143.0 115.0 154.0 118.0 05:37:16 INFO - PROCESS | 19867 | 05:37:16 INFO - PROCESS | 19867 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 05:37:16 INFO - PROCESS | 19867 | Values: 161.0 160.0 159.0 161.0 161.0 161.0 158.0 161.0 161.0 161.0 05:37:16 INFO - PROCESS | 19867 | 05:37:16 INFO - PROCESS | 19867 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.00 stddev:14.80 (19.7%) stddev-sans-first:15.52 05:37:16 INFO - PROCESS | 19867 | Values: 75.0 75.0 75.0 118.0 75.0 75.0 75.0 75.0 98.0 73.0 05:37:16 INFO - PROCESS | 19867 | 05:37:16 INFO - PROCESS | 19867 | [#4] audio-oscillator Cycles:10 Average:97.60 Median:83.50 stddev:22.15 (26.5%) stddev-sans-first:22.86 05:37:16 INFO - PROCESS | 19867 | Values: 83.0 83.0 139.0 83.0 85.0 84.0 120.0 86.0 85.0 128.0 05:37:16 INFO - PROCESS | 19867 | 05:37:16 INFO - PROCESS | 19867 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 05:37:16 INFO - PROCESS | 19867 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 117.0 05:37:16 INFO - PROCESS | 19867 | 05:37:16 INFO - PROCESS | 19867 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.97 (0.7%) stddev-sans-first:1.01 05:37:16 INFO - PROCESS | 19867 | Values: 146.0 145.0 146.0 147.0 146.0 146.0 146.0 148.0 148.0 147.0 05:37:16 INFO - PROCESS | 19867 | 05:37:16 INFO - PROCESS | 19867 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 05:37:16 INFO - PROCESS | 19867 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 05:37:16 INFO - PROCESS | 19867 | 05:37:16 INFO - PROCESS | 19867 | [#8] json-parse-financial Cycles:10 Average:49.20 Median:49.00 stddev:0.63 (1.3%) stddev-sans-first:0.67 05:37:16 INFO - PROCESS | 19867 | Values: 49.0 49.0 50.0 49.0 49.0 50.0 49.0 48.0 49.0 50.0 05:37:16 INFO - PROCESS | 19867 | 05:37:16 INFO - PROCESS | 19867 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.88 (1.5%) stddev-sans-first:0.93 05:37:16 INFO - PROCESS | 19867 | Values: 59.0 59.0 59.0 60.0 59.0 59.0 59.0 61.0 58.0 58.0 05:37:16 INFO - PROCESS | 19867 | 05:37:16 INFO - PROCESS | 19867 | [#10] stanford-crypto-aes Cycles:10 Average:76.40 Median:74.50 stddev:4.38 (5.9%) stddev-sans-first:2.96 05:37:16 INFO - PROCESS | 19867 | Values: 86.0 76.0 75.0 74.0 83.0 74.0 74.0 74.0 74.0 74.0 05:37:16 INFO - PROCESS | 19867 | 05:37:16 INFO - PROCESS | 19867 | [#11] stanford-crypto-ccm Cycles:10 Average:134.90 Median:132.00 stddev:25.95 (19.7%) stddev-sans-first:27.48 05:37:16 INFO - PROCESS | 19867 | Values: 131.0 120.0 138.0 120.0 118.0 133.0 122.0 126.0 206.0 135.0 05:37:16 INFO - PROCESS | 19867 | 05:37:16 INFO - PROCESS | 19867 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.10 Median:163.50 stddev:3.54 (2.2%) stddev-sans-first:3.28 05:37:16 INFO - PROCESS | 19867 | Values: 168.0 159.0 162.0 164.0 163.0 165.0 169.0 162.0 161.0 158.0 05:37:16 INFO - PROCESS | 19867 | 05:37:16 INFO - PROCESS | 19867 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:64.00 stddev:1.26 (2.0%) stddev-sans-first:1.33 05:37:16 INFO - PROCESS | 19867 | Values: 63.0 64.0 63.0 65.0 65.0 64.0 63.0 64.0 61.0 62.0 05:37:16 INFO - PROCESS | 19867 | -------- Summary: end -------- 05:37:16 INFO - PROCESS | 19867 | 05:37:17 INFO - TEST-INFO | 19867: exit 0 05:37:17 INFO - TEST-OK | kraken | took 60647ms 05:37:17 INFO - SUITE-END | took 1176s 05:37:17 INFO - Completed test suite (00:19:36) 05:37:17 INFO - javascript benchmark 05:37:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3055.5722198892154, 3064.233941514621, 3094.8916787912426, 3100.658927517974, 3110.3934732727125, 5161.612879034069, 5183.196604526304, 5217.947820521794, 5305.734713264335, 5319.095753721872, 5259.421463638997, 5284.973575132119, 5342.332208473941, 5342.412334643196, 5376.838694839161, 4820.987592605557, 4840.201366774478, 4852.830150944717, 4876.122297986361, 4981.5516603505675, 4915.139850526161, 4942.728149951751, 4955.430125535556, 4972.179590367585, 4976.925346119811, 4778.665493415462, 4814.7833347499445, 4831.1062453445875, 4912.680675756083, 4939.629527785412, 4872.098661747588, 4884.096442158212, 4886.144924638174, 4886.389201349832, 4889.3643826302705, 4829.058333624945, 4840.564349208588, 4849.490803465621, 4852.636052296057, 4853.635977301717, 5254.448282930275, 5321.255024296563, 5335.653182543122, 5386.569074474032, 5406.243125962368, 5548.805791797308, 5559.416261292587, 5569.526590239834, 5622.746976386073, 5628.409017053233, 5633.15502674598, 5645.689487078209, 5667.461591148875, 5671.914921276184, 5696.886062278772, 5162.767675454614, 5225.372955245395, 5266.34170728659, 5277.683338999673, 5278.023565640369, 5790.507806836382, 5827.7668893244645, 5850.180974663551, 5853.853653658693, 5854.531637469077, 5570.275864137717, 5608.439156084359, 5620.353659329147, 5623.0, 5625.634333768292, 5486.533644640171, 5642.351129620146, 5685.800996965169, 5687.914681279784, 5760.049591817303, 5692.203091567184, 5694.373618901917, 5695.686737229492, 5705.258316418922, 5707.229524014205, 5702.572307076985, 5707.6290041147195, 5709.857253568611, 5710.0, 5710.685912274782, 4279.16556271524, 4302.7848607569495, 4306.870793876189, 4326.718763280377, 4356.411884395629, 3906.1797022625565, 3911.2959667260166, 3936.5472970608175, 3946.8026598670526, 3957.109650328653, 5330.280412144389, 5375.462453754593, 5383.273258110184, 5385.353757549119, 5439.782408703687, 5496.038193316233, 5624.437556244425, 5677.971610141923, 5711.7144142792695, 5721.656700597894, 5363.973180134074, 5371.865703357447, 5372.973135134299, 5405.702686352289, 5411.458854114636, 4882.487338829443, 4921.409430868319, 4923.335349727741, 4933.802647894044, 4967.950320496821, 5755.3381361144, 5823.272090988627, 5853.1220316952795, 5859.355470898197, 5876.3536011039605, 5754.9424505754405, 5761.91357129635, 5771.134329850556, 5800.6809625471005, 5822.592418530662, 5869.618474799125, 5906.557008224315, 5910.734016969161, 5918.822435326947, 5922.052471604523, 5435.456454354533, 5572.387037425961, 5580.079286917776, 5650.717464126859, 5657.547396208376, 5731.942680573141, 5736.971315143398, 5742.1673857289625, 5765.279340082489, 5778.826635200782, 5568.276124103841, 5597.188407680945, 5597.468240517144, 5603.915941260966, 5611.130274807411, 5335.6265061446875, 5553.777848886161, 5580.86047848807, 5603.8879222416135, 5606.131049687305, 5552.611317207919, 5553.222548843084, 5566.109422492382, 5609.747561359667, 5611.551075913999, 5664.660120392789, 5666.631668941505, 5669.20631111653, 5710.8001219957105, 5711.8857622848145, 5282.339707536558, 5287.154055351125, 5314.601404894725, 5527.391986881359, 5533.197686335539], "value": 5251.570558644133, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.6040898291101, 582.3623132669727, 605.657803341112, 607.0105727663907, 608.9299730530985, 44904.32643510346, 46365.76817115918, 46395.76802115989, 46536.30195547069, 50729.49270507294, 46514.53485465153, 46761.532384676146, 47037.29444058342, 47075.293870591966, 47171.52828471714, 9096.77258068547, 9244.0, 9244.306676999218, 9257.861132083024, 9259.398139120969, 9043.186113249807, 9117.72646820593, 9138.908610913906, 9141.680041198559, 9146.176844084031, 9167.908320916773, 9192.35653504255, 9204.309676774235, 9205.263578913704, 9208.309376796733, 9121.635134594608, 9144.994050654455, 9149.817003659957, 9156.496392698398, 9164.8625270621, 9030.819383612357, 9058.864117038249, 9067.501287429188, 9075.818483630357, 9094.49980251086, 44056.77971610153, 44288.0, 44498.0, 44632.55367446349, 44664.0, 3625.5649322081254, 3637.672609465161, 3665.596784353719, 3686.5760437549757, 3889.2804831106337, 34001.0, 34235.0, 34765.6523434765, 34831.303373932635, 35425.822870885735, 4372.584604462571, 4379.211741886459, 4458.665600080007, 4525.524819893897, 4629.837955671535, 373628.0, 374320.0, 377069.0, 377710.0, 378060.10969945247, 64152.679236604454, 64408.35591644117, 64637.67681161564, 64682.0, 64705.0, 67419.0, 67483.0, 67547.66226168838, 67612.66193669, 67854.0, 16486.17569121539, 16579.50261492157, 16687.33250669984, 16724.993000839735, 16726.330946761995, 12355.567555135527, 12387.504499820086, 12389.318587477595, 12389.62831115068, 12399.318037507843, 17724.12439628, 19815.811051336965, 20040.398788036382, 20129.39611811648, 20184.495387615134, 6998.335158159966, 7160.892586611205, 7232.674529646073, 7246.746363877344, 7249.238829922782, 945.7730144765206, 1031.1029404418055, 1117.9161562882653, 1124.3703526025452, 1126.9718257043476, 33601.15997100092, 33820.154496137795, 34414.48378274328, 34454.0, 34688.479672804926, 1060.8355704865758, 1081.6160263106642, 1086.7935092332589, 1115.130198445214, 1166.7762699029568, 17589.912050439667, 17859.642807143784, 17951.281948722168, 18008.279668813102, 18067.27730890776, 592912.0, 594438.0, 598208.0, 598670.0, 600039.0, 62181.37818621756, 62687.0, 62850.37149628536, 62910.68544657339, 63047.36952630507, 1208.6434501821984, 1228.1648479034343, 1324.8079028541001, 1334.1794796200268, 1394.4143459746729, 31479.52780708337, 33419.832900836314, 35338.0, 35756.28487430185, 35776.0, 55785.0, 56726.14910776259, 56765.148522773015, 56801.0, 56843.715781420826, 550011.0, 561953.0, 562611.0, 562865.0, 566278.0, 47111.76444117758, 47310.344137955006, 48195.27707084467, 48502.0, 48547.0, 50833.0, 51566.22650660318, 51569.0, 51840.0, 52412.21381679354, 42219.36670949877, 44122.117557648024, 45217.54782452133, 45232.32151517664, 46007.76996114998, 44161.0, 44856.551434485234, 44969.55030449654, 45527.806988253025, 46065.53934460613, 43460.78269608758, 43569.56430435782, 43994.560054399044, 44077.55922440735, 45085.0, 36826.0, 38930.80534597309, 39104.41343379908, 39380.62167824112, 39704.80147599243, 28551.18102376993, 29392.26519337034, 29414.264643384086, 29818.254543636584, 29945.850270748506], "value": 21531.206344160568, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.9427085937111, 394.11521135051805, 398.18968399307397, 406.6380920980327, 418.3118769623967, 14294.28528573571, 18679.71980420293, 19670.803291967077, 20147.39557813268, 20154.093065812038, 12950.093493455439, 13192.406341714623, 13209.075364724473, 13284.601461956132, 13313.267770272656, 4086.652634526069, 5341.893162136755, 5486.423925487826, 5500.80747173849, 5501.202325662776, 5792.333881603607, 5999.040153575429, 6002.2197114375285, 6109.3890610939, 6121.908171377433, 6065.727042283086, 6110.450059494645, 6117.724702388381, 6587.0119482077835, 6630.336966303379, 6580.078788969548, 6584.308647591982, 6595.472362211011, 6615.073889655428, 6627.403533681968, 5116.872078198037, 5333.0, 5372.462753724635, 5452.073147564924, 5460.863478413072, 13883.652908677263, 14108.224047677373, 19109.522261943424, 24163.0, 24326.39184020396, 2251.6509940959177, 2320.6286994081033, 2376.0614557249964, 2845.9430811383863, 2924.049683852735, 13024.088313818036, 14473.927630361886, 14611.123332600078, 14617.342219600037, 15408.3836646534, 1888.537308359447, 1910.2645481489587, 1998.2306811877386, 2055.465578949484, 2070.8032736889973, 77706.61146694286, 84469.57765211134, 85321.57339213326, 85773.0, 86947.13052869454, 11177.21759476845, 11364.0, 11483.77032459346, 11557.306561606163, 11640.476178571984, 16038.75941860873, 16177.514674559781, 16182.109983950995, 16187.919060404623, 16208.51374458768, 8079.232472915063, 8170.509769413854, 8202.26179643835, 8304.916950830415, 8334.874976875351, 7710.074791025113, 7736.7292144774665, 7785.299323060952, 7993.0, 8001.679932802623, 4820.638452116105, 4861.7326047067045, 4875.122477953932, 4995.900081998339, 5038.370203724535, 1952.5997170579997, 2020.8787472751387, 2021.3935819254166, 2026.9797302027087, 2039.877607343564, 861.9353548483889, 951.6859436385976, 997.5411310796969, 1023.0127926550914, 1061.7239517725293, 20695.689564656543, 20922.37232883016, 20961.68557471639, 21010.894945525175, 21088.156473740877, 984.2372161574837, 1007.8840933292619, 1015.3248090020202, 1069.3637285814928, 1094.2559059839386, 10756.139508839275, 11495.942520287512, 11506.884931150582, 11657.708557286136, 11688.0, 472371.0, 479164.0, 479787.0, 479953.0, 501120.0, 76653.61673191599, 95282.52358738301, 96153.51923240339, 98117.5094124539, 99576.0, 958.1424624960621, 1014.4015031131668, 1014.6651604970342, 1035.4201647077662, 1043.0820877627639, 17571.385001524886, 17754.467365979042, 18259.0, 18424.17091230871, 18552.536186595444, 43258.0, 43806.0, 44775.0, 44784.0, 45550.31674524819, 62682.68658656678, 63110.0, 63263.0, 63832.36167638264, 64082.3591764095, 8681.91318086811, 9036.728898133066, 9059.637614495346, 9079.863802043106, 9169.724908252763, 11742.354170520703, 12830.588635250302, 13804.861951380759, 13848.169109853441, 13913.860861391257, 11189.664310070712, 11453.828192577284, 11930.76138477243, 11971.580994665494, 12506.374681266083, 11775.99904008169, 11781.587644432404, 12026.939865300617, 12274.75450491003, 12276.386180691108, 11944.163908526667, 11961.282323060645, 12244.326562038817, 12339.568115115928, 12434.25394476298, 7781.688732450639, 7793.532388056735, 8034.758957231293, 8175.550344730859, 8464.111268316738, 10166.694999150037, 11525.769484610428, 11772.293662380285, 12016.399180041139, 12349.073819463396], "value": 9385.069005154914, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1311.082242430299, 1470.69115485748, 1519.8708109810664, 1650.7441346591274, 1787.9463616091523, 8470.703525376613, 8904.51025193614, 8930.508822014795, 9159.084091590854, 9159.496227707474, 8931.106889311066, 9044.54777261136, 9048.411853229552, 9057.184853363196, 9058.501782401981, 2386.4630458146908, 2434.671319371889, 2434.7686969737847, 2435.6833611630464, 2435.7077150741848, 2332.0438620165737, 2386.0, 2389.7132344118645, 2393.018862266471, 2405.398650337416, 2353.329301149173, 2377.619580867062, 2386.260259319608, 2416.069813121952, 2419.8548087114827, 2258.977410225893, 2262.73978492473, 2264.083046366224, 2270.863748175115, 2355.364051706047, 2278.236790675126, 2281.498070424504, 2321.570509455756, 2324.6048171810835, 2328.196772113618, 8881.600327985256, 8891.510966896818, 9024.909750902472, 9028.052054534244, 9034.728958131202, 5330.147176451749, 5550.69471179085, 5555.250041244421, 5556.499915007628, 5564.10974244123, 3469.6530346965355, 3507.8772242971627, 3510.9824450877836, 3557.1680584499004, 3565.841101641951, 1075.569772091162, 1085.5711993762498, 1133.2463911498844, 1157.2477889371892, 1159.8633339327423, 12461.626151215478, 12504.31226282554, 12532.686682832911, 12587.685307867285, 12591.181573197713, 4424.6902716810155, 4527.750973696412, 4606.953930460652, 4659.767011649404, 4662.090892276042, 9801.852972205423, 9808.21534277256, 9818.75453113678, 9823.705288841345, 9828.508574571242, 5264.289320941701, 5267.367915850046, 5275.155975043975, 5275.762590683428, 5288.7091209983055, 4368.956310436918, 4796.664233503621, 4940.283658869444, 4945.0, 4978.701277923336, 3895.2014836958356, 3950.802459876995, 4029.8992525187105, 4040.313146765057, 4065.308897487434, 1184.1710802438329, 1196.7726132034886, 1200.6278053803348, 1202.428846298019, 1218.1716432825763, 928.5960607135918, 976.1068622210739, 981.1316984468797, 985.6895078050392, 1005.8088963096989, 5864.0, 5868.2664666916635, 5890.087036509348, 5926.703664816742, 5981.880362392728, 452.79624169124025, 455.521702212682, 457.0767050557921, 469.5421963585545, 470.15841643457827, 3827.3684842001317, 3975.562688104364, 4024.7786371749835, 4026.4765580474937, 4029.6373326400767, 11111.611093611846, 11421.486033128529, 11509.251898626562, 11525.077993760648, 11529.827052594217, 11396.658100257006, 11431.428428578703, 11447.942760286145, 11461.942690286662, 11477.368744718953, 8440.746777596682, 8487.787805304917, 8523.318134549345, 8531.74404767858, 8537.701180458655, 5630.74661640219, 5775.306963164448, 5791.160281759206, 5820.126980952891, 6114.296855861455, 9976.15202707778, 10082.344647597884, 10218.978102190018, 10418.218633602359, 10480.895191047992, 10635.787284254426, 10668.946655266984, 10672.413017283814, 10685.412302323446, 10714.464276785973, 7647.082350118021, 8235.547044912348, 8467.83064338722, 8522.91477085246, 8657.480551166951, 8618.353623478139, 8770.429922055046, 8778.56107194625, 8781.20969112783, 8805.603747831492, 7740.961295193488, 7763.767086987174, 7926.207379262028, 8021.398395120506, 8107.14874938123, 7515.0, 7567.167611562833, 7592.202818703957, 7610.505317154367, 7625.046869141357, 6943.895841562482, 7061.082059332254, 7062.611556364243, 7066.152061752623, 7074.469414793808, 4944.752762361795, 4964.131277026434, 5013.874653133555, 5041.4454410015605, 5206.297149884868, 5200.349956255468, 5237.3453318335205, 5238.659487133325, 5264.052470555337, 5308.601854860824], "value": 4602.711503407466, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.5936875749101, 344.1911507956302, 344.2375139066966, 348.30339321357286, 354.5568039950061, 5229.764660590273, 5238.6332956692995, 5240.973795131019, 5250.868728281795, 5283.313169287992, 5106.77019534121, 5186.974065129679, 5200.687958722479, 5202.92195617066, 5210.843674689756, 3874.6319099685484, 3916.4125381192766, 4048.858289959852, 4052.2705912935658, 4074.816633251496, 4035.9304784232204, 4041.8585349512773, 4054.614811592894, 4066.6340029397347, 4083.2650122977852, 3983.900402489932, 3995.2009598080353, 3996.4604778354988, 4009.117994041321, 4013.2374848778786, 3867.4198870169416, 3946.1121247719175, 4038.7980600970127, 4045.8583949561626, 4068.857589984366, 3604.855805767766, 3608.5308909841815, 3616.2948225096115, 3620.7827530348, 3623.710103191738, 4952.900941981176, 4962.602991760687, 4983.6760610560195, 4999.575036121934, 5037.697738135724, 4478.686491945565, 4619.8219454039345, 4635.142498637762, 4645.303204519315, 4672.906541869178, 5305.495977882095, 5309.654872433318, 5313.273186214496, 5321.201819727034, 5332.653377530448, 3972.0, 3992.920141597152, 4015.1166743316426, 4017.15211002939, 4019.256437559032, 5493.285872836545, 5494.450554944514, 5517.282753242052, 5559.416261292587, 5572.916406253909, 4074.490688663917, 4074.9185016299507, 4078.2659121357847, 4087.2234275487563, 4087.6919385796855, 4138.551506972596, 4153.875383738493, 4155.501339839238, 4159.750414975111, 4186.958130418718, 4396.1867054595, 4630.421197350332, 4675.719456832601, 4714.481407045222, 4720.126776546282, 5414.648047876875, 5422.376426710979, 5428.5385742211565, 5433.1850222466155, 5475.780968761205, 1388.3058470764618, 1410.605030591436, 1413.1662319231702, 1414.816073910385, 1419.176877411099, 837.3719710217337, 899.4648184330313, 910.0671811393242, 913.917747402737, 914.8581969794559, 5060.873478163002, 5169.586433085344, 5178.404483484373, 5201.349831271091, 5221.269022336875, 5480.424555421703, 5494.917576236359, 5520.66875987442, 5524.033294173503, 5526.696031718294, 4993.550580447777, 5206.349206349207, 5207.947920520822, 5213.113770658997, 5217.0870097733505, 2872.9138125856257, 2875.3099256178784, 2895.7104289571294, 2897.3770639312647, 2911.4177164567172, 5656.547476201894, 5667.744951477193, 5675.659460432387, 5696.974544582015, 5733.512651424592, 5353.678779273256, 5598.468145526169, 5611.158326251013, 5632.155176723524, 5644.520215781622, 5640.746166422438, 5643.830685079454, 5644.689542075225, 5661.46216109469, 5675.262215911987, 5278.868028299324, 5520.254765606753, 5524.596800391842, 5532.889342213052, 5534.39121696605, 5398.676079435247, 5432.320959880015, 5436.646617969819, 5447.972760136174, 5478.726063696879, 5676.7161641918565, 5687.317521897398, 5719.885602287848, 5777.526730683649, 5789.363170051375, 3810.695144388387, 3971.3050216212623, 3995.900102497461, 4002.0995276062654, 4005.7796821175116, 5466.180072989084, 5486.780528778804, 5491.670499769867, 5519.199716041071, 5529.557635389078, 5401.540869026177, 5423.972880135732, 5496.367917689357, 5507.642003269774, 5508.779648814003, 5330.946690533045, 5345.465453454779, 5351.625386222927, 5379.946200538101, 5493.121100623881, 5284.894302114013, 5295.602829787705, 5309.787608495617, 5349.662584353911, 5358.892822143614, 5239.580833533384, 5305.416404195458, 5409.350148204678, 5440.564754819526, 5447.264619276347, 5304.0, 5305.549028332481, 5314.070037743457, 5315.6279060465395, 5320.9467905322], "value": 4139.45513886678, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.582316814168, 763.7746864674924, 796.34699546372, 803.5700900018492, 859.2395729779143, 15099.773503397444, 16724.080175590338, 16724.66550668986, 16749.246283917222, 16819.074950877697, 14991.175485348329, 15254.389824407039, 15259.92370038151, 15274.0, 15293.235338233071, 659.2221179008768, 790.9406794490408, 814.2590242878966, 816.4081041245109, 817.9182081791803, 814.4176913506841, 814.8696208606624, 816.7141500474846, 816.8039670479072, 820.7783898347443, 864.3862857371274, 866.7789713623017, 867.0982178534348, 867.319154463746, 867.453504292295, 862.5514732339179, 864.1401805203831, 864.6584599083327, 864.7059999600135, 865.1564724393729, 506.45050120619175, 613.349849159892, 626.8495561065312, 629.238621268266, 638.6232123047424, 14267.286635668279, 14276.714465710731, 14360.0, 14366.138031718026, 14370.856291437056, 14253.358598862973, 14781.199351701784, 14973.0, 14979.550613481613, 15233.390664373412, 13544.59366219015, 13571.1857288563, 13831.861681383158, 14237.644058898506, 14293.356798943969, 4501.7974191161475, 4522.129251903254, 4553.165163247403, 4623.8150473981, 4714.957141289066, 82006.17993820045, 83939.0, 84128.57935710343, 84636.57681711613, 84739.57630211872, 10698.197635177392, 10786.892131078588, 11144.777104458028, 11303.660890173307, 11995.220310679779, 22844.715528447356, 23186.536269274857, 24251.151209707576, 24296.757032429803, 24303.51392972166, 8991.55042247885, 9090.636374545076, 9273.536323183815, 9275.72172834816, 9383.108604682544, 4596.931046034312, 4617.58441740245, 4668.159731248408, 4694.178518759203, 4882.194437917704, 3652.178259891556, 3786.734928554975, 3819.809009549567, 3823.8279277432584, 3825.1202223488754, 656.4617014048434, 657.8980258060009, 658.0622612776774, 666.3436515032689, 688.4905170174135, 651.5243871973391, 690.1159833654052, 694.6804469943781, 716.8279612892868, 767.3285874859498, 9656.806863862683, 9976.351537150062, 10124.493775311204, 10271.486425678835, 10439.634612788515, 691.5539477037383, 700.3276854220006, 707.3775077931388, 732.8497657980101, 745.4185735126609, 4845.442774081026, 5073.543381095646, 5089.262057001714, 5091.949080509147, 5159.7678104485385, 73718.0, 74095.0, 74303.62848185725, 94935.0, 96278.0372196269, 62545.0, 100381.49809251053, 105568.79913242071, 106209.0, 109563.0, 59099.40900591025, 60900.0, 76107.61946190345, 95887.28788984843, 99678.0, 9667.323287369816, 9667.854982175133, 9674.322797404115, 9728.173105285847, 9734.707958761248, 57597.0, 57772.0, 57900.710496447246, 57965.710171448874, 60554.697226513585, 70181.0, 78755.0, 82591.5870420644, 84958.57520712356, 85480.0, 11711.531538738354, 12066.276023438622, 12133.635990920286, 12200.81698774537, 12251.509939602316, 14308.0, 14685.0, 14763.630909227355, 14835.851641483447, 15873.365065397255, 13538.0, 13690.726185476435, 14139.634865425782, 14381.209033502839, 14728.410863565337, 11199.60801371948, 13432.462701491831, 13709.0, 13710.65723356924, 13829.340479142567, 13607.455701771818, 14123.0, 14552.708945821236, 14837.0, 14992.700145997238, 11949.236565536317, 12495.687607809878, 12498.875011249771, 12510.18683785551, 12943.5469758558, 12678.239305641691, 13052.804207936699, 13115.475380984653, 13189.9648740613, 13222.537211197561], "value": 7760.993597986137, "unit": "score"}], "name": "dromaeo_css", "value": 7344.346246452118, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 112.0, 112.0, 114.0, 112.0, 113.0, 112.0, 112.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 118.0, 118.0, 187.0, 119.0, 118.0, 143.0, 115.0, 154.0, 118.0], "value": 133.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 159.0, 161.0, 161.0, 161.0, 158.0, 161.0, 161.0, 161.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 118.0, 75.0, 75.0, 75.0, 75.0, 98.0, 73.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 139.0, 83.0, 85.0, 84.0, 120.0, 86.0, 85.0, 128.0], "value": 97.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 146.0, 148.0, 148.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 50.0, 49.0, 49.0, 50.0, 49.0, 48.0, 49.0, 50.0], "value": 49.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 60.0, 59.0, 59.0, 59.0, 61.0, 58.0, 58.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 76.0, 75.0, 74.0, 83.0, 74.0, 74.0, 74.0, 74.0, 74.0], "value": 76.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 120.0, 138.0, 120.0, 118.0, 133.0, 122.0, 126.0, 206.0, 135.0], "value": 134.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 159.0, 162.0, 164.0, 163.0, 165.0, 169.0, 162.0, 161.0, 158.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 65.0, 65.0, 64.0, 63.0, 64.0, 61.0, 62.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1488.9, "alertThreshold": 2.0}]} 05:37:17 INFO - Return code: 0 05:37:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:37:17 INFO - # TBPL SUCCESS # 05:37:17 INFO - Running post-action listener: _resource_record_post_action 05:37:17 INFO - [mozharness: 2016-08-07 12:37:17.767343Z] Finished run-tests step (success) 05:37:17 INFO - Running post-run listener: _resource_record_post_run 05:37:17 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 553721856; Read time: 0; Write time: 571476 05:37:17 INFO - TinderboxPrint: CPU usage
13.0% 05:37:17 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:37:17 INFO - TinderboxPrint: I/O write bytes / time
553,721,856 / 571,476 05:37:17 INFO - TinderboxPrint: CPU idle
8,288.7 (87.0%) 05:37:17 INFO - TinderboxPrint: CPU user
1,195.2 (12.5%) 05:37:17 INFO - TinderboxPrint: Swap in / out
0 / 0 05:37:17 INFO - install - Wall time: 18s; CPU: 15.0%; Read bytes: 0; Write bytes: 259284992; Read time: 0; Write time: 320448 05:37:17 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 294436864; Read time: 0; Write time: 251028 05:37:18 INFO - Running post-run listener: _upload_blobber_files 05:37:18 INFO - Blob upload gear active. 05:37:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:37:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:37:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:37:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:37:18 INFO - (blobuploader) - INFO - Open directory for files ... 05:37:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:37:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:37:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:19 INFO - (blobuploader) - INFO - Done attempting. 05:37:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:37:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:37:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:22 INFO - (blobuploader) - INFO - Done attempting. 05:37:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:37:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:37:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:23 INFO - (blobuploader) - INFO - Done attempting. 05:37:23 INFO - (blobuploader) - INFO - Iteration through files over. 05:37:23 INFO - Return code: 0 05:37:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:37:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:37:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18ca61f2fb20faddda3b0684009ea201ac7e354af470a5284481a06c19ab4012266018dc9c7d5117f81ab2bd88f65c4384b24040baeb38ef92ef42308a17ffce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79b4a7ad8e2c34a7b0e2afb5c1555431c621199d818067ccbffdf367a4df9b1e14b3ec1f19d85f2d22646702641f1478a2c0fdd541eceda3a91ed7187ad3a703", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c41e69a75ada72ebd9caab2e8a00421a34d29814357ff9520f3bb02bf245a199578820e5fa9a367f578ef10618b8e6b89df723305483000f75886aac7615d0de"} 05:37:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:37:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:37:23 INFO - Contents: 05:37:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18ca61f2fb20faddda3b0684009ea201ac7e354af470a5284481a06c19ab4012266018dc9c7d5117f81ab2bd88f65c4384b24040baeb38ef92ef42308a17ffce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79b4a7ad8e2c34a7b0e2afb5c1555431c621199d818067ccbffdf367a4df9b1e14b3ec1f19d85f2d22646702641f1478a2c0fdd541eceda3a91ed7187ad3a703", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c41e69a75ada72ebd9caab2e8a00421a34d29814357ff9520f3bb02bf245a199578820e5fa9a367f578ef10618b8e6b89df723305483000f75886aac7615d0de"} 05:37:23 INFO - Running post-run listener: copy_logs_to_upload_dir 05:37:23 INFO - Copying logs to upload dir... 05:37:23 INFO - mkdir: /builds/slave/test/build/upload/logs 05:37:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.199622 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-08-07 05:37:23.393455) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 05:37:23.396561) ========= 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=232498196343f89f466a4a9a000001c8-1470572163.998294-1223643947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18ca61f2fb20faddda3b0684009ea201ac7e354af470a5284481a06c19ab4012266018dc9c7d5117f81ab2bd88f65c4384b24040baeb38ef92ef42308a17ffce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79b4a7ad8e2c34a7b0e2afb5c1555431c621199d818067ccbffdf367a4df9b1e14b3ec1f19d85f2d22646702641f1478a2c0fdd541eceda3a91ed7187ad3a703", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c41e69a75ada72ebd9caab2e8a00421a34d29814357ff9520f3bb02bf245a199578820e5fa9a367f578ef10618b8e6b89df723305483000f75886aac7615d0de"} build_url:https://queue.taskcluster.net/v1/task/aaplzBjPQSiANfbcdQOeqg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011282 build_url: 'https://queue.taskcluster.net/v1/task/aaplzBjPQSiANfbcdQOeqg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18ca61f2fb20faddda3b0684009ea201ac7e354af470a5284481a06c19ab4012266018dc9c7d5117f81ab2bd88f65c4384b24040baeb38ef92ef42308a17ffce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79b4a7ad8e2c34a7b0e2afb5c1555431c621199d818067ccbffdf367a4df9b1e14b3ec1f19d85f2d22646702641f1478a2c0fdd541eceda3a91ed7187ad3a703", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c41e69a75ada72ebd9caab2e8a00421a34d29814357ff9520f3bb02bf245a199578820e5fa9a367f578ef10618b8e6b89df723305483000f75886aac7615d0de"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 05:37:23.421653) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 05:37:23.421981) ========= 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=232498196343f89f466a4a9a000001c8-1470572163.998294-1223643947 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004400 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 05:37:23.507005) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 05:37:23.507331) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 05:37:23.507616) ========= ========= Total master_lag: 0.16 =========