builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-056 starttime: 1470658963.89 results: success (0) buildid: 20160808004930 builduid: 51737524999c4a2d8a766a8b50205625 revision: f8fc21bb232095b7b4c995d259558212cb90a44b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 05:22:43.890537) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 05:22:43.890955) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 05:22:43.891221) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 05:22:44.190182) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:22:44.190559) ========= 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=52faae308a556c440401f8e5000001e8-1470658965.765580-1551500431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-08 05:22:47-- 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% 222M=0s 2016-08-08 05:22:47 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122710 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:22:44.326952) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:22:44.327282) ========= 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=52faae308a556c440401f8e5000001e8-1470658965.765580-1551500431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017602 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:22:44.378810) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:22:44.379121) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f8fc21bb232095b7b4c995d259558212cb90a44b --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 f8fc21bb232095b7b4c995d259558212cb90a44b --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=52faae308a556c440401f8e5000001e8-1470658965.765580-1551500431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-08 05:22:47,769 truncating revision to first 12 chars 2016-08-08 05:22:47,769 Setting DEBUG logging. 2016-08-08 05:22:47,769 attempt 1/10 2016-08-08 05:22:47,769 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f8fc21bb2320?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 05:22:48,105 unpacking tar archive at: fx-team-f8fc21bb2320/testing/mozharness/ program finished with exit code 0 elapsedTime=0.663314 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:22:45.059804) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 05:22:45.060127) ========= script_repo_revision: f8fc21bb232095b7b4c995d259558212cb90a44b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 05:22:45.060568) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 05:22:45.060853) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 05:22:45.070868) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-08 05:22:45.071136) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1470658965.765580-1551500431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:22:48 INFO - MultiFileLogger online at 20160808 05:22:48 in /builds/slave/test 05:22:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:22:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:22:48 INFO - {'append_to_log': False, 05:22:48 INFO - 'base_work_dir': '/builds/slave/test', 05:22:48 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:22:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:22:48 INFO - 'branch': 'Fx-Team-Non-PGO', 05:22:48 INFO - 'buildbot_json_path': 'buildprops.json', 05:22:48 INFO - 'config_files': ('talos/linux_config.py',), 05:22:48 INFO - 'default_actions': ('clobber', 05:22:48 INFO - 'read-buildbot-config', 05:22:48 INFO - 'download-and-extract', 05:22:48 INFO - 'populate-webroot', 05:22:48 INFO - 'create-virtualenv', 05:22:48 INFO - 'install', 05:22:48 INFO - 'run-tests'), 05:22:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:22:48 INFO - 'download_minidump_stackwalk': True, 05:22:48 INFO - 'download_symbols': 'ondemand', 05:22:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:22:48 INFO - 'tooltool.py': '/tools/tooltool.py', 05:22:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:22:48 INFO - '/tools/misc-python/virtualenv.py')}, 05:22:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:22:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:22:48 INFO - 'installer_path': 'installer.exe', 05:22:48 INFO - 'log_level': 'info', 05:22:48 INFO - 'log_name': 'talos', 05:22:48 INFO - 'log_to_console': True, 05:22:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:22:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:22:48 INFO - 'opt_config_files': (), 05:22:48 INFO - 'pip_index': False, 05:22:48 INFO - 'sps_profile': False, 05:22:48 INFO - 'sps_profile_interval': 0, 05:22:48 INFO - 'suite': 'dromaeojs', 05:22:48 INFO - 'system_bits': '32', 05:22:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:22:48 INFO - 'title': 'talos-linux64-ix-056', 05:22:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:22:48 INFO - 'use_talos_json': True, 05:22:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:22:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:22:48 INFO - 'work_dir': 'build'} 05:22:48 INFO - [mozharness: 2016-08-08 12:22:48.553513Z] Running clobber step. 05:22:48 INFO - Running pre-action listener: _resource_record_pre_action 05:22:48 INFO - Running main action method: clobber 05:22:48 INFO - rmtree: /builds/slave/test/build 05:22:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:22:49 INFO - Running post-action listener: _resource_record_post_action 05:22:49 INFO - [mozharness: 2016-08-08 12:22:49.027261Z] Finished clobber step (success) 05:22:49 INFO - [mozharness: 2016-08-08 12:22:49.027376Z] Running read-buildbot-config step. 05:22:49 INFO - Running pre-action listener: _resource_record_pre_action 05:22:49 INFO - Running main action method: read_buildbot_config 05:22:49 INFO - Using buildbot properties: 05:22:49 INFO - { 05:22:49 INFO - "project": "", 05:22:49 INFO - "product": "firefox", 05:22:49 INFO - "script_repo_revision": "production", 05:22:49 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:22:49 INFO - "repository": "", 05:22:49 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:22:49 INFO - "buildid": "20160808004930", 05:22:49 INFO - "pgo_build": "False", 05:22:49 INFO - "basedir": "/builds/slave/test", 05:22:49 INFO - "buildnumber": 3222, 05:22:49 INFO - "slavename": "talos-linux64-ix-056", 05:22:49 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:22:49 INFO - "platform": "ubuntu64_hw", 05:22:49 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 05:22:49 INFO - "branch": "fx-team", 05:22:49 INFO - "repo_path": "integration/fx-team", 05:22:49 INFO - "revision": "f8fc21bb232095b7b4c995d259558212cb90a44b", 05:22:49 INFO - "stage_platform": "linux64", 05:22:49 INFO - "builduid": "51737524999c4a2d8a766a8b50205625", 05:22:49 INFO - "slavebuilddir": "test" 05:22:49 INFO - } 05:22:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/coaYgGDhTrGlP-4o4SJdTA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:22:49 INFO - Running post-action listener: _resource_record_post_action 05:22:49 INFO - [mozharness: 2016-08-08 12:22:49.030355Z] Finished read-buildbot-config step (success) 05:22:49 INFO - [mozharness: 2016-08-08 12:22:49.030442Z] Running download-and-extract step. 05:22:49 INFO - Running pre-action listener: _resource_record_pre_action 05:22:49 INFO - Running main action method: download_and_extract 05:22:49 INFO - mkdir: /builds/slave/test/build/tests 05:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:49 INFO - trying https://queue.taskcluster.net/v1/task/coaYgGDhTrGlP-4o4SJdTA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:22:49 INFO - Downloading https://queue.taskcluster.net/v1/task/coaYgGDhTrGlP-4o4SJdTA/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:22:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/coaYgGDhTrGlP-4o4SJdTA/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:22:49 INFO - Downloaded 1361 bytes. 05:22:49 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:22:49 INFO - Using the following test package requirements: 05:22:49 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:22:49 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:49 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:22:49 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:49 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:22:49 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:49 INFO - u'jsshell-linux-x86_64.zip'], 05:22:49 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:49 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:22:49 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:22:49 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:49 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:22:49 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:49 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:22:49 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:49 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:22:49 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:22:49 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:22:49 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:49 INFO - trying https://queue.taskcluster.net/v1/task/coaYgGDhTrGlP-4o4SJdTA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:22:49 INFO - Downloading https://queue.taskcluster.net/v1/task/coaYgGDhTrGlP-4o4SJdTA/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:22:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/coaYgGDhTrGlP-4o4SJdTA/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:22:50 INFO - Downloaded 20254056 bytes. 05:22:50 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 05:22:54 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:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:22:54 INFO - trying https://queue.taskcluster.net/v1/task/coaYgGDhTrGlP-4o4SJdTA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:22:54 INFO - Downloading https://queue.taskcluster.net/v1/task/coaYgGDhTrGlP-4o4SJdTA/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:22:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/coaYgGDhTrGlP-4o4SJdTA/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:22:55 INFO - Downloaded 20254056 bytes. 05:22:55 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 05:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:00 INFO - trying https://queue.taskcluster.net/v1/task/coaYgGDhTrGlP-4o4SJdTA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:23:00 INFO - Downloading https://queue.taskcluster.net/v1/task/coaYgGDhTrGlP-4o4SJdTA/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:23:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/coaYgGDhTrGlP-4o4SJdTA/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:23:01 INFO - Downloaded 14413723 bytes. 05:23:01 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 05:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:01 INFO - trying https://queue.taskcluster.net/v1/task/coaYgGDhTrGlP-4o4SJdTA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:23:01 INFO - Downloading https://queue.taskcluster.net/v1/task/coaYgGDhTrGlP-4o4SJdTA/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:23:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/coaYgGDhTrGlP-4o4SJdTA/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:23:02 INFO - Downloaded 56138085 bytes. 05:23:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/coaYgGDhTrGlP-4o4SJdTA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:23:02 INFO - mkdir: /builds/slave/test/properties 05:23:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:23:02 INFO - Writing to file /builds/slave/test/properties/build_url 05:23:02 INFO - Contents: 05:23:02 INFO - build_url:https://queue.taskcluster.net/v1/task/coaYgGDhTrGlP-4o4SJdTA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:23:03 INFO - Running post-action listener: _resource_record_post_action 05:23:03 INFO - Running post-action listener: set_extra_try_arguments 05:23:03 INFO - [mozharness: 2016-08-08 12:23:03.351268Z] Finished download-and-extract step (success) 05:23:03 INFO - [mozharness: 2016-08-08 12:23:03.351492Z] Running populate-webroot step. 05:23:03 INFO - Running pre-action listener: _resource_record_pre_action 05:23:03 INFO - Running main action method: populate_webroot 05:23:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:23:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:23:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:23:03 INFO - '--tppagecycles', 05:23:03 INFO - '7'], 05:23:03 INFO - 'tests': ['tsvgm']}}, 05:23:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:23:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:23:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:23:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:23:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:23:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:23:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:03 INFO - 'talos_options': ['--disable-e10s'], 05:23:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:23:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:23:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:03 INFO - 'talos_options': ['--disable-e10s'], 05:23:03 INFO - 'tests': ['damp', 'tps']}, 05:23:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:03 INFO - 'tests': ['damp', 'tps']}, 05:23:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:23:03 INFO - 'tests': ['dromaeo_dom']}, 05:23:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:23:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:23:03 INFO - 'tests': ['basic_compositor_video']}, 05:23:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:23:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:23:03 INFO - 'tests': ['a11yr', 05:23:03 INFO - 'ts_paint', 05:23:03 INFO - 'tpaint', 05:23:03 INFO - 'sessionrestore', 05:23:03 INFO - 'sessionrestore_no_auto_restore', 05:23:03 INFO - 'tabpaint']}, 05:23:03 INFO - 'other-e10s': {'tests': ['a11yr', 05:23:03 INFO - 'ts_paint', 05:23:03 INFO - 'tpaint', 05:23:03 INFO - 'sessionrestore', 05:23:03 INFO - 'sessionrestore_no_auto_restore', 05:23:03 INFO - 'tabpaint']}, 05:23:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:23:03 INFO - 'ts_paint', 05:23:03 INFO - 'tpaint', 05:23:03 INFO - 'sessionrestore', 05:23:03 INFO - 'sessionrestore_no_auto_restore', 05:23:03 INFO - 'tabpaint']}, 05:23:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:23:03 INFO - 'ts_paint', 05:23:03 INFO - 'tpaint', 05:23:03 INFO - 'sessionrestore', 05:23:03 INFO - 'sessionrestore_no_auto_restore', 05:23:03 INFO - 'tabpaint']}, 05:23:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:23:03 INFO - 'tests': ['a11yr', 05:23:03 INFO - 'ts_paint', 05:23:03 INFO - 'tpaint', 05:23:03 INFO - 'sessionrestore', 05:23:03 INFO - 'sessionrestore_no_auto_restore', 05:23:03 INFO - 'tabpaint']}, 05:23:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:23:03 INFO - 'tests': ['a11yr', 05:23:03 INFO - 'ts_paint', 05:23:03 INFO - 'tpaint', 05:23:03 INFO - 'sessionrestore', 05:23:03 INFO - 'sessionrestore_no_auto_restore', 05:23:03 INFO - 'tabpaint']}, 05:23:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:23:03 INFO - 'tests': ['tsvgx', 05:23:03 INFO - 'tsvgr_opacity', 05:23:03 INFO - 'tart', 05:23:03 INFO - 'tscrollx', 05:23:03 INFO - 'cart']}, 05:23:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:23:03 INFO - 'tsvgr_opacity', 05:23:03 INFO - 'tart', 05:23:03 INFO - 'tscrollx', 05:23:03 INFO - 'cart']}, 05:23:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:03 INFO - 'talos_options': ['--disable-e10s'], 05:23:03 INFO - 'tests': ['tp5o']}, 05:23:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:03 INFO - 'tests': ['tp5o']}, 05:23:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:03 INFO - 'talos_options': ['--disable-e10s', 05:23:03 INFO - '--xperf_path', 05:23:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:23:03 INFO - 'tests': ['tp5n']}, 05:23:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:03 INFO - 'talos_options': ['--xperf_path', 05:23:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:23:03 INFO - 'tests': ['tp5n']}}, 05:23:03 INFO - 'talos.zip': {'path': '', 05:23:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:23:03 INFO - Running post-action listener: _resource_record_post_action 05:23:03 INFO - [mozharness: 2016-08-08 12:23:03.370411Z] Finished populate-webroot step (success) 05:23:03 INFO - [mozharness: 2016-08-08 12:23:03.370500Z] Running create-virtualenv step. 05:23:03 INFO - Running pre-action listener: _resource_record_pre_action 05:23:03 INFO - Running main action method: create_virtualenv 05:23:03 INFO - Creating virtualenv /builds/slave/test/build/venv 05:23:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:23:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:23:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:23:03 INFO - Using real prefix '/usr' 05:23:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:23:03 INFO - Installing distribute.............................................................................................................................................................................................done. 05:23:05 INFO - Installing pip.................done. 05:23:05 INFO - Return code: 0 05:23:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:23:05 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:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:05 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:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:05 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 0x17e8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa73b0>, '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 0x1aa82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa8740>, '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': '52faae308a556c440401f8e5000001e8-1470658965.765580-1551500431', '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:23:05 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:23:05 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:23:05 INFO - Using env: {'DISPLAY': ':0', 05:23:05 INFO - 'HOME': '/home/cltbld', 05:23:05 INFO - 'LANG': 'en_US.UTF-8', 05:23:05 INFO - 'LANGUAGE': 'en_US:en', 05:23:05 INFO - 'LOGNAME': 'cltbld', 05:23:05 INFO - 'MAIL': '/var/mail/cltbld', 05:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:05 INFO - 'MOZ_NO_REMOTE': '1', 05:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:05 INFO - 'NO_EM_RESTART': '1', 05:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:05 INFO - 'PWD': '/builds/slave/test', 05:23:05 INFO - 'SHELL': '/bin/bash', 05:23:05 INFO - 'SHLVL': '1', 05:23:05 INFO - 'TERM': 'linux', 05:23:05 INFO - 'TMOUT': '86400', 05:23:05 INFO - 'USER': 'cltbld', 05:23:05 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470658965.765580-1551500431', 05:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:05 INFO - '_': '/tools/buildbot/bin/python'} 05:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:23:06 INFO - Cleaning up... 05:23:06 INFO - Return code: 0 05:23:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa73b0>, '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 0x1aa82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa8740>, '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': '52faae308a556c440401f8e5000001e8-1470658965.765580-1551500431', '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:23:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:23:06 INFO - Using env: {'DISPLAY': ':0', 05:23:06 INFO - 'HOME': '/home/cltbld', 05:23:06 INFO - 'LANG': 'en_US.UTF-8', 05:23:06 INFO - 'LANGUAGE': 'en_US:en', 05:23:06 INFO - 'LOGNAME': 'cltbld', 05:23:06 INFO - 'MAIL': '/var/mail/cltbld', 05:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:06 INFO - 'MOZ_NO_REMOTE': '1', 05:23:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:06 INFO - 'NO_EM_RESTART': '1', 05:23:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:06 INFO - 'PWD': '/builds/slave/test', 05:23:06 INFO - 'SHELL': '/bin/bash', 05:23:06 INFO - 'SHLVL': '1', 05:23:06 INFO - 'TERM': 'linux', 05:23:06 INFO - 'TMOUT': '86400', 05:23:06 INFO - 'USER': 'cltbld', 05:23:06 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470658965.765580-1551500431', 05:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:06 INFO - '_': '/tools/buildbot/bin/python'} 05:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:06 INFO - Downloading/unpacking psutil>=3.1.1 05:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:23:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:23:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:23:08 INFO - Installing collected packages: psutil 05:23:08 INFO - Running setup.py install for psutil 05:23:08 INFO - building 'psutil._psutil_linux' extension 05:23:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:23:08 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:23:08 INFO - building 'psutil._psutil_posix' extension 05:23:08 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:23:08 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:23:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:23:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:23:08 INFO - Successfully installed psutil 05:23:08 INFO - Cleaning up... 05:23:08 INFO - Return code: 0 05:23:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:23:08 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:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:08 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:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:08 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 0x17e8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa73b0>, '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 0x1aa82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa8740>, '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': '52faae308a556c440401f8e5000001e8-1470658965.765580-1551500431', '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:23:08 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:23:08 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:23:08 INFO - Using env: {'DISPLAY': ':0', 05:23:08 INFO - 'HOME': '/home/cltbld', 05:23:08 INFO - 'LANG': 'en_US.UTF-8', 05:23:08 INFO - 'LANGUAGE': 'en_US:en', 05:23:08 INFO - 'LOGNAME': 'cltbld', 05:23:08 INFO - 'MAIL': '/var/mail/cltbld', 05:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:08 INFO - 'MOZ_NO_REMOTE': '1', 05:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:08 INFO - 'NO_EM_RESTART': '1', 05:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:08 INFO - 'PWD': '/builds/slave/test', 05:23:08 INFO - 'SHELL': '/bin/bash', 05:23:08 INFO - 'SHLVL': '1', 05:23:08 INFO - 'TERM': 'linux', 05:23:08 INFO - 'TMOUT': '86400', 05:23:08 INFO - 'USER': 'cltbld', 05:23:08 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470658965.765580-1551500431', 05:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:08 INFO - '_': '/tools/buildbot/bin/python'} 05:23:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:23: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:23: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:23: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:23: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:23: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:23: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:23:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:23:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:23:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:23:11 INFO - Installing collected packages: mozsystemmonitor 05:23:11 INFO - Running setup.py install for mozsystemmonitor 05:23:11 INFO - Successfully installed mozsystemmonitor 05:23:11 INFO - Cleaning up... 05:23:11 INFO - Return code: 0 05:23:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:23: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:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23: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:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa73b0>, '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 0x1aa82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa8740>, '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': '52faae308a556c440401f8e5000001e8-1470658965.765580-1551500431', '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:23:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:23:11 INFO - Using env: {'DISPLAY': ':0', 05:23:11 INFO - 'HOME': '/home/cltbld', 05:23:11 INFO - 'LANG': 'en_US.UTF-8', 05:23:11 INFO - 'LANGUAGE': 'en_US:en', 05:23:11 INFO - 'LOGNAME': 'cltbld', 05:23:11 INFO - 'MAIL': '/var/mail/cltbld', 05:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:11 INFO - 'MOZ_NO_REMOTE': '1', 05:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:11 INFO - 'NO_EM_RESTART': '1', 05:23:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:11 INFO - 'PWD': '/builds/slave/test', 05:23:11 INFO - 'SHELL': '/bin/bash', 05:23:11 INFO - 'SHLVL': '1', 05:23:11 INFO - 'TERM': 'linux', 05:23:11 INFO - 'TMOUT': '86400', 05:23:11 INFO - 'USER': 'cltbld', 05:23:11 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470658965.765580-1551500431', 05:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:11 INFO - '_': '/tools/buildbot/bin/python'} 05:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:11 INFO - Downloading/unpacking jsonschema==2.5.1 05:23: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:23: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:23: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:23: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:23: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:23: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:23:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:23:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:13 INFO - Downloading functools32-3.2.3-2.tar.gz 05:23:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:23:13 INFO - warning: no files found matching '*.txt' 05:23:13 INFO - no previously-included directories found matching 'build' 05:23:13 INFO - no previously-included directories found matching 'dist' 05:23:13 INFO - no previously-included directories found matching '.git*' 05:23:13 INFO - Installing collected packages: jsonschema, functools32 05:23:13 INFO - Running setup.py install for functools32 05:23:13 INFO - warning: no files found matching '*.txt' 05:23:13 INFO - no previously-included directories found matching 'build' 05:23:13 INFO - no previously-included directories found matching 'dist' 05:23:13 INFO - no previously-included directories found matching '.git*' 05:23:13 INFO - Successfully installed jsonschema functools32 05:23:13 INFO - Cleaning up... 05:23:13 INFO - Return code: 0 05:23:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:23:13 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:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:13 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:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:13 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 0x17e8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa73b0>, '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 0x1aa82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa8740>, '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': '52faae308a556c440401f8e5000001e8-1470658965.765580-1551500431', '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:23:13 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:23:13 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:23:13 INFO - Using env: {'DISPLAY': ':0', 05:23:13 INFO - 'HOME': '/home/cltbld', 05:23:13 INFO - 'LANG': 'en_US.UTF-8', 05:23:13 INFO - 'LANGUAGE': 'en_US:en', 05:23:13 INFO - 'LOGNAME': 'cltbld', 05:23:13 INFO - 'MAIL': '/var/mail/cltbld', 05:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:13 INFO - 'MOZ_NO_REMOTE': '1', 05:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:13 INFO - 'NO_EM_RESTART': '1', 05:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:13 INFO - 'PWD': '/builds/slave/test', 05:23:13 INFO - 'SHELL': '/bin/bash', 05:23:13 INFO - 'SHLVL': '1', 05:23:13 INFO - 'TERM': 'linux', 05:23:13 INFO - 'TMOUT': '86400', 05:23:13 INFO - 'USER': 'cltbld', 05:23:13 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470658965.765580-1551500431', 05:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:13 INFO - '_': '/tools/buildbot/bin/python'} 05:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:23:13 INFO - Cleaning up... 05:23:14 INFO - Return code: 0 05:23:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa73b0>, '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 0x1aa82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa8740>, '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': '52faae308a556c440401f8e5000001e8-1470658965.765580-1551500431', '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:23:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:23:14 INFO - Using env: {'DISPLAY': ':0', 05:23:14 INFO - 'HOME': '/home/cltbld', 05:23:14 INFO - 'LANG': 'en_US.UTF-8', 05:23:14 INFO - 'LANGUAGE': 'en_US:en', 05:23:14 INFO - 'LOGNAME': 'cltbld', 05:23:14 INFO - 'MAIL': '/var/mail/cltbld', 05:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:14 INFO - 'MOZ_NO_REMOTE': '1', 05:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:14 INFO - 'NO_EM_RESTART': '1', 05:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:14 INFO - 'PWD': '/builds/slave/test', 05:23:14 INFO - 'SHELL': '/bin/bash', 05:23:14 INFO - 'SHLVL': '1', 05:23:14 INFO - 'TERM': 'linux', 05:23:14 INFO - 'TMOUT': '86400', 05:23:14 INFO - 'USER': 'cltbld', 05:23:14 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470658965.765580-1551500431', 05:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:14 INFO - '_': '/tools/buildbot/bin/python'} 05:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:14 INFO - Downloading/unpacking blobuploader==1.2.4 05:23: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:23: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:23: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:23: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:23: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:23: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:23:16 INFO - Downloading blobuploader-1.2.4.tar.gz 05:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:23:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:23:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:16 INFO - Downloading docopt-0.6.1.tar.gz 05:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:23:16 INFO - Installing collected packages: blobuploader, requests, docopt 05:23:16 INFO - Running setup.py install for blobuploader 05:23:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:23:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:23:17 INFO - Running setup.py install for requests 05:23:17 INFO - Running setup.py install for docopt 05:23:17 INFO - Successfully installed blobuploader requests docopt 05:23:17 INFO - Cleaning up... 05:23:17 INFO - Return code: 0 05:23:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa73b0>, '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 0x1aa82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa8740>, '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': '52faae308a556c440401f8e5000001e8-1470658965.765580-1551500431', '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:23:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:23:17 INFO - Using env: {'DISPLAY': ':0', 05:23:17 INFO - 'HOME': '/home/cltbld', 05:23:17 INFO - 'LANG': 'en_US.UTF-8', 05:23:17 INFO - 'LANGUAGE': 'en_US:en', 05:23:17 INFO - 'LOGNAME': 'cltbld', 05:23:17 INFO - 'MAIL': '/var/mail/cltbld', 05:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:17 INFO - 'MOZ_NO_REMOTE': '1', 05:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:17 INFO - 'NO_EM_RESTART': '1', 05:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:17 INFO - 'PWD': '/builds/slave/test', 05:23:17 INFO - 'SHELL': '/bin/bash', 05:23:17 INFO - 'SHLVL': '1', 05:23:17 INFO - 'TERM': 'linux', 05:23:17 INFO - 'TMOUT': '86400', 05:23:17 INFO - 'USER': 'cltbld', 05:23:17 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470658965.765580-1551500431', 05:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:17 INFO - '_': '/tools/buildbot/bin/python'} 05:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:23:17 INFO - Running setup.py (path:/tmp/pip-DO4NY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:23:17 INFO - Running setup.py (path:/tmp/pip-osPqjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:23:17 INFO - Running setup.py (path:/tmp/pip-2j6Wdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:23:17 INFO - Running setup.py (path:/tmp/pip-N4nHDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:23:18 INFO - Running setup.py (path:/tmp/pip-PBb9Jq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:23:18 INFO - Running setup.py (path:/tmp/pip-g77iuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:23:18 INFO - Running setup.py (path:/tmp/pip-eszjl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:23:18 INFO - Running setup.py (path:/tmp/pip-YjbZSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:23:18 INFO - Running setup.py (path:/tmp/pip-4cJC2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:23:18 INFO - Running setup.py (path:/tmp/pip-3XFPrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:23:18 INFO - Running setup.py (path:/tmp/pip-aQwsA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:23:18 INFO - Running setup.py (path:/tmp/pip-QGI663-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:23:18 INFO - Running setup.py (path:/tmp/pip-hILhZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:23:18 INFO - Running setup.py (path:/tmp/pip-7FYgjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:18 INFO - Running setup.py (path:/tmp/pip-Eu4EJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:23:18 INFO - Running setup.py (path:/tmp/pip-ad0a3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:23:18 INFO - Running setup.py (path:/tmp/pip-_Odyh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:23:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:23:18 INFO - Running setup.py install for manifestparser 05:23:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:23:19 INFO - Running setup.py install for mozcrash 05:23:19 INFO - Running setup.py install for mozdebug 05:23:19 INFO - Running setup.py install for mozdevice 05:23:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:23:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:23:19 INFO - Running setup.py install for mozfile 05:23:19 INFO - Running setup.py install for mozhttpd 05:23:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:23:19 INFO - Running setup.py install for mozinfo 05:23:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:23:19 INFO - Running setup.py install for mozInstall 05:23:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:23:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:23:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:23:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:23:19 INFO - Running setup.py install for mozleak 05:23:19 INFO - Running setup.py install for mozlog 05:23:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:23:20 INFO - Running setup.py install for moznetwork 05:23:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:23:20 INFO - Running setup.py install for mozprocess 05:23:20 INFO - Running setup.py install for mozprofile 05:23:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:23:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:23:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:23:20 INFO - Running setup.py install for mozrunner 05:23:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:23:20 INFO - Running setup.py install for mozscreenshot 05:23:20 INFO - Running setup.py install for moztest 05:23:20 INFO - Running setup.py install for mozversion 05:23:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:23:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:23:20 INFO - Cleaning up... 05:23:20 INFO - Return code: 0 05:23:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:20 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 0x17e8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa73b0>, '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 0x1aa82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa8740>, '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': '52faae308a556c440401f8e5000001e8-1470658965.765580-1551500431', '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:23:20 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:23:20 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:23:20 INFO - Using env: {'DISPLAY': ':0', 05:23:20 INFO - 'HOME': '/home/cltbld', 05:23:20 INFO - 'LANG': 'en_US.UTF-8', 05:23:20 INFO - 'LANGUAGE': 'en_US:en', 05:23:20 INFO - 'LOGNAME': 'cltbld', 05:23:20 INFO - 'MAIL': '/var/mail/cltbld', 05:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:20 INFO - 'MOZ_NO_REMOTE': '1', 05:23:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:20 INFO - 'NO_EM_RESTART': '1', 05:23:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:20 INFO - 'PWD': '/builds/slave/test', 05:23:20 INFO - 'SHELL': '/bin/bash', 05:23:20 INFO - 'SHLVL': '1', 05:23:20 INFO - 'TERM': 'linux', 05:23:20 INFO - 'TMOUT': '86400', 05:23:20 INFO - 'USER': 'cltbld', 05:23:20 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470658965.765580-1551500431', 05:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:20 INFO - '_': '/tools/buildbot/bin/python'} 05:23:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:23:21 INFO - Running setup.py (path:/tmp/pip-5jWDyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:23:21 INFO - Running setup.py (path:/tmp/pip-5fUaZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:23:21 INFO - Running setup.py (path:/tmp/pip-6VatFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:23:21 INFO - Running setup.py (path:/tmp/pip-R4ap6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:23:21 INFO - Running setup.py (path:/tmp/pip-cvqz5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:23:21 INFO - Running setup.py (path:/tmp/pip-AMbVdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:23:21 INFO - Running setup.py (path:/tmp/pip-T4L6Ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:23:21 INFO - Running setup.py (path:/tmp/pip-DDZZfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:23:21 INFO - Running setup.py (path:/tmp/pip-UafGeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:23:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:23:21 INFO - Running setup.py (path:/tmp/pip-YXK0fJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:23:21 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:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:23:21 INFO - Running setup.py (path:/tmp/pip-bj15Kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:23:21 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:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:23:21 INFO - Running setup.py (path:/tmp/pip-cgyOxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:23:21 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:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:23:21 INFO - Running setup.py (path:/tmp/pip-rVLvX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:23:21 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:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:23:21 INFO - Running setup.py (path:/tmp/pip-QWQpDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:23:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:22 INFO - Running setup.py (path:/tmp/pip-z5A8VB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:23:22 INFO - Running setup.py (path:/tmp/pip-EogH1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:23:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:23:22 INFO - Running setup.py (path:/tmp/pip-EONuPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:23:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:23:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:23:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:23:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:23:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:23:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:23:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:24 INFO - Downloading blessings-1.6.tar.gz 05:23:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:23:24 INFO - Installing collected packages: blessings 05:23:24 INFO - Running setup.py install for blessings 05:23:24 INFO - Successfully installed blessings 05:23:24 INFO - Cleaning up... 05:23:24 INFO - Return code: 0 05:23:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:23:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:23:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:23:24 INFO - Reading from file tmpfile_stdout 05:23:24 INFO - Current package versions: 05:23:24 INFO - argparse == 1.2.1 05:23:24 INFO - blessings == 1.6 05:23:24 INFO - blobuploader == 1.2.4 05:23:24 INFO - docopt == 0.6.1 05:23:24 INFO - functools32 == 3.2.3-2 05:23:24 INFO - jsonschema == 2.5.1 05:23:24 INFO - manifestparser == 1.1 05:23:24 INFO - mozInstall == 1.12 05:23:24 INFO - mozcrash == 0.17 05:23:24 INFO - mozdebug == 0.1 05:23:24 INFO - mozdevice == 0.48 05:23:24 INFO - mozfile == 1.2 05:23:24 INFO - mozhttpd == 0.7 05:23:24 INFO - mozinfo == 0.9 05:23:24 INFO - mozleak == 0.1 05:23:24 INFO - mozlog == 3.3 05:23:24 INFO - moznetwork == 0.27 05:23:24 INFO - mozprocess == 0.23 05:23:24 INFO - mozprofile == 0.28 05:23:24 INFO - mozrunner == 6.12 05:23:24 INFO - mozscreenshot == 0.1 05:23:24 INFO - mozsystemmonitor == 0.3 05:23:24 INFO - moztest == 0.7 05:23:24 INFO - mozversion == 1.4 05:23:24 INFO - psutil == 3.1.1 05:23:24 INFO - requests == 1.2.3 05:23:24 INFO - wsgiref == 0.1.2 05:23:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa73b0>, '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 0x1aa82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa8740>, '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': '52faae308a556c440401f8e5000001e8-1470658965.765580-1551500431', '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:23:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:23:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:23:24 INFO - Using env: {'DISPLAY': ':0', 05:23:24 INFO - 'HOME': '/home/cltbld', 05:23:24 INFO - 'LANG': 'en_US.UTF-8', 05:23:24 INFO - 'LANGUAGE': 'en_US:en', 05:23:24 INFO - 'LOGNAME': 'cltbld', 05:23:24 INFO - 'MAIL': '/var/mail/cltbld', 05:23:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:24 INFO - 'MOZ_NO_REMOTE': '1', 05:23:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:24 INFO - 'NO_EM_RESTART': '1', 05:23:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:24 INFO - 'PWD': '/builds/slave/test', 05:23:24 INFO - 'SHELL': '/bin/bash', 05:23:24 INFO - 'SHLVL': '1', 05:23:24 INFO - 'TERM': 'linux', 05:23:24 INFO - 'TMOUT': '86400', 05:23:24 INFO - 'USER': 'cltbld', 05:23:24 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470658965.765580-1551500431', 05:23:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:24 INFO - '_': '/tools/buildbot/bin/python'} 05:23:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:24 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:23:24 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:23:24 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:23:24 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:23:24 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:23:24 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:23:24 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:23:24 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:23:24 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:23:24 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:23:24 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:23:24 INFO - Cleaning up... 05:23:24 INFO - Return code: 0 05:23:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:24 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 0x17e8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x194b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa73b0>, '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 0x1aa82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa8740>, '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': '52faae308a556c440401f8e5000001e8-1470658965.765580-1551500431', '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:23:24 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:23:24 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:23:24 INFO - Using env: {'DISPLAY': ':0', 05:23:24 INFO - 'HOME': '/home/cltbld', 05:23:24 INFO - 'LANG': 'en_US.UTF-8', 05:23:24 INFO - 'LANGUAGE': 'en_US:en', 05:23:24 INFO - 'LOGNAME': 'cltbld', 05:23:24 INFO - 'MAIL': '/var/mail/cltbld', 05:23:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:24 INFO - 'MOZ_NO_REMOTE': '1', 05:23:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:24 INFO - 'NO_EM_RESTART': '1', 05:23:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:24 INFO - 'PWD': '/builds/slave/test', 05:23:24 INFO - 'SHELL': '/bin/bash', 05:23:24 INFO - 'SHLVL': '1', 05:23:24 INFO - 'TERM': 'linux', 05:23:24 INFO - 'TMOUT': '86400', 05:23:24 INFO - 'USER': 'cltbld', 05:23:24 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470658965.765580-1551500431', 05:23:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:24 INFO - '_': '/tools/buildbot/bin/python'} 05:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:23:25 INFO - Cleaning up... 05:23:25 INFO - Return code: 0 05:23:25 INFO - Running post-action listener: _resource_record_post_action 05:23:25 INFO - Running post-action listener: _start_resource_monitoring 05:23:25 INFO - Starting resource monitoring. 05:23:25 INFO - [mozharness: 2016-08-08 12:23:25.107358Z] Finished create-virtualenv step (success) 05:23:25 INFO - [mozharness: 2016-08-08 12:23:25.107810Z] Running install step. 05:23:25 INFO - Running pre-action listener: _resource_record_pre_action 05:23:25 INFO - Running main action method: install 05:23:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:23:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:23:25 INFO - Reading from file tmpfile_stdout 05:23:25 INFO - Detecting whether we're running mozinstall >=1.0... 05:23:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:23:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:23:25 INFO - Reading from file tmpfile_stdout 05:23:25 INFO - Output received: 05:23:25 INFO - Usage: mozinstall [options] installer 05:23:25 INFO - Options: 05:23:25 INFO - -h, --help show this help message and exit 05:23:25 INFO - -d DEST, --destination=DEST 05:23:25 INFO - Directory to install application into. [default: 05:23:25 INFO - "/builds/slave/test"] 05:23:25 INFO - --app=APP Application being installed. [default: firefox] 05:23:25 INFO - mkdir: /builds/slave/test/build/application 05:23:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:23:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:23:41 INFO - Reading from file tmpfile_stdout 05:23:41 INFO - Output received: 05:23:41 INFO - /builds/slave/test/build/application/firefox/firefox 05:23:41 INFO - Running post-action listener: _resource_record_post_action 05:23:41 INFO - [mozharness: 2016-08-08 12:23:41.598367Z] Finished install step (success) 05:23:41 INFO - [mozharness: 2016-08-08 12:23:41.598614Z] Running run-tests step. 05:23:41 INFO - Running pre-action listener: _resource_record_pre_action 05:23:41 INFO - Running main action method: run_tests 05:23:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:23:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:23:41 INFO - Python 2.7.3 05:23:41 INFO - Return code: 0 05:23:41 INFO - grabbing minidump binary from tooltool 05:23: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:23: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 0x1aa73b0>, '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 0x1aa82b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa8740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:23: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:23: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:23: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:23:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:23:41 INFO - Return code: 0 05:23:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:23:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:23:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:23:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:23:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:23:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/coaYgGDhTrGlP-4o4SJdTA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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:23:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/coaYgGDhTrGlP-4o4SJdTA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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:23:41 INFO - Using env: {'DISPLAY': ':0', 05:23:41 INFO - 'HOME': '/home/cltbld', 05:23:41 INFO - 'LANG': 'en_US.UTF-8', 05:23:41 INFO - 'LANGUAGE': 'en_US:en', 05:23:41 INFO - 'LOGNAME': 'cltbld', 05:23:41 INFO - 'MAIL': '/var/mail/cltbld', 05:23:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:23:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:41 INFO - 'MOZ_NO_REMOTE': '1', 05:23:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:23:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:41 INFO - 'NO_EM_RESTART': '1', 05:23:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:41 INFO - 'PWD': '/builds/slave/test', 05:23:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:23:41 INFO - 'SHELL': '/bin/bash', 05:23:41 INFO - 'SHLVL': '1', 05:23:41 INFO - 'TERM': 'linux', 05:23:41 INFO - 'TMOUT': '86400', 05:23:41 INFO - 'USER': 'cltbld', 05:23:41 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1470658965.765580-1551500431', 05:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:41 INFO - '_': '/tools/buildbot/bin/python'} 05:23:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/coaYgGDhTrGlP-4o4SJdTA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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:23:41 INFO - mozversion application_buildid: 20160808004930 05:23:41 INFO - mozversion application_changeset: f8fc21bb232095b7b4c995d259558212cb90a44b 05:23:41 INFO - mozversion application_display_name: Nightly 05:23:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:23:41 INFO - mozversion application_name: Firefox 05:23:41 INFO - mozversion application_remotingname: firefox 05:23:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:23:41 INFO - mozversion application_vendor: Mozilla 05:23:41 INFO - mozversion application_version: 51.0a1 05:23:41 INFO - mozversion platform_buildid: 20160808004930 05:23:41 INFO - mozversion platform_changeset: f8fc21bb232095b7b4c995d259558212cb90a44b 05:23:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:23:41 INFO - mozversion platform_version: 51.0a1 05:23:41 INFO - using testdate: 1470659021 05:23:41 INFO - actual date: 1470659021 05:23:41 INFO - starting webserver on 'localhost:34306' 05:23:41 INFO - SUITE-START | Running 2 tests 05:23:41 INFO - TEST-START | dromaeo_css 05:23:41 INFO - operating with platform_type : linux_ 05:23:41 INFO - Initialising browser for dromaeo_css test... 05:23:41 INFO - TEST-INFO | started process 24223 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEtkz7M/profile http://localhost:34306/getInfo.html) 05:23:46 INFO - PROCESS | 24223 | __metrics Screen width/height:1600/1200 05:23:46 INFO - PROCESS | 24223 | colorDepth:24 05:23:46 INFO - PROCESS | 24223 | Browser inner width/height: 1024/697 05:23:46 INFO - PROCESS | 24223 | __metrics 05:23:47 INFO - PROCESS | 24223 | 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:23:47 INFO - PROCESS | 24223 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:23:48 INFO - TEST-INFO | 24223: exit 0 05:23:48 INFO - Browser initialized. 05:23:48 INFO - Running cycle 1/1 for dromaeo_css test... 05:23:48 INFO - TEST-INFO | started process 24302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEtkz7M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:24:00 INFO - PROCESS | 24302 | RSS: Main: 157949952 05:24:00 INFO - PROCESS | 24302 | 05:24:51 INFO - PROCESS | 24302 | 1470659091593 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:27:04 INFO - PROCESS | 24302 | Cycle 1(1): loaded http://localhost:34306/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34306/tests/dromaeo/cssquery-ext.html) 05:27:05 INFO - PROCESS | 24302 | RSS: Main: 251654144 05:27:05 INFO - PROCESS | 24302 | 05:30:08 INFO - PROCESS | 24302 | Cycle 1(1): loaded http://localhost:34306/tests/dromaeo/cssquery-ext.html (next: http://localhost:34306/tests/dromaeo/cssquery-jquery.html) 05:30:09 INFO - PROCESS | 24302 | RSS: Main: 249827328 05:30:09 INFO - PROCESS | 24302 | 05:33:11 INFO - PROCESS | 24302 | Cycle 1(1): loaded http://localhost:34306/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34306/tests/dromaeo/cssquery-mootools.html) 05:33:12 INFO - PROCESS | 24302 | RSS: Main: 189349888 05:33:12 INFO - PROCESS | 24302 | 05:36:14 INFO - PROCESS | 24302 | Cycle 1(1): loaded http://localhost:34306/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34306/tests/dromaeo/cssquery-prototype.html) 05:36:14 INFO - PROCESS | 24302 | RSS: Main: 190259200 05:36:14 INFO - PROCESS | 24302 | 05:39:17 INFO - PROCESS | 24302 | Cycle 1(1): loaded http://localhost:34306/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34306/tests/dromaeo/cssquery-yui.html) 05:39:18 INFO - PROCESS | 24302 | RSS: Main: 189313024 05:39:18 INFO - PROCESS | 24302 | 05:42:21 INFO - PROCESS | 24302 | Cycle 1(1): loaded http://localhost:34306/tests/dromaeo/cssquery-yui.html (next: http://localhost:34306/tests/dromaeo/cssquery-dojo.html) 05:42:21 INFO - PROCESS | 24302 | RSS: Main: 282742784 05:42:21 INFO - PROCESS | 24302 | 05:42:21 INFO - PROCESS | 24302 | __start_tp_report 05:42:21 INFO - PROCESS | 24302 | _x_x_mozilla_page_load 05:42:21 INFO - PROCESS | 24302 | _x_x_mozilla_page_load_details 05:42:21 INFO - PROCESS | 24302 | |i|pagename|runs| 05:42:21 INFO - PROCESS | 24302 | |0;dojo.html;2565.153499345216;2570.8457492550438;2599.831010984286;2604.713481517034;2607.17873869731;4545.4545454545505;4646.210144275473;4709.764511774406;4728.432588089429;4759.762011899405;4687.789049492772;4725.740084295371;4731.929021064687;4740.9762951185285;4821.566059054684;4336.21948049351;4365.039691267924;4393.231184542708;4400.867973960786;4536.092781443708;4486.304622783474;4488.685791994561;4491.550844915499;4501.437320334958;4513.819447222108;4213.936790948138;4216.430781844442;4245.066085461193;4338.913221735579;4346.369776382407;4293.270144075484;4295.226859165349;4295.613394794484;4300.161468513641;4316.2446571849805;4276.72201306914;4280.9143817123795;4302.333138363528;4359.782010899442;4379.364992076163;4671.159191345557;4721.173794585968;4729.834455794065;4736.573708366229;4797.7601119943865;5044.268581055763;5047.167217409123;5083.822066227701;5097.7960881564695;5117.8464646060675;4843.39457567804;5072.822451214227;5092;5097.388313402378;5118.846434606968;4839.782209800567;4840.177169881129;4840.782164802592;4841.830535931225;4843.152448321565;5232.764525596357;5320.17537281722;5326.36083669962;5326.707031113326;5338.412774594792;4845.6608037437745;4969.801207951714;5009.198528235464;5070.112730272188;5074.416442109131;5148.536631703165;5170.819021334235;5209.0363282792805;5230.320058392384;5231.895362092737;5124;5124.820631277962;5128.12821820284;5131;5132.050570644443;4844.588210002119;4995.875103122378;5027.748612569357;5057.494250574913;5151.974240128776;4391.473023237232;4400.9119817604105;4408.6913916026215;4436.578525040116;4460.397846290709;3818.3699689550913;3843.807809609564;3847.1920896611464;3867.0332416895776;3881.126746482019;4167.541570427251;4213.262679031219;4241.660667146621;4342.392065110887;4353.804078816461;5144.048351054992;5171.663841850268;5183.092958732207;5211.140161873324;5229.529342359206;4352.064306174188;4353.281708518059;4372.322290045048;4386.978065109654;4419.204543182193;4455.22033644111;4594.540545945379;4649.139909116824;4650.069986002745;4652.464966528825;4761.0001899601475;4774.522547745198;4779.569838714532;4822.903541929212;4823.9517604824905;5171.3018742469285;5174.172132458789;5174.818881339135;5176.50823171798;5224.373075230845;4499.505054443943;4595.609373203181;4603.58567728906;4759.333693282874;4824.469308376146;4954.900901981868;4956.578690811321;4963.181075122564;4965.503449655005;4969.378827646544;5035.5719763819025;5068.037072956126;5089.982003599221;5092.516210959953;5145.768440420115;4841.491643377535;4879.316895634685;4888.804447822047;4923.926141107814;4924.606031517398;4749.620030397629;4918.581920536794;4924.212126059813;4929.950700492949;4987.177115776001;4682.2508398656055;4794.808207671654;4847.103285892122;4847.442544107473;4918.43438004634;4991.47589503097;4996.850094497171;4998.300237966615;5021.171506701499;5040.773165207648;4816.34979277793;4828.517148285144;4834;4881.389826271716;4919.557239848431 05:42:21 INFO - PROCESS | 24302 | |1;ext.html;526.5182358142299;569.7464628240432;570.657605436738;591.4115455122154;592.5999950033727;29694.851525742393;32321.191970200758;39030.41454378183;40471.190576188535;40586.39120413196;41011;41098.79450602743;41101.38347924784;41482;41522.792386038105;7548.4338674599485;7695.0765908090825;7700.1914798946145;7701.653425595834;7711.922880771177;7466.328030477256;9798;10035.69892903214;10065.949670251639;10395.584176632963;10131.088202061814;10151.492425378701;10202.387856728583;10205.132563732055;10226.744331391737;9977.551010204557;10028.89971100287;10043.799124017478;10045.497725113788;10057.949710251474;9789.070038346346;9983.90016099837;10006.349587276804;10008.64969726056;10009.249306302056;37956;38124.42813357802;38313.80843095794;38383.616163838284;38417.61582384168;2876.8993085242128;2948.174511136885;3071.8924837630575;3316.651751566099;3437.1063523483826;30377.848110759525;30872.8456357719;30920.226994325098;31250;31446.685533144835;3214.4856822908455;3309.3381323735107;3359.8992030238887;3368.6968172864313;3418.3163367326633;203975;258903;259166;260441;260663.9999999981;56488;57119.71440142856;57200.42799572034;57244;57319.42680573224;32332.676673232967;32996.1750956228;33277;34980.82509587436;35068.82465587656;13836.23900685472;13931.721365572834;13946;13960.650983725489;13969.65075873091;9479.715608531755;10352.792944141074;10783.730406739895;10893.727656808485;10946.671599852018;17784.199711013036;18224.544386390182;18405.355812546495;18479.353222637143;18727.250909963448;6822;7064.788056358318;7080.150381954199;7082.822929426702;7083.15002199729;811.3022800391658;853.3088198559187;863.9934476335125;873.6025108575583;1032.210359075308;28749.56875646867;28917.421651566852;29292.414151716846;29754.702452975627;29781.702182977893;931.5249222896372;959.203860795538;1028.28534168752;1036.3988886445993;1059.5708737961138;14748.852511474748;15392.615184620474;15496.845031549765;15853.128077955593;15919.522414327588;397665;681859;689246.1075389181;694706;695777;51805.7409712949;52664;52717.736411317695;52784.73607632014;52819.47180528222;1063.1494804156798;1137.516555463908;1198.4726720243066;1220.0971281251987;1223.6023292429818;26258;29026.564601531416;30561;30856.537151943186;31156.532652009784;44783.55216447924;45731;46284.7685761569;46423.53576464192;46435.53564464312;350929.4721158369;356757;356966;357080;357488;33867;35182.64817351794;40328.3950740745;40562.1887562253;41068.383974241005;42583.57416425796;43075.56924430715;43199;43407;43481.56518434902;36835.63164368322;37139.07152321214;37326.25347493089;37766.43350349692;38160.427593586675;37403.37569124009;38032.61967380291;39115.41326880156;39171.608283916794;39788.005299867735;37125.44311835379;37965.430518542795;38124.61875381211;39943.20113597654;40535.797321013204;32407.837960810044;34008;34641.30717385688;34734;35016.299674006885;25846.612300815126;26567.60148597734;26611.60082598724;26705.732942670325;26858.194254172406 05:42:21 INFO - PROCESS | 24302 | |2;jquery.html;357.39243286413097;359.48952487467795;363.150228465391;381.0853950518755;384.22770231834005;15636;16991.23539440725;17698;17783.11084445776;17878.37425690101;16145.757813632776;17171.399001034966;17446.30214791407;17617;17633.29466821329;4958.752062396884;5186.974065129688;5187.559057480119;5199;5202.661826981253;3808.5620153682403;3998.6801055915457;5188.04021256067;5736.913946290809;5978.611390259619;6057.697115144248;6059.212302400704;6070.150178974947;6074.17998570194;6076.969615151918;5850.736716847752;6015.308239552442;6024.759009639609;6035.698215089228;6036.7283472243635;4556.316552517116;5323.520883120537;5327.30745003151;5342.332208473941;5344.118220493614;11287.322760634388;11957.820632690517;11994.940025299818;12018.038556915426;12077;1831.6611426886068;1894.9052547372576;2169.425102347879;2266.4900397410615;2299.4596269876565;8466.915330846736;8532.8720069199;8664;9013.459192448408;9311.627534898596;1660.103544086192;1681.3442757324653;1694.2291257477941;1706.7183914654192;1736.3228340947041;68924.6553767233;70159;70473;72863;73038;9776.022397760167;10147;10158.511164764679;10391.064804167661;10429.68710938673;13720.382582783599;13755.243461609707;13782.173069615654;13791.586252412444;13806.93096534531;6927.757528486479;7179.138503379523;7243.348098671145;7294.890576641248;7354.852902941911;6828.2488926218075;6832.555883867532;7027.61348125858;7084.185318688416;7103.147622285359;4145.626893579592;4298.8280468780895;4301.440812694393;4403.295472724349;4428.977855110704;1569.3800948625458;1794.6500432415553;1845.4094689699436;2824.68928417878;2993.258426966292;776.4370831147486;844.8056946902124;864.9437786543855;867.8154319354036;879.1077056787366;15695.921520392325;16591.08936081049;17323.740143897852;17364.95810251389;17776.55558611045;821.326512259953;837.7528629054443;841.4320333774677;879.4327658660128;890.8530092534659;9515.57179926905;9663.323567350359;9747.074027967332;9920.702378928643;10029.448380339152;400695;407123;415466;416428;420443;77180;77359.61320193364;77790.60873738263;78800;80353.59823200846;803.1005274093053;860.8708693695995;871.6295574380736;878.3719640457103;884.1344762551013;15206.46777362787;16010.439634612732;16370.345186192419;16445.67108657844;16682.165891705125;35282.470762938065;35545.82227088848;35790;36195.45706814347;37548.24903501969;45822.31266531072;49982.50017499778;50020.24969625531;50434.243486347;50971.490285096676;6662;6687.063811066552;6767.289434609295;6783.219929708147;6904.3095690432565;8628.654853806029;11534.365609891202;11915.2255103418;12061.577844775742;12090.214136081127;9240.214581760625;9344.906550934676;9561.378510396802;9748.756281093029;10284.434356110485;9678.75803104928;9733.9026609733;10392.636257730943;10687.358758474516;10738.516766745359;9251.167394934488;9721.805563888824;9915.900840991499;10581.523831427758;10730.89269107299;7513.060867391576;7519.210482899217;7602.011738474184;7636.198199189005;7654.311111999724;8427.62075706607;9983.351082179635;10119.190464762654;10331.121854642439;10406.479676016017 05:42:21 INFO - PROCESS | 24302 | |3;mootools.html;1359.1912811876937;1410.6261840612237;1455.5560554031024;1667.6748034133334;1682.091670497931;7242.927570724291;7843.725469608565;7861.331786798115;7876.015498062749;7886.6845326186885;6227.532935029868;7167.89248161278;7422.925770742291;7470.850582988337;7745.612719364038;2121.915123395066;2175.41263858758;2177.3794468576457;2180.9127634894585;2189.890505474728;2117.2166298469588;2153.2786516516985;2155.461134716321;2156.5579056293423;2170.2295685031822;2117.3436234767196;2119.79861913118;2129.286688959193;2129.595376878396;2169.7287839020123;2092.278164033406;2094.7695753467106;2095.308548179097;2104.705341252226;2107.12554289971;2006.2476571285767;2070.5030792609814;2070.927517536879;2082.2816128435666;2086.050846864673;7535.058117735283;7558.73544425948;7561.659725312375;7645.2736989986415;7649.311561959395;4275.764832934187;4390.604845563915;4393.362962370438;4396.60430561251;4396.626286765629;2688.8386696798257;2728.4133911208987;2770.0581802187153;2788.707185745508;2798.188525327673;873.895132584094;903.7424334064825;920.1120918313792;923.9214666753334;936.6862101196108;10202.846957295647;10432.426216558086;10472.26694131411;10483.161347092291;10518.474076296154;3830.367989281737;3861.4787003754695;4044.130511939947;4047.7166598337835;4143.254214241466;9001.144891235323;9005.234555062892;9005.369624126248;9015.14356136166;9031.63873445055;4271.6369108625495;4327.56724327571;4337.609615134653;4338.609525142752;4481;3344.381289461409;3831.482749828793;3901.1612503311926;3903.512060992376;3967.722259441869;3641.7632853864416;3666.2667466506805;3763.2097259575794;3766.3408903441787;3771.453139294787;1105.4307031878589;1153.3887039868882;1162.598903378333;1163.243891470534;1167.486306025363;743.0674503498076;750.1373420566392;765.7396485195061;787.1931270447723;807.0072819023216;4792.880177995508;4893.657443978958;4956.256561515802;4959.727215003138;5110.97444512775;892.6652505310509;911.480456140007;912.4707669551777;913.5295322908707;917.6925729880564;3229.9031029069165;3274.8198849063056;3277.868885244611;3339.716124129476;3417.0773891049776;9391.812163756687;9656.71029869105;9753.756156096155;9760.267979901535;9764.218862490983;9646.083622055894;9736.41581505112;9757.073078057572;9761.267904907161;9772.413655180711;7224.4581656375985;7364.77905662831;7367.373773229336;7391.926080739231;7451.068616422839;4794.568488836021;4949.307097006494;4985.177445721561;4986.626003049858;5186.559142472932;8659.177378149066;8739.956300218459;8744.475331479876;8775.517346546001;8866.911330886609;8591.6992905248;8817.603207855791;9009.189172974464;9073.13805188506;9085.727428177166;6155.969220153871;6216.409441103088;6285.937140628535;6306.873862522632;6372.936270637234;6763.053172555945;6819.215790184192;6823.93176068233;6828.9658551706925;6836.897446538405;6100.816975490742;6184.257889053342;6336.7465301389275;6384.489240860813;6443.967780161257;6086.786962456293;6086.908696369646;6146.661933593696;6170.136180934763;6207.286162091417;5634.661920284796;5699.800506982236;5701.657900525982;5710;5717.313922329347;4019.2363450944226;4095.7542547447247;4137.91724165509;4161.8335266589;4268.231718290737;4072.859599312197;4092.07928216149;4098.323776576832;4135.855245066408;4176.0395109124465 05:42:21 INFO - PROCESS | 24302 | |4;prototype.html;288.4461833280102;300.72033009301356;301.7510553793121;303.95136778115506;306.2069240666673;4775.235962246042;4800.231962885939;4819.8795030124265;4852.150873597119;4896.706197628145;4774.49867763885;4826.348442960208;4832.903341933159;4833.492483289257;4837.274408838676;3604.8377822997963;3734.514513113305;3745.1947831216285;3749.737518373715;3758.530183727034;3624.3476174288617;3770.7171962102816;3773.151041015777;3813.8283777229954;3832.865849695261;3726.5341832270965;3738.327101121797;3744.906377340561;3757.1170774867883;3765.698744100479;3531.894043178683;3719.5350581177354;3721.106934335767;3733.8343760618777;3771.41543060826;3275.918102047444;3284.3759685659647;3284.770066095374;3294.8187849668257;3298.835058247078;4639.5360463953675;4647.955589089152;4665.626749860003;4676.976615116937;4691.62467002639;4278.4010238566625;4295.398644189816;4300.6344460720875;4307.117041006586;4312.525622181557;4909.94436196216;4930.408350997867;4997.575206107449;5008.824691135829;5035.6978581284875;3563.8574457021687;3567.982160089183;3575.0168703606714;3575.2134530403528;3576.088097535138;5228.137357336035;5241.42344342122;5261.684298942076;5276.498732620395;5305.230741542493;3552.662497062775;3606.8376923038527;3640.635936406391;3684.8341824617955;3693.8153092345815;3663.377225871608;3664.230511592542;3669.3945498992366;3670.944935825965;3698.5561732591723;4193.161367726467;4209.726367786084;4213.335732385752;4232.703710740218;4251.29853574163;4866.367372241586;4947.82682606107;4984.526469985346;5028.874278143003;5084.949150508522;1277.150694787974;1282.9679258018625;1286.1382873474795;1289.942247357158;1294.5792617399384;804.4047404920317;822.8765685147276;824.5464994253136;829.9585020748939;839.8908141941508;4212.641925436311;4296.677749168824;4372.300431930876;4403.987082970934;4427.601515863587;5169.276301317818;5179.171332586768;5187.5993481759715;5220.556252718561;5253.44838791929;4382.474103107584;4386.429764130643;4393.978030109893;4400.3399490076745;4400.603945644907;2623.921282361532;2714.8099633025895;2741.7258274172423;2747.983246198919;2765.7787377010195;4799.880002999883;4801.567858892717;4805.591524720368;4807.711537307703;4816.54242846929;5027.265593370282;5244.265802787613;5257.815976440883;5319.308489896289;5332.120200166929;4804.975975120102;4807.18277892759;4810.254410566367;4819.734914579732;4832.251001094836;5174.930027988835;5187.273781670494;5189.273501709839;5207.71357575337;5213.488088454457;4856.8300109495995;5113.284140220447;5127.205283180963;5129.230615407719;5137.537621613923;4850.466448690711;4876.80492780299;4880;4890.486498917705;4891.584215341736;3702.241040586727;3718.5537735471917;3729.5524537055726;3735.738498305201;3745.36328824106;5108.846734597968;5311.601629877698;5324.387695415076;5333;5334.466553344634;5041.269015992734;5077.238414237746;5078.365204349457;5079.517445842639;5092.210707340369;5052.317937078595;5076.847694569169;5084.51697088776;5091.949080509147;5092.261622064854;4669.603083737785;5003.799848006039;5008.273800299009;5019.573336266459;5036.445990940921;4752.881177970578;4933.9506604933495;5060.645754797276;5070.518300761421;5087.448328259917;4883.169861123689;4884.65807393479;4893.339399181065;4895.4859739728245;4907.190313598217 05:42:21 INFO - PROCESS | 24302 | |5;yui.html;541.7264281537823;633.6008314761699;650.6746626686656;671.2750229751869;695.3580154106369;11925.403729813506;13238.470461181565;13315.866841331585;13532.661683457905;13541.458341666334;13271.668208294797;13309.93345033276;13356.398962046707;13369;13385.732285354286;737.8487410080934;762.3558093411059;768.6617888129206;769.1385648074165;769.7960040589248;626.1765778001935;738.9889151662702;758.5145506875604;767.7044337929881;768.5311959704576;805.7542449552884;805.9395545334094;806.7095845495617;806.9314108300802;807.039622848808;800.1958032177653;801.2068052627857;801.2388231180402;802.0615879421063;802.2058162419221;485.40780248097263;569.3623142080854;578.5747475605468;583.8365257727843;588.3204898342378;13132.6716832079;13163.736725265537;13168.736625267537;13171.275579843104;13184;12630.873691263154;12842.935785321108;13104;13221.471141154343;13544.022566714117;11781.116416268815;12196.57311994076;12197.39013049344;12559.56041538551;12854.55009074678;4071.450354202204;4127.6904232182405;4156.688248381353;4182.2890108681295;4206.957930420687;66469;66547.33452665508;66654;66949.66525167391;67612.66193669049;10309.329893557046;10484.317965055523;10539.947300263602;10628.202884783672;10667.093297069836;20402.38792836217;20503.69244461334;20561.280355187497;20640.48398790042;20668.17327306921;6842.521023528305;7041.436685065182;7054.2240353561065;7065.92934070663;7094.255103214191;3713.814309284579;3769.8869033929027;3815.5612104608326;3837.884863454101;3883.3592457244804;2670.0788228061288;2780.291025788411;2780.3466185446405;2781.805273630867;2789.302674331417;465.4159030416805;470.65642081280856;479.5707841481854;488.060483569128;501.0105042541025;457.2478273240501;482.3247453565037;504.19077380804015;506.9011542749202;510.85440649415483;7430.219826918204;7807.570583617842;7854.450188486865;8021.438499304993;8367.916320836835;427.3909678707829;516.1418891988885;524.2660275614095;524.8005757812083;534.1453674121452;3725.739198256096;3734.1784807342883;3854.845806167722;3877.185790983925;3978.840846366171;56741.71629141828;59929.40070599238;81178.59410702909;85756.57121714352;105726;51393.486065139616;51935.48064519382;52639;85781;92405.53797230971;47441;80877;81232;81560.59219703864;81807.59096204481;7233.855322893618;7514.892469628341;7551.660175292015;7556.395488360808;7570;32007.199820004687;33005.834970825956;44602.330965034904;46308.768456158854;47470;64124.67937660282;66848.33151668421;67306;67640.6617966907;69157.65421173064;8372.665093396196;8402.453840500348;8405.747827565183;8643;8711.869321960303;10574.947125264325;10651.467426628482;10843.67468975932;11172.72068198269;11533.538658453568;8777.736667899973;8925.196732294125;8993.820123597623;9218.170364667212;9501.524923753646;10128.848067279145;10141.949290253502;10499;12780.61658150257;12834.101612887382;11660.53357865676;11988.400579970792;12021.158518903943;12115.697107572381;12222.633321000385;10121.190304775748;10207.693769186937;10574.735631609272;10878.292910960763;10925.688917329971;10706.89293107059;10762.192835537522;10942.835857461985;10946.890531094587;10988.615398461016 05:42:21 INFO - PROCESS | 24302 | __end_tp_report 05:42:21 INFO - PROCESS | 24302 | __start_cc_report 05:42:21 INFO - PROCESS | 24302 | _x_x_mozilla_cycle_collect,1058 05:42:21 INFO - PROCESS | 24302 | __end_cc_report 05:42:21 INFO - PROCESS | 24302 | __startTimestamp1470660141619__endTimestamp 05:42:21 INFO - PROCESS | 24302 | 05:42:21 INFO - PROCESS | 24302 | ------- Summary: start ------- 05:42:21 INFO - PROCESS | 24302 | Number of tests: 6 05:42:21 INFO - PROCESS | 24302 | 05:42:21 INFO - PROCESS | 24302 | [#0] dojo.html Cycles:165 Average:4697.03 Median:4823.95 stddev:507.68 (10.5%) stddev-sans-first:480.90 05:42:21 INFO - PROCESS | 24302 | Values: 2565.2 2570.8 2599.8 2604.7 2607.2 4545.5 4646.2 4709.8 4728.4 4759.8 4687.8 4725.7 4731.9 4741.0 4821.6 4336.2 4365.0 4393.2 4400.9 4536.1 4486.3 4488.7 4491.6 4501.4 4513.8 4213.9 4216.4 4245.1 4338.9 4346.4 4293.3 4295.2 4295.6 4300.2 4316.2 4276.7 4280.9 4302.3 4359.8 4379.4 4671.2 4721.2 4729.8 4736.6 4797.8 5044.3 5047.2 5083.8 5097.8 5117.8 4843.4 5072.8 5092.0 5097.4 5118.8 4839.8 4840.2 4840.8 4841.8 4843.2 5232.8 5320.2 5326.4 5326.7 5338.4 4845.7 4969.8 5009.2 5070.1 5074.4 5148.5 5170.8 5209.0 5230.3 5231.9 5124.0 5124.8 5128.1 5131.0 5132.1 4844.6 4995.9 5027.7 5057.5 5152.0 4391.5 4400.9 4408.7 4436.6 4460.4 3818.4 3843.8 3847.2 3867.0 3881.1 4167.5 4213.3 4241.7 4342.4 4353.8 5144.0 5171.7 5183.1 5211.1 5229.5 4352.1 4353.3 4372.3 4387.0 4419.2 4455.2 4594.5 4649.1 4650.1 4652.5 4761.0 4774.5 4779.6 4822.9 4824.0 5171.3 5174.2 5174.8 5176.5 5224.4 4499.5 4595.6 4603.6 4759.3 4824.5 4954.9 4956.6 4963.2 4965.5 4969.4 5035.6 5068.0 5090.0 5092.5 5145.8 4841.5 4879.3 4888.8 4923.9 4924.6 4749.6 4918.6 4924.2 4930.0 4987.2 4682.3 4794.8 4847.1 4847.4 4918.4 4991.5 4996.9 4998.3 5021.2 5040.8 4816.3 4828.5 4834.0 4881.4 4919.6 05:42:21 INFO - PROCESS | 24302 | 05:42:21 INFO - PROCESS | 24302 | [#1] ext.html Cycles:180 Average:55861.89 Median:192999.15 stddev:120179.87 (62.3%) stddev-sans-first:120445.19 05:42:21 INFO - PROCESS | 24302 | Values: 526.5 569.7 570.7 591.4 592.6 29694.9 32321.2 39030.4 40471.2 40586.4 41011.0 41098.8 41101.4 41482.0 41522.8 7548.4 7695.1 7700.2 7701.7 7711.9 7466.3 9798.0 10035.7 10065.9 10395.6 10131.1 10151.5 10202.4 10205.1 10226.7 9977.6 10028.9 10043.8 10045.5 10057.9 9789.1 9983.9 10006.3 10008.6 10009.2 37956.0 38124.4 38313.8 38383.6 38417.6 2876.9 2948.2 3071.9 3316.7 3437.1 30377.8 30872.8 30920.2 31250.0 31446.7 3214.5 3309.3 3359.9 3368.7 3418.3 203975.0 258903.0 259166.0 260441.0 260664.0 56488.0 57119.7 57200.4 57244.0 57319.4 32332.7 32996.2 33277.0 34980.8 35068.8 13836.2 13931.7 13946.0 13960.7 13969.7 9479.7 10352.8 10783.7 10893.7 10946.7 17784.2 18224.5 18405.4 18479.4 18727.3 6822.0 7064.8 7080.2 7082.8 7083.2 811.3 853.3 864.0 873.6 1032.2 28749.6 28917.4 29292.4 29754.7 29781.7 931.5 959.2 1028.3 1036.4 1059.6 14748.9 15392.6 15496.8 15853.1 15919.5 397665.0 681859.0 689246.1 694706.0 695777.0 51805.7 52664.0 52717.7 52784.7 52819.5 1063.1 1137.5 1198.5 1220.1 1223.6 26258.0 29026.6 30561.0 30856.5 31156.5 44783.6 45731.0 46284.8 46423.5 46435.5 350929.5 356757.0 356966.0 357080.0 357488.0 33867.0 35182.6 40328.4 40562.2 41068.4 42583.6 43075.6 43199.0 43407.0 43481.6 36835.6 37139.1 37326.3 37766.4 38160.4 37403.4 38032.6 39115.4 39171.6 39788.0 37125.4 37965.4 38124.6 39943.2 40535.8 32407.8 34008.0 34641.3 34734.0 35016.3 25846.6 26567.6 26611.6 26705.7 26858.2 05:42:21 INFO - PROCESS | 24302 | 05:42:21 INFO - PROCESS | 24302 | [#2] jquery.html Cycles:180 Average:24692.58 Median:50702.87 stddev:67986.08 (134.1%) stddev-sans-first:68152.24 05:42:21 INFO - PROCESS | 24302 | Values: 357.4 359.5 363.2 381.1 384.2 15636.0 16991.2 17698.0 17783.1 17878.4 16145.8 17171.4 17446.3 17617.0 17633.3 4958.8 5187.0 5187.6 5199.0 5202.7 3808.6 3998.7 5188.0 5736.9 5978.6 6057.7 6059.2 6070.2 6074.2 6077.0 5850.7 6015.3 6024.8 6035.7 6036.7 4556.3 5323.5 5327.3 5342.3 5344.1 11287.3 11957.8 11994.9 12018.0 12077.0 1831.7 1894.9 2169.4 2266.5 2299.5 8466.9 8532.9 8664.0 9013.5 9311.6 1660.1 1681.3 1694.2 1706.7 1736.3 68924.7 70159.0 70473.0 72863.0 73038.0 9776.0 10147.0 10158.5 10391.1 10429.7 13720.4 13755.2 13782.2 13791.6 13806.9 6927.8 7179.1 7243.3 7294.9 7354.9 6828.2 6832.6 7027.6 7084.2 7103.1 4145.6 4298.8 4301.4 4403.3 4429.0 1569.4 1794.7 1845.4 2824.7 2993.3 776.4 844.8 864.9 867.8 879.1 15695.9 16591.1 17323.7 17365.0 17776.6 821.3 837.8 841.4 879.4 890.9 9515.6 9663.3 9747.1 9920.7 10029.4 400695.0 407123.0 415466.0 416428.0 420443.0 77180.0 77359.6 77790.6 78800.0 80353.6 803.1 860.9 871.6 878.4 884.1 15206.5 16010.4 16370.3 16445.7 16682.2 35282.5 35545.8 35790.0 36195.5 37548.2 45822.3 49982.5 50020.2 50434.2 50971.5 6662.0 6687.1 6767.3 6783.2 6904.3 8628.7 11534.4 11915.2 12061.6 12090.2 9240.2 9344.9 9561.4 9748.8 10284.4 9678.8 9733.9 10392.6 10687.4 10738.5 9251.2 9721.8 9915.9 10581.5 10730.9 7513.1 7519.2 7602.0 7636.2 7654.3 8427.6 9983.4 10119.2 10331.1 10406.5 05:42:21 INFO - PROCESS | 24302 | 05:42:21 INFO - PROCESS | 24302 | [#3] mootools.html Cycles:180 Average:4942.72 Median:4972.45 stddev:2829.74 (56.9%) stddev-sans-first:2824.87 05:42:21 INFO - PROCESS | 24302 | Values: 1359.2 1410.6 1455.6 1667.7 1682.1 7242.9 7843.7 7861.3 7876.0 7886.7 6227.5 7167.9 7422.9 7470.9 7745.6 2121.9 2175.4 2177.4 2180.9 2189.9 2117.2 2153.3 2155.5 2156.6 2170.2 2117.3 2119.8 2129.3 2129.6 2169.7 2092.3 2094.8 2095.3 2104.7 2107.1 2006.2 2070.5 2070.9 2082.3 2086.1 7535.1 7558.7 7561.7 7645.3 7649.3 4275.8 4390.6 4393.4 4396.6 4396.6 2688.8 2728.4 2770.1 2788.7 2798.2 873.9 903.7 920.1 923.9 936.7 10202.8 10432.4 10472.3 10483.2 10518.5 3830.4 3861.5 4044.1 4047.7 4143.3 9001.1 9005.2 9005.4 9015.1 9031.6 4271.6 4327.6 4337.6 4338.6 4481.0 3344.4 3831.5 3901.2 3903.5 3967.7 3641.8 3666.3 3763.2 3766.3 3771.5 1105.4 1153.4 1162.6 1163.2 1167.5 743.1 750.1 765.7 787.2 807.0 4792.9 4893.7 4956.3 4959.7 5111.0 892.7 911.5 912.5 913.5 917.7 3229.9 3274.8 3277.9 3339.7 3417.1 9391.8 9656.7 9753.8 9760.3 9764.2 9646.1 9736.4 9757.1 9761.3 9772.4 7224.5 7364.8 7367.4 7391.9 7451.1 4794.6 4949.3 4985.2 4986.6 5186.6 8659.2 8740.0 8744.5 8775.5 8866.9 8591.7 8817.6 9009.2 9073.1 9085.7 6156.0 6216.4 6285.9 6306.9 6372.9 6763.1 6819.2 6823.9 6829.0 6836.9 6100.8 6184.3 6336.7 6384.5 6444.0 6086.8 6086.9 6146.7 6170.1 6207.3 5634.7 5699.8 5701.7 5710.0 5717.3 4019.2 4095.8 4137.9 4161.8 4268.2 4072.9 4092.1 4098.3 4135.9 4176.0 05:42:21 INFO - PROCESS | 24302 | 05:42:21 INFO - PROCESS | 24302 | [#4] prototype.html Cycles:180 Average:4172.21 Median:4800.90 stddev:1217.87 (25.4%) stddev-sans-first:1185.88 05:42:21 INFO - PROCESS | 24302 | Values: 288.4 300.7 301.8 304.0 306.2 4775.2 4800.2 4819.9 4852.2 4896.7 4774.5 4826.3 4832.9 4833.5 4837.3 3604.8 3734.5 3745.2 3749.7 3758.5 3624.3 3770.7 3773.2 3813.8 3832.9 3726.5 3738.3 3744.9 3757.1 3765.7 3531.9 3719.5 3721.1 3733.8 3771.4 3275.9 3284.4 3284.8 3294.8 3298.8 4639.5 4648.0 4665.6 4677.0 4691.6 4278.4 4295.4 4300.6 4307.1 4312.5 4909.9 4930.4 4997.6 5008.8 5035.7 3563.9 3568.0 3575.0 3575.2 3576.1 5228.1 5241.4 5261.7 5276.5 5305.2 3552.7 3606.8 3640.6 3684.8 3693.8 3663.4 3664.2 3669.4 3670.9 3698.6 4193.2 4209.7 4213.3 4232.7 4251.3 4866.4 4947.8 4984.5 5028.9 5084.9 1277.2 1283.0 1286.1 1289.9 1294.6 804.4 822.9 824.5 830.0 839.9 4212.6 4296.7 4372.3 4404.0 4427.6 5169.3 5179.2 5187.6 5220.6 5253.4 4382.5 4386.4 4394.0 4400.3 4400.6 2623.9 2714.8 2741.7 2748.0 2765.8 4799.9 4801.6 4805.6 4807.7 4816.5 5027.3 5244.3 5257.8 5319.3 5332.1 4805.0 4807.2 4810.3 4819.7 4832.3 5174.9 5187.3 5189.3 5207.7 5213.5 4856.8 5113.3 5127.2 5129.2 5137.5 4850.5 4876.8 4880.0 4890.5 4891.6 3702.2 3718.6 3729.6 3735.7 3745.4 5108.8 5311.6 5324.4 5333.0 5334.5 5041.3 5077.2 5078.4 5079.5 5092.2 5052.3 5076.8 5084.5 5091.9 5092.3 4669.6 5003.8 5008.3 5019.6 5036.4 4752.9 4934.0 5060.6 5070.5 5087.4 4883.2 4884.7 4893.3 4895.5 4907.2 05:42:21 INFO - PROCESS | 24302 | 05:42:21 INFO - PROCESS | 24302 | [#5] yui.html Cycles:180 Average:16829.63 Median:23974.79 stddev:23507.77 (98.1%) stddev-sans-first:23541.90 05:42:21 INFO - PROCESS | 24302 | Values: 541.7 633.6 650.7 671.3 695.4 11925.4 13238.5 13315.9 13532.7 13541.5 13271.7 13309.9 13356.4 13369.0 13385.7 737.8 762.4 768.7 769.1 769.8 626.2 739.0 758.5 767.7 768.5 805.8 805.9 806.7 806.9 807.0 800.2 801.2 801.2 802.1 802.2 485.4 569.4 578.6 583.8 588.3 13132.7 13163.7 13168.7 13171.3 13184.0 12630.9 12842.9 13104.0 13221.5 13544.0 11781.1 12196.6 12197.4 12559.6 12854.6 4071.5 4127.7 4156.7 4182.3 4207.0 66469.0 66547.3 66654.0 66949.7 67612.7 10309.3 10484.3 10539.9 10628.2 10667.1 20402.4 20503.7 20561.3 20640.5 20668.2 6842.5 7041.4 7054.2 7065.9 7094.3 3713.8 3769.9 3815.6 3837.9 3883.4 2670.1 2780.3 2780.3 2781.8 2789.3 465.4 470.7 479.6 488.1 501.0 457.2 482.3 504.2 506.9 510.9 7430.2 7807.6 7854.5 8021.4 8367.9 427.4 516.1 524.3 524.8 534.1 3725.7 3734.2 3854.8 3877.2 3978.8 56741.7 59929.4 81178.6 85756.6 105726.0 51393.5 51935.5 52639.0 85781.0 92405.5 47441.0 80877.0 81232.0 81560.6 81807.6 7233.9 7514.9 7551.7 7556.4 7570.0 32007.2 33005.8 44602.3 46308.8 47470.0 64124.7 66848.3 67306.0 67640.7 69157.7 8372.7 8402.5 8405.7 8643.0 8711.9 10574.9 10651.5 10843.7 11172.7 11533.5 8777.7 8925.2 8993.8 9218.2 9501.5 10128.8 10141.9 10499.0 12780.6 12834.1 11660.5 11988.4 12021.2 12115.7 12222.6 10121.2 10207.7 10574.7 10878.3 10925.7 10706.9 10762.2 10942.8 10946.9 10988.6 05:42:21 INFO - PROCESS | 24302 | -------- Summary: end -------- 05:42:21 INFO - PROCESS | 24302 | 05:42:22 INFO - TEST-INFO | 24302: exit 0 05:42:22 INFO - TEST-OK | dromaeo_css | took 1120668ms 05:42:22 INFO - TEST-START | kraken 05:42:22 INFO - operating with platform_type : linux_ 05:42:22 INFO - Initialising browser for kraken test... 05:42:22 INFO - TEST-INFO | started process 24604 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKAIVxJ/profile http://localhost:34306/getInfo.html) 05:42:26 INFO - PROCESS | 24604 | __metrics Screen width/height:1600/1200 05:42:26 INFO - PROCESS | 24604 | colorDepth:24 05:42:26 INFO - PROCESS | 24604 | Browser inner width/height: 1024/697 05:42:26 INFO - PROCESS | 24604 | __metrics 05:42:27 INFO - PROCESS | 24604 | 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:42:27 INFO - PROCESS | 24604 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:42:29 INFO - TEST-INFO | 24604: exit 0 05:42:29 INFO - Browser initialized. 05:42:29 INFO - Running cycle 1/1 for kraken test... 05:42:29 INFO - TEST-INFO | started process 24686 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKAIVxJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:42:41 INFO - PROCESS | 24686 | RSS: Main: 158314496 05:42:41 INFO - PROCESS | 24686 | 05:42:43 INFO - PROCESS | 24686 | Cycle 1(1): loaded http://localhost:34306/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34306/tests/kraken/driver.html?testName=audio-beat-detection) 05:42:44 INFO - PROCESS | 24686 | RSS: Main: 214347776 05:42:44 INFO - PROCESS | 24686 | 05:42:47 INFO - PROCESS | 24686 | Cycle 1(1): loaded http://localhost:34306/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34306/tests/kraken/driver.html?testName=audio-dft) 05:42:47 INFO - PROCESS | 24686 | RSS: Main: 192380928 05:42:47 INFO - PROCESS | 24686 | 05:42:51 INFO - PROCESS | 24686 | Cycle 1(1): loaded http://localhost:34306/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34306/tests/kraken/driver.html?testName=audio-fft) 05:42:51 INFO - PROCESS | 24686 | RSS: Main: 271867904 05:42:51 INFO - PROCESS | 24686 | 05:42:54 INFO - PROCESS | 24686 | Cycle 1(1): loaded http://localhost:34306/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34306/tests/kraken/driver.html?testName=audio-oscillator) 05:42:54 INFO - PROCESS | 24686 | RSS: Main: 181080064 05:42:54 INFO - PROCESS | 24686 | 05:42:56 INFO - PROCESS | 24686 | Cycle 1(1): loaded http://localhost:34306/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34306/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:42:57 INFO - PROCESS | 24686 | RSS: Main: 185655296 05:42:57 INFO - PROCESS | 24686 | 05:43:00 INFO - PROCESS | 24686 | Cycle 1(1): loaded http://localhost:34306/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34306/tests/kraken/driver.html?testName=imaging-darkroom) 05:43:01 INFO - PROCESS | 24686 | RSS: Main: 222375936 05:43:01 INFO - PROCESS | 24686 | 05:43:04 INFO - PROCESS | 24686 | Cycle 1(1): loaded http://localhost:34306/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34306/tests/kraken/driver.html?testName=imaging-desaturate) 05:43:05 INFO - PROCESS | 24686 | RSS: Main: 221188096 05:43:05 INFO - PROCESS | 24686 | 05:43:08 INFO - PROCESS | 24686 | Cycle 1(1): loaded http://localhost:34306/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34306/tests/kraken/driver.html?testName=json-parse-financial) 05:43:08 INFO - PROCESS | 24686 | RSS: Main: 220839936 05:43:08 INFO - PROCESS | 24686 | 05:43:10 INFO - PROCESS | 24686 | Cycle 1(1): loaded http://localhost:34306/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34306/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:43:11 INFO - PROCESS | 24686 | RSS: Main: 185532416 05:43:11 INFO - PROCESS | 24686 | 05:43:13 INFO - PROCESS | 24686 | Cycle 1(1): loaded http://localhost:34306/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34306/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:43:13 INFO - PROCESS | 24686 | RSS: Main: 192208896 05:43:13 INFO - PROCESS | 24686 | 05:43:15 INFO - PROCESS | 24686 | Cycle 1(1): loaded http://localhost:34306/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34306/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:43:16 INFO - PROCESS | 24686 | RSS: Main: 195657728 05:43:16 INFO - PROCESS | 24686 | 05:43:19 INFO - PROCESS | 24686 | Cycle 1(1): loaded http://localhost:34306/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:43:20 INFO - PROCESS | 24686 | RSS: Main: 196239360 05:43:20 INFO - PROCESS | 24686 | 05:43:22 INFO - PROCESS | 24686 | Cycle 1(1): loaded http://localhost:34306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:43:23 INFO - PROCESS | 24686 | RSS: Main: 197140480 05:43:23 INFO - PROCESS | 24686 | 05:43:25 INFO - PROCESS | 24686 | Cycle 1(1): loaded http://localhost:34306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34306/tests/kraken/driver.html?testName=ai-astar) 05:43:25 INFO - PROCESS | 24686 | RSS: Main: 244793344 05:43:25 INFO - PROCESS | 24686 | 05:43:25 INFO - PROCESS | 24686 | __start_tp_report 05:43:25 INFO - PROCESS | 24686 | _x_x_mozilla_page_load 05:43:25 INFO - PROCESS | 24686 | _x_x_mozilla_page_load_details 05:43:25 INFO - PROCESS | 24686 | |i|pagename|runs| 05:43:25 INFO - PROCESS | 24686 | |0;ai-astar;106;114;116;116;114;114;114;115;114;114 05:43:25 INFO - PROCESS | 24686 | |1;audio-beat-detection;155;122;125;182;123;123;149;121;159;122 05:43:25 INFO - PROCESS | 24686 | |2;audio-dft;161;163;162;162;162;163;162;164;163;163 05:43:25 INFO - PROCESS | 24686 | |3;audio-fft;77;77;76;139;77;77;74;76;106;77 05:43:25 INFO - PROCESS | 24686 | |4;audio-oscillator;87;85;126;85;86;86;116;85;86;126 05:43:25 INFO - PROCESS | 24686 | |5;imaging-gaussian-blur;116;118;117;117;118;118;118;117;116;117 05:43:25 INFO - PROCESS | 24686 | |6;imaging-darkroom;146;147;147;147;146;147;148;146;146;146 05:43:25 INFO - PROCESS | 24686 | |7;imaging-desaturate;95;95;95;95;95;95;96;96;96;96 05:43:25 INFO - PROCESS | 24686 | |8;json-parse-financial;64;64;62;70;64;66;62;63;64;62 05:43:25 INFO - PROCESS | 24686 | |9;json-stringify-tinderbox;67;66;68;66;67;66;67;66;66;67 05:43:25 INFO - PROCESS | 24686 | |10;stanford-crypto-aes;83;85;80;81;80;80;80;85;79;80 05:43:25 INFO - PROCESS | 24686 | |11;stanford-crypto-ccm;135;133;130;128;131;127;130;132;146;135 05:43:25 INFO - PROCESS | 24686 | |12;stanford-crypto-pbkdf2;166;166;167;164;166;167;165;165;164;169 05:43:25 INFO - PROCESS | 24686 | |13;stanford-crypto-sha256-iterative;67;67;68;69;67;75;67;66;68;68 05:43:25 INFO - PROCESS | 24686 | __end_tp_report 05:43:25 INFO - PROCESS | 24686 | __start_cc_report 05:43:25 INFO - PROCESS | 24686 | _x_x_mozilla_cycle_collect,1954 05:43:25 INFO - PROCESS | 24686 | __end_cc_report 05:43:25 INFO - PROCESS | 24686 | __startTimestamp1470660205597__endTimestamp 05:43:25 INFO - PROCESS | 24686 | 05:43:25 INFO - PROCESS | 24686 | ------- Summary: start ------- 05:43:25 INFO - PROCESS | 24686 | Number of tests: 14 05:43:25 INFO - PROCESS | 24686 | 05:43:25 INFO - PROCESS | 24686 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:2.83 (2.5%) stddev-sans-first:0.88 05:43:25 INFO - PROCESS | 24686 | Values: 106.0 114.0 116.0 116.0 114.0 114.0 114.0 115.0 114.0 114.0 05:43:25 INFO - PROCESS | 24686 | 05:43:25 INFO - PROCESS | 24686 | [#1] audio-beat-detection Cycles:10 Average:138.10 Median:137.00 stddev:21.62 (15.8%) stddev-sans-first:22.05 05:43:25 INFO - PROCESS | 24686 | Values: 155.0 122.0 125.0 182.0 123.0 123.0 149.0 121.0 159.0 122.0 05:43:25 INFO - PROCESS | 24686 | 05:43:25 INFO - PROCESS | 24686 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:0.85 (0.5%) stddev-sans-first:0.71 05:43:25 INFO - PROCESS | 24686 | Values: 161.0 163.0 162.0 162.0 162.0 163.0 162.0 164.0 163.0 163.0 05:43:25 INFO - PROCESS | 24686 | 05:43:25 INFO - PROCESS | 24686 | [#3] audio-fft Cycles:10 Average:85.60 Median:77.00 stddev:20.97 (27.2%) stddev-sans-first:22.01 05:43:25 INFO - PROCESS | 24686 | Values: 77.0 77.0 76.0 139.0 77.0 77.0 74.0 76.0 106.0 77.0 05:43:25 INFO - PROCESS | 24686 | 05:43:25 INFO - PROCESS | 24686 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:85.50 stddev:18.07 (21.1%) stddev-sans-first:18.81 05:43:25 INFO - PROCESS | 24686 | Values: 87.0 85.0 126.0 85.0 86.0 86.0 116.0 85.0 86.0 126.0 05:43:25 INFO - PROCESS | 24686 | 05:43:25 INFO - PROCESS | 24686 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.50 stddev:0.79 (0.7%) stddev-sans-first:0.71 05:43:25 INFO - PROCESS | 24686 | Values: 116.0 118.0 117.0 117.0 118.0 118.0 118.0 117.0 116.0 117.0 05:43:25 INFO - PROCESS | 24686 | 05:43:25 INFO - PROCESS | 24686 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 05:43:25 INFO - PROCESS | 24686 | Values: 146.0 147.0 147.0 147.0 146.0 147.0 148.0 146.0 146.0 146.0 05:43:25 INFO - PROCESS | 24686 | 05:43:25 INFO - PROCESS | 24686 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:43:25 INFO - PROCESS | 24686 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 05:43:25 INFO - PROCESS | 24686 | 05:43:25 INFO - PROCESS | 24686 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.00 stddev:2.42 (3.8%) stddev-sans-first:2.57 05:43:25 INFO - PROCESS | 24686 | Values: 64.0 64.0 62.0 70.0 64.0 66.0 62.0 63.0 64.0 62.0 05:43:25 INFO - PROCESS | 24686 | 05:43:25 INFO - PROCESS | 24686 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 05:43:25 INFO - PROCESS | 24686 | Values: 67.0 66.0 68.0 66.0 67.0 66.0 67.0 66.0 66.0 67.0 05:43:25 INFO - PROCESS | 24686 | 05:43:25 INFO - PROCESS | 24686 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:80.50 stddev:2.21 (2.7%) stddev-sans-first:2.26 05:43:25 INFO - PROCESS | 24686 | Values: 83.0 85.0 80.0 81.0 80.0 80.0 80.0 85.0 79.0 80.0 05:43:25 INFO - PROCESS | 24686 | 05:43:25 INFO - PROCESS | 24686 | [#11] stanford-crypto-ccm Cycles:10 Average:132.70 Median:132.50 stddev:5.38 (4.1%) stddev-sans-first:5.64 05:43:25 INFO - PROCESS | 24686 | Values: 135.0 133.0 130.0 128.0 131.0 127.0 130.0 132.0 146.0 135.0 05:43:25 INFO - PROCESS | 24686 | 05:43:25 INFO - PROCESS | 24686 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:166.00 stddev:1.52 (0.9%) stddev-sans-first:1.62 05:43:25 INFO - PROCESS | 24686 | Values: 166.0 166.0 167.0 164.0 166.0 167.0 165.0 165.0 164.0 169.0 05:43:25 INFO - PROCESS | 24686 | 05:43:25 INFO - PROCESS | 24686 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:2.53 (3.7%) stddev-sans-first:2.65 05:43:25 INFO - PROCESS | 24686 | Values: 67.0 67.0 68.0 69.0 67.0 75.0 67.0 66.0 68.0 68.0 05:43:25 INFO - PROCESS | 24686 | -------- Summary: end -------- 05:43:25 INFO - PROCESS | 24686 | 05:43:26 INFO - TEST-INFO | 24686: exit 0 05:43:26 INFO - TEST-OK | kraken | took 64191ms 05:43:26 INFO - SUITE-END | took 1184s 05:43:26 INFO - Completed test suite (00:19:44) 05:43:26 INFO - javascript benchmark 05:43:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2565.153499345216, 2570.8457492550438, 2599.831010984286, 2604.713481517034, 2607.17873869731, 4545.4545454545505, 4646.210144275473, 4709.764511774406, 4728.432588089429, 4759.762011899405, 4687.789049492772, 4725.740084295371, 4731.929021064687, 4740.9762951185285, 4821.566059054684, 4336.21948049351, 4365.039691267924, 4393.231184542708, 4400.867973960786, 4536.092781443708, 4486.304622783474, 4488.685791994561, 4491.550844915499, 4501.437320334958, 4513.819447222108, 4213.936790948138, 4216.430781844442, 4245.066085461193, 4338.913221735579, 4346.369776382407, 4293.270144075484, 4295.226859165349, 4295.613394794484, 4300.161468513641, 4316.2446571849805, 4276.72201306914, 4280.9143817123795, 4302.333138363528, 4359.782010899442, 4379.364992076163, 4671.159191345557, 4721.173794585968, 4729.834455794065, 4736.573708366229, 4797.7601119943865, 5044.268581055763, 5047.167217409123, 5083.822066227701, 5097.7960881564695, 5117.8464646060675, 4843.39457567804, 5072.822451214227, 5092.0, 5097.388313402378, 5118.846434606968, 4839.782209800567, 4840.177169881129, 4840.782164802592, 4841.830535931225, 4843.152448321565, 5232.764525596357, 5320.17537281722, 5326.36083669962, 5326.707031113326, 5338.412774594792, 4845.6608037437745, 4969.801207951714, 5009.198528235464, 5070.112730272188, 5074.416442109131, 5148.536631703165, 5170.819021334235, 5209.0363282792805, 5230.320058392384, 5231.895362092737, 5124.0, 5124.820631277962, 5128.12821820284, 5131.0, 5132.050570644443, 4844.588210002119, 4995.875103122378, 5027.748612569357, 5057.494250574913, 5151.974240128776, 4391.473023237232, 4400.9119817604105, 4408.6913916026215, 4436.578525040116, 4460.397846290709, 3818.3699689550913, 3843.807809609564, 3847.1920896611464, 3867.0332416895776, 3881.126746482019, 4167.541570427251, 4213.262679031219, 4241.660667146621, 4342.392065110887, 4353.804078816461, 5144.048351054992, 5171.663841850268, 5183.092958732207, 5211.140161873324, 5229.529342359206, 4352.064306174188, 4353.281708518059, 4372.322290045048, 4386.978065109654, 4419.204543182193, 4455.22033644111, 4594.540545945379, 4649.139909116824, 4650.069986002745, 4652.464966528825, 4761.0001899601475, 4774.522547745198, 4779.569838714532, 4822.903541929212, 4823.9517604824905, 5171.3018742469285, 5174.172132458789, 5174.818881339135, 5176.50823171798, 5224.373075230845, 4499.505054443943, 4595.609373203181, 4603.58567728906, 4759.333693282874, 4824.469308376146, 4954.900901981868, 4956.578690811321, 4963.181075122564, 4965.503449655005, 4969.378827646544, 5035.5719763819025, 5068.037072956126, 5089.982003599221, 5092.516210959953, 5145.768440420115, 4841.491643377535, 4879.316895634685, 4888.804447822047, 4923.926141107814, 4924.606031517398, 4749.620030397629, 4918.581920536794, 4924.212126059813, 4929.950700492949, 4987.177115776001, 4682.2508398656055, 4794.808207671654, 4847.103285892122, 4847.442544107473, 4918.43438004634, 4991.47589503097, 4996.850094497171, 4998.300237966615, 5021.171506701499, 5040.773165207648, 4816.34979277793, 4828.517148285144, 4834.0, 4881.389826271716, 4919.557239848431], "value": 4663.552006654111, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [526.5182358142299, 569.7464628240432, 570.657605436738, 591.4115455122154, 592.5999950033727, 29694.851525742393, 32321.191970200758, 39030.41454378183, 40471.190576188535, 40586.39120413196, 41011.0, 41098.79450602743, 41101.38347924784, 41482.0, 41522.792386038105, 7548.4338674599485, 7695.0765908090825, 7700.1914798946145, 7701.653425595834, 7711.922880771177, 7466.328030477256, 9798.0, 10035.69892903214, 10065.949670251639, 10395.584176632963, 10131.088202061814, 10151.492425378701, 10202.387856728583, 10205.132563732055, 10226.744331391737, 9977.551010204557, 10028.89971100287, 10043.799124017478, 10045.497725113788, 10057.949710251474, 9789.070038346346, 9983.90016099837, 10006.349587276804, 10008.64969726056, 10009.249306302056, 37956.0, 38124.42813357802, 38313.80843095794, 38383.616163838284, 38417.61582384168, 2876.8993085242128, 2948.174511136885, 3071.8924837630575, 3316.651751566099, 3437.1063523483826, 30377.848110759525, 30872.8456357719, 30920.226994325098, 31250.0, 31446.685533144835, 3214.4856822908455, 3309.3381323735107, 3359.8992030238887, 3368.6968172864313, 3418.3163367326633, 203975.0, 258903.0, 259166.0, 260441.0, 260663.9999999981, 56488.0, 57119.71440142856, 57200.42799572034, 57244.0, 57319.42680573224, 32332.676673232967, 32996.1750956228, 33277.0, 34980.82509587436, 35068.82465587656, 13836.23900685472, 13931.721365572834, 13946.0, 13960.650983725489, 13969.65075873091, 9479.715608531755, 10352.792944141074, 10783.730406739895, 10893.727656808485, 10946.671599852018, 17784.199711013036, 18224.544386390182, 18405.355812546495, 18479.353222637143, 18727.250909963448, 6822.0, 7064.788056358318, 7080.150381954199, 7082.822929426702, 7083.15002199729, 811.3022800391658, 853.3088198559187, 863.9934476335125, 873.6025108575583, 1032.210359075308, 28749.56875646867, 28917.421651566852, 29292.414151716846, 29754.702452975627, 29781.702182977893, 931.5249222896372, 959.203860795538, 1028.28534168752, 1036.3988886445993, 1059.5708737961138, 14748.852511474748, 15392.615184620474, 15496.845031549765, 15853.128077955593, 15919.522414327588, 397665.0, 681859.0, 689246.1075389181, 694706.0, 695777.0, 51805.7409712949, 52664.0, 52717.736411317695, 52784.73607632014, 52819.47180528222, 1063.1494804156798, 1137.516555463908, 1198.4726720243066, 1220.0971281251987, 1223.6023292429818, 26258.0, 29026.564601531416, 30561.0, 30856.537151943186, 31156.532652009784, 44783.55216447924, 45731.0, 46284.7685761569, 46423.53576464192, 46435.53564464312, 350929.4721158369, 356757.0, 356966.0, 357080.0, 357488.0, 33867.0, 35182.64817351794, 40328.3950740745, 40562.1887562253, 41068.383974241005, 42583.57416425796, 43075.56924430715, 43199.0, 43407.0, 43481.56518434902, 36835.63164368322, 37139.07152321214, 37326.25347493089, 37766.43350349692, 38160.427593586675, 37403.37569124009, 38032.61967380291, 39115.41326880156, 39171.608283916794, 39788.005299867735, 37125.44311835379, 37965.430518542795, 38124.61875381211, 39943.20113597654, 40535.797321013204, 32407.837960810044, 34008.0, 34641.30717385688, 34734.0, 35016.299674006885, 25846.612300815126, 26567.60148597734, 26611.60082598724, 26705.732942670325, 26858.194254172406], "value": 18545.137195163756, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.39243286413097, 359.48952487467795, 363.150228465391, 381.0853950518755, 384.22770231834005, 15636.0, 16991.23539440725, 17698.0, 17783.11084445776, 17878.37425690101, 16145.757813632776, 17171.399001034966, 17446.30214791407, 17617.0, 17633.29466821329, 4958.752062396884, 5186.974065129688, 5187.559057480119, 5199.0, 5202.661826981253, 3808.5620153682403, 3998.6801055915457, 5188.04021256067, 5736.913946290809, 5978.611390259619, 6057.697115144248, 6059.212302400704, 6070.150178974947, 6074.17998570194, 6076.969615151918, 5850.736716847752, 6015.308239552442, 6024.759009639609, 6035.698215089228, 6036.7283472243635, 4556.316552517116, 5323.520883120537, 5327.30745003151, 5342.332208473941, 5344.118220493614, 11287.322760634388, 11957.820632690517, 11994.940025299818, 12018.038556915426, 12077.0, 1831.6611426886068, 1894.9052547372576, 2169.425102347879, 2266.4900397410615, 2299.4596269876565, 8466.915330846736, 8532.8720069199, 8664.0, 9013.459192448408, 9311.627534898596, 1660.103544086192, 1681.3442757324653, 1694.2291257477941, 1706.7183914654192, 1736.3228340947041, 68924.6553767233, 70159.0, 70473.0, 72863.0, 73038.0, 9776.022397760167, 10147.0, 10158.511164764679, 10391.064804167661, 10429.68710938673, 13720.382582783599, 13755.243461609707, 13782.173069615654, 13791.586252412444, 13806.93096534531, 6927.757528486479, 7179.138503379523, 7243.348098671145, 7294.890576641248, 7354.852902941911, 6828.2488926218075, 6832.555883867532, 7027.61348125858, 7084.185318688416, 7103.147622285359, 4145.626893579592, 4298.8280468780895, 4301.440812694393, 4403.295472724349, 4428.977855110704, 1569.3800948625458, 1794.6500432415553, 1845.4094689699436, 2824.68928417878, 2993.258426966292, 776.4370831147486, 844.8056946902124, 864.9437786543855, 867.8154319354036, 879.1077056787366, 15695.921520392325, 16591.08936081049, 17323.740143897852, 17364.95810251389, 17776.55558611045, 821.326512259953, 837.7528629054443, 841.4320333774677, 879.4327658660128, 890.8530092534659, 9515.57179926905, 9663.323567350359, 9747.074027967332, 9920.702378928643, 10029.448380339152, 400695.0, 407123.0, 415466.0, 416428.0, 420443.0, 77180.0, 77359.61320193364, 77790.60873738263, 78800.0, 80353.59823200846, 803.1005274093053, 860.8708693695995, 871.6295574380736, 878.3719640457103, 884.1344762551013, 15206.46777362787, 16010.439634612732, 16370.345186192419, 16445.67108657844, 16682.165891705125, 35282.470762938065, 35545.82227088848, 35790.0, 36195.45706814347, 37548.24903501969, 45822.31266531072, 49982.50017499778, 50020.24969625531, 50434.243486347, 50971.490285096676, 6662.0, 6687.063811066552, 6767.289434609295, 6783.219929708147, 6904.3095690432565, 8628.654853806029, 11534.365609891202, 11915.2255103418, 12061.577844775742, 12090.214136081127, 9240.214581760625, 9344.906550934676, 9561.378510396802, 9748.756281093029, 10284.434356110485, 9678.75803104928, 9733.9026609733, 10392.636257730943, 10687.358758474516, 10738.516766745359, 9251.167394934488, 9721.805563888824, 9915.900840991499, 10581.523831427758, 10730.89269107299, 7513.060867391576, 7519.210482899217, 7602.011738474184, 7636.198199189005, 7654.311111999724, 8427.62075706607, 9983.351082179635, 10119.190464762654, 10331.121854642439, 10406.479676016017], "value": 8096.907807539788, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.1912811876937, 1410.6261840612237, 1455.5560554031024, 1667.6748034133334, 1682.091670497931, 7242.927570724291, 7843.725469608565, 7861.331786798115, 7876.015498062749, 7886.6845326186885, 6227.532935029868, 7167.89248161278, 7422.925770742291, 7470.850582988337, 7745.612719364038, 2121.915123395066, 2175.41263858758, 2177.3794468576457, 2180.9127634894585, 2189.890505474728, 2117.2166298469588, 2153.2786516516985, 2155.461134716321, 2156.5579056293423, 2170.2295685031822, 2117.3436234767196, 2119.79861913118, 2129.286688959193, 2129.595376878396, 2169.7287839020123, 2092.278164033406, 2094.7695753467106, 2095.308548179097, 2104.705341252226, 2107.12554289971, 2006.2476571285767, 2070.5030792609814, 2070.927517536879, 2082.2816128435666, 2086.050846864673, 7535.058117735283, 7558.73544425948, 7561.659725312375, 7645.2736989986415, 7649.311561959395, 4275.764832934187, 4390.604845563915, 4393.362962370438, 4396.60430561251, 4396.626286765629, 2688.8386696798257, 2728.4133911208987, 2770.0581802187153, 2788.707185745508, 2798.188525327673, 873.895132584094, 903.7424334064825, 920.1120918313792, 923.9214666753334, 936.6862101196108, 10202.846957295647, 10432.426216558086, 10472.26694131411, 10483.161347092291, 10518.474076296154, 3830.367989281737, 3861.4787003754695, 4044.130511939947, 4047.7166598337835, 4143.254214241466, 9001.144891235323, 9005.234555062892, 9005.369624126248, 9015.14356136166, 9031.63873445055, 4271.6369108625495, 4327.56724327571, 4337.609615134653, 4338.609525142752, 4481.0, 3344.381289461409, 3831.482749828793, 3901.1612503311926, 3903.512060992376, 3967.722259441869, 3641.7632853864416, 3666.2667466506805, 3763.2097259575794, 3766.3408903441787, 3771.453139294787, 1105.4307031878589, 1153.3887039868882, 1162.598903378333, 1163.243891470534, 1167.486306025363, 743.0674503498076, 750.1373420566392, 765.7396485195061, 787.1931270447723, 807.0072819023216, 4792.880177995508, 4893.657443978958, 4956.256561515802, 4959.727215003138, 5110.97444512775, 892.6652505310509, 911.480456140007, 912.4707669551777, 913.5295322908707, 917.6925729880564, 3229.9031029069165, 3274.8198849063056, 3277.868885244611, 3339.716124129476, 3417.0773891049776, 9391.812163756687, 9656.71029869105, 9753.756156096155, 9760.267979901535, 9764.218862490983, 9646.083622055894, 9736.41581505112, 9757.073078057572, 9761.267904907161, 9772.413655180711, 7224.4581656375985, 7364.77905662831, 7367.373773229336, 7391.926080739231, 7451.068616422839, 4794.568488836021, 4949.307097006494, 4985.177445721561, 4986.626003049858, 5186.559142472932, 8659.177378149066, 8739.956300218459, 8744.475331479876, 8775.517346546001, 8866.911330886609, 8591.6992905248, 8817.603207855791, 9009.189172974464, 9073.13805188506, 9085.727428177166, 6155.969220153871, 6216.409441103088, 6285.937140628535, 6306.873862522632, 6372.936270637234, 6763.053172555945, 6819.215790184192, 6823.93176068233, 6828.9658551706925, 6836.897446538405, 6100.816975490742, 6184.257889053342, 6336.7465301389275, 6384.489240860813, 6443.967780161257, 6086.786962456293, 6086.908696369646, 6146.661933593696, 6170.136180934763, 6207.286162091417, 5634.661920284796, 5699.800506982236, 5701.657900525982, 5710.0, 5717.313922329347, 4019.2363450944226, 4095.7542547447247, 4137.91724165509, 4161.8335266589, 4268.231718290737, 4072.859599312197, 4092.07928216149, 4098.323776576832, 4135.855245066408, 4176.0395109124465], "value": 3980.706231702529, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.4461833280102, 300.72033009301356, 301.7510553793121, 303.95136778115506, 306.2069240666673, 4775.235962246042, 4800.231962885939, 4819.8795030124265, 4852.150873597119, 4896.706197628145, 4774.49867763885, 4826.348442960208, 4832.903341933159, 4833.492483289257, 4837.274408838676, 3604.8377822997963, 3734.514513113305, 3745.1947831216285, 3749.737518373715, 3758.530183727034, 3624.3476174288617, 3770.7171962102816, 3773.151041015777, 3813.8283777229954, 3832.865849695261, 3726.5341832270965, 3738.327101121797, 3744.906377340561, 3757.1170774867883, 3765.698744100479, 3531.894043178683, 3719.5350581177354, 3721.106934335767, 3733.8343760618777, 3771.41543060826, 3275.918102047444, 3284.3759685659647, 3284.770066095374, 3294.8187849668257, 3298.835058247078, 4639.5360463953675, 4647.955589089152, 4665.626749860003, 4676.976615116937, 4691.62467002639, 4278.4010238566625, 4295.398644189816, 4300.6344460720875, 4307.117041006586, 4312.525622181557, 4909.94436196216, 4930.408350997867, 4997.575206107449, 5008.824691135829, 5035.6978581284875, 3563.8574457021687, 3567.982160089183, 3575.0168703606714, 3575.2134530403528, 3576.088097535138, 5228.137357336035, 5241.42344342122, 5261.684298942076, 5276.498732620395, 5305.230741542493, 3552.662497062775, 3606.8376923038527, 3640.635936406391, 3684.8341824617955, 3693.8153092345815, 3663.377225871608, 3664.230511592542, 3669.3945498992366, 3670.944935825965, 3698.5561732591723, 4193.161367726467, 4209.726367786084, 4213.335732385752, 4232.703710740218, 4251.29853574163, 4866.367372241586, 4947.82682606107, 4984.526469985346, 5028.874278143003, 5084.949150508522, 1277.150694787974, 1282.9679258018625, 1286.1382873474795, 1289.942247357158, 1294.5792617399384, 804.4047404920317, 822.8765685147276, 824.5464994253136, 829.9585020748939, 839.8908141941508, 4212.641925436311, 4296.677749168824, 4372.300431930876, 4403.987082970934, 4427.601515863587, 5169.276301317818, 5179.171332586768, 5187.5993481759715, 5220.556252718561, 5253.44838791929, 4382.474103107584, 4386.429764130643, 4393.978030109893, 4400.3399490076745, 4400.603945644907, 2623.921282361532, 2714.8099633025895, 2741.7258274172423, 2747.983246198919, 2765.7787377010195, 4799.880002999883, 4801.567858892717, 4805.591524720368, 4807.711537307703, 4816.54242846929, 5027.265593370282, 5244.265802787613, 5257.815976440883, 5319.308489896289, 5332.120200166929, 4804.975975120102, 4807.18277892759, 4810.254410566367, 4819.734914579732, 4832.251001094836, 5174.930027988835, 5187.273781670494, 5189.273501709839, 5207.71357575337, 5213.488088454457, 4856.8300109495995, 5113.284140220447, 5127.205283180963, 5129.230615407719, 5137.537621613923, 4850.466448690711, 4876.80492780299, 4880.0, 4890.486498917705, 4891.584215341736, 3702.241040586727, 3718.5537735471917, 3729.5524537055726, 3735.738498305201, 3745.36328824106, 5108.846734597968, 5311.601629877698, 5324.387695415076, 5333.0, 5334.466553344634, 5041.269015992734, 5077.238414237746, 5078.365204349457, 5079.517445842639, 5092.210707340369, 5052.317937078595, 5076.847694569169, 5084.51697088776, 5091.949080509147, 5092.261622064854, 4669.603083737785, 5003.799848006039, 5008.273800299009, 5019.573336266459, 5036.445990940921, 4752.881177970578, 4933.9506604933495, 5060.645754797276, 5070.518300761421, 5087.448328259917, 4883.169861123689, 4884.65807393479, 4893.339399181065, 4895.4859739728245, 4907.190313598217], "value": 3784.1690759491194, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.7264281537823, 633.6008314761699, 650.6746626686656, 671.2750229751869, 695.3580154106369, 11925.403729813506, 13238.470461181565, 13315.866841331585, 13532.661683457905, 13541.458341666334, 13271.668208294797, 13309.93345033276, 13356.398962046707, 13369.0, 13385.732285354286, 737.8487410080934, 762.3558093411059, 768.6617888129206, 769.1385648074165, 769.7960040589248, 626.1765778001935, 738.9889151662702, 758.5145506875604, 767.7044337929881, 768.5311959704576, 805.7542449552884, 805.9395545334094, 806.7095845495617, 806.9314108300802, 807.039622848808, 800.1958032177653, 801.2068052627857, 801.2388231180402, 802.0615879421063, 802.2058162419221, 485.40780248097263, 569.3623142080854, 578.5747475605468, 583.8365257727843, 588.3204898342378, 13132.6716832079, 13163.736725265537, 13168.736625267537, 13171.275579843104, 13184.0, 12630.873691263154, 12842.935785321108, 13104.0, 13221.471141154343, 13544.022566714117, 11781.116416268815, 12196.57311994076, 12197.39013049344, 12559.56041538551, 12854.55009074678, 4071.450354202204, 4127.6904232182405, 4156.688248381353, 4182.2890108681295, 4206.957930420687, 66469.0, 66547.33452665508, 66654.0, 66949.66525167391, 67612.66193669049, 10309.329893557046, 10484.317965055523, 10539.947300263602, 10628.202884783672, 10667.093297069836, 20402.38792836217, 20503.69244461334, 20561.280355187497, 20640.48398790042, 20668.17327306921, 6842.521023528305, 7041.436685065182, 7054.2240353561065, 7065.92934070663, 7094.255103214191, 3713.814309284579, 3769.8869033929027, 3815.5612104608326, 3837.884863454101, 3883.3592457244804, 2670.0788228061288, 2780.291025788411, 2780.3466185446405, 2781.805273630867, 2789.302674331417, 465.4159030416805, 470.65642081280856, 479.5707841481854, 488.060483569128, 501.0105042541025, 457.2478273240501, 482.3247453565037, 504.19077380804015, 506.9011542749202, 510.85440649415483, 7430.219826918204, 7807.570583617842, 7854.450188486865, 8021.438499304993, 8367.916320836835, 427.3909678707829, 516.1418891988885, 524.2660275614095, 524.8005757812083, 534.1453674121452, 3725.739198256096, 3734.1784807342883, 3854.845806167722, 3877.185790983925, 3978.840846366171, 56741.71629141828, 59929.40070599238, 81178.59410702909, 85756.57121714352, 105726.0, 51393.486065139616, 51935.48064519382, 52639.0, 85781.0, 92405.53797230971, 47441.0, 80877.0, 81232.0, 81560.59219703864, 81807.59096204481, 7233.855322893618, 7514.892469628341, 7551.660175292015, 7556.395488360808, 7570.0, 32007.199820004687, 33005.834970825956, 44602.330965034904, 46308.768456158854, 47470.0, 64124.67937660282, 66848.33151668421, 67306.0, 67640.6617966907, 69157.65421173064, 8372.665093396196, 8402.453840500348, 8405.747827565183, 8643.0, 8711.869321960303, 10574.947125264325, 10651.467426628482, 10843.67468975932, 11172.72068198269, 11533.538658453568, 8777.736667899973, 8925.196732294125, 8993.820123597623, 9218.170364667212, 9501.524923753646, 10128.848067279145, 10141.949290253502, 10499.0, 12780.61658150257, 12834.101612887382, 11660.53357865676, 11988.400579970792, 12021.158518903943, 12115.697107572381, 12222.633321000385, 10121.190304775748, 10207.693769186937, 10574.735631609272, 10878.292910960763, 10925.688917329971, 10706.89293107059, 10762.192835537522, 10942.835857461985, 10946.890531094587, 10988.615398461016], "value": 6352.709815460647, "unit": "score"}], "name": "dromaeo_css", "value": 6373.356543571411, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 116.0, 116.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 122.0, 125.0, 182.0, 123.0, 123.0, 149.0, 121.0, 159.0, 122.0], "value": 138.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 162.0, 162.0, 163.0, 162.0, 164.0, 163.0, 163.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 139.0, 77.0, 77.0, 74.0, 76.0, 106.0, 77.0], "value": 85.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 126.0, 85.0, 86.0, 86.0, 116.0, 85.0, 86.0, 126.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 116.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 148.0, 146.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 62.0, 70.0, 64.0, 66.0, 62.0, 63.0, 64.0, 62.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 66.0, 67.0, 66.0, 67.0, 66.0, 66.0, 67.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 80.0, 81.0, 80.0, 80.0, 80.0, 85.0, 79.0, 80.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 133.0, 130.0, 128.0, 131.0, 127.0, 130.0, 132.0, 146.0, 135.0], "value": 132.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 167.0, 164.0, 166.0, 167.0, 165.0, 165.0, 164.0, 169.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 69.0, 67.0, 75.0, 67.0, 66.0, 68.0, 68.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1534.7, "alertThreshold": 2.0}]} 05:43:26 INFO - Return code: 0 05:43:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:43:26 INFO - # TBPL SUCCESS # 05:43:26 INFO - Running post-action listener: _resource_record_post_action 05:43:26 INFO - [mozharness: 2016-08-08 12:43:26.905526Z] Finished run-tests step (success) 05:43:26 INFO - Running post-run listener: _resource_record_post_run 05:43:26 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 398962688; Read time: 0; Write time: 323952 05:43:26 INFO - TinderboxPrint: CPU usage
13.0% 05:43:26 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:43:26 INFO - TinderboxPrint: I/O write bytes / time
398,962,688 / 323,952 05:43:26 INFO - TinderboxPrint: CPU idle
8,336.4 (87.0%) 05:43:26 INFO - TinderboxPrint: CPU user
1,202.2 (12.5%) 05:43:26 INFO - TinderboxPrint: Swap in / out
0 / 0 05:43:26 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115486720; Read time: 0; Write time: 89680 05:43:27 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 283475968; Read time: 0; Write time: 234272 05:43:27 INFO - Running post-run listener: _upload_blobber_files 05:43:27 INFO - Blob upload gear active. 05:43:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:43:27 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:43:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:43:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:43:27 INFO - (blobuploader) - INFO - Open directory for files ... 05:43:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:43:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:43:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:43:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:43:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:43:31 INFO - (blobuploader) - INFO - Done attempting. 05:43:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:43:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:43:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:43:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:43:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:43:32 INFO - (blobuploader) - INFO - Done attempting. 05:43:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:43:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:43:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:43:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:43:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:43:33 INFO - (blobuploader) - INFO - Done attempting. 05:43:33 INFO - (blobuploader) - INFO - Iteration through files over. 05:43:33 INFO - Return code: 0 05:43:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:43:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:43:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/371bdd13e1adbe530e64a5fb3a82fe773590bf9eff04e0a0e08c716e554753fdc5faa4aa92ed40a51bab1fd339993de646ef833671a89be737c3479a72ca2bf5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d95c9c6a96a34cf9b0b31a2582a9249eae5f7fbf3e07b9dfa3d30178271d7310a0ac45b20ad50e0474126fa95c3edf0f5c93e46b943e12e7b1cd75a61eb204a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ef7df4c3df0404efdbf9c534a87820a4275dd2e748358cf1292796e312771fbda0c3af03c1ff007418df6ec8cb09c4b50d2f408390d76178da69415d5037d839"} 05:43:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:43:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:43:33 INFO - Contents: 05:43:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/371bdd13e1adbe530e64a5fb3a82fe773590bf9eff04e0a0e08c716e554753fdc5faa4aa92ed40a51bab1fd339993de646ef833671a89be737c3479a72ca2bf5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d95c9c6a96a34cf9b0b31a2582a9249eae5f7fbf3e07b9dfa3d30178271d7310a0ac45b20ad50e0474126fa95c3edf0f5c93e46b943e12e7b1cd75a61eb204a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ef7df4c3df0404efdbf9c534a87820a4275dd2e748358cf1292796e312771fbda0c3af03c1ff007418df6ec8cb09c4b50d2f408390d76178da69415d5037d839"} 05:43:33 INFO - Running post-run listener: copy_logs_to_upload_dir 05:43:33 INFO - Copying logs to upload dir... 05:43:33 INFO - mkdir: /builds/slave/test/build/upload/logs 05:43:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.718034 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-08 05:43:29.790102) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 05:43:29.793798) ========= 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=52faae308a556c440401f8e5000001e8-1470658965.765580-1551500431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/371bdd13e1adbe530e64a5fb3a82fe773590bf9eff04e0a0e08c716e554753fdc5faa4aa92ed40a51bab1fd339993de646ef833671a89be737c3479a72ca2bf5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d95c9c6a96a34cf9b0b31a2582a9249eae5f7fbf3e07b9dfa3d30178271d7310a0ac45b20ad50e0474126fa95c3edf0f5c93e46b943e12e7b1cd75a61eb204a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ef7df4c3df0404efdbf9c534a87820a4275dd2e748358cf1292796e312771fbda0c3af03c1ff007418df6ec8cb09c4b50d2f408390d76178da69415d5037d839"} build_url:https://queue.taskcluster.net/v1/task/coaYgGDhTrGlP-4o4SJdTA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011201 build_url: 'https://queue.taskcluster.net/v1/task/coaYgGDhTrGlP-4o4SJdTA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/371bdd13e1adbe530e64a5fb3a82fe773590bf9eff04e0a0e08c716e554753fdc5faa4aa92ed40a51bab1fd339993de646ef833671a89be737c3479a72ca2bf5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d95c9c6a96a34cf9b0b31a2582a9249eae5f7fbf3e07b9dfa3d30178271d7310a0ac45b20ad50e0474126fa95c3edf0f5c93e46b943e12e7b1cd75a61eb204a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ef7df4c3df0404efdbf9c534a87820a4275dd2e748358cf1292796e312771fbda0c3af03c1ff007418df6ec8cb09c4b50d2f408390d76178da69415d5037d839"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 05:43:29.819017) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:43:29.819360) ========= 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=52faae308a556c440401f8e5000001e8-1470658965.765580-1551500431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004426 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:43:29.904012) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 05:43:29.904725) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 05:43:29.905406) ========= ========= Total master_lag: 0.16 =========