builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1472235504.98 results: success (0) buildid: 20160826111805 builduid: b7130d7dcf4d442ba0a46d0ea2003543 revision: a65b35c8e5b17c2585968974aef1da67a8c56642 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 11:18:24.977001) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 11:18:24.977551) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 11:18:24.978084) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 11:18:25.008858) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 11:18:25.009163) ========= 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=00204705a9daa57ed339a427000001b9-1472233956.215283-1561741918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-26 11:18:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2016-08-26 11:18:25 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163806 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 11:18:25.187426) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 11:18:25.187719) ========= 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=00204705a9daa57ed339a427000001b9-1472233956.215283-1561741918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020192 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 11:18:25.238147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 11:18:25.238629) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a65b35c8e5b17c2585968974aef1da67a8c56642 --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 a65b35c8e5b17c2585968974aef1da67a8c56642 --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=00204705a9daa57ed339a427000001b9-1472233956.215283-1561741918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-26 11:18:25,451 truncating revision to first 12 chars 2016-08-26 11:18:25,451 Setting DEBUG logging. 2016-08-26 11:18:25,451 attempt 1/10 2016-08-26 11:18:25,451 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a65b35c8e5b1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-26 11:18:25,794 unpacking tar archive at: fx-team-a65b35c8e5b1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.624433 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 11:18:25.877404) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 11:18:25.877776) ========= script_repo_revision: a65b35c8e5b17c2585968974aef1da67a8c56642 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 11:18:25.878174) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 11:18:25.878492) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 11:18:25.889109) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-26 11:18:25.889488) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1472233956.215283-1561741918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:18:26 INFO - MultiFileLogger online at 20160826 11:18:26 in /builds/slave/test 11:18:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:18:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:18:26 INFO - {'append_to_log': False, 11:18:26 INFO - 'base_work_dir': '/builds/slave/test', 11:18:26 INFO - 'blob_upload_branch': 'Fx-Team', 11:18:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:18:26 INFO - 'branch': 'Fx-Team', 11:18:26 INFO - 'buildbot_json_path': 'buildprops.json', 11:18:26 INFO - 'config_files': ('talos/linux_config.py',), 11:18:26 INFO - 'default_actions': ('clobber', 11:18:26 INFO - 'read-buildbot-config', 11:18:26 INFO - 'download-and-extract', 11:18:26 INFO - 'populate-webroot', 11:18:26 INFO - 'create-virtualenv', 11:18:26 INFO - 'install', 11:18:26 INFO - 'run-tests'), 11:18:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:18:26 INFO - 'download_minidump_stackwalk': True, 11:18:26 INFO - 'download_symbols': 'ondemand', 11:18:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:18:26 INFO - 'tooltool.py': '/tools/tooltool.py', 11:18:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:18:26 INFO - '/tools/misc-python/virtualenv.py')}, 11:18:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:18:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:18:26 INFO - 'installer_path': 'installer.exe', 11:18:26 INFO - 'log_level': 'info', 11:18:26 INFO - 'log_name': 'talos', 11:18:26 INFO - 'log_to_console': True, 11:18:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:18:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:18:26 INFO - 'opt_config_files': (), 11:18:26 INFO - 'pip_index': False, 11:18:26 INFO - 'sps_profile': False, 11:18:26 INFO - 'sps_profile_interval': 0, 11:18:26 INFO - 'suite': 'dromaeojs', 11:18:26 INFO - 'system_bits': '32', 11:18:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:18:26 INFO - 'title': 'talos-linux64-ix-016', 11:18:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:18:26 INFO - 'use_talos_json': True, 11:18:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:18:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:18:26 INFO - 'work_dir': 'build'} 11:18:26 INFO - [mozharness: 2016-08-26 18:18:26.197995Z] Running clobber step. 11:18:26 INFO - Running pre-action listener: _resource_record_pre_action 11:18:26 INFO - Running main action method: clobber 11:18:26 INFO - rmtree: /builds/slave/test/build 11:18:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:18:26 INFO - Running post-action listener: _resource_record_post_action 11:18:26 INFO - [mozharness: 2016-08-26 18:18:26.657921Z] Finished clobber step (success) 11:18:26 INFO - [mozharness: 2016-08-26 18:18:26.658023Z] Running read-buildbot-config step. 11:18:26 INFO - Running pre-action listener: _resource_record_pre_action 11:18:26 INFO - Running main action method: read_buildbot_config 11:18:26 INFO - Using buildbot properties: 11:18:26 INFO - { 11:18:26 INFO - "project": "", 11:18:26 INFO - "product": "firefox", 11:18:26 INFO - "script_repo_revision": "production", 11:18:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:18:26 INFO - "repository": "", 11:18:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:18:26 INFO - "buildid": "20160826111805", 11:18:26 INFO - "stage_platform": "linux64-pgo", 11:18:26 INFO - "basedir": "/builds/slave/test", 11:18:26 INFO - "buildnumber": 396, 11:18:26 INFO - "platform": "ubuntu64_hw", 11:18:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:18:26 INFO - "slavebuilddir": "test", 11:18:26 INFO - "branch": "fx-team", 11:18:26 INFO - "revision": "a65b35c8e5b17c2585968974aef1da67a8c56642", 11:18:26 INFO - "slavename": "talos-linux64-ix-016", 11:18:26 INFO - "builduid": "b7130d7dcf4d442ba0a46d0ea2003543", 11:18:26 INFO - "repo_path": "integration/fx-team" 11:18:26 INFO - } 11:18:26 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472225419/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:18:26 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472225419/firefox-51.0a1.en-US.linux-x86_64.test_packages.json. 11:18:26 INFO - Running post-action listener: _resource_record_post_action 11:18:26 INFO - [mozharness: 2016-08-26 18:18:26.660514Z] Finished read-buildbot-config step (success) 11:18:26 INFO - [mozharness: 2016-08-26 18:18:26.660604Z] Running download-and-extract step. 11:18:26 INFO - Running pre-action listener: _resource_record_pre_action 11:18:26 INFO - Running main action method: download_and_extract 11:18:26 INFO - mkdir: /builds/slave/test/build/tests 11:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:26 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472225419/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:18:26 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472225419/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 11:18:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472225419/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 11:18:26 INFO - Downloaded 1361 bytes. 11:18:26 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:18:26 INFO - Using the following test package requirements: 11:18:26 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:18:26 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:18:26 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:18:26 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:26 INFO - u'jsshell-linux-x86_64.zip'], 11:18:26 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:18:26 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:18:26 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:18:26 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:18:26 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:18:26 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:18:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:18:26 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:26 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472225419/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:18:26 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472225419/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 11:18:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472225419/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 11:18:27 INFO - Downloaded 21875225 bytes. 11:18:27 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 11:18:31 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 11:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:31 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472225419/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:18:31 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472225419/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 11:18:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472225419/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 11:18:31 INFO - Downloaded 21875225 bytes. 11:18:31 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 11:18:36 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')]} 11:18:36 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472225419/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:18:36 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472225419/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 11:18:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472225419/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 11:18:36 INFO - Downloaded 14413998 bytes. 11:18:36 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 11:18:36 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')]} 11:18:36 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472225419/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:18:36 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472225419/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 11:18:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472225419/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 11:18:37 INFO - Downloaded 59706532 bytes. 11:18:37 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472225419/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:18:37 INFO - mkdir: /builds/slave/test/properties 11:18:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:18:37 INFO - Writing to file /builds/slave/test/properties/build_url 11:18:37 INFO - Contents: 11:18:37 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472225419/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:18:38 INFO - Running post-action listener: _resource_record_post_action 11:18:38 INFO - Running post-action listener: set_extra_try_arguments 11:18:38 INFO - [mozharness: 2016-08-26 18:18:38.163225Z] Finished download-and-extract step (success) 11:18:38 INFO - [mozharness: 2016-08-26 18:18:38.163453Z] Running populate-webroot step. 11:18:38 INFO - Running pre-action listener: _resource_record_pre_action 11:18:38 INFO - Running main action method: populate_webroot 11:18:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:18:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:18:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:18:38 INFO - '--tppagecycles', 11:18:38 INFO - '7'], 11:18:38 INFO - 'tests': ['tsvgm']}}, 11:18:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:18:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:18:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:18:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:18:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:18:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:18:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:38 INFO - 'talos_options': ['--disable-e10s'], 11:18:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:18:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:18:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:38 INFO - 'talos_options': ['--disable-e10s'], 11:18:38 INFO - 'tests': ['damp', 'tps']}, 11:18:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:38 INFO - 'tests': ['damp', 'tps']}, 11:18:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:18:38 INFO - 'tests': ['dromaeo_dom']}, 11:18:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:18:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:18:38 INFO - 'tests': ['basic_compositor_video']}, 11:18:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:18:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:18:38 INFO - 'tests': ['a11yr', 11:18:38 INFO - 'ts_paint', 11:18:38 INFO - 'tpaint', 11:18:38 INFO - 'sessionrestore', 11:18:38 INFO - 'sessionrestore_no_auto_restore', 11:18:38 INFO - 'tabpaint']}, 11:18:38 INFO - 'other-e10s': {'tests': ['a11yr', 11:18:38 INFO - 'ts_paint', 11:18:38 INFO - 'tpaint', 11:18:38 INFO - 'sessionrestore', 11:18:38 INFO - 'sessionrestore_no_auto_restore', 11:18:38 INFO - 'tabpaint']}, 11:18:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:18:38 INFO - 'ts_paint', 11:18:38 INFO - 'tpaint', 11:18:38 INFO - 'sessionrestore', 11:18:38 INFO - 'sessionrestore_no_auto_restore', 11:18:38 INFO - 'tabpaint']}, 11:18:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:18:38 INFO - 'ts_paint', 11:18:38 INFO - 'tpaint', 11:18:38 INFO - 'sessionrestore', 11:18:38 INFO - 'sessionrestore_no_auto_restore', 11:18:38 INFO - 'tabpaint']}, 11:18:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:18:38 INFO - 'tests': ['a11yr', 11:18:38 INFO - 'ts_paint', 11:18:38 INFO - 'tpaint', 11:18:38 INFO - 'sessionrestore', 11:18:38 INFO - 'sessionrestore_no_auto_restore', 11:18:38 INFO - 'tabpaint']}, 11:18:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:18:38 INFO - 'tests': ['a11yr', 11:18:38 INFO - 'ts_paint', 11:18:38 INFO - 'tpaint', 11:18:38 INFO - 'sessionrestore', 11:18:38 INFO - 'sessionrestore_no_auto_restore', 11:18:38 INFO - 'tabpaint']}, 11:18:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:18:38 INFO - 'tests': ['tsvgx', 11:18:38 INFO - 'tsvgr_opacity', 11:18:38 INFO - 'tart', 11:18:38 INFO - 'tscrollx', 11:18:38 INFO - 'cart']}, 11:18:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:18:38 INFO - 'tsvgr_opacity', 11:18:38 INFO - 'tart', 11:18:38 INFO - 'tscrollx', 11:18:38 INFO - 'cart']}, 11:18:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:38 INFO - 'talos_options': ['--disable-e10s'], 11:18:38 INFO - 'tests': ['tp5o']}, 11:18:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:38 INFO - 'tests': ['tp5o']}, 11:18:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:38 INFO - 'talos_options': ['--disable-e10s', 11:18:38 INFO - '--xperf_path', 11:18:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:18:38 INFO - 'tests': ['tp5n']}, 11:18:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:38 INFO - 'talos_options': ['--xperf_path', 11:18:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:18:38 INFO - 'tests': ['tp5n']}}, 11:18:38 INFO - 'talos.zip': {'path': '', 11:18:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:18:38 INFO - Running post-action listener: _resource_record_post_action 11:18:38 INFO - [mozharness: 2016-08-26 18:18:38.182258Z] Finished populate-webroot step (success) 11:18:38 INFO - [mozharness: 2016-08-26 18:18:38.182348Z] Running create-virtualenv step. 11:18:38 INFO - Running pre-action listener: _resource_record_pre_action 11:18:38 INFO - Running main action method: create_virtualenv 11:18:38 INFO - Creating virtualenv /builds/slave/test/build/venv 11:18:38 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 11:18:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:18:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:18:38 INFO - Using real prefix '/usr' 11:18:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:18:38 INFO - Installing distribute.............................................................................................................................................................................................done. 11:18:40 INFO - Installing pip.................done. 11:18:40 INFO - Return code: 0 11:18:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:18:40 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')]} 11:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:40 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')]} 11:18:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:40 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 0x7f8149b28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2039370>, '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 0x203c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203cd80>, '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': '00204705a9daa57ed339a427000001b9-1472233956.215283-1561741918', '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 11:18:40 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 11:18:40 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 11:18:40 INFO - Using env: {'DISPLAY': ':0', 11:18:40 INFO - 'HOME': '/home/cltbld', 11:18:40 INFO - 'LANG': 'en_US.UTF-8', 11:18:40 INFO - 'LANGUAGE': 'en_US:en', 11:18:40 INFO - 'LOGNAME': 'cltbld', 11:18:40 INFO - 'MAIL': '/var/mail/cltbld', 11:18:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:40 INFO - 'MOZ_NO_REMOTE': '1', 11:18:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:40 INFO - 'NO_EM_RESTART': '1', 11:18:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:40 INFO - 'PWD': '/builds/slave/test', 11:18:40 INFO - 'SHELL': '/bin/bash', 11:18:40 INFO - 'SHLVL': '1', 11:18:40 INFO - 'TERM': 'linux', 11:18:40 INFO - 'TMOUT': '86400', 11:18:40 INFO - 'USER': 'cltbld', 11:18:40 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1472233956.215283-1561741918', 11:18:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:40 INFO - '_': '/tools/buildbot/bin/python'} 11:18:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:40 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 11:18:40 INFO - Cleaning up... 11:18:41 INFO - Return code: 0 11:18:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:18: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')]} 11:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18: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')]} 11:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:41 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 0x7f8149b28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2039370>, '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 0x203c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203cd80>, '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': '00204705a9daa57ed339a427000001b9-1472233956.215283-1561741918', '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 11:18:41 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 11:18:41 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 11:18:41 INFO - Using env: {'DISPLAY': ':0', 11:18:41 INFO - 'HOME': '/home/cltbld', 11:18:41 INFO - 'LANG': 'en_US.UTF-8', 11:18:41 INFO - 'LANGUAGE': 'en_US:en', 11:18:41 INFO - 'LOGNAME': 'cltbld', 11:18:41 INFO - 'MAIL': '/var/mail/cltbld', 11:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:41 INFO - 'MOZ_NO_REMOTE': '1', 11:18:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:41 INFO - 'NO_EM_RESTART': '1', 11:18:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:41 INFO - 'PWD': '/builds/slave/test', 11:18:41 INFO - 'SHELL': '/bin/bash', 11:18:41 INFO - 'SHLVL': '1', 11:18:41 INFO - 'TERM': 'linux', 11:18:41 INFO - 'TMOUT': '86400', 11:18:41 INFO - 'USER': 'cltbld', 11:18:41 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1472233956.215283-1561741918', 11:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:41 INFO - '_': '/tools/buildbot/bin/python'} 11:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:41 INFO - Downloading/unpacking psutil>=3.1.1 11:18:41 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 11:18:41 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 11:18:41 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 11:18:41 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 11:18:41 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 11:18:41 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 11:18:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:18:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:18:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:18:43 INFO - Installing collected packages: psutil 11:18:43 INFO - Running setup.py install for psutil 11:18:43 INFO - building 'psutil._psutil_linux' extension 11:18:43 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 11:18:43 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 11:18:43 INFO - building 'psutil._psutil_posix' extension 11:18:43 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 11:18:43 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 11:18:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:18:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:18:43 INFO - Successfully installed psutil 11:18:43 INFO - Cleaning up... 11:18:43 INFO - Return code: 0 11:18:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:18:43 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')]} 11:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:43 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')]} 11:18:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:43 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 0x7f8149b28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2039370>, '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 0x203c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203cd80>, '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': '00204705a9daa57ed339a427000001b9-1472233956.215283-1561741918', '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 11:18:43 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 11:18:43 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 11:18:43 INFO - Using env: {'DISPLAY': ':0', 11:18:43 INFO - 'HOME': '/home/cltbld', 11:18:43 INFO - 'LANG': 'en_US.UTF-8', 11:18:43 INFO - 'LANGUAGE': 'en_US:en', 11:18:43 INFO - 'LOGNAME': 'cltbld', 11:18:43 INFO - 'MAIL': '/var/mail/cltbld', 11:18:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:43 INFO - 'MOZ_NO_REMOTE': '1', 11:18:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:43 INFO - 'NO_EM_RESTART': '1', 11:18:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:43 INFO - 'PWD': '/builds/slave/test', 11:18:43 INFO - 'SHELL': '/bin/bash', 11:18:43 INFO - 'SHLVL': '1', 11:18:43 INFO - 'TERM': 'linux', 11:18:43 INFO - 'TMOUT': '86400', 11:18:43 INFO - 'USER': 'cltbld', 11:18:43 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1472233956.215283-1561741918', 11:18:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:43 INFO - '_': '/tools/buildbot/bin/python'} 11:18:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:18:43 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 11:18:43 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 11:18:43 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 11:18:43 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 11:18:43 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 11:18:43 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 11:18:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:18:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:18:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:18:45 INFO - Installing collected packages: mozsystemmonitor 11:18:45 INFO - Running setup.py install for mozsystemmonitor 11:18:45 INFO - Successfully installed mozsystemmonitor 11:18:45 INFO - Cleaning up... 11:18:46 INFO - Return code: 0 11:18:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:18:46 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')]} 11:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:46 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')]} 11:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:46 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 0x7f8149b28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2039370>, '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 0x203c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203cd80>, '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': '00204705a9daa57ed339a427000001b9-1472233956.215283-1561741918', '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 11:18:46 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 11:18:46 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 11:18:46 INFO - Using env: {'DISPLAY': ':0', 11:18:46 INFO - 'HOME': '/home/cltbld', 11:18:46 INFO - 'LANG': 'en_US.UTF-8', 11:18:46 INFO - 'LANGUAGE': 'en_US:en', 11:18:46 INFO - 'LOGNAME': 'cltbld', 11:18:46 INFO - 'MAIL': '/var/mail/cltbld', 11:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:46 INFO - 'MOZ_NO_REMOTE': '1', 11:18:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:46 INFO - 'NO_EM_RESTART': '1', 11:18:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:46 INFO - 'PWD': '/builds/slave/test', 11:18:46 INFO - 'SHELL': '/bin/bash', 11:18:46 INFO - 'SHLVL': '1', 11:18:46 INFO - 'TERM': 'linux', 11:18:46 INFO - 'TMOUT': '86400', 11:18:46 INFO - 'USER': 'cltbld', 11:18:46 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1472233956.215283-1561741918', 11:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:46 INFO - '_': '/tools/buildbot/bin/python'} 11:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:46 INFO - Downloading/unpacking jsonschema==2.5.1 11:18:46 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 11:18:46 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 11:18:46 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 11:18:46 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 11:18:46 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 11:18:46 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 11:18:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:18:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:18:48 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 11:18:48 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 11:18:48 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 11:18:48 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 11:18:48 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 11:18:48 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 11:18:48 INFO - Downloading functools32-3.2.3-2.tar.gz 11:18:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:18:48 INFO - warning: no files found matching '*.txt' 11:18:48 INFO - no previously-included directories found matching 'build' 11:18:48 INFO - no previously-included directories found matching 'dist' 11:18:48 INFO - no previously-included directories found matching '.git*' 11:18:48 INFO - Installing collected packages: jsonschema, functools32 11:18:48 INFO - Running setup.py install for functools32 11:18:48 INFO - warning: no files found matching '*.txt' 11:18:48 INFO - no previously-included directories found matching 'build' 11:18:48 INFO - no previously-included directories found matching 'dist' 11:18:48 INFO - no previously-included directories found matching '.git*' 11:18:48 INFO - Successfully installed jsonschema functools32 11:18:48 INFO - Cleaning up... 11:18:48 INFO - Return code: 0 11:18:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:18:48 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')]} 11:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:48 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')]} 11:18:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:48 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 0x7f8149b28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2039370>, '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 0x203c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203cd80>, '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': '00204705a9daa57ed339a427000001b9-1472233956.215283-1561741918', '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 11:18:48 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 11:18:48 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 11:18:48 INFO - Using env: {'DISPLAY': ':0', 11:18:48 INFO - 'HOME': '/home/cltbld', 11:18:48 INFO - 'LANG': 'en_US.UTF-8', 11:18:48 INFO - 'LANGUAGE': 'en_US:en', 11:18:48 INFO - 'LOGNAME': 'cltbld', 11:18:48 INFO - 'MAIL': '/var/mail/cltbld', 11:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:48 INFO - 'MOZ_NO_REMOTE': '1', 11:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:48 INFO - 'NO_EM_RESTART': '1', 11:18:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:48 INFO - 'PWD': '/builds/slave/test', 11:18:48 INFO - 'SHELL': '/bin/bash', 11:18:48 INFO - 'SHLVL': '1', 11:18:48 INFO - 'TERM': 'linux', 11:18:48 INFO - 'TMOUT': '86400', 11:18:48 INFO - 'USER': 'cltbld', 11:18:48 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1472233956.215283-1561741918', 11:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:48 INFO - '_': '/tools/buildbot/bin/python'} 11:18:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:18:48 INFO - Cleaning up... 11:18:48 INFO - Return code: 0 11:18:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:18:48 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')]} 11:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:48 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')]} 11:18:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:48 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 0x7f8149b28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2039370>, '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 0x203c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203cd80>, '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': '00204705a9daa57ed339a427000001b9-1472233956.215283-1561741918', '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 11:18:48 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 11:18:48 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 11:18:48 INFO - Using env: {'DISPLAY': ':0', 11:18:48 INFO - 'HOME': '/home/cltbld', 11:18:48 INFO - 'LANG': 'en_US.UTF-8', 11:18:48 INFO - 'LANGUAGE': 'en_US:en', 11:18:48 INFO - 'LOGNAME': 'cltbld', 11:18:48 INFO - 'MAIL': '/var/mail/cltbld', 11:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:48 INFO - 'MOZ_NO_REMOTE': '1', 11:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:48 INFO - 'NO_EM_RESTART': '1', 11:18:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:48 INFO - 'PWD': '/builds/slave/test', 11:18:48 INFO - 'SHELL': '/bin/bash', 11:18:48 INFO - 'SHLVL': '1', 11:18:48 INFO - 'TERM': 'linux', 11:18:48 INFO - 'TMOUT': '86400', 11:18:48 INFO - 'USER': 'cltbld', 11:18:48 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1472233956.215283-1561741918', 11:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:48 INFO - '_': '/tools/buildbot/bin/python'} 11:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:49 INFO - Downloading/unpacking blobuploader==1.2.4 11:18:49 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 11:18:49 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 11:18:49 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 11:18:49 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 11:18:49 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 11:18:49 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 11:18:50 INFO - Downloading blobuploader-1.2.4.tar.gz 11:18:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:18:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:18:50 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 11:18:50 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 11:18:50 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 11:18:50 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 11:18:50 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 11:18:50 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 11:18:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:18:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:18:51 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 11:18:51 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 11:18:51 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 11:18:51 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 11:18:51 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 11:18:51 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 11:18:51 INFO - Downloading docopt-0.6.1.tar.gz 11:18:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:18:51 INFO - Installing collected packages: blobuploader, requests, docopt 11:18:51 INFO - Running setup.py install for blobuploader 11:18:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:18:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:18:51 INFO - Running setup.py install for requests 11:18:52 INFO - Running setup.py install for docopt 11:18:52 INFO - Successfully installed blobuploader requests docopt 11:18:52 INFO - Cleaning up... 11:18:52 INFO - Return code: 0 11:18:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:52 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 0x7f8149b28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2039370>, '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 0x203c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203cd80>, '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': '00204705a9daa57ed339a427000001b9-1472233956.215283-1561741918', '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 11:18:52 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 11:18:52 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 11:18:52 INFO - Using env: {'DISPLAY': ':0', 11:18:52 INFO - 'HOME': '/home/cltbld', 11:18:52 INFO - 'LANG': 'en_US.UTF-8', 11:18:52 INFO - 'LANGUAGE': 'en_US:en', 11:18:52 INFO - 'LOGNAME': 'cltbld', 11:18:52 INFO - 'MAIL': '/var/mail/cltbld', 11:18:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:52 INFO - 'MOZ_NO_REMOTE': '1', 11:18:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:52 INFO - 'NO_EM_RESTART': '1', 11:18:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:52 INFO - 'PWD': '/builds/slave/test', 11:18:52 INFO - 'SHELL': '/bin/bash', 11:18:52 INFO - 'SHLVL': '1', 11:18:52 INFO - 'TERM': 'linux', 11:18:52 INFO - 'TMOUT': '86400', 11:18:52 INFO - 'USER': 'cltbld', 11:18:52 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1472233956.215283-1561741918', 11:18:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:52 INFO - '_': '/tools/buildbot/bin/python'} 11:18:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:18:52 INFO - Running setup.py (path:/tmp/pip-4Mro0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:18:52 INFO - Running setup.py (path:/tmp/pip-S7BFI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:18:52 INFO - Running setup.py (path:/tmp/pip-YZy3vT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:18:52 INFO - Running setup.py (path:/tmp/pip-JODqkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:18:52 INFO - Running setup.py (path:/tmp/pip-uNdr9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:18:52 INFO - Running setup.py (path:/tmp/pip-ZlKxcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:18:52 INFO - Running setup.py (path:/tmp/pip-0LY4HK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:18:52 INFO - Running setup.py (path:/tmp/pip-KLcwqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:18:53 INFO - Running setup.py (path:/tmp/pip-pbu4a6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:18:53 INFO - Running setup.py (path:/tmp/pip-rVaRqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:18:53 INFO - Running setup.py (path:/tmp/pip-SqijkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:18:53 INFO - Running setup.py (path:/tmp/pip-mgu1xG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:18:53 INFO - Running setup.py (path:/tmp/pip-u0z7XW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:18:53 INFO - Running setup.py (path:/tmp/pip-P1q21T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:53 INFO - Running setup.py (path:/tmp/pip-o76Vph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:18:53 INFO - Running setup.py (path:/tmp/pip-VYHBTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:18:53 INFO - Running setup.py (path:/tmp/pip-zjnnYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:18:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:18:53 INFO - Running setup.py install for manifestparser 11:18:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:18:53 INFO - Running setup.py install for mozcrash 11:18:53 INFO - Running setup.py install for mozdebug 11:18:54 INFO - Running setup.py install for mozdevice 11:18:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:18:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:18:54 INFO - Running setup.py install for mozfile 11:18:54 INFO - Running setup.py install for mozhttpd 11:18:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:18:54 INFO - Running setup.py install for mozinfo 11:18:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:18:54 INFO - Running setup.py install for mozInstall 11:18:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:18:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:18:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:18:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:18:54 INFO - Running setup.py install for mozleak 11:18:54 INFO - Running setup.py install for mozlog 11:18:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:18:54 INFO - Running setup.py install for moznetwork 11:18:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:18:54 INFO - Running setup.py install for mozprocess 11:18:54 INFO - Running setup.py install for mozprofile 11:18:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:18:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:18:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:18:55 INFO - Running setup.py install for mozrunner 11:18:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:18:55 INFO - Running setup.py install for mozscreenshot 11:18:55 INFO - Running setup.py install for moztest 11:18:55 INFO - Running setup.py install for mozversion 11:18:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:18:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:18:55 INFO - Cleaning up... 11:18:55 INFO - Return code: 0 11:18:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:55 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 0x7f8149b28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2039370>, '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 0x203c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203cd80>, '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': '00204705a9daa57ed339a427000001b9-1472233956.215283-1561741918', '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 11:18:55 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 11:18:55 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 11:18:55 INFO - Using env: {'DISPLAY': ':0', 11:18:55 INFO - 'HOME': '/home/cltbld', 11:18:55 INFO - 'LANG': 'en_US.UTF-8', 11:18:55 INFO - 'LANGUAGE': 'en_US:en', 11:18:55 INFO - 'LOGNAME': 'cltbld', 11:18:55 INFO - 'MAIL': '/var/mail/cltbld', 11:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:55 INFO - 'MOZ_NO_REMOTE': '1', 11:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:55 INFO - 'NO_EM_RESTART': '1', 11:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:55 INFO - 'PWD': '/builds/slave/test', 11:18:55 INFO - 'SHELL': '/bin/bash', 11:18:55 INFO - 'SHLVL': '1', 11:18:55 INFO - 'TERM': 'linux', 11:18:55 INFO - 'TMOUT': '86400', 11:18:55 INFO - 'USER': 'cltbld', 11:18:55 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1472233956.215283-1561741918', 11:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:55 INFO - '_': '/tools/buildbot/bin/python'} 11:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:18:55 INFO - Running setup.py (path:/tmp/pip-G8G4l0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:18:55 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)) 11:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:18:55 INFO - Running setup.py (path:/tmp/pip-ACGaC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:18:55 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)) 11:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:18:55 INFO - Running setup.py (path:/tmp/pip-0kw0bT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:18:55 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)) 11:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:18:55 INFO - Running setup.py (path:/tmp/pip-R5lCzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:18:56 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)) 11:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:18:56 INFO - Running setup.py (path:/tmp/pip-Ch7pr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:18:56 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)) 11:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:18:56 INFO - Running setup.py (path:/tmp/pip-Ph_5yG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:18:56 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)) 11:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:18:56 INFO - Running setup.py (path:/tmp/pip-i3PdPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:18:56 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)) 11:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:18:56 INFO - Running setup.py (path:/tmp/pip-562vS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:18:56 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)) 11:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:18:56 INFO - Running setup.py (path:/tmp/pip-58Hi9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:18:56 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)) 11:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:18:56 INFO - Running setup.py (path:/tmp/pip-hLFxQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:18:56 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)) 11:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:18:56 INFO - Running setup.py (path:/tmp/pip-_XX5qV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:18:56 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)) 11:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:18:56 INFO - Running setup.py (path:/tmp/pip-uWGMX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:18:56 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)) 11:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:18:56 INFO - Running setup.py (path:/tmp/pip-JRQ7v6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:18:56 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)) 11:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:18:56 INFO - Running setup.py (path:/tmp/pip-k6kvoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:18:56 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)) 11:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:56 INFO - Running setup.py (path:/tmp/pip-EsKSUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:56 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)) 11:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:18:56 INFO - Running setup.py (path:/tmp/pip-3eywkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:18:56 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)) 11:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:18:56 INFO - Running setup.py (path:/tmp/pip-NXyQm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:18:56 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)) 11:18:56 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)) 11:18:56 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)) 11:18:56 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)) 11:18:56 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)) 11:18:56 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)) 11:18:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:18:56 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 11:18:56 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 11:18:56 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 11:18:56 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 11:18:56 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 11:18:56 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 11:18:58 INFO - Downloading blessings-1.6.tar.gz 11:18:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:18:58 INFO - Installing collected packages: blessings 11:18:58 INFO - Running setup.py install for blessings 11:18:59 INFO - Successfully installed blessings 11:18:59 INFO - Cleaning up... 11:18:59 INFO - Return code: 0 11:18:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:18:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:18:59 INFO - Reading from file tmpfile_stdout 11:18:59 INFO - Current package versions: 11:18:59 INFO - argparse == 1.2.1 11:18:59 INFO - blessings == 1.6 11:18:59 INFO - blobuploader == 1.2.4 11:18:59 INFO - docopt == 0.6.1 11:18:59 INFO - functools32 == 3.2.3-2 11:18:59 INFO - jsonschema == 2.5.1 11:18:59 INFO - manifestparser == 1.1 11:18:59 INFO - mozInstall == 1.12 11:18:59 INFO - mozcrash == 0.17 11:18:59 INFO - mozdebug == 0.1 11:18:59 INFO - mozdevice == 0.48 11:18:59 INFO - mozfile == 1.2 11:18:59 INFO - mozhttpd == 0.7 11:18:59 INFO - mozinfo == 0.9 11:18:59 INFO - mozleak == 0.1 11:18:59 INFO - mozlog == 3.3 11:18:59 INFO - moznetwork == 0.27 11:18:59 INFO - mozprocess == 0.23 11:18:59 INFO - mozprofile == 0.28 11:18:59 INFO - mozrunner == 6.12 11:18:59 INFO - mozscreenshot == 0.1 11:18:59 INFO - mozsystemmonitor == 0.3 11:18:59 INFO - moztest == 0.7 11:18:59 INFO - mozversion == 1.4 11:18:59 INFO - psutil == 3.1.1 11:18:59 INFO - requests == 1.2.3 11:18:59 INFO - wsgiref == 0.1.2 11:18:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:59 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 0x7f8149b28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2039370>, '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 0x203c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203cd80>, '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': '00204705a9daa57ed339a427000001b9-1472233956.215283-1561741918', '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 11:18:59 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 11:18:59 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 11:18:59 INFO - Using env: {'DISPLAY': ':0', 11:18:59 INFO - 'HOME': '/home/cltbld', 11:18:59 INFO - 'LANG': 'en_US.UTF-8', 11:18:59 INFO - 'LANGUAGE': 'en_US:en', 11:18:59 INFO - 'LOGNAME': 'cltbld', 11:18:59 INFO - 'MAIL': '/var/mail/cltbld', 11:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:59 INFO - 'MOZ_NO_REMOTE': '1', 11:18:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:59 INFO - 'NO_EM_RESTART': '1', 11:18:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:59 INFO - 'PWD': '/builds/slave/test', 11:18:59 INFO - 'SHELL': '/bin/bash', 11:18:59 INFO - 'SHLVL': '1', 11:18:59 INFO - 'TERM': 'linux', 11:18:59 INFO - 'TMOUT': '86400', 11:18:59 INFO - 'USER': 'cltbld', 11:18:59 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1472233956.215283-1561741918', 11:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:59 INFO - '_': '/tools/buildbot/bin/python'} 11:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:59 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)) 11:18:59 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)) 11:18:59 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)) 11:18:59 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)) 11:18:59 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)) 11:18:59 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)) 11:18:59 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)) 11:18:59 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)) 11:18:59 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)) 11:18:59 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)) 11:18:59 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)) 11:18:59 INFO - Cleaning up... 11:18:59 INFO - Return code: 0 11:18:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:59 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 0x7f8149b28f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x203e850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2039370>, '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 0x203c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203cd80>, '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': '00204705a9daa57ed339a427000001b9-1472233956.215283-1561741918', '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 11:18:59 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 11:18:59 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 11:18:59 INFO - Using env: {'DISPLAY': ':0', 11:18:59 INFO - 'HOME': '/home/cltbld', 11:18:59 INFO - 'LANG': 'en_US.UTF-8', 11:18:59 INFO - 'LANGUAGE': 'en_US:en', 11:18:59 INFO - 'LOGNAME': 'cltbld', 11:18:59 INFO - 'MAIL': '/var/mail/cltbld', 11:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:59 INFO - 'MOZ_NO_REMOTE': '1', 11:18:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:59 INFO - 'NO_EM_RESTART': '1', 11:18:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:59 INFO - 'PWD': '/builds/slave/test', 11:18:59 INFO - 'SHELL': '/bin/bash', 11:18:59 INFO - 'SHLVL': '1', 11:18:59 INFO - 'TERM': 'linux', 11:18:59 INFO - 'TMOUT': '86400', 11:18:59 INFO - 'USER': 'cltbld', 11:18:59 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1472233956.215283-1561741918', 11:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:59 INFO - '_': '/tools/buildbot/bin/python'} 11:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:18:59 INFO - Cleaning up... 11:18:59 INFO - Return code: 0 11:18:59 INFO - Running post-action listener: _resource_record_post_action 11:18:59 INFO - Running post-action listener: _start_resource_monitoring 11:18:59 INFO - Starting resource monitoring. 11:18:59 INFO - [mozharness: 2016-08-26 18:18:59.799867Z] Finished create-virtualenv step (success) 11:18:59 INFO - [mozharness: 2016-08-26 18:18:59.800476Z] Running install step. 11:18:59 INFO - Running pre-action listener: _resource_record_pre_action 11:18:59 INFO - Running main action method: install 11:18:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:19:00 INFO - Reading from file tmpfile_stdout 11:19:00 INFO - Detecting whether we're running mozinstall >=1.0... 11:19:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:19:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:19:00 INFO - Reading from file tmpfile_stdout 11:19:00 INFO - Output received: 11:19:00 INFO - Usage: mozinstall [options] installer 11:19:00 INFO - Options: 11:19:00 INFO - -h, --help show this help message and exit 11:19:00 INFO - -d DEST, --destination=DEST 11:19:00 INFO - Directory to install application into. [default: 11:19:00 INFO - "/builds/slave/test"] 11:19:00 INFO - --app=APP Application being installed. [default: firefox] 11:19:00 INFO - mkdir: /builds/slave/test/build/application 11:19:00 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'] 11:19:00 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 11:19:17 INFO - Reading from file tmpfile_stdout 11:19:17 INFO - Output received: 11:19:17 INFO - /builds/slave/test/build/application/firefox/firefox 11:19:17 INFO - Running post-action listener: _resource_record_post_action 11:19:17 INFO - [mozharness: 2016-08-26 18:19:17.099705Z] Finished install step (success) 11:19:17 INFO - [mozharness: 2016-08-26 18:19:17.099958Z] Running run-tests step. 11:19:17 INFO - Running pre-action listener: _resource_record_pre_action 11:19:17 INFO - Running main action method: run_tests 11:19:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:19:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:19:17 INFO - Python 2.7.3 11:19:17 INFO - Return code: 0 11:19:17 INFO - grabbing minidump binary from tooltool 11:19: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')]} 11:19:17 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 0x2039370>, '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 0x203c8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203cd80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:19:17 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 11:19:17 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 11:19:17 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 11:19:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:19:17 INFO - Return code: 0 11:19:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:19:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:19:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:19:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:19:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:19:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472225419/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 11:19:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472225419/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 11:19:17 INFO - Using env: {'DISPLAY': ':0', 11:19:17 INFO - 'HOME': '/home/cltbld', 11:19:17 INFO - 'LANG': 'en_US.UTF-8', 11:19:17 INFO - 'LANGUAGE': 'en_US:en', 11:19:17 INFO - 'LOGNAME': 'cltbld', 11:19:17 INFO - 'MAIL': '/var/mail/cltbld', 11:19:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:19:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:17 INFO - 'MOZ_NO_REMOTE': '1', 11:19:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:19:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:19:17 INFO - 'NO_EM_RESTART': '1', 11:19:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:17 INFO - 'PWD': '/builds/slave/test', 11:19:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:19:17 INFO - 'SHELL': '/bin/bash', 11:19:17 INFO - 'SHLVL': '1', 11:19:17 INFO - 'TERM': 'linux', 11:19:17 INFO - 'TMOUT': '86400', 11:19:17 INFO - 'USER': 'cltbld', 11:19:17 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1472233956.215283-1561741918', 11:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:17 INFO - '_': '/tools/buildbot/bin/python'} 11:19:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472225419/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 11:19:17 INFO - mozversion application_buildid: 20160826083019 11:19:17 INFO - mozversion application_changeset: a65b35c8e5b17c2585968974aef1da67a8c56642 11:19:17 INFO - mozversion application_display_name: Nightly 11:19:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:19:17 INFO - mozversion application_name: Firefox 11:19:17 INFO - mozversion application_remotingname: firefox 11:19:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:19:17 INFO - mozversion application_vendor: Mozilla 11:19:17 INFO - mozversion application_version: 51.0a1 11:19:17 INFO - mozversion platform_buildid: 20160826083019 11:19:17 INFO - mozversion platform_changeset: a65b35c8e5b17c2585968974aef1da67a8c56642 11:19:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:19:17 INFO - mozversion platform_version: 51.0a1 11:19:17 INFO - using testdate: 1472235557 11:19:17 INFO - actual date: 1472235557 11:19:17 INFO - starting webserver on 'localhost:46363' 11:19:17 INFO - SUITE-START | Running 2 tests 11:19:17 INFO - TEST-START | dromaeo_css 11:19:17 INFO - operating with platform_type : linux_ 11:19:17 INFO - Initialising browser for dromaeo_css test... 11:19:17 INFO - TEST-INFO | started process 13542 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp7ZXlO/profile http://localhost:46363/getInfo.html) 11:19:21 INFO - PROCESS | 13542 | __metrics Screen width/height:1600/1200 11:19:21 INFO - PROCESS | 13542 | colorDepth:24 11:19:21 INFO - PROCESS | 13542 | Browser inner width/height: 1024/697 11:19:21 INFO - PROCESS | 13542 | __metrics 11:19:22 INFO - PROCESS | 13542 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:19:22 INFO - PROCESS | 13542 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:19:22 INFO - PROCESS | 13542 | console.error: PushService: 11:19:22 INFO - PROCESS | 13542 | stateChangeProcessEnqueue: Error transitioning state 11:19:22 INFO - PROCESS | 13542 | UnknownError 11:19:23 INFO - TEST-INFO | 13542: exit 0 11:19:23 INFO - Browser initialized. 11:19:23 INFO - Running cycle 1/1 for dromaeo_css test... 11:19:23 INFO - TEST-INFO | started process 13626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp7ZXlO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:19:35 INFO - PROCESS | 13626 | RSS: Main: 179224576 11:19:35 INFO - PROCESS | 13626 | 11:20:27 INFO - PROCESS | 13626 | 1472235627014 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] 11:22:36 INFO - PROCESS | 13626 | Cycle 1(1): loaded http://localhost:46363/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46363/tests/dromaeo/cssquery-ext.html) 11:22:37 INFO - PROCESS | 13626 | RSS: Main: 326475776 11:22:37 INFO - PROCESS | 13626 | 11:25:40 INFO - PROCESS | 13626 | Cycle 1(1): loaded http://localhost:46363/tests/dromaeo/cssquery-ext.html (next: http://localhost:46363/tests/dromaeo/cssquery-jquery.html) 11:25:40 INFO - PROCESS | 13626 | RSS: Main: 269094912 11:25:40 INFO - PROCESS | 13626 | 11:28:42 INFO - PROCESS | 13626 | Cycle 1(1): loaded http://localhost:46363/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46363/tests/dromaeo/cssquery-mootools.html) 11:28:43 INFO - PROCESS | 13626 | RSS: Main: 212353024 11:28:43 INFO - PROCESS | 13626 | 11:31:45 INFO - PROCESS | 13626 | Cycle 1(1): loaded http://localhost:46363/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46363/tests/dromaeo/cssquery-prototype.html) 11:31:46 INFO - PROCESS | 13626 | RSS: Main: 252928000 11:31:46 INFO - PROCESS | 13626 | 11:34:48 INFO - PROCESS | 13626 | Cycle 1(1): loaded http://localhost:46363/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46363/tests/dromaeo/cssquery-yui.html) 11:34:49 INFO - PROCESS | 13626 | RSS: Main: 215552000 11:34:49 INFO - PROCESS | 13626 | 11:37:52 INFO - PROCESS | 13626 | Cycle 1(1): loaded http://localhost:46363/tests/dromaeo/cssquery-yui.html (next: http://localhost:46363/tests/dromaeo/cssquery-dojo.html) 11:37:52 INFO - PROCESS | 13626 | RSS: Main: 305909760 11:37:52 INFO - PROCESS | 13626 | 11:37:52 INFO - PROCESS | 13626 | __start_tp_report 11:37:52 INFO - PROCESS | 13626 | _x_x_mozilla_page_load 11:37:52 INFO - PROCESS | 13626 | _x_x_mozilla_page_load_details 11:37:52 INFO - PROCESS | 13626 | |i|pagename|runs| 11:37:52 INFO - PROCESS | 13626 | |0;dojo.html;3001.0396673064615;3012.7589792816575;3019.0188188838633;3024.5311976643616;3059.4492991261577;4963.329950456688;5032.345795046639;5153.510416510435;5231.424543300239;5268.789248430058;5091.898162036757;5247.449017853128;5344.545713614348;5354.036273470773;5433.0763770159065;4739.0758802033615;4774.331593576902;4811.30236115763;4866.853994380165;4879.536444037811;4754.405699287589;4857.052874689437;4946.579540739023;4956.578690811285;4961.553460188582;4874.829380971667;4890.877728056791;4896.583790377822;4904.509549045102;4924.28597853311;4600.5169457207185;4719.457262414832;4768.618510519184;4783.473817880031;4825.710457372569;4637.489876113625;4649.976750116261;4677;4720.929186062212;4778.402699662543;5174.818881339173;5204.505571970657;5213.3743950725775;5220.608454365938;5232.084385232569;5371.785128594891;5490;5540.418256083134;5548.611597188198;5553.305836770403;5535.750891209906;5587.776488940438;5600.775968961237;5603;5673.23411339468;5262.552683021948;5272.340957380327;5274.26160337553;5276.3140791697215;5280.419153893069;5492.47821456961;5670.546356291569;5726.885462290731;5732.082866741302;5814.970925145347;5512.724363781795;5521.69630670317;5521.779128834882;5523.7790488380815;5524.8066317679495;5539.19681646159;5541.944580554143;5544.805931792368;5546.694931778791;5582.888342233133;5290.841274761763;5475;5572.582056345709;5592.3009623797025;5684.204211410406;5615.0454422748235;5622.409646987089;5623.5220006299105;5623.578231632562;5687.232223649837;4370.409994650745;4379.255526560492;4381.496127945327;4383.430154080013;4394.846180383735;3811.0472381904524;3879.7284190106984;3882.6311500407414;3926.4895563577124;3927.6857851371824;5398.892022159614;5400.621956463088;5401.054815407288;5438.945610543844;5465.754041068161;5683.26117604717;5688;5689.231953686282;5696.259486266758;5696.601237913389;5170.457102004236;5254.894902101936;5275.5515781158265;5377.811776587879;5454.53636440899;4796.448408433005;4810.518948105161;4855.465898751135;4858.05267972742;4858.1012512685265;5703.572232082527;5745.9425405745405;5747.8563035924435;5750.367459579443;5756.597038207369;5330.307060082165;5563.499285064364;5572.526335261548;5583.8883222336135;5639.774409023593;5796.304443466811;5833.445822646841;5845.064789633639;5888.676122813286;5954.791582294599;5552.97223513896;5554.750036248298;5557.722113894209;5559.2217089606675;5567.582431317748;5378.489043540857;5612.494875461065;5686.2323586315315;5692.686902220417;5695.943040569707;5329.813456529003;5383.353997520323;5417.052015897281;5422.267993820784;5428.83713488596;5369.570434365163;5415.296011518478;5417.079096553674;5418;5470.72646367688;5409.0804563223555;5413.1880217966045;5413.566914646897;5421.864453388697;5477.726113694379;5283.286756288006;5436.401995780382;5441.156620723794;5481.451854814646;5497.752601132878;5399.919001215064;5400.1899715043055;5401.3248343957;5402.621816472809;5449.809256675997 11:37:52 INFO - PROCESS | 13626 | |1;ext.html;539.2103814466459;587.6943989125652;592.6088781404272;592.6858764854624;601.8525461261991;31771;34451.483227751574;44264.3360349595;45021.32468012974;45082;45414.77292613532;45905.770471147596;46022.53977460224;46040.539594604044;46077.539224607746;8821.161989610993;8967.506787126706;8976.281897448189;8985.550722463884;8990.640374385017;8162.673493060271;8797.516136612483;10545.261831671785;10734;10814.567417303298;10932.726681832939;10979.17656175786;10982.560697572088;10989.780204395907;10997.61508347208;10816.405097719622;10860.511276992474;10865.728356791144;10879.945600272027;10883.292585981886;10662.466876656214;10721.410322432263;10722.839157412645;10724.356538607708;10729.624463143753;42662;42975.570244297785;43337.56662433398;43380.78309608432;43386.566134338565;3571.8392672329546;3685.3734865073;3693.778373297611;4162.7502349859105;4197.97901010493;31495.905532280656;33900.49149262763;34094;34143.82928085344;36287.63712362869;4074.6740260779065;4109.465769449982;4215.536291007987;4242.66058715302;4359.782010899474;398972;406649;406986;407178;408198.95900520607;64325;65564.34435655677;65575.67212163909;65639.67180164068;65679;68971;69326.65336673285;69696;69723.3027669727;69724;18087.819121808614;18129.36547220841;18233.361832335806;18354.63290734178;18359.63280734378;12110.273383597012;13927.930360348133;14079;14149.15105093677;14165.220912849893;17330.436667890765;20854.37436876896;20871.478213044797;21118;21145.471363216042;7511.51175173612;7557.395408367317;7586.431017673696;7592.658330375147;7678.462507624525;947.9526023698787;983.1692220074026;1025.3796453145887;1037.4345981440133;1053.262716098734;31772;32754;33112.834435827666;33367.83316083404;35742;1074.978500429987;1116.268843907242;1134.551852018448;1135.4720055174384;1180.7992641251008;16010.439634612965;16719.993600767986;16885.24016419264;16923.830761692472;16957.15214239283;575138;582813;583657;584289;585409;58491.70754146287;58871;58972;59035;59042.40957590455;1246.401727170945;1345.3609535470573;1364.8293963254594;1366.1052010932856;1415.7451658701327;31111.688883111783;32784.50823237701;33224;33368.66631333656;33812;49635.751821240665;50313;50313.49686503234;50332;50350.49649503458;444645;447245;447260.76369617943;448019;449244;29174.7082529172;29323.560146598244;30019.849900750356;30101.84949075328;31497.37005259928;47625.52374476349;48251.27623085586;48582.27126593175;49170;49776;40066.79966600148;42203.57796421996;42806;42955;43282.56717432785;41334.37998429966;42607.4690028948;42637.36043959281;42781.572184279;43849.85062995215;41047.58952410557;41772.164556708085;42111.7894410526;42610.36084458797;42784.57215427806;35152.82423587866;37717.4342384859;37866;38280;39014.219715606094;28011;28576.857115714287;28750.424991499636;28782;28812.711872881002 11:37:52 INFO - PROCESS | 13626 | |2;jquery.html;388.5473423461667;393.3981009056145;407.8144444277853;409.8401623366887;419.70620565604065;15898.20508974551;19163.712544311846;19259.614807703856;19338.419847404566;20397.082131304127;18921.526961825926;19155.042247887584;19446.70829937552;19770.505737356572;19858.503537411536;5254.789808407678;5724.084146536555;5954.553408494358;5962.25471816023;5994.46049855513;4287.528371879106;5861.531077513789;6315.557910946236;6580.605163690194;6596.307387724291;6360.268569114542;6602.8679426411445;6643.169603799525;6682.19813622366;6684.3315668433015;6520.739170433177;6523.7716679915975;6528.902066469007;6563.638999855006;6577.210734711842;5670.6030577859565;5758.596898217126;5767.077267637158;5815.069588865804;5822.155787410802;24110.397240068964;24111.156109536256;24186.274411767674;24218.273451796475;24294.514109717707;2443.706755189389;2472.5796614575384;2482.193287181673;2523.8864251108744;2552.923412297634;14465.638359041002;14622.415103395957;14842.332095055748;14887.627809304746;15021.324040418207;1877.2599187052801;1919.5680971781237;1922.490844686914;1932.5651728361006;2009.2364901337398;83115.58442207811;83117.58441207756;84808.57595712044;84882.5755871223;85186.61100417493;10559.947200263949;10566;10785.62250321235;10812.459377031117;11039.39283339408;15212.695746085017;15244.618884527976;15305.234738263041;15325.46360877364;15363.308651110727;8371.246587807127;8482.236598706146;8544.658213671508;8721.694740684046;8733.126687331343;8343.916560834314;8370.49777013369;8378;8569.715741619573;8584.270337021424;6422.454091402283;6470.805875823733;6594.538382313192;6687.297833727486;6705.396514313637;1797.3619365125192;1823.4078864636645;1869.635421092901;1888.1779083184517;1890.810918908098;873.5675840459013;945.3618807305041;967.2793768642406;983.5967253426061;1061.8938106189473;18107;19802.306919257757;19946.20215191405;20026.899865500578;20374.28689995843;957.1768279279814;986.0878687214298;1001.2090448545713;1012.6759436980243;1026.58423338548;10966.561337546409;11328;11467.655970320904;11470.139739519569;11476.942615286871;527543;530994;532597;534682;542202;81999.5900020508;96562.51718741503;98192;98345;99789;944.8299306124826;959.947202903847;965.7151140413595;966.463612694947;968.9224862011022;17113.828861711223;17176.22706978164;17315.2208150631;17697.911510442365;18064.548386290448;40289.79855100706;40526;40600.39099413452;40982.79508602438;42563.18988961751;54551;57029;57105;57271.71364143319;58768.70615646894;7767.3786097113225;7945.721899733481;8618.095100014409;8793.29653627721;8831.425957313011;10777.784444311226;13417.127886687334;13520.39158237862;13669.453221871412;14090.577282681536;11329.830052549383;11735.47190376418;11943.940280298542;11982.520699171935;12000.219985700902;11684.357360345262;11776.293422394683;11836.70408239801;11889.940550297193;12051.879481205076;11868.881311187122;11978.46096925623;12174.513019479476;12190.57332993341;12266.815997759863;7699.076110866732;8725.91274087251;8869.822603548022;8971.50656713887;9158.542072896194;11191.2725672831;11303.717407064889;11605;11656.417179140839;12188.634340969786 11:37:52 INFO - PROCESS | 13626 | |3;mootools.html;1506.615812967693;1515.015240093939;1655.8675305975523;1748.4404990403077;1785.464360691792;8544.273736732377;9142.45145291283;9159;9160.587773550189;9162.496062716547;7576.621168941559;8192.426530142893;8497.872531912026;8514.446560973533;8962.238209752179;2274.9203777867738;2331.860088394702;2339.30990357844;2346.636271377939;2347.6361164019604;2301.9424514387106;2320.9767902321014;2368.7631236876346;2381.095183830142;2383.7973772229293;2036.8472364572642;2090.644590419625;2094.214669498938;2317.0268487235317;2389.2473870730664;2290.2900100968754;2338.240071976614;2338.38032921276;2339.0643742502966;2340.9180678676335;2271.1937262271986;2283.8287128465267;2292.495650956787;2295.391721193885;2296.081567373064;8261.297789687884;8371.790705232357;8747.343949203836;8870.645174193025;8884.734392729877;5233.084210263189;5372.113601255788;5399.514043736082;5403.297571315704;5417.079096553595;3227.774055816094;3327.8169700666695;3409.573803274591;3413.5050417689545;3418.7265018798435;1160.6982184631972;1221.1757063981865;1227.643983244858;1236.749116607774;1244.352936473038;12148.757024859453;12391;12391.75216495674;12398.5660501882;12399.380030998504;4669.929951050737;4761.47623761386;4903.656744027884;4916.360873086547;4929.767558110472;9599.47202903847;9643.08390702882;9680.419174849532;9689.41863488193;9693.903060969442;5255.842324730264;5264.236685680555;5268.762905669254;5313.760880760297;5334;4842.951570484321;4944;4978.6763860348965;5002.699838009731;5021.799128034838;3690.597572922326;3838.4626152338697;3890.708196885245;3906.8902792492304;3920.5099362579676;1178.3990165015903;1198.4187668980537;1198.9940050299692;1203.0315595945174;1212.6240865331774;780.8321210939675;819.3690858039396;833.6604051053015;963.1716723617683;967.9854802177973;5377.838664840061;5749.626274292157;5959.76160953557;6031.155638210654;6177.135201071854;477.49147158276327;479.36005432746975;480.76442543154303;493.9380332285615;663.4493370502471;4035.7174997749876;4248.171606536757;4273.572642735701;4284.550122237182;4343.305071188594;10759.246852720235;11070.889291107147;11175.329480231212;11176.27354221973;11179.776404471864;11019.449027548591;11032.613858514913;11060.336379817076;11076.169287303484;11092.168087393478;7781.572013539309;8232.50604963704;8291.626876790559;8294.626741796634;8295.211954864279;6104.969475152596;6145.385461453819;6154.969225153845;6246.656433895998;6303.779367722108;10100.949495252476;10220.488975551045;10222.335548189343;10233.846492302473;10357.533910974174;10135.898641013791;10306.433146176732;10382.480875956324;10386.792264154827;10518;7793.571353575381;8001.5999200038605;8009.118996910219;8015.318697910743;8018.238267364591;8471.745847624581;8608;8611.095834937241;8660.307175425825;8678.913210868062;7717.459777815724;7725.1502334744255;7759.650815713419;7765.0681918170185;7905.920940790518;7395.667194976347;7407.407407407502;7557.697692092254;7595.658195381332;7822.217778222132;6893.620850853251;7071.080759501232;7109.075820143556;7163;7175.605341706257;4826.95173048265;5085.186370180753;5163.638545301793;5328.8401347959625;5338.279332290091;5323.228131920927;5335.973320133375;5344.893102138013;5366.865828354166;5433.864153396039 11:37:52 INFO - PROCESS | 13626 | |4;prototype.html;326.1894192930567;338.20859189496576;340.4280808242154;340.9181796368872;344.63468723153443;5201;5251.711155886424;5270.894582108355;5293.682379057259;5306.867328316794;4940.431850337212;4997.450280469146;5102.5407713305885;5129.30689903269;5149.201873709581;4097.754134751909;4105.290508264546;4105.568915263899;4108.465899433069;4113.938290925631;4101.897452563695;4107.137501124753;4124.876253712393;4125.690573207006;4136.482939632546;3800.847966081353;3881.001214679713;4008.418779277003;4010.2781499330254;4074.694397920153;4046.514418269797;4052.4529188559463;4058.0463591056077;4060.3961435233064;4067.3695577185435;3570.767900086486;3572.7677700949357;3574.8212589370687;3579.7673151245085;3588.6949609283242;4860.902781944341;5046.5710414614805;5070.898582028376;5081.974590127063;5108.770105345268;4640.60554852838;4659;4662.323963025342;4665.883352916204;4677.134730074947;5379.273798037254;5407.594430417735;5412.783488660449;5441.5102640762525;5451.991381594417;3701.611330810253;3860.575336712959;3897.376419772851;3916.862909798172;3918.7648741075627;5569.916451253194;5597.6641401516035;5600.383957764642;5603.327600687903;5628.183913332585;3991.4212439196153;4026.255142798533;4035.878923632296;4037.1320166164414;4066.573009833984;3967.166894952092;4054.858079967246;4110.712250142461;4118.794060296973;4121.361189015707;4619.798852298427;4623.468301145412;4632.3977882875015;4637.60580350674;4673.299005149255;5450.727463626803;5458.4814442627885;5459.935312614002;5468.207109969032;5480.205370221295;1332.6068809701162;1388.2572823539358;1405.1639274631577;1405.283305514195;1410.6543896745159;893.0756666849779;905.8233644439402;906.6418764588083;918.7335672654989;922.2529750901791;4695.572232270461;4729.219678753036;4754.548317909793;4792.586187074821;4802.711837289774;4565.657575681837;4940.555350018516;4944.678595891256;4948.826791062295;4960.693277625921;4703.435587729495;4715.552022557851;4720.95279047212;4725.818545363659;4730.972177806207;2627.1067836935536;2630.552806022981;2633.631291619175;2634;2642.471505698868;5065.518775716301;5066.454731306913;5075;5115.800205911494;5449.6730196188355;5719.084946408555;5739.311282646109;5754.338251101177;5774.797882074107;5782.739776710058;5812.38969908162;5815.912761308584;5827.183195007277;5840.182374467493;5842.1236814477315;5481.424450432647;5596.972015139898;5623.875224955107;5626.5780066496;5642.081692224663;5557.943990641765;5590.372524913284;5591.356993945586;5594.5244654203225;5600.551955843442;5617.775288988395;5845.853853653693;5854.882902342015;5857.58996870215;5859.882802343844;3976.721629485908;4016.7991600420446;4021.7586944783407;4023.551521452216;4048;5384.730763461733;5486.396496385474;5509.47659972302;5512.476314750093;5620.241267429008;5343.904499577655;5468.835934921959;5502.339719233718;5512.586556008396;5541.534017362396;5305.389880163831;5489.313835770528;5492.450754924475;5500.779968801203;5501.834944951658;5440.564754819526;5457.345118585795;5472.72636368188;5473.480019398151;5486.451354864641;5513.979913715975;5521.558275337883;5547.278853748987;5552;5552.861178470571;5279.868003299948;5384.303944257546;5410.648307859977;5411.621186516906;5421.268128802719 11:37:52 INFO - PROCESS | 13626 | |5;yui.html;696.3558708194919;704.8379320114724;716.2085895085933;729.1942403643973;804.4569915307167;14853.40586376545;15987.440439584618;16119.597010074755;16126.758098628501;16143.273552690112;13705.451781928736;14266.572002839905;14412.135271883695;14947.103173809579;14957.775633365509;795.3994733975854;824.6330382979577;827.1645637905729;828.0146625515647;828.511178404741;663.6880666086955;791;802.9558374289412;808.7614153824636;821.5029906906325;858.8582883824162;859.3554833874595;859.4370687199894;859.7506723050308;863.9006514250879;679.9048133261348;853.5177624642057;854.0903937306748;854.2824027816602;855.4696088425154;601.7803501721884;613.3406587918006;613.487737738984;619.4394073363613;622.1942584353228;14416.207108609022;14420;14958.177300248482;14962.027468214532;15016.624584385369;12944.223346599234;12994.935025324907;13089.345532723326;13200;13553.864461355359;12525.373731313397;12650.430730617145;12673;12687.619371418872;12690.555830545887;3842.731008829383;4498.325251212312;4498.887527811831;4506.2564676828615;4566.360709500673;71763;80597.19402806014;81115.59442202811;81128;81251;10480.68557943263;10613.416262105504;10759.3544387337;10856.945715271373;11506.884931150582;20388.79611203899;20438.59122817535;20440.28459003928;20501.58996820055;20535.8973205136;8260.504369737835;8294.129116442808;8294.170582941779;8426.957865210758;8701.782455438664;4807.158747219222;4823.614110871122;4825.276208568673;4834.009028149221;4859.246816743411;3290.6380298167182;3420.931581368359;3422.264213194175;3424.33225521026;3424.9486257706153;601;606.8968275393105;610.914471973924;611.7583554496039;613.1262950295811;662.2549631664377;668.7124536449373;698.2284575544053;703.2580627438;704.8213941010821;8605.655773769104;9195.127061570332;9417.764555886157;9532.90467095334;9835.852462213072;639.7984634840011;693.466031156007;711.8754218011827;713.1584730018628;734.5042096584891;4544;4586.747728874877;4625.791839367236;4819.903601927942;4858.344123543347;126803;127683;130514;130812;135303;88729.55635221912;89874;93992.53003734938;97489;98434.5078274604;89281.55359223162;89745;90075;90127.54936225408;91239.54380228056;9861.616536700087;9983.900160998297;10026.749331266778;10034.448105354275;10143.949280253551;50837.23744143767;50959.745201273756;50994.74502627463;51707.48292517027;52986.73506632442;45273.09453810971;64441.67779161074;75091;77442.6127869357;77615.2238477608;12336;12808.807867882175;12946;13032.348382581024;13217.339133043117;15143.318550665026;15329.923350383177;15352.155631440379;15447.459338923083;15855.68288634244;13405.798913016508;14136.646583835074;14555.781663275271;15010.249487525798;15343.846561534241;13345.662808734025;13784.104033237807;13874.306284685927;14029.719405612035;14199;13489.325533723471;14433.92783036078;14480;14509.709805803614;14611.85388146105;11409.045984832359;11609.593664221711;11668.533258669897;11903.940480297542;12169.939150304192;11901.285922844658;11979.460924258256;12135.393230338272;12337.753244934871;12559.811602826148 11:37:52 INFO - PROCESS | 13626 | __end_tp_report 11:37:52 INFO - PROCESS | 13626 | __start_cc_report 11:37:52 INFO - PROCESS | 13626 | _x_x_mozilla_cycle_collect,1226 11:37:52 INFO - PROCESS | 13626 | __end_cc_report 11:37:52 INFO - PROCESS | 13626 | __startTimestamp1472236672585__endTimestamp 11:37:52 INFO - PROCESS | 13626 | 11:37:52 INFO - PROCESS | 13626 | ------- Summary: start ------- 11:37:52 INFO - PROCESS | 13626 | Number of tests: 6 11:37:52 INFO - PROCESS | 13626 | 11:37:52 INFO - PROCESS | 13626 | [#0] dojo.html Cycles:165 Average:5209.19 Median:5402.62 stddev:576.74 (10.7%) stddev-sans-first:551.88 11:37:52 INFO - PROCESS | 13626 | Values: 3001.0 3012.8 3019.0 3024.5 3059.4 4963.3 5032.3 5153.5 5231.4 5268.8 5091.9 5247.4 5344.5 5354.0 5433.1 4739.1 4774.3 4811.3 4866.9 4879.5 4754.4 4857.1 4946.6 4956.6 4961.6 4874.8 4890.9 4896.6 4904.5 4924.3 4600.5 4719.5 4768.6 4783.5 4825.7 4637.5 4650.0 4677.0 4720.9 4778.4 5174.8 5204.5 5213.4 5220.6 5232.1 5371.8 5490.0 5540.4 5548.6 5553.3 5535.8 5587.8 5600.8 5603.0 5673.2 5262.6 5272.3 5274.3 5276.3 5280.4 5492.5 5670.5 5726.9 5732.1 5815.0 5512.7 5521.7 5521.8 5523.8 5524.8 5539.2 5541.9 5544.8 5546.7 5582.9 5290.8 5475.0 5572.6 5592.3 5684.2 5615.0 5622.4 5623.5 5623.6 5687.2 4370.4 4379.3 4381.5 4383.4 4394.8 3811.0 3879.7 3882.6 3926.5 3927.7 5398.9 5400.6 5401.1 5438.9 5465.8 5683.3 5688.0 5689.2 5696.3 5696.6 5170.5 5254.9 5275.6 5377.8 5454.5 4796.4 4810.5 4855.5 4858.1 4858.1 5703.6 5745.9 5747.9 5750.4 5756.6 5330.3 5563.5 5572.5 5583.9 5639.8 5796.3 5833.4 5845.1 5888.7 5954.8 5553.0 5554.8 5557.7 5559.2 5567.6 5378.5 5612.5 5686.2 5692.7 5695.9 5329.8 5383.4 5417.1 5422.3 5428.8 5369.6 5415.3 5417.1 5418.0 5470.7 5409.1 5413.2 5413.6 5421.9 5477.7 5283.3 5436.4 5441.2 5481.5 5497.8 5399.9 5400.2 5401.3 5402.6 5449.8 11:37:52 INFO - PROCESS | 13626 | 11:37:52 INFO - PROCESS | 13626 | [#1] ext.html Cycles:180 Average:64449.59 Median:205626.34 stddev:128469.70 (62.5%) stddev-sans-first:128740.47 11:37:52 INFO - PROCESS | 13626 | Values: 539.2 587.7 592.6 592.7 601.9 31771.0 34451.5 44264.3 45021.3 45082.0 45414.8 45905.8 46022.5 46040.5 46077.5 8821.2 8967.5 8976.3 8985.6 8990.6 8162.7 8797.5 10545.3 10734.0 10814.6 10932.7 10979.2 10982.6 10989.8 10997.6 10816.4 10860.5 10865.7 10879.9 10883.3 10662.5 10721.4 10722.8 10724.4 10729.6 42662.0 42975.6 43337.6 43380.8 43386.6 3571.8 3685.4 3693.8 4162.8 4198.0 31495.9 33900.5 34094.0 34143.8 36287.6 4074.7 4109.5 4215.5 4242.7 4359.8 398972.0 406649.0 406986.0 407178.0 408199.0 64325.0 65564.3 65575.7 65639.7 65679.0 68971.0 69326.7 69696.0 69723.3 69724.0 18087.8 18129.4 18233.4 18354.6 18359.6 12110.3 13927.9 14079.0 14149.2 14165.2 17330.4 20854.4 20871.5 21118.0 21145.5 7511.5 7557.4 7586.4 7592.7 7678.5 948.0 983.2 1025.4 1037.4 1053.3 31772.0 32754.0 33112.8 33367.8 35742.0 1075.0 1116.3 1134.6 1135.5 1180.8 16010.4 16720.0 16885.2 16923.8 16957.2 575138.0 582813.0 583657.0 584289.0 585409.0 58491.7 58871.0 58972.0 59035.0 59042.4 1246.4 1345.4 1364.8 1366.1 1415.7 31111.7 32784.5 33224.0 33368.7 33812.0 49635.8 50313.0 50313.5 50332.0 50350.5 444645.0 447245.0 447260.8 448019.0 449244.0 29174.7 29323.6 30019.8 30101.8 31497.4 47625.5 48251.3 48582.3 49170.0 49776.0 40066.8 42203.6 42806.0 42955.0 43282.6 41334.4 42607.5 42637.4 42781.6 43849.9 41047.6 41772.2 42111.8 42610.4 42784.6 35152.8 37717.4 37866.0 38280.0 39014.2 28011.0 28576.9 28750.4 28782.0 28812.7 11:37:52 INFO - PROCESS | 13626 | 11:37:52 INFO - PROCESS | 13626 | [#2] jquery.html Cycles:180 Average:30660.07 Median:20341.60 stddev:87800.46 (431.6%) stddev-sans-first:88017.34 11:37:52 INFO - PROCESS | 13626 | Values: 388.5 393.4 407.8 409.8 419.7 15898.2 19163.7 19259.6 19338.4 20397.1 18921.5 19155.0 19446.7 19770.5 19858.5 5254.8 5724.1 5954.6 5962.3 5994.5 4287.5 5861.5 6315.6 6580.6 6596.3 6360.3 6602.9 6643.2 6682.2 6684.3 6520.7 6523.8 6528.9 6563.6 6577.2 5670.6 5758.6 5767.1 5815.1 5822.2 24110.4 24111.2 24186.3 24218.3 24294.5 2443.7 2472.6 2482.2 2523.9 2552.9 14465.6 14622.4 14842.3 14887.6 15021.3 1877.3 1919.6 1922.5 1932.6 2009.2 83115.6 83117.6 84808.6 84882.6 85186.6 10559.9 10566.0 10785.6 10812.5 11039.4 15212.7 15244.6 15305.2 15325.5 15363.3 8371.2 8482.2 8544.7 8721.7 8733.1 8343.9 8370.5 8378.0 8569.7 8584.3 6422.5 6470.8 6594.5 6687.3 6705.4 1797.4 1823.4 1869.6 1888.2 1890.8 873.6 945.4 967.3 983.6 1061.9 18107.0 19802.3 19946.2 20026.9 20374.3 957.2 986.1 1001.2 1012.7 1026.6 10966.6 11328.0 11467.7 11470.1 11476.9 527543.0 530994.0 532597.0 534682.0 542202.0 81999.6 96562.5 98192.0 98345.0 99789.0 944.8 959.9 965.7 966.5 968.9 17113.8 17176.2 17315.2 17697.9 18064.5 40289.8 40526.0 40600.4 40982.8 42563.2 54551.0 57029.0 57105.0 57271.7 58768.7 7767.4 7945.7 8618.1 8793.3 8831.4 10777.8 13417.1 13520.4 13669.5 14090.6 11329.8 11735.5 11943.9 11982.5 12000.2 11684.4 11776.3 11836.7 11889.9 12051.9 11868.9 11978.5 12174.5 12190.6 12266.8 7699.1 8725.9 8869.8 8971.5 9158.5 11191.3 11303.7 11605.0 11656.4 12188.6 11:37:52 INFO - PROCESS | 13626 | 11:37:52 INFO - PROCESS | 13626 | [#3] mootools.html Cycles:180 Average:5813.03 Median:2718.97 stddev:3317.57 (122.0%) stddev-sans-first:3311.09 11:37:52 INFO - PROCESS | 13626 | Values: 1506.6 1515.0 1655.9 1748.4 1785.5 8544.3 9142.5 9159.0 9160.6 9162.5 7576.6 8192.4 8497.9 8514.4 8962.2 2274.9 2331.9 2339.3 2346.6 2347.6 2301.9 2321.0 2368.8 2381.1 2383.8 2036.8 2090.6 2094.2 2317.0 2389.2 2290.3 2338.2 2338.4 2339.1 2340.9 2271.2 2283.8 2292.5 2295.4 2296.1 8261.3 8371.8 8747.3 8870.6 8884.7 5233.1 5372.1 5399.5 5403.3 5417.1 3227.8 3327.8 3409.6 3413.5 3418.7 1160.7 1221.2 1227.6 1236.7 1244.4 12148.8 12391.0 12391.8 12398.6 12399.4 4669.9 4761.5 4903.7 4916.4 4929.8 9599.5 9643.1 9680.4 9689.4 9693.9 5255.8 5264.2 5268.8 5313.8 5334.0 4843.0 4944.0 4978.7 5002.7 5021.8 3690.6 3838.5 3890.7 3906.9 3920.5 1178.4 1198.4 1199.0 1203.0 1212.6 780.8 819.4 833.7 963.2 968.0 5377.8 5749.6 5959.8 6031.2 6177.1 477.5 479.4 480.8 493.9 663.4 4035.7 4248.2 4273.6 4284.6 4343.3 10759.2 11070.9 11175.3 11176.3 11179.8 11019.4 11032.6 11060.3 11076.2 11092.2 7781.6 8232.5 8291.6 8294.6 8295.2 6105.0 6145.4 6155.0 6246.7 6303.8 10100.9 10220.5 10222.3 10233.8 10357.5 10135.9 10306.4 10382.5 10386.8 10518.0 7793.6 8001.6 8009.1 8015.3 8018.2 8471.7 8608.0 8611.1 8660.3 8678.9 7717.5 7725.2 7759.7 7765.1 7905.9 7395.7 7407.4 7557.7 7595.7 7822.2 6893.6 7071.1 7109.1 7163.0 7175.6 4827.0 5085.2 5163.6 5328.8 5338.3 5323.2 5336.0 5344.9 5366.9 5433.9 11:37:52 INFO - PROCESS | 13626 | 11:37:52 INFO - PROCESS | 13626 | [#4] prototype.html Cycles:180 Average:4530.55 Median:5068.68 stddev:1338.42 (26.4%) stddev-sans-first:1304.44 11:37:52 INFO - PROCESS | 13626 | Values: 326.2 338.2 340.4 340.9 344.6 5201.0 5251.7 5270.9 5293.7 5306.9 4940.4 4997.5 5102.5 5129.3 5149.2 4097.8 4105.3 4105.6 4108.5 4113.9 4101.9 4107.1 4124.9 4125.7 4136.5 3800.8 3881.0 4008.4 4010.3 4074.7 4046.5 4052.5 4058.0 4060.4 4067.4 3570.8 3572.8 3574.8 3579.8 3588.7 4860.9 5046.6 5070.9 5082.0 5108.8 4640.6 4659.0 4662.3 4665.9 4677.1 5379.3 5407.6 5412.8 5441.5 5452.0 3701.6 3860.6 3897.4 3916.9 3918.8 5569.9 5597.7 5600.4 5603.3 5628.2 3991.4 4026.3 4035.9 4037.1 4066.6 3967.2 4054.9 4110.7 4118.8 4121.4 4619.8 4623.5 4632.4 4637.6 4673.3 5450.7 5458.5 5459.9 5468.2 5480.2 1332.6 1388.3 1405.2 1405.3 1410.7 893.1 905.8 906.6 918.7 922.3 4695.6 4729.2 4754.5 4792.6 4802.7 4565.7 4940.6 4944.7 4948.8 4960.7 4703.4 4715.6 4721.0 4725.8 4731.0 2627.1 2630.6 2633.6 2634.0 2642.5 5065.5 5066.5 5075.0 5115.8 5449.7 5719.1 5739.3 5754.3 5774.8 5782.7 5812.4 5815.9 5827.2 5840.2 5842.1 5481.4 5597.0 5623.9 5626.6 5642.1 5557.9 5590.4 5591.4 5594.5 5600.6 5617.8 5845.9 5854.9 5857.6 5859.9 3976.7 4016.8 4021.8 4023.6 4048.0 5384.7 5486.4 5509.5 5512.5 5620.2 5343.9 5468.8 5502.3 5512.6 5541.5 5305.4 5489.3 5492.5 5500.8 5501.8 5440.6 5457.3 5472.7 5473.5 5486.5 5514.0 5521.6 5547.3 5552.0 5552.9 5279.9 5384.3 5410.6 5411.6 5421.3 11:37:52 INFO - PROCESS | 13626 | 11:37:52 INFO - PROCESS | 13626 | [#5] yui.html Cycles:180 Average:21148.15 Median:4606.27 stddev:31119.68 (675.6%) stddev-sans-first:31169.09 11:37:52 INFO - PROCESS | 13626 | Values: 696.4 704.8 716.2 729.2 804.5 14853.4 15987.4 16119.6 16126.8 16143.3 13705.5 14266.6 14412.1 14947.1 14957.8 795.4 824.6 827.2 828.0 828.5 663.7 791.0 803.0 808.8 821.5 858.9 859.4 859.4 859.8 863.9 679.9 853.5 854.1 854.3 855.5 601.8 613.3 613.5 619.4 622.2 14416.2 14420.0 14958.2 14962.0 15016.6 12944.2 12994.9 13089.3 13200.0 13553.9 12525.4 12650.4 12673.0 12687.6 12690.6 3842.7 4498.3 4498.9 4506.3 4566.4 71763.0 80597.2 81115.6 81128.0 81251.0 10480.7 10613.4 10759.4 10856.9 11506.9 20388.8 20438.6 20440.3 20501.6 20535.9 8260.5 8294.1 8294.2 8427.0 8701.8 4807.2 4823.6 4825.3 4834.0 4859.2 3290.6 3420.9 3422.3 3424.3 3424.9 601.0 606.9 610.9 611.8 613.1 662.3 668.7 698.2 703.3 704.8 8605.7 9195.1 9417.8 9532.9 9835.9 639.8 693.5 711.9 713.2 734.5 4544.0 4586.7 4625.8 4819.9 4858.3 126803.0 127683.0 130514.0 130812.0 135303.0 88729.6 89874.0 93992.5 97489.0 98434.5 89281.6 89745.0 90075.0 90127.5 91239.5 9861.6 9983.9 10026.7 10034.4 10143.9 50837.2 50959.7 50994.7 51707.5 52986.7 45273.1 64441.7 75091.0 77442.6 77615.2 12336.0 12808.8 12946.0 13032.3 13217.3 15143.3 15329.9 15352.2 15447.5 15855.7 13405.8 14136.6 14555.8 15010.2 15343.8 13345.7 13784.1 13874.3 14029.7 14199.0 13489.3 14433.9 14480.0 14509.7 14611.9 11409.0 11609.6 11668.5 11903.9 12169.9 11901.3 11979.5 12135.4 12337.8 12559.8 11:37:52 INFO - PROCESS | 13626 | -------- Summary: end -------- 11:37:52 INFO - PROCESS | 13626 | 11:37:53 INFO - TEST-INFO | 13626: exit 0 11:37:53 INFO - TEST-OK | dromaeo_css | took 1116208ms 11:37:53 INFO - TEST-START | kraken 11:37:53 INFO - operating with platform_type : linux_ 11:37:53 INFO - Initialising browser for kraken test... 11:37:53 INFO - TEST-INFO | started process 13932 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcJv9nd/profile http://localhost:46363/getInfo.html) 11:37:57 INFO - PROCESS | 13932 | __metrics Screen width/height:1600/1200 11:37:57 INFO - PROCESS | 13932 | colorDepth:24 11:37:57 INFO - PROCESS | 13932 | Browser inner width/height: 1024/697 11:37:57 INFO - PROCESS | 13932 | __metrics 11:37:58 INFO - PROCESS | 13932 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:37:58 INFO - PROCESS | 13932 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:37:59 INFO - PROCESS | 13932 | console.error: PushService: 11:37:59 INFO - PROCESS | 13932 | stateChangeProcessEnqueue: Error transitioning state 11:37:59 INFO - PROCESS | 13932 | UnknownError 11:37:59 INFO - TEST-INFO | 13932: exit 0 11:37:59 INFO - Browser initialized. 11:37:59 INFO - Running cycle 1/1 for kraken test... 11:37:59 INFO - TEST-INFO | started process 14014 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcJv9nd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:38:11 INFO - PROCESS | 14014 | RSS: Main: 178421760 11:38:11 INFO - PROCESS | 14014 | 11:38:14 INFO - PROCESS | 14014 | Cycle 1(1): loaded http://localhost:46363/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46363/tests/kraken/driver.html?testName=audio-beat-detection) 11:38:15 INFO - PROCESS | 14014 | RSS: Main: 232828928 11:38:15 INFO - PROCESS | 14014 | 11:38:17 INFO - PROCESS | 14014 | Cycle 1(1): loaded http://localhost:46363/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46363/tests/kraken/driver.html?testName=audio-dft) 11:38:18 INFO - PROCESS | 14014 | RSS: Main: 222978048 11:38:18 INFO - PROCESS | 14014 | 11:38:21 INFO - PROCESS | 14014 | Cycle 1(1): loaded http://localhost:46363/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46363/tests/kraken/driver.html?testName=audio-fft) 11:38:22 INFO - PROCESS | 14014 | RSS: Main: 299589632 11:38:22 INFO - PROCESS | 14014 | 11:38:24 INFO - PROCESS | 14014 | Cycle 1(1): loaded http://localhost:46363/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46363/tests/kraken/driver.html?testName=audio-oscillator) 11:38:24 INFO - PROCESS | 14014 | RSS: Main: 211673088 11:38:24 INFO - PROCESS | 14014 | 11:38:26 INFO - PROCESS | 14014 | Cycle 1(1): loaded http://localhost:46363/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46363/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:38:27 INFO - PROCESS | 14014 | RSS: Main: 213295104 11:38:27 INFO - PROCESS | 14014 | 11:38:30 INFO - PROCESS | 14014 | Cycle 1(1): loaded http://localhost:46363/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46363/tests/kraken/driver.html?testName=imaging-darkroom) 11:38:31 INFO - PROCESS | 14014 | RSS: Main: 252260352 11:38:31 INFO - PROCESS | 14014 | 11:38:34 INFO - PROCESS | 14014 | Cycle 1(1): loaded http://localhost:46363/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46363/tests/kraken/driver.html?testName=imaging-desaturate) 11:38:34 INFO - PROCESS | 14014 | RSS: Main: 250916864 11:38:34 INFO - PROCESS | 14014 | 11:38:37 INFO - PROCESS | 14014 | Cycle 1(1): loaded http://localhost:46363/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46363/tests/kraken/driver.html?testName=json-parse-financial) 11:38:38 INFO - PROCESS | 14014 | RSS: Main: 250720256 11:38:38 INFO - PROCESS | 14014 | 11:38:39 INFO - PROCESS | 14014 | Cycle 1(1): loaded http://localhost:46363/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46363/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:38:40 INFO - PROCESS | 14014 | RSS: Main: 213454848 11:38:40 INFO - PROCESS | 14014 | 11:38:42 INFO - PROCESS | 14014 | Cycle 1(1): loaded http://localhost:46363/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46363/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:38:42 INFO - PROCESS | 14014 | RSS: Main: 221351936 11:38:42 INFO - PROCESS | 14014 | 11:38:44 INFO - PROCESS | 14014 | Cycle 1(1): loaded http://localhost:46363/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46363/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:38:45 INFO - PROCESS | 14014 | RSS: Main: 221663232 11:38:45 INFO - PROCESS | 14014 | 11:38:48 INFO - PROCESS | 14014 | Cycle 1(1): loaded http://localhost:46363/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46363/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:38:48 INFO - PROCESS | 14014 | RSS: Main: 222441472 11:38:48 INFO - PROCESS | 14014 | 11:38:51 INFO - PROCESS | 14014 | Cycle 1(1): loaded http://localhost:46363/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46363/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:38:52 INFO - PROCESS | 14014 | RSS: Main: 220155904 11:38:52 INFO - PROCESS | 14014 | 11:38:53 INFO - PROCESS | 14014 | Cycle 1(1): loaded http://localhost:46363/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46363/tests/kraken/driver.html?testName=ai-astar) 11:38:53 INFO - PROCESS | 14014 | RSS: Main: 271622144 11:38:53 INFO - PROCESS | 14014 | 11:38:53 INFO - PROCESS | 14014 | __start_tp_report 11:38:53 INFO - PROCESS | 14014 | _x_x_mozilla_page_load 11:38:53 INFO - PROCESS | 14014 | _x_x_mozilla_page_load_details 11:38:53 INFO - PROCESS | 14014 | |i|pagename|runs| 11:38:53 INFO - PROCESS | 14014 | |0;ai-astar;113;114;130;113;114;113;113;111;111;113 11:38:53 INFO - PROCESS | 14014 | |1;audio-beat-detection;149;118;148;179;120;145;151;124;172;118 11:38:53 INFO - PROCESS | 14014 | |2;audio-dft;163;162;162;161;163;163;163;163;162;161 11:38:53 INFO - PROCESS | 14014 | |3;audio-fft;75;75;77;174;77;75;74;75;163;77 11:38:53 INFO - PROCESS | 14014 | |4;audio-oscillator;82;81;142;81;81;81;147;81;82;135 11:38:53 INFO - PROCESS | 14014 | |5;imaging-gaussian-blur;118;117;118;117;118;117;118;118;118;118 11:38:53 INFO - PROCESS | 14014 | |6;imaging-darkroom;149;147;146;147;146;146;146;146;146;145 11:38:53 INFO - PROCESS | 14014 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;95;95 11:38:53 INFO - PROCESS | 14014 | |8;json-parse-financial;53;53;54;56;55;55;54;53;56;54 11:38:53 INFO - PROCESS | 14014 | |9;json-stringify-tinderbox;62;63;62;62;61;62;62;61;62;62 11:38:53 INFO - PROCESS | 14014 | |10;stanford-crypto-aes;79;80;79;79;85;78;79;79;79;87 11:38:53 INFO - PROCESS | 14014 | |11;stanford-crypto-ccm;133;133;123;128;134;128;123;125;160;125 11:38:53 INFO - PROCESS | 14014 | |12;stanford-crypto-pbkdf2;163;165;165;163;164;164;167;167;162;165 11:38:53 INFO - PROCESS | 14014 | |13;stanford-crypto-sha256-iterative;67;64;66;64;68;65;64;65;64;64 11:38:53 INFO - PROCESS | 14014 | __end_tp_report 11:38:53 INFO - PROCESS | 14014 | __start_cc_report 11:38:53 INFO - PROCESS | 14014 | _x_x_mozilla_cycle_collect,1696 11:38:53 INFO - PROCESS | 14014 | __end_cc_report 11:38:53 INFO - PROCESS | 14014 | __startTimestamp1472236733974__endTimestamp 11:38:53 INFO - PROCESS | 14014 | 11:38:53 INFO - PROCESS | 14014 | ------- Summary: start ------- 11:38:53 INFO - PROCESS | 14014 | Number of tests: 14 11:38:53 INFO - PROCESS | 14014 | 11:38:53 INFO - PROCESS | 14014 | [#0] ai-astar Cycles:10 Average:114.50 Median:113.00 stddev:5.54 (4.9%) stddev-sans-first:5.85 11:38:53 INFO - PROCESS | 14014 | Values: 113.0 114.0 130.0 113.0 114.0 113.0 113.0 111.0 111.0 113.0 11:38:53 INFO - PROCESS | 14014 | 11:38:53 INFO - PROCESS | 14014 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:148.50 stddev:22.12 (14.9%) stddev-sans-first:23.33 11:38:53 INFO - PROCESS | 14014 | Values: 149.0 118.0 148.0 179.0 120.0 145.0 151.0 124.0 172.0 118.0 11:38:53 INFO - PROCESS | 14014 | 11:38:53 INFO - PROCESS | 14014 | [#2] audio-dft Cycles:10 Average:162.30 Median:163.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 11:38:53 INFO - PROCESS | 14014 | Values: 163.0 162.0 162.0 161.0 163.0 163.0 163.0 163.0 162.0 161.0 11:38:53 INFO - PROCESS | 14014 | 11:38:53 INFO - PROCESS | 14014 | [#3] audio-fft Cycles:10 Average:94.20 Median:75.00 stddev:39.26 (52.3%) stddev-sans-first:41.02 11:38:53 INFO - PROCESS | 14014 | Values: 75.0 75.0 77.0 174.0 77.0 75.0 74.0 75.0 163.0 77.0 11:38:53 INFO - PROCESS | 14014 | 11:38:53 INFO - PROCESS | 14014 | [#4] audio-oscillator Cycles:10 Average:99.30 Median:81.00 stddev:29.15 (36.0%) stddev-sans-first:30.24 11:38:53 INFO - PROCESS | 14014 | Values: 82.0 81.0 142.0 81.0 81.0 81.0 147.0 81.0 82.0 135.0 11:38:53 INFO - PROCESS | 14014 | 11:38:53 INFO - PROCESS | 14014 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 11:38:53 INFO - PROCESS | 14014 | Values: 118.0 117.0 118.0 117.0 118.0 117.0 118.0 118.0 118.0 118.0 11:38:53 INFO - PROCESS | 14014 | 11:38:53 INFO - PROCESS | 14014 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:1.07 (0.7%) stddev-sans-first:0.60 11:38:53 INFO - PROCESS | 14014 | Values: 149.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 145.0 11:38:53 INFO - PROCESS | 14014 | 11:38:53 INFO - PROCESS | 14014 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:38:53 INFO - PROCESS | 14014 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 11:38:53 INFO - PROCESS | 14014 | 11:38:53 INFO - PROCESS | 14014 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.50 stddev:1.16 (2.1%) stddev-sans-first:1.13 11:38:53 INFO - PROCESS | 14014 | Values: 53.0 53.0 54.0 56.0 55.0 55.0 54.0 53.0 56.0 54.0 11:38:53 INFO - PROCESS | 14014 | 11:38:53 INFO - PROCESS | 14014 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 11:38:53 INFO - PROCESS | 14014 | Values: 62.0 63.0 62.0 62.0 61.0 62.0 62.0 61.0 62.0 62.0 11:38:53 INFO - PROCESS | 14014 | 11:38:53 INFO - PROCESS | 14014 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:79.00 stddev:3.03 (3.8%) stddev-sans-first:3.17 11:38:53 INFO - PROCESS | 14014 | Values: 79.0 80.0 79.0 79.0 85.0 78.0 79.0 79.0 79.0 87.0 11:38:53 INFO - PROCESS | 14014 | 11:38:53 INFO - PROCESS | 14014 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:130.50 stddev:10.93 (8.4%) stddev-sans-first:11.58 11:38:53 INFO - PROCESS | 14014 | Values: 133.0 133.0 123.0 128.0 134.0 128.0 123.0 125.0 160.0 125.0 11:38:53 INFO - PROCESS | 14014 | 11:38:53 INFO - PROCESS | 14014 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.50 Median:165.00 stddev:1.65 (1.0%) stddev-sans-first:1.66 11:38:53 INFO - PROCESS | 14014 | Values: 163.0 165.0 165.0 163.0 164.0 164.0 167.0 167.0 162.0 165.0 11:38:53 INFO - PROCESS | 14014 | 11:38:53 INFO - PROCESS | 14014 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:1.45 (2.2%) stddev-sans-first:1.36 11:38:53 INFO - PROCESS | 14014 | Values: 67.0 64.0 66.0 64.0 68.0 65.0 64.0 65.0 64.0 64.0 11:38:53 INFO - PROCESS | 14014 | -------- Summary: end -------- 11:38:53 INFO - PROCESS | 14014 | 11:38:55 INFO - TEST-INFO | 14014: exit 0 11:38:55 INFO - TEST-OK | kraken | took 61558ms 11:38:55 INFO - SUITE-END | took 1177s 11:38:55 INFO - Completed test suite (00:19:38) 11:38:55 INFO - javascript benchmark 11:38:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3001.0396673064615, 3012.7589792816575, 3019.0188188838633, 3024.5311976643616, 3059.4492991261577, 4963.329950456688, 5032.345795046639, 5153.510416510435, 5231.424543300239, 5268.789248430058, 5091.898162036757, 5247.449017853128, 5344.545713614348, 5354.036273470773, 5433.0763770159065, 4739.0758802033615, 4774.331593576902, 4811.30236115763, 4866.853994380165, 4879.536444037811, 4754.405699287589, 4857.052874689437, 4946.579540739023, 4956.578690811285, 4961.553460188582, 4874.829380971667, 4890.877728056791, 4896.583790377822, 4904.509549045102, 4924.28597853311, 4600.5169457207185, 4719.457262414832, 4768.618510519184, 4783.473817880031, 4825.710457372569, 4637.489876113625, 4649.976750116261, 4677.0, 4720.929186062212, 4778.402699662543, 5174.818881339173, 5204.505571970657, 5213.3743950725775, 5220.608454365938, 5232.084385232569, 5371.785128594891, 5490.0, 5540.418256083134, 5548.611597188198, 5553.305836770403, 5535.750891209906, 5587.776488940438, 5600.775968961237, 5603.0, 5673.23411339468, 5262.552683021948, 5272.340957380327, 5274.26160337553, 5276.3140791697215, 5280.419153893069, 5492.47821456961, 5670.546356291569, 5726.885462290731, 5732.082866741302, 5814.970925145347, 5512.724363781795, 5521.69630670317, 5521.779128834882, 5523.7790488380815, 5524.8066317679495, 5539.19681646159, 5541.944580554143, 5544.805931792368, 5546.694931778791, 5582.888342233133, 5290.841274761763, 5475.0, 5572.582056345709, 5592.3009623797025, 5684.204211410406, 5615.0454422748235, 5622.409646987089, 5623.5220006299105, 5623.578231632562, 5687.232223649837, 4370.409994650745, 4379.255526560492, 4381.496127945327, 4383.430154080013, 4394.846180383735, 3811.0472381904524, 3879.7284190106984, 3882.6311500407414, 3926.4895563577124, 3927.6857851371824, 5398.892022159614, 5400.621956463088, 5401.054815407288, 5438.945610543844, 5465.754041068161, 5683.26117604717, 5688.0, 5689.231953686282, 5696.259486266758, 5696.601237913389, 5170.457102004236, 5254.894902101936, 5275.5515781158265, 5377.811776587879, 5454.53636440899, 4796.448408433005, 4810.518948105161, 4855.465898751135, 4858.05267972742, 4858.1012512685265, 5703.572232082527, 5745.9425405745405, 5747.8563035924435, 5750.367459579443, 5756.597038207369, 5330.307060082165, 5563.499285064364, 5572.526335261548, 5583.8883222336135, 5639.774409023593, 5796.304443466811, 5833.445822646841, 5845.064789633639, 5888.676122813286, 5954.791582294599, 5552.97223513896, 5554.750036248298, 5557.722113894209, 5559.2217089606675, 5567.582431317748, 5378.489043540857, 5612.494875461065, 5686.2323586315315, 5692.686902220417, 5695.943040569707, 5329.813456529003, 5383.353997520323, 5417.052015897281, 5422.267993820784, 5428.83713488596, 5369.570434365163, 5415.296011518478, 5417.079096553674, 5418.0, 5470.72646367688, 5409.0804563223555, 5413.1880217966045, 5413.566914646897, 5421.864453388697, 5477.726113694379, 5283.286756288006, 5436.401995780382, 5441.156620723794, 5481.451854814646, 5497.752601132878, 5399.919001215064, 5400.1899715043055, 5401.3248343957, 5402.621816472809, 5449.809256675997], "value": 5171.165317485974, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.2103814466459, 587.6943989125652, 592.6088781404272, 592.6858764854624, 601.8525461261991, 31771.0, 34451.483227751574, 44264.3360349595, 45021.32468012974, 45082.0, 45414.77292613532, 45905.770471147596, 46022.53977460224, 46040.539594604044, 46077.539224607746, 8821.161989610993, 8967.506787126706, 8976.281897448189, 8985.550722463884, 8990.640374385017, 8162.673493060271, 8797.516136612483, 10545.261831671785, 10734.0, 10814.567417303298, 10932.726681832939, 10979.17656175786, 10982.560697572088, 10989.780204395907, 10997.61508347208, 10816.405097719622, 10860.511276992474, 10865.728356791144, 10879.945600272027, 10883.292585981886, 10662.466876656214, 10721.410322432263, 10722.839157412645, 10724.356538607708, 10729.624463143753, 42662.0, 42975.570244297785, 43337.56662433398, 43380.78309608432, 43386.566134338565, 3571.8392672329546, 3685.3734865073, 3693.778373297611, 4162.7502349859105, 4197.97901010493, 31495.905532280656, 33900.49149262763, 34094.0, 34143.82928085344, 36287.63712362869, 4074.6740260779065, 4109.465769449982, 4215.536291007987, 4242.66058715302, 4359.782010899474, 398972.0, 406649.0, 406986.0, 407178.0, 408198.95900520607, 64325.0, 65564.34435655677, 65575.67212163909, 65639.67180164068, 65679.0, 68971.0, 69326.65336673285, 69696.0, 69723.3027669727, 69724.0, 18087.819121808614, 18129.36547220841, 18233.361832335806, 18354.63290734178, 18359.63280734378, 12110.273383597012, 13927.930360348133, 14079.0, 14149.15105093677, 14165.220912849893, 17330.436667890765, 20854.37436876896, 20871.478213044797, 21118.0, 21145.471363216042, 7511.51175173612, 7557.395408367317, 7586.431017673696, 7592.658330375147, 7678.462507624525, 947.9526023698787, 983.1692220074026, 1025.3796453145887, 1037.4345981440133, 1053.262716098734, 31772.0, 32754.0, 33112.834435827666, 33367.83316083404, 35742.0, 1074.978500429987, 1116.268843907242, 1134.551852018448, 1135.4720055174384, 1180.7992641251008, 16010.439634612965, 16719.993600767986, 16885.24016419264, 16923.830761692472, 16957.15214239283, 575138.0, 582813.0, 583657.0, 584289.0, 585409.0, 58491.70754146287, 58871.0, 58972.0, 59035.0, 59042.40957590455, 1246.401727170945, 1345.3609535470573, 1364.8293963254594, 1366.1052010932856, 1415.7451658701327, 31111.688883111783, 32784.50823237701, 33224.0, 33368.66631333656, 33812.0, 49635.751821240665, 50313.0, 50313.49686503234, 50332.0, 50350.49649503458, 444645.0, 447245.0, 447260.76369617943, 448019.0, 449244.0, 29174.7082529172, 29323.560146598244, 30019.849900750356, 30101.84949075328, 31497.37005259928, 47625.52374476349, 48251.27623085586, 48582.27126593175, 49170.0, 49776.0, 40066.79966600148, 42203.57796421996, 42806.0, 42955.0, 43282.56717432785, 41334.37998429966, 42607.4690028948, 42637.36043959281, 42781.572184279, 43849.85062995215, 41047.58952410557, 41772.164556708085, 42111.7894410526, 42610.36084458797, 42784.57215427806, 35152.82423587866, 37717.4342384859, 37866.0, 38280.0, 39014.219715606094, 28011.0, 28576.857115714287, 28750.424991499636, 28782.0, 28812.711872881002], "value": 21159.98638839975, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.5473423461667, 393.3981009056145, 407.8144444277853, 409.8401623366887, 419.70620565604065, 15898.20508974551, 19163.712544311846, 19259.614807703856, 19338.419847404566, 20397.082131304127, 18921.526961825926, 19155.042247887584, 19446.70829937552, 19770.505737356572, 19858.503537411536, 5254.789808407678, 5724.084146536555, 5954.553408494358, 5962.25471816023, 5994.46049855513, 4287.528371879106, 5861.531077513789, 6315.557910946236, 6580.605163690194, 6596.307387724291, 6360.268569114542, 6602.8679426411445, 6643.169603799525, 6682.19813622366, 6684.3315668433015, 6520.739170433177, 6523.7716679915975, 6528.902066469007, 6563.638999855006, 6577.210734711842, 5670.6030577859565, 5758.596898217126, 5767.077267637158, 5815.069588865804, 5822.155787410802, 24110.397240068964, 24111.156109536256, 24186.274411767674, 24218.273451796475, 24294.514109717707, 2443.706755189389, 2472.5796614575384, 2482.193287181673, 2523.8864251108744, 2552.923412297634, 14465.638359041002, 14622.415103395957, 14842.332095055748, 14887.627809304746, 15021.324040418207, 1877.2599187052801, 1919.5680971781237, 1922.490844686914, 1932.5651728361006, 2009.2364901337398, 83115.58442207811, 83117.58441207756, 84808.57595712044, 84882.5755871223, 85186.61100417493, 10559.947200263949, 10566.0, 10785.62250321235, 10812.459377031117, 11039.39283339408, 15212.695746085017, 15244.618884527976, 15305.234738263041, 15325.46360877364, 15363.308651110727, 8371.246587807127, 8482.236598706146, 8544.658213671508, 8721.694740684046, 8733.126687331343, 8343.916560834314, 8370.49777013369, 8378.0, 8569.715741619573, 8584.270337021424, 6422.454091402283, 6470.805875823733, 6594.538382313192, 6687.297833727486, 6705.396514313637, 1797.3619365125192, 1823.4078864636645, 1869.635421092901, 1888.1779083184517, 1890.810918908098, 873.5675840459013, 945.3618807305041, 967.2793768642406, 983.5967253426061, 1061.8938106189473, 18107.0, 19802.306919257757, 19946.20215191405, 20026.899865500578, 20374.28689995843, 957.1768279279814, 986.0878687214298, 1001.2090448545713, 1012.6759436980243, 1026.58423338548, 10966.561337546409, 11328.0, 11467.655970320904, 11470.139739519569, 11476.942615286871, 527543.0, 530994.0, 532597.0, 534682.0, 542202.0, 81999.5900020508, 96562.51718741503, 98192.0, 98345.0, 99789.0, 944.8299306124826, 959.947202903847, 965.7151140413595, 966.463612694947, 968.9224862011022, 17113.828861711223, 17176.22706978164, 17315.2208150631, 17697.911510442365, 18064.548386290448, 40289.79855100706, 40526.0, 40600.39099413452, 40982.79508602438, 42563.18988961751, 54551.0, 57029.0, 57105.0, 57271.71364143319, 58768.70615646894, 7767.3786097113225, 7945.721899733481, 8618.095100014409, 8793.29653627721, 8831.425957313011, 10777.784444311226, 13417.127886687334, 13520.39158237862, 13669.453221871412, 14090.577282681536, 11329.830052549383, 11735.47190376418, 11943.940280298542, 11982.520699171935, 12000.219985700902, 11684.357360345262, 11776.293422394683, 11836.70408239801, 11889.940550297193, 12051.879481205076, 11868.881311187122, 11978.46096925623, 12174.513019479476, 12190.57332993341, 12266.815997759863, 7699.076110866732, 8725.91274087251, 8869.822603548022, 8971.50656713887, 9158.542072896194, 11191.2725672831, 11303.717407064889, 11605.0, 11656.417179140839, 12188.634340969786], "value": 9578.839330959674, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1506.615812967693, 1515.015240093939, 1655.8675305975523, 1748.4404990403077, 1785.464360691792, 8544.273736732377, 9142.45145291283, 9159.0, 9160.587773550189, 9162.496062716547, 7576.621168941559, 8192.426530142893, 8497.872531912026, 8514.446560973533, 8962.238209752179, 2274.9203777867738, 2331.860088394702, 2339.30990357844, 2346.636271377939, 2347.6361164019604, 2301.9424514387106, 2320.9767902321014, 2368.7631236876346, 2381.095183830142, 2383.7973772229293, 2036.8472364572642, 2090.644590419625, 2094.214669498938, 2317.0268487235317, 2389.2473870730664, 2290.2900100968754, 2338.240071976614, 2338.38032921276, 2339.0643742502966, 2340.9180678676335, 2271.1937262271986, 2283.8287128465267, 2292.495650956787, 2295.391721193885, 2296.081567373064, 8261.297789687884, 8371.790705232357, 8747.343949203836, 8870.645174193025, 8884.734392729877, 5233.084210263189, 5372.113601255788, 5399.514043736082, 5403.297571315704, 5417.079096553595, 3227.774055816094, 3327.8169700666695, 3409.573803274591, 3413.5050417689545, 3418.7265018798435, 1160.6982184631972, 1221.1757063981865, 1227.643983244858, 1236.749116607774, 1244.352936473038, 12148.757024859453, 12391.0, 12391.75216495674, 12398.5660501882, 12399.380030998504, 4669.929951050737, 4761.47623761386, 4903.656744027884, 4916.360873086547, 4929.767558110472, 9599.47202903847, 9643.08390702882, 9680.419174849532, 9689.41863488193, 9693.903060969442, 5255.842324730264, 5264.236685680555, 5268.762905669254, 5313.760880760297, 5334.0, 4842.951570484321, 4944.0, 4978.6763860348965, 5002.699838009731, 5021.799128034838, 3690.597572922326, 3838.4626152338697, 3890.708196885245, 3906.8902792492304, 3920.5099362579676, 1178.3990165015903, 1198.4187668980537, 1198.9940050299692, 1203.0315595945174, 1212.6240865331774, 780.8321210939675, 819.3690858039396, 833.6604051053015, 963.1716723617683, 967.9854802177973, 5377.838664840061, 5749.626274292157, 5959.76160953557, 6031.155638210654, 6177.135201071854, 477.49147158276327, 479.36005432746975, 480.76442543154303, 493.9380332285615, 663.4493370502471, 4035.7174997749876, 4248.171606536757, 4273.572642735701, 4284.550122237182, 4343.305071188594, 10759.246852720235, 11070.889291107147, 11175.329480231212, 11176.27354221973, 11179.776404471864, 11019.449027548591, 11032.613858514913, 11060.336379817076, 11076.169287303484, 11092.168087393478, 7781.572013539309, 8232.50604963704, 8291.626876790559, 8294.626741796634, 8295.211954864279, 6104.969475152596, 6145.385461453819, 6154.969225153845, 6246.656433895998, 6303.779367722108, 10100.949495252476, 10220.488975551045, 10222.335548189343, 10233.846492302473, 10357.533910974174, 10135.898641013791, 10306.433146176732, 10382.480875956324, 10386.792264154827, 10518.0, 7793.571353575381, 8001.5999200038605, 8009.118996910219, 8015.318697910743, 8018.238267364591, 8471.745847624581, 8608.0, 8611.095834937241, 8660.307175425825, 8678.913210868062, 7717.459777815724, 7725.1502334744255, 7759.650815713419, 7765.0681918170185, 7905.920940790518, 7395.667194976347, 7407.407407407502, 7557.697692092254, 7595.658195381332, 7822.217778222132, 6893.620850853251, 7071.080759501232, 7109.075820143556, 7163.0, 7175.605341706257, 4826.95173048265, 5085.186370180753, 5163.638545301793, 5328.8401347959625, 5338.279332290091, 5323.228131920927, 5335.973320133375, 5344.893102138013, 5366.865828354166, 5433.864153396039], "value": 4577.941561491925, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.1894192930567, 338.20859189496576, 340.4280808242154, 340.9181796368872, 344.63468723153443, 5201.0, 5251.711155886424, 5270.894582108355, 5293.682379057259, 5306.867328316794, 4940.431850337212, 4997.450280469146, 5102.5407713305885, 5129.30689903269, 5149.201873709581, 4097.754134751909, 4105.290508264546, 4105.568915263899, 4108.465899433069, 4113.938290925631, 4101.897452563695, 4107.137501124753, 4124.876253712393, 4125.690573207006, 4136.482939632546, 3800.847966081353, 3881.001214679713, 4008.418779277003, 4010.2781499330254, 4074.694397920153, 4046.514418269797, 4052.4529188559463, 4058.0463591056077, 4060.3961435233064, 4067.3695577185435, 3570.767900086486, 3572.7677700949357, 3574.8212589370687, 3579.7673151245085, 3588.6949609283242, 4860.902781944341, 5046.5710414614805, 5070.898582028376, 5081.974590127063, 5108.770105345268, 4640.60554852838, 4659.0, 4662.323963025342, 4665.883352916204, 4677.134730074947, 5379.273798037254, 5407.594430417735, 5412.783488660449, 5441.5102640762525, 5451.991381594417, 3701.611330810253, 3860.575336712959, 3897.376419772851, 3916.862909798172, 3918.7648741075627, 5569.916451253194, 5597.6641401516035, 5600.383957764642, 5603.327600687903, 5628.183913332585, 3991.4212439196153, 4026.255142798533, 4035.878923632296, 4037.1320166164414, 4066.573009833984, 3967.166894952092, 4054.858079967246, 4110.712250142461, 4118.794060296973, 4121.361189015707, 4619.798852298427, 4623.468301145412, 4632.3977882875015, 4637.60580350674, 4673.299005149255, 5450.727463626803, 5458.4814442627885, 5459.935312614002, 5468.207109969032, 5480.205370221295, 1332.6068809701162, 1388.2572823539358, 1405.1639274631577, 1405.283305514195, 1410.6543896745159, 893.0756666849779, 905.8233644439402, 906.6418764588083, 918.7335672654989, 922.2529750901791, 4695.572232270461, 4729.219678753036, 4754.548317909793, 4792.586187074821, 4802.711837289774, 4565.657575681837, 4940.555350018516, 4944.678595891256, 4948.826791062295, 4960.693277625921, 4703.435587729495, 4715.552022557851, 4720.95279047212, 4725.818545363659, 4730.972177806207, 2627.1067836935536, 2630.552806022981, 2633.631291619175, 2634.0, 2642.471505698868, 5065.518775716301, 5066.454731306913, 5075.0, 5115.800205911494, 5449.6730196188355, 5719.084946408555, 5739.311282646109, 5754.338251101177, 5774.797882074107, 5782.739776710058, 5812.38969908162, 5815.912761308584, 5827.183195007277, 5840.182374467493, 5842.1236814477315, 5481.424450432647, 5596.972015139898, 5623.875224955107, 5626.5780066496, 5642.081692224663, 5557.943990641765, 5590.372524913284, 5591.356993945586, 5594.5244654203225, 5600.551955843442, 5617.775288988395, 5845.853853653693, 5854.882902342015, 5857.58996870215, 5859.882802343844, 3976.721629485908, 4016.7991600420446, 4021.7586944783407, 4023.551521452216, 4048.0, 5384.730763461733, 5486.396496385474, 5509.47659972302, 5512.476314750093, 5620.241267429008, 5343.904499577655, 5468.835934921959, 5502.339719233718, 5512.586556008396, 5541.534017362396, 5305.389880163831, 5489.313835770528, 5492.450754924475, 5500.779968801203, 5501.834944951658, 5440.564754819526, 5457.345118585795, 5472.72636368188, 5473.480019398151, 5486.451354864641, 5513.979913715975, 5521.558275337883, 5547.278853748987, 5552.0, 5552.861178470571, 5279.868003299948, 5384.303944257546, 5410.648307859977, 5411.621186516906, 5421.268128802719], "value": 4107.903110770459, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.3558708194919, 704.8379320114724, 716.2085895085933, 729.1942403643973, 804.4569915307167, 14853.40586376545, 15987.440439584618, 16119.597010074755, 16126.758098628501, 16143.273552690112, 13705.451781928736, 14266.572002839905, 14412.135271883695, 14947.103173809579, 14957.775633365509, 795.3994733975854, 824.6330382979577, 827.1645637905729, 828.0146625515647, 828.511178404741, 663.6880666086955, 791.0, 802.9558374289412, 808.7614153824636, 821.5029906906325, 858.8582883824162, 859.3554833874595, 859.4370687199894, 859.7506723050308, 863.9006514250879, 679.9048133261348, 853.5177624642057, 854.0903937306748, 854.2824027816602, 855.4696088425154, 601.7803501721884, 613.3406587918006, 613.487737738984, 619.4394073363613, 622.1942584353228, 14416.207108609022, 14420.0, 14958.177300248482, 14962.027468214532, 15016.624584385369, 12944.223346599234, 12994.935025324907, 13089.345532723326, 13200.0, 13553.864461355359, 12525.373731313397, 12650.430730617145, 12673.0, 12687.619371418872, 12690.555830545887, 3842.731008829383, 4498.325251212312, 4498.887527811831, 4506.2564676828615, 4566.360709500673, 71763.0, 80597.19402806014, 81115.59442202811, 81128.0, 81251.0, 10480.68557943263, 10613.416262105504, 10759.3544387337, 10856.945715271373, 11506.884931150582, 20388.79611203899, 20438.59122817535, 20440.28459003928, 20501.58996820055, 20535.8973205136, 8260.504369737835, 8294.129116442808, 8294.170582941779, 8426.957865210758, 8701.782455438664, 4807.158747219222, 4823.614110871122, 4825.276208568673, 4834.009028149221, 4859.246816743411, 3290.6380298167182, 3420.931581368359, 3422.264213194175, 3424.33225521026, 3424.9486257706153, 601.0, 606.8968275393105, 610.914471973924, 611.7583554496039, 613.1262950295811, 662.2549631664377, 668.7124536449373, 698.2284575544053, 703.2580627438, 704.8213941010821, 8605.655773769104, 9195.127061570332, 9417.764555886157, 9532.90467095334, 9835.852462213072, 639.7984634840011, 693.466031156007, 711.8754218011827, 713.1584730018628, 734.5042096584891, 4544.0, 4586.747728874877, 4625.791839367236, 4819.903601927942, 4858.344123543347, 126803.0, 127683.0, 130514.0, 130812.0, 135303.0, 88729.55635221912, 89874.0, 93992.53003734938, 97489.0, 98434.5078274604, 89281.55359223162, 89745.0, 90075.0, 90127.54936225408, 91239.54380228056, 9861.616536700087, 9983.900160998297, 10026.749331266778, 10034.448105354275, 10143.949280253551, 50837.23744143767, 50959.745201273756, 50994.74502627463, 51707.48292517027, 52986.73506632442, 45273.09453810971, 64441.67779161074, 75091.0, 77442.6127869357, 77615.2238477608, 12336.0, 12808.807867882175, 12946.0, 13032.348382581024, 13217.339133043117, 15143.318550665026, 15329.923350383177, 15352.155631440379, 15447.459338923083, 15855.68288634244, 13405.798913016508, 14136.646583835074, 14555.781663275271, 15010.249487525798, 15343.846561534241, 13345.662808734025, 13784.104033237807, 13874.306284685927, 14029.719405612035, 14199.0, 13489.325533723471, 14433.92783036078, 14480.0, 14509.709805803614, 14611.85388146105, 11409.045984832359, 11609.593664221711, 11668.533258669897, 11903.940480297542, 12169.939150304192, 11901.285922844658, 11979.460924258256, 12135.393230338272, 12337.753244934871, 12559.811602826148], "value": 7589.586177950817, "unit": "score"}], "name": "dromaeo_css", "value": 7286.112505174095, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 130.0, 113.0, 114.0, 113.0, 113.0, 111.0, 111.0, 113.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 118.0, 148.0, 179.0, 120.0, 145.0, 151.0, 124.0, 172.0, 118.0], "value": 142.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 161.0, 163.0, 163.0, 163.0, 163.0, 162.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 174.0, 77.0, 75.0, 74.0, 75.0, 163.0, 77.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 142.0, 81.0, 81.0, 81.0, 147.0, 81.0, 82.0, 135.0], "value": 99.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 56.0, 55.0, 55.0, 54.0, 53.0, 56.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 61.0, 62.0, 62.0, 61.0, 62.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 79.0, 85.0, 78.0, 79.0, 79.0, 79.0, 87.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 133.0, 123.0, 128.0, 134.0, 128.0, 123.0, 125.0, 160.0, 125.0], "value": 131.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 165.0, 163.0, 164.0, 164.0, 167.0, 167.0, 162.0, 165.0], "value": 164.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 66.0, 64.0, 68.0, 65.0, 64.0, 65.0, 64.0, 64.0], "value": 65.1, "unit": "score"}], "name": "kraken", "value": 1529.1000000000001, "alertThreshold": 2.0}]} 11:38:55 INFO - Return code: 0 11:38:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:38:55 INFO - # TBPL SUCCESS # 11:38:55 INFO - Running post-action listener: _resource_record_post_action 11:38:55 INFO - [mozharness: 2016-08-26 18:38:55.797926Z] Finished run-tests step (success) 11:38:55 INFO - Running post-run listener: _resource_record_post_run 11:38:55 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 8192; Write bytes: 422096896; Read time: 28; Write time: 330904 11:38:55 INFO - TinderboxPrint: CPU usage
13.1% 11:38:55 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 28 11:38:55 INFO - TinderboxPrint: I/O write bytes / time
422,096,896 / 330,904 11:38:55 INFO - TinderboxPrint: CPU idle
8,285.5 (86.9%) 11:38:55 INFO - TinderboxPrint: CPU user
1,198.4 (12.6%) 11:38:55 INFO - TinderboxPrint: Swap in / out
0 / 0 11:38:55 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 130023424; Read time: 0; Write time: 113640 11:38:55 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288251904; Read time: 16; Write time: 216536 11:38:56 INFO - Running post-run listener: _upload_blobber_files 11:38:56 INFO - Blob upload gear active. 11:38:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:38:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:38:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:38:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:38:56 INFO - (blobuploader) - INFO - Open directory for files ... 11:38:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:38:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:38:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:57 INFO - (blobuploader) - INFO - Done attempting. 11:38:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:38:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:39:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:03 INFO - (blobuploader) - INFO - Done attempting. 11:39:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:39:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:39:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:04 INFO - (blobuploader) - INFO - Done attempting. 11:39:04 INFO - (blobuploader) - INFO - Iteration through files over. 11:39:04 INFO - Return code: 0 11:39:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:39:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:39:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94ed9e2d28a4acd1d0a8600bd67f232ebcee3ca1fb912acf58a207f695d6705dd3c95048413c805fa3a74c4a7ebdb646bb8d12f2e2bb0757c55bf690200dc79a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79120a33c570e071e405f0d52c9449dac1f422391751ef147120c99dc6ee5df1ef37b1402504ec26ae6b2dd5a83035da915fcab4995012c89044779d97861fd8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2a78a917c55e6803e83412a525504e519db442003e9f64881b23978f8bc930cf64c739469d5ac70b12384bffe8c3e530d0de61c54d8cb3c18c4784990a715e6"} 11:39:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:39:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:39:04 INFO - Contents: 11:39:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94ed9e2d28a4acd1d0a8600bd67f232ebcee3ca1fb912acf58a207f695d6705dd3c95048413c805fa3a74c4a7ebdb646bb8d12f2e2bb0757c55bf690200dc79a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79120a33c570e071e405f0d52c9449dac1f422391751ef147120c99dc6ee5df1ef37b1402504ec26ae6b2dd5a83035da915fcab4995012c89044779d97861fd8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2a78a917c55e6803e83412a525504e519db442003e9f64881b23978f8bc930cf64c739469d5ac70b12384bffe8c3e530d0de61c54d8cb3c18c4784990a715e6"} 11:39:04 INFO - Running post-run listener: copy_logs_to_upload_dir 11:39:04 INFO - Copying logs to upload dir... 11:39:04 INFO - mkdir: /builds/slave/test/build/upload/logs 11:39:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.591409 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-08-26 11:39:04.521358) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 11:39:04.524511) ========= 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=00204705a9daa57ed339a427000001b9-1472233956.215283-1561741918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94ed9e2d28a4acd1d0a8600bd67f232ebcee3ca1fb912acf58a207f695d6705dd3c95048413c805fa3a74c4a7ebdb646bb8d12f2e2bb0757c55bf690200dc79a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79120a33c570e071e405f0d52c9449dac1f422391751ef147120c99dc6ee5df1ef37b1402504ec26ae6b2dd5a83035da915fcab4995012c89044779d97861fd8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2a78a917c55e6803e83412a525504e519db442003e9f64881b23978f8bc930cf64c739469d5ac70b12384bffe8c3e530d0de61c54d8cb3c18c4784990a715e6"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472225419/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472225419/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94ed9e2d28a4acd1d0a8600bd67f232ebcee3ca1fb912acf58a207f695d6705dd3c95048413c805fa3a74c4a7ebdb646bb8d12f2e2bb0757c55bf690200dc79a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79120a33c570e071e405f0d52c9449dac1f422391751ef147120c99dc6ee5df1ef37b1402504ec26ae6b2dd5a83035da915fcab4995012c89044779d97861fd8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d2a78a917c55e6803e83412a525504e519db442003e9f64881b23978f8bc930cf64c739469d5ac70b12384bffe8c3e530d0de61c54d8cb3c18c4784990a715e6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 11:39:04.552757) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 11:39:04.553150) ========= 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=00204705a9daa57ed339a427000001b9-1472233956.215283-1561741918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004418 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 11:39:04.631933) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 11:39:04.632253) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 11:39:04.632547) ========= ========= Total master_lag: 0.19 =========