builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1472746690.11 results: success (0) buildid: 20160901082419 builduid: 3642cc6692834be9831030298460cd10 revision: 9d715b38e5f094c63df4fa560fd00b6ff6852f9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 09:18:10.111140) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 09:18:10.111613) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 09:18:10.111900) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 09:18:10.127007) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 09:18:10.127394) ========= 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=0333a256a5e4f052382dd180000001b1-1472746690.143193-1241331832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-01 09:18:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-09-01 09:18:10 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126998 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 09:18:10.270433) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 09:18:10.270784) ========= 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=0333a256a5e4f052382dd180000001b1-1472746690.143193-1241331832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015429 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 09:18:10.320774) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 09:18:10.321164) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9d715b38e5f094c63df4fa560fd00b6ff6852f9b --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 9d715b38e5f094c63df4fa560fd00b6ff6852f9b --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=0333a256a5e4f052382dd180000001b1-1472746690.143193-1241331832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-01 09:18:11,080 truncating revision to first 12 chars 2016-09-01 09:18:11,080 Setting DEBUG logging. 2016-09-01 09:18:11,080 attempt 1/10 2016-09-01 09:18:11,080 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9d715b38e5f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 09:18:11,437 unpacking tar archive at: fx-team-9d715b38e5f0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.769120 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 09:18:11.103808) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 09:18:11.104128) ========= script_repo_revision: 9d715b38e5f094c63df4fa560fd00b6ff6852f9b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 09:18:11.104569) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 09:18:11.104845) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 09:18:11.114035) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-09-01 09:18:11.114384) ========= /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=0333a256a5e4f052382dd180000001b1-1472746690.143193-1241331832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:18:11 INFO - MultiFileLogger online at 20160901 09:18:11 in /builds/slave/test 09:18:11 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 09:18:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:18:11 INFO - {'append_to_log': False, 09:18:11 INFO - 'base_work_dir': '/builds/slave/test', 09:18:11 INFO - 'blob_upload_branch': 'Fx-Team', 09:18:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:18:11 INFO - 'branch': 'Fx-Team', 09:18:11 INFO - 'buildbot_json_path': 'buildprops.json', 09:18:11 INFO - 'config_files': ('talos/linux_config.py',), 09:18:11 INFO - 'default_actions': ('clobber', 09:18:11 INFO - 'read-buildbot-config', 09:18:11 INFO - 'download-and-extract', 09:18:11 INFO - 'populate-webroot', 09:18:11 INFO - 'create-virtualenv', 09:18:11 INFO - 'install', 09:18:11 INFO - 'run-tests'), 09:18:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:18:11 INFO - 'download_minidump_stackwalk': True, 09:18:11 INFO - 'download_symbols': 'ondemand', 09:18:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:18:11 INFO - 'tooltool.py': '/tools/tooltool.py', 09:18:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:18:11 INFO - '/tools/misc-python/virtualenv.py')}, 09:18:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:18:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:18:11 INFO - 'installer_path': 'installer.exe', 09:18:11 INFO - 'log_level': 'info', 09:18:11 INFO - 'log_name': 'talos', 09:18:11 INFO - 'log_to_console': True, 09:18:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:18:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:18:11 INFO - 'opt_config_files': (), 09:18:11 INFO - 'pip_index': False, 09:18:11 INFO - 'sps_profile': False, 09:18:11 INFO - 'sps_profile_interval': 0, 09:18:11 INFO - 'suite': 'dromaeojs', 09:18:11 INFO - 'system_bits': '32', 09:18:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:18:11 INFO - 'title': 'talos-linux64-ix-017', 09:18:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:18:11 INFO - 'use_talos_json': True, 09:18:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:18:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:18:11 INFO - 'work_dir': 'build'} 09:18:11 INFO - [mozharness: 2016-09-01 16:18:11.971248Z] Running clobber step. 09:18:11 INFO - Running pre-action listener: _resource_record_pre_action 09:18:11 INFO - Running main action method: clobber 09:18:11 INFO - rmtree: /builds/slave/test/build 09:18:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:18:12 INFO - Running post-action listener: _resource_record_post_action 09:18:12 INFO - [mozharness: 2016-09-01 16:18:12.971463Z] Finished clobber step (success) 09:18:12 INFO - [mozharness: 2016-09-01 16:18:12.971563Z] Running read-buildbot-config step. 09:18:12 INFO - Running pre-action listener: _resource_record_pre_action 09:18:12 INFO - Running main action method: read_buildbot_config 09:18:12 INFO - Using buildbot properties: 09:18:12 INFO - { 09:18:12 INFO - "project": "", 09:18:12 INFO - "product": "firefox", 09:18:12 INFO - "script_repo_revision": "production", 09:18:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:18:12 INFO - "repository": "", 09:18:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 09:18:12 INFO - "buildid": "20160901082419", 09:18:12 INFO - "stage_platform": "linux64-pgo", 09:18:12 INFO - "basedir": "/builds/slave/test", 09:18:12 INFO - "buildnumber": 1518, 09:18:12 INFO - "platform": "ubuntu64_hw", 09:18:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:18:12 INFO - "slavebuilddir": "test", 09:18:12 INFO - "branch": "fx-team", 09:18:12 INFO - "revision": "9d715b38e5f094c63df4fa560fd00b6ff6852f9b", 09:18:12 INFO - "slavename": "talos-linux64-ix-017", 09:18:12 INFO - "builduid": "3642cc6692834be9831030298460cd10", 09:18:12 INFO - "repo_path": "integration/fx-team" 09:18:12 INFO - } 09:18:12 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 09:18:12 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/firefox-51.0a1.en-US.linux-x86_64.test_packages.json. 09:18:12 INFO - Running post-action listener: _resource_record_post_action 09:18:12 INFO - [mozharness: 2016-09-01 16:18:12.973913Z] Finished read-buildbot-config step (success) 09:18:12 INFO - [mozharness: 2016-09-01 16:18:12.974003Z] Running download-and-extract step. 09:18:12 INFO - Running pre-action listener: _resource_record_pre_action 09:18:12 INFO - Running main action method: download_and_extract 09:18:12 INFO - mkdir: /builds/slave/test/build/tests 09:18:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:12 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:18:12 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/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 09:18:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/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 09:18:13 INFO - Downloaded 1361 bytes. 09:18:13 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:18:13 INFO - Using the following test package requirements: 09:18:13 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:18:13 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:18:13 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:18:13 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:13 INFO - u'jsshell-linux-x86_64.zip'], 09:18:13 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:18:13 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:18:13 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:18:13 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:18:13 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:18:13 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:18:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:18:13 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:13 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:18:13 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/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 09:18:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/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 09:18:16 INFO - Downloaded 21905498 bytes. 09:18:16 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 09:18:21 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 09:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:21 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:18:21 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/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 09:18:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/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 09:18:21 INFO - Downloaded 21905498 bytes. 09:18:21 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 09: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')]} 09:18:26 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 09:18:26 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/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 09:18:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/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 09:18:30 INFO - Downloaded 14413998 bytes. 09:18:30 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 09:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:30 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:18:30 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/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 09:18:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/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 09:18:42 INFO - Downloaded 59733953 bytes. 09:18:42 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:18:42 INFO - mkdir: /builds/slave/test/properties 09:18:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:18:42 INFO - Writing to file /builds/slave/test/properties/build_url 09:18:42 INFO - Contents: 09:18:42 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:18:42 INFO - Running post-action listener: _resource_record_post_action 09:18:42 INFO - Running post-action listener: set_extra_try_arguments 09:18:42 INFO - [mozharness: 2016-09-01 16:18:42.979144Z] Finished download-and-extract step (success) 09:18:42 INFO - [mozharness: 2016-09-01 16:18:42.979372Z] Running populate-webroot step. 09:18:42 INFO - Running pre-action listener: _resource_record_pre_action 09:18:42 INFO - Running main action method: populate_webroot 09:18:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:18:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:18:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:18:42 INFO - '--tppagecycles', 09:18:42 INFO - '7'], 09:18:42 INFO - 'tests': ['tsvgm']}}, 09:18:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:18:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:18:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:18:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:18:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:18:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:18:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:42 INFO - 'talos_options': ['--disable-e10s'], 09:18:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:18:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:18:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:42 INFO - 'talos_options': ['--disable-e10s'], 09:18:42 INFO - 'tests': ['damp', 'tps']}, 09:18:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:42 INFO - 'tests': ['damp', 'tps']}, 09:18:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:18:42 INFO - 'tests': ['dromaeo_dom']}, 09:18:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:18:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:18:42 INFO - 'tests': ['basic_compositor_video']}, 09:18:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:18:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:18:42 INFO - 'tests': ['a11yr', 09:18:42 INFO - 'ts_paint', 09:18:42 INFO - 'tpaint', 09:18:42 INFO - 'sessionrestore', 09:18:42 INFO - 'sessionrestore_no_auto_restore', 09:18:42 INFO - 'tabpaint']}, 09:18:42 INFO - 'other-e10s': {'tests': ['a11yr', 09:18:42 INFO - 'ts_paint', 09:18:42 INFO - 'tpaint', 09:18:42 INFO - 'sessionrestore', 09:18:42 INFO - 'sessionrestore_no_auto_restore', 09:18:42 INFO - 'tabpaint']}, 09:18:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:18:42 INFO - 'ts_paint', 09:18:42 INFO - 'tpaint', 09:18:42 INFO - 'sessionrestore', 09:18:42 INFO - 'sessionrestore_no_auto_restore', 09:18:42 INFO - 'tabpaint']}, 09:18:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:18:42 INFO - 'ts_paint', 09:18:42 INFO - 'tpaint', 09:18:42 INFO - 'sessionrestore', 09:18:42 INFO - 'sessionrestore_no_auto_restore', 09:18:42 INFO - 'tabpaint']}, 09:18:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:18:42 INFO - 'tests': ['a11yr', 09:18:42 INFO - 'ts_paint', 09:18:42 INFO - 'tpaint', 09:18:42 INFO - 'sessionrestore', 09:18:42 INFO - 'sessionrestore_no_auto_restore', 09:18:42 INFO - 'tabpaint']}, 09:18:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:18:42 INFO - 'tests': ['a11yr', 09:18:42 INFO - 'ts_paint', 09:18:42 INFO - 'tpaint', 09:18:42 INFO - 'sessionrestore', 09:18:42 INFO - 'sessionrestore_no_auto_restore', 09:18:42 INFO - 'tabpaint']}, 09:18:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:18:42 INFO - 'tests': ['tsvgx', 09:18:42 INFO - 'tsvgr_opacity', 09:18:42 INFO - 'tart', 09:18:42 INFO - 'tscrollx', 09:18:42 INFO - 'cart']}, 09:18:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:18:42 INFO - 'tsvgr_opacity', 09:18:42 INFO - 'tart', 09:18:42 INFO - 'tscrollx', 09:18:42 INFO - 'cart']}, 09:18:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:42 INFO - 'talos_options': ['--disable-e10s'], 09:18:42 INFO - 'tests': ['tp5o']}, 09:18:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:42 INFO - 'tests': ['tp5o']}, 09:18:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:42 INFO - 'talos_options': ['--disable-e10s', 09:18:42 INFO - '--xperf_path', 09:18:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:18:42 INFO - 'tests': ['tp5n']}, 09:18:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:18:42 INFO - 'talos_options': ['--xperf_path', 09:18:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:18:42 INFO - 'tests': ['tp5n']}}, 09:18:42 INFO - 'talos.zip': {'path': '', 09:18:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:18:42 INFO - Running post-action listener: _resource_record_post_action 09:18:42 INFO - [mozharness: 2016-09-01 16:18:42.999608Z] Finished populate-webroot step (success) 09:18:42 INFO - [mozharness: 2016-09-01 16:18:42.999697Z] Running create-virtualenv step. 09:18:42 INFO - Running pre-action listener: _resource_record_pre_action 09:18:42 INFO - Running main action method: create_virtualenv 09:18:42 INFO - Creating virtualenv /builds/slave/test/build/venv 09:18:43 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 09:18:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:18:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:18:43 INFO - Using real prefix '/usr' 09:18:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:18:43 INFO - Installing distribute.............................................................................................................................................................................................done. 09:18:45 INFO - Installing pip.................done. 09:18:45 INFO - Return code: 0 09:18:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:18:45 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')]} 09:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:45 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')]} 09:18:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:45 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 0x7f9cd8497f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a370>, '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 0x108d8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dd80>, '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': '0333a256a5e4f052382dd180000001b1-1472746690.143193-1241331832', '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 09:18:45 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 09:18:45 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 09:18:45 INFO - Using env: {'DISPLAY': ':0', 09:18:45 INFO - 'HOME': '/home/cltbld', 09:18:45 INFO - 'LANG': 'en_US.UTF-8', 09:18:45 INFO - 'LANGUAGE': 'en_US:en', 09:18:45 INFO - 'LOGNAME': 'cltbld', 09:18:45 INFO - 'MAIL': '/var/mail/cltbld', 09:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:45 INFO - 'MOZ_NO_REMOTE': '1', 09:18:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:45 INFO - 'NO_EM_RESTART': '1', 09:18:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:45 INFO - 'PWD': '/builds/slave/test', 09:18:45 INFO - 'SHELL': '/bin/bash', 09:18:45 INFO - 'SHLVL': '1', 09:18:45 INFO - 'TERM': 'linux', 09:18:45 INFO - 'TMOUT': '86400', 09:18:45 INFO - 'USER': 'cltbld', 09:18:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1472746690.143193-1241331832', 09:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:45 INFO - '_': '/tools/buildbot/bin/python'} 09:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:45 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 09:18:45 INFO - Cleaning up... 09:18:45 INFO - Return code: 0 09:18:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:18:45 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')]} 09:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:45 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')]} 09:18:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:45 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 0x7f9cd8497f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a370>, '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 0x108d8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dd80>, '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': '0333a256a5e4f052382dd180000001b1-1472746690.143193-1241331832', '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 09:18:45 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 09:18:45 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 09:18:45 INFO - Using env: {'DISPLAY': ':0', 09:18:45 INFO - 'HOME': '/home/cltbld', 09:18:45 INFO - 'LANG': 'en_US.UTF-8', 09:18:45 INFO - 'LANGUAGE': 'en_US:en', 09:18:45 INFO - 'LOGNAME': 'cltbld', 09:18:45 INFO - 'MAIL': '/var/mail/cltbld', 09:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:45 INFO - 'MOZ_NO_REMOTE': '1', 09:18:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:45 INFO - 'NO_EM_RESTART': '1', 09:18:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:45 INFO - 'PWD': '/builds/slave/test', 09:18:45 INFO - 'SHELL': '/bin/bash', 09:18:45 INFO - 'SHLVL': '1', 09:18:45 INFO - 'TERM': 'linux', 09:18:45 INFO - 'TMOUT': '86400', 09:18:45 INFO - 'USER': 'cltbld', 09:18:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1472746690.143193-1241331832', 09:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:45 INFO - '_': '/tools/buildbot/bin/python'} 09:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:46 INFO - Downloading/unpacking psutil>=3.1.1 09: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 09: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 09: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 09: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 09: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 09: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 09:18:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:18:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:18:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:18:48 INFO - Installing collected packages: psutil 09:18:48 INFO - Running setup.py install for psutil 09:18:48 INFO - building 'psutil._psutil_linux' extension 09:18:48 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 09:18:48 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 09:18:48 INFO - building 'psutil._psutil_posix' extension 09:18:48 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 09:18:48 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 09:18:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:18:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:18:48 INFO - Successfully installed psutil 09:18:48 INFO - Cleaning up... 09:18:48 INFO - Return code: 0 09:18:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09: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')]} 09:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09: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')]} 09:18:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cd8497f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a370>, '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 0x108d8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dd80>, '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': '0333a256a5e4f052382dd180000001b1-1472746690.143193-1241331832', '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 09: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09: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 mozsystemmonitor==0.3 09:18:48 INFO - Using env: {'DISPLAY': ':0', 09:18:48 INFO - 'HOME': '/home/cltbld', 09:18:48 INFO - 'LANG': 'en_US.UTF-8', 09:18:48 INFO - 'LANGUAGE': 'en_US:en', 09:18:48 INFO - 'LOGNAME': 'cltbld', 09:18:48 INFO - 'MAIL': '/var/mail/cltbld', 09:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:48 INFO - 'MOZ_NO_REMOTE': '1', 09:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:48 INFO - 'NO_EM_RESTART': '1', 09:18:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:48 INFO - 'PWD': '/builds/slave/test', 09:18:48 INFO - 'SHELL': '/bin/bash', 09:18:48 INFO - 'SHLVL': '1', 09:18:48 INFO - 'TERM': 'linux', 09:18:48 INFO - 'TMOUT': '86400', 09:18:48 INFO - 'USER': 'cltbld', 09:18:48 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1472746690.143193-1241331832', 09:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:48 INFO - '_': '/tools/buildbot/bin/python'} 09:18:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 09: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 09: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 09: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 09: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 09: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 09: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 09:18:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:18:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:18:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:18:50 INFO - Installing collected packages: mozsystemmonitor 09:18:50 INFO - Running setup.py install for mozsystemmonitor 09:18:50 INFO - Successfully installed mozsystemmonitor 09:18:50 INFO - Cleaning up... 09:18:50 INFO - Return code: 0 09:18:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:50 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 0x7f9cd8497f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a370>, '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 0x108d8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dd80>, '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': '0333a256a5e4f052382dd180000001b1-1472746690.143193-1241331832', '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 09:18:50 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 09:18:50 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 09:18:50 INFO - Using env: {'DISPLAY': ':0', 09:18:50 INFO - 'HOME': '/home/cltbld', 09:18:50 INFO - 'LANG': 'en_US.UTF-8', 09:18:50 INFO - 'LANGUAGE': 'en_US:en', 09:18:50 INFO - 'LOGNAME': 'cltbld', 09:18:50 INFO - 'MAIL': '/var/mail/cltbld', 09:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:50 INFO - 'MOZ_NO_REMOTE': '1', 09:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:50 INFO - 'NO_EM_RESTART': '1', 09:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:50 INFO - 'PWD': '/builds/slave/test', 09:18:50 INFO - 'SHELL': '/bin/bash', 09:18:50 INFO - 'SHLVL': '1', 09:18:50 INFO - 'TERM': 'linux', 09:18:50 INFO - 'TMOUT': '86400', 09:18:50 INFO - 'USER': 'cltbld', 09:18:50 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1472746690.143193-1241331832', 09:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:50 INFO - '_': '/tools/buildbot/bin/python'} 09:18:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:51 INFO - Downloading/unpacking jsonschema==2.5.1 09: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 09: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 09: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 09: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 09: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 09: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 09:18:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:18:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:18:52 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 09:18:52 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 09:18:52 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 09:18:52 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 09:18:52 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 09:18:52 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 09:18:53 INFO - Downloading functools32-3.2.3-2.tar.gz 09:18:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:18:53 INFO - warning: no files found matching '*.txt' 09:18:53 INFO - no previously-included directories found matching 'build' 09:18:53 INFO - no previously-included directories found matching 'dist' 09:18:53 INFO - no previously-included directories found matching '.git*' 09:18:53 INFO - Installing collected packages: jsonschema, functools32 09:18:53 INFO - Running setup.py install for functools32 09:18:53 INFO - warning: no files found matching '*.txt' 09:18:53 INFO - no previously-included directories found matching 'build' 09:18:53 INFO - no previously-included directories found matching 'dist' 09:18:53 INFO - no previously-included directories found matching '.git*' 09:18:53 INFO - Successfully installed jsonschema functools32 09:18:53 INFO - Cleaning up... 09:18:53 INFO - Return code: 0 09:18:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:53 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 0x7f9cd8497f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a370>, '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 0x108d8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dd80>, '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': '0333a256a5e4f052382dd180000001b1-1472746690.143193-1241331832', '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 09:18:53 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 09:18:53 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 09:18:53 INFO - Using env: {'DISPLAY': ':0', 09:18:53 INFO - 'HOME': '/home/cltbld', 09:18:53 INFO - 'LANG': 'en_US.UTF-8', 09:18:53 INFO - 'LANGUAGE': 'en_US:en', 09:18:53 INFO - 'LOGNAME': 'cltbld', 09:18:53 INFO - 'MAIL': '/var/mail/cltbld', 09:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:53 INFO - 'MOZ_NO_REMOTE': '1', 09:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:53 INFO - 'NO_EM_RESTART': '1', 09:18:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:53 INFO - 'PWD': '/builds/slave/test', 09:18:53 INFO - 'SHELL': '/bin/bash', 09:18:53 INFO - 'SHLVL': '1', 09:18:53 INFO - 'TERM': 'linux', 09:18:53 INFO - 'TMOUT': '86400', 09:18:53 INFO - 'USER': 'cltbld', 09:18:53 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1472746690.143193-1241331832', 09:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:53 INFO - '_': '/tools/buildbot/bin/python'} 09:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:18:53 INFO - Cleaning up... 09:18:53 INFO - Return code: 0 09:18:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:53 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 0x7f9cd8497f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a370>, '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 0x108d8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dd80>, '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': '0333a256a5e4f052382dd180000001b1-1472746690.143193-1241331832', '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 09:18:53 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 09:18:53 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 09:18:53 INFO - Using env: {'DISPLAY': ':0', 09:18:53 INFO - 'HOME': '/home/cltbld', 09:18:53 INFO - 'LANG': 'en_US.UTF-8', 09:18:53 INFO - 'LANGUAGE': 'en_US:en', 09:18:53 INFO - 'LOGNAME': 'cltbld', 09:18:53 INFO - 'MAIL': '/var/mail/cltbld', 09:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:53 INFO - 'MOZ_NO_REMOTE': '1', 09:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:53 INFO - 'NO_EM_RESTART': '1', 09:18:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:53 INFO - 'PWD': '/builds/slave/test', 09:18:53 INFO - 'SHELL': '/bin/bash', 09:18:53 INFO - 'SHLVL': '1', 09:18:53 INFO - 'TERM': 'linux', 09:18:53 INFO - 'TMOUT': '86400', 09:18:53 INFO - 'USER': 'cltbld', 09:18:53 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1472746690.143193-1241331832', 09:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:53 INFO - '_': '/tools/buildbot/bin/python'} 09:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:53 INFO - Downloading/unpacking blobuploader==1.2.4 09:18:53 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 09:18:53 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 09:18:53 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 09:18:53 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 09:18:53 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 09:18:53 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 09:18:55 INFO - Downloading blobuploader-1.2.4.tar.gz 09:18:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:18:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:18:55 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 09:18:55 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 09:18:55 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 09:18:55 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 09:18:55 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 09:18:55 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 09:18:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:18:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09: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 09: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 09: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 09: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 09: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 09: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 09:18:56 INFO - Downloading docopt-0.6.1.tar.gz 09:18:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:18:56 INFO - Installing collected packages: blobuploader, requests, docopt 09:18:56 INFO - Running setup.py install for blobuploader 09:18:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:18:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:18:56 INFO - Running setup.py install for requests 09:18:56 INFO - Running setup.py install for docopt 09:18:57 INFO - Successfully installed blobuploader requests docopt 09:18:57 INFO - Cleaning up... 09:18:57 INFO - Return code: 0 09:18:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:18:57 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')]} 09:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:18:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:57 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')]} 09:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:18:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:18:57 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 0x7f9cd8497f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a370>, '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 0x108d8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dd80>, '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': '0333a256a5e4f052382dd180000001b1-1472746690.143193-1241331832', '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 09:18:57 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 09:18:57 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 09:18:57 INFO - Using env: {'DISPLAY': ':0', 09:18:57 INFO - 'HOME': '/home/cltbld', 09:18:57 INFO - 'LANG': 'en_US.UTF-8', 09:18:57 INFO - 'LANGUAGE': 'en_US:en', 09:18:57 INFO - 'LOGNAME': 'cltbld', 09:18:57 INFO - 'MAIL': '/var/mail/cltbld', 09:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:57 INFO - 'MOZ_NO_REMOTE': '1', 09:18:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:18:57 INFO - 'NO_EM_RESTART': '1', 09:18:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:57 INFO - 'PWD': '/builds/slave/test', 09:18:57 INFO - 'SHELL': '/bin/bash', 09:18:57 INFO - 'SHLVL': '1', 09:18:57 INFO - 'TERM': 'linux', 09:18:57 INFO - 'TMOUT': '86400', 09:18:57 INFO - 'USER': 'cltbld', 09:18:57 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1472746690.143193-1241331832', 09:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:57 INFO - '_': '/tools/buildbot/bin/python'} 09:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:18:57 INFO - Running setup.py (path:/tmp/pip-gaJaus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:18:57 INFO - Running setup.py (path:/tmp/pip-b2QKkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:18:57 INFO - Running setup.py (path:/tmp/pip-6NFaJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:18:57 INFO - Running setup.py (path:/tmp/pip-RX3zFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:18:57 INFO - Running setup.py (path:/tmp/pip-Kv_jB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:18:57 INFO - Running setup.py (path:/tmp/pip-Z6kfUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:18:57 INFO - Running setup.py (path:/tmp/pip-iglxYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:18:57 INFO - Running setup.py (path:/tmp/pip-UF06wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:18:57 INFO - Running setup.py (path:/tmp/pip-LqQEhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:18:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:18:57 INFO - Running setup.py (path:/tmp/pip-ZDOp_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:18:58 INFO - Running setup.py (path:/tmp/pip-Ti3Jlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:18:58 INFO - Running setup.py (path:/tmp/pip-yu0SIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:18:58 INFO - Running setup.py (path:/tmp/pip-SezYxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:18:58 INFO - Running setup.py (path:/tmp/pip-uvZcUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:58 INFO - Running setup.py (path:/tmp/pip-pV2K4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:18:58 INFO - Running setup.py (path:/tmp/pip-AAZWNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:18:58 INFO - Running setup.py (path:/tmp/pip-ZRIIWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:18:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:18:58 INFO - Running setup.py install for manifestparser 09:18:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:18:58 INFO - Running setup.py install for mozcrash 09:18:58 INFO - Running setup.py install for mozdebug 09:18:58 INFO - Running setup.py install for mozdevice 09:18:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:18:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:18:58 INFO - Running setup.py install for mozfile 09:18:59 INFO - Running setup.py install for mozhttpd 09:18:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:18:59 INFO - Running setup.py install for mozinfo 09:18:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:18:59 INFO - Running setup.py install for mozInstall 09:18:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:18:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:18:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:18:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:18:59 INFO - Running setup.py install for mozleak 09:18:59 INFO - Running setup.py install for mozlog 09:18:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:18:59 INFO - Running setup.py install for moznetwork 09:18:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:18:59 INFO - Running setup.py install for mozprocess 09:18:59 INFO - Running setup.py install for mozprofile 09:18:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:18:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:18:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:18:59 INFO - Running setup.py install for mozrunner 09:19:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:19:00 INFO - Running setup.py install for mozscreenshot 09:19:00 INFO - Running setup.py install for moztest 09:19:00 INFO - Running setup.py install for mozversion 09:19:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:19:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:19:00 INFO - Cleaning up... 09:19:00 INFO - Return code: 0 09:19:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:00 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 0x7f9cd8497f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a370>, '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 0x108d8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dd80>, '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': '0333a256a5e4f052382dd180000001b1-1472746690.143193-1241331832', '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 09:19:00 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 09:19:00 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 09:19:00 INFO - Using env: {'DISPLAY': ':0', 09:19:00 INFO - 'HOME': '/home/cltbld', 09:19:00 INFO - 'LANG': 'en_US.UTF-8', 09:19:00 INFO - 'LANGUAGE': 'en_US:en', 09:19:00 INFO - 'LOGNAME': 'cltbld', 09:19:00 INFO - 'MAIL': '/var/mail/cltbld', 09:19:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:00 INFO - 'MOZ_NO_REMOTE': '1', 09:19:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:00 INFO - 'NO_EM_RESTART': '1', 09:19:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:00 INFO - 'PWD': '/builds/slave/test', 09:19:00 INFO - 'SHELL': '/bin/bash', 09:19:00 INFO - 'SHLVL': '1', 09:19:00 INFO - 'TERM': 'linux', 09:19:00 INFO - 'TMOUT': '86400', 09:19:00 INFO - 'USER': 'cltbld', 09:19:00 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1472746690.143193-1241331832', 09:19:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:00 INFO - '_': '/tools/buildbot/bin/python'} 09:19:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:00 INFO - Running setup.py (path:/tmp/pip-vaWXWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:00 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)) 09:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:00 INFO - Running setup.py (path:/tmp/pip-6rtg6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:00 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)) 09:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:00 INFO - Running setup.py (path:/tmp/pip-xzLY3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:00 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)) 09:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:00 INFO - Running setup.py (path:/tmp/pip-H0shhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:00 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)) 09:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:00 INFO - Running setup.py (path:/tmp/pip-OSYpdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:00 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)) 09:19:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:00 INFO - Running setup.py (path:/tmp/pip-c_3mjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:01 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)) 09:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:01 INFO - Running setup.py (path:/tmp/pip-h4tWZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:01 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)) 09:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:01 INFO - Running setup.py (path:/tmp/pip-cScCe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:01 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)) 09:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:01 INFO - Running setup.py (path:/tmp/pip-oxoOEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:01 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)) 09:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:01 INFO - Running setup.py (path:/tmp/pip-UCIV8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:01 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)) 09:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:01 INFO - Running setup.py (path:/tmp/pip-2bzPlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:01 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)) 09:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:01 INFO - Running setup.py (path:/tmp/pip-WEOBWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:01 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)) 09:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:01 INFO - Running setup.py (path:/tmp/pip-pB8y4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:01 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)) 09:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:01 INFO - Running setup.py (path:/tmp/pip-xlkbLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:01 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)) 09:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:01 INFO - Running setup.py (path:/tmp/pip-XJUCGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:01 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)) 09:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:01 INFO - Running setup.py (path:/tmp/pip-MCTpjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:01 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)) 09:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:01 INFO - Running setup.py (path:/tmp/pip-Im2SsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:01 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)) 09:19:01 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)) 09:19:01 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)) 09:19:01 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)) 09:19:01 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)) 09:19:01 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)) 09:19:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:19:01 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 09:19:01 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 09:19:01 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 09:19:01 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 09:19:01 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 09:19:01 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 09:19:03 INFO - Downloading blessings-1.6.tar.gz 09:19:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:19:03 INFO - Installing collected packages: blessings 09:19:03 INFO - Running setup.py install for blessings 09:19:03 INFO - Successfully installed blessings 09:19:03 INFO - Cleaning up... 09:19:04 INFO - Return code: 0 09:19:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:19:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:04 INFO - Reading from file tmpfile_stdout 09:19:04 INFO - Current package versions: 09:19:04 INFO - argparse == 1.2.1 09:19:04 INFO - blessings == 1.6 09:19:04 INFO - blobuploader == 1.2.4 09:19:04 INFO - docopt == 0.6.1 09:19:04 INFO - functools32 == 3.2.3-2 09:19:04 INFO - jsonschema == 2.5.1 09:19:04 INFO - manifestparser == 1.1 09:19:04 INFO - mozInstall == 1.12 09:19:04 INFO - mozcrash == 0.17 09:19:04 INFO - mozdebug == 0.1 09:19:04 INFO - mozdevice == 0.48 09:19:04 INFO - mozfile == 1.2 09:19:04 INFO - mozhttpd == 0.7 09:19:04 INFO - mozinfo == 0.9 09:19:04 INFO - mozleak == 0.1 09:19:04 INFO - mozlog == 3.3 09:19:04 INFO - moznetwork == 0.27 09:19:04 INFO - mozprocess == 0.23 09:19:04 INFO - mozprofile == 0.28 09:19:04 INFO - mozrunner == 6.12 09:19:04 INFO - mozscreenshot == 0.1 09:19:04 INFO - mozsystemmonitor == 0.3 09:19:04 INFO - moztest == 0.7 09:19:04 INFO - mozversion == 1.4 09:19:04 INFO - psutil == 3.1.1 09:19:04 INFO - requests == 1.2.3 09:19:04 INFO - wsgiref == 0.1.2 09:19:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:04 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 0x7f9cd8497f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a370>, '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 0x108d8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dd80>, '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': '0333a256a5e4f052382dd180000001b1-1472746690.143193-1241331832', '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 09:19:04 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 09:19:04 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 09:19:04 INFO - Using env: {'DISPLAY': ':0', 09:19:04 INFO - 'HOME': '/home/cltbld', 09:19:04 INFO - 'LANG': 'en_US.UTF-8', 09:19:04 INFO - 'LANGUAGE': 'en_US:en', 09:19:04 INFO - 'LOGNAME': 'cltbld', 09:19:04 INFO - 'MAIL': '/var/mail/cltbld', 09:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:04 INFO - 'MOZ_NO_REMOTE': '1', 09:19:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:04 INFO - 'NO_EM_RESTART': '1', 09:19:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:04 INFO - 'PWD': '/builds/slave/test', 09:19:04 INFO - 'SHELL': '/bin/bash', 09:19:04 INFO - 'SHLVL': '1', 09:19:04 INFO - 'TERM': 'linux', 09:19:04 INFO - 'TMOUT': '86400', 09:19:04 INFO - 'USER': 'cltbld', 09:19:04 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1472746690.143193-1241331832', 09:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:04 INFO - '_': '/tools/buildbot/bin/python'} 09:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:04 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)) 09:19:04 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)) 09:19:04 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)) 09:19:04 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)) 09:19:04 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)) 09:19:04 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)) 09:19:04 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)) 09:19:04 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)) 09:19:04 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)) 09:19:04 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)) 09:19:04 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)) 09:19:04 INFO - Cleaning up... 09:19:04 INFO - Return code: 0 09:19:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cd8497f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a370>, '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 0x108d8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dd80>, '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': '0333a256a5e4f052382dd180000001b1-1472746690.143193-1241331832', '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 09:19:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:19:04 INFO - Using env: {'DISPLAY': ':0', 09:19:04 INFO - 'HOME': '/home/cltbld', 09:19:04 INFO - 'LANG': 'en_US.UTF-8', 09:19:04 INFO - 'LANGUAGE': 'en_US:en', 09:19:04 INFO - 'LOGNAME': 'cltbld', 09:19:04 INFO - 'MAIL': '/var/mail/cltbld', 09:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:04 INFO - 'MOZ_NO_REMOTE': '1', 09:19:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:04 INFO - 'NO_EM_RESTART': '1', 09:19:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:04 INFO - 'PWD': '/builds/slave/test', 09:19:04 INFO - 'SHELL': '/bin/bash', 09:19:04 INFO - 'SHLVL': '1', 09:19:04 INFO - 'TERM': 'linux', 09:19:04 INFO - 'TMOUT': '86400', 09:19:04 INFO - 'USER': 'cltbld', 09:19:04 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1472746690.143193-1241331832', 09:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:04 INFO - '_': '/tools/buildbot/bin/python'} 09:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:19:04 INFO - Cleaning up... 09:19:04 INFO - Return code: 0 09:19:04 INFO - Running post-action listener: _resource_record_post_action 09:19:04 INFO - Running post-action listener: _start_resource_monitoring 09:19:04 INFO - Starting resource monitoring. 09:19:04 INFO - [mozharness: 2016-09-01 16:19:04.977750Z] Finished create-virtualenv step (success) 09:19:04 INFO - [mozharness: 2016-09-01 16:19:04.978202Z] Running install step. 09:19:04 INFO - Running pre-action listener: _resource_record_pre_action 09:19:04 INFO - Running main action method: install 09:19:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:05 INFO - Reading from file tmpfile_stdout 09:19:05 INFO - Detecting whether we're running mozinstall >=1.0... 09:19:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:19:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:19:05 INFO - Reading from file tmpfile_stdout 09:19:05 INFO - Output received: 09:19:05 INFO - Usage: mozinstall [options] installer 09:19:05 INFO - Options: 09:19:05 INFO - -h, --help show this help message and exit 09:19:05 INFO - -d DEST, --destination=DEST 09:19:05 INFO - Directory to install application into. [default: 09:19:05 INFO - "/builds/slave/test"] 09:19:05 INFO - --app=APP Application being installed. [default: firefox] 09:19:05 INFO - mkdir: /builds/slave/test/build/application 09:19:05 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'] 09:19:05 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 09:19:22 INFO - Reading from file tmpfile_stdout 09:19:22 INFO - Output received: 09:19:22 INFO - /builds/slave/test/build/application/firefox/firefox 09:19:22 INFO - Running post-action listener: _resource_record_post_action 09:19:22 INFO - [mozharness: 2016-09-01 16:19:22.278957Z] Finished install step (success) 09:19:22 INFO - [mozharness: 2016-09-01 16:19:22.279296Z] Running run-tests step. 09:19:22 INFO - Running pre-action listener: _resource_record_pre_action 09:19:22 INFO - Running main action method: run_tests 09:19:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:19:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:19:22 INFO - Python 2.7.3 09:19:22 INFO - Return code: 0 09:19:22 INFO - grabbing minidump binary from tooltool 09:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:19:22 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 0x108a370>, '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 0x108d8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108dd80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:19:22 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 09:19:22 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 09:19:22 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 09:19:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:19:22 INFO - Return code: 0 09:19:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:19:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:19:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:19:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:19:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:19:22 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/1472733002/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 09:19:22 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/1472733002/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 09:19:22 INFO - Using env: {'DISPLAY': ':0', 09:19:22 INFO - 'HOME': '/home/cltbld', 09:19:22 INFO - 'LANG': 'en_US.UTF-8', 09:19:22 INFO - 'LANGUAGE': 'en_US:en', 09:19:22 INFO - 'LOGNAME': 'cltbld', 09:19:22 INFO - 'MAIL': '/var/mail/cltbld', 09:19:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:19:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:19:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:22 INFO - 'MOZ_NO_REMOTE': '1', 09:19:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:19:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:22 INFO - 'NO_EM_RESTART': '1', 09:19:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:22 INFO - 'PWD': '/builds/slave/test', 09:19:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:19:22 INFO - 'SHELL': '/bin/bash', 09:19:22 INFO - 'SHLVL': '1', 09:19:22 INFO - 'TERM': 'linux', 09:19:22 INFO - 'TMOUT': '86400', 09:19:22 INFO - 'USER': 'cltbld', 09:19:22 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1472746690.143193-1241331832', 09:19:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:22 INFO - '_': '/tools/buildbot/bin/python'} 09:19:22 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/1472733002/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 09:19:22 INFO - mozversion application_buildid: 20160901053002 09:19:22 INFO - mozversion application_changeset: 9d715b38e5f094c63df4fa560fd00b6ff6852f9b 09:19:22 INFO - mozversion application_display_name: Nightly 09:19:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:19:22 INFO - mozversion application_name: Firefox 09:19:22 INFO - mozversion application_remotingname: firefox 09:19:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:19:22 INFO - mozversion application_vendor: Mozilla 09:19:22 INFO - mozversion application_version: 51.0a1 09:19:22 INFO - mozversion platform_buildid: 20160901053002 09:19:22 INFO - mozversion platform_changeset: 9d715b38e5f094c63df4fa560fd00b6ff6852f9b 09:19:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:19:22 INFO - mozversion platform_version: 51.0a1 09:19:22 INFO - using testdate: 1472746762 09:19:22 INFO - actual date: 1472746762 09:19:22 INFO - starting webserver on 'localhost:55362' 09:19:22 INFO - SUITE-START | Running 2 tests 09:19:22 INFO - TEST-START | dromaeo_css 09:19:22 INFO - operating with platform_type : linux_ 09:19:22 INFO - Initialising browser for dromaeo_css test... 09:19:22 INFO - TEST-INFO | started process 32763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphY2k8e/profile http://localhost:55362/getInfo.html) 09:19:26 INFO - PROCESS | 32763 | __metrics Screen width/height:1600/1200 09:19:26 INFO - PROCESS | 32763 | colorDepth:24 09:19:26 INFO - PROCESS | 32763 | Browser inner width/height: 1024/697 09:19:26 INFO - PROCESS | 32763 | __metrics 09:19:26 INFO - PROCESS | 32763 | 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" 09:19:26 INFO - PROCESS | 32763 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:19:27 INFO - PROCESS | 32763 | console.error: PushService: 09:19:27 INFO - PROCESS | 32763 | stateChangeProcessEnqueue: Error transitioning state 09:19:27 INFO - PROCESS | 32763 | UnknownError 09:19:28 INFO - TEST-INFO | 32763: exit 0 09:19:28 INFO - Browser initialized. 09:19:28 INFO - Running cycle 1/1 for dromaeo_css test... 09:19:28 INFO - TEST-INFO | started process 379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphY2k8e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:19:40 INFO - PROCESS | 379 | RSS: Main: 180572160 09:19:40 INFO - PROCESS | 379 | 09:20:31 INFO - PROCESS | 379 | 1472746831547 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] 09:22:41 INFO - PROCESS | 379 | Cycle 1(1): loaded http://localhost:55362/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55362/tests/dromaeo/cssquery-ext.html) 09:22:42 INFO - PROCESS | 379 | RSS: Main: 318214144 09:22:42 INFO - PROCESS | 379 | 09:25:44 INFO - PROCESS | 379 | Cycle 1(1): loaded http://localhost:55362/tests/dromaeo/cssquery-ext.html (next: http://localhost:55362/tests/dromaeo/cssquery-jquery.html) 09:25:45 INFO - PROCESS | 379 | RSS: Main: 273829888 09:25:45 INFO - PROCESS | 379 | 09:28:47 INFO - PROCESS | 379 | Cycle 1(1): loaded http://localhost:55362/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55362/tests/dromaeo/cssquery-mootools.html) 09:28:47 INFO - PROCESS | 379 | RSS: Main: 251551744 09:28:47 INFO - PROCESS | 379 | 09:31:49 INFO - PROCESS | 379 | Cycle 1(1): loaded http://localhost:55362/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55362/tests/dromaeo/cssquery-prototype.html) 09:31:50 INFO - PROCESS | 379 | RSS: Main: 230547456 09:31:50 INFO - PROCESS | 379 | 09:34:53 INFO - PROCESS | 379 | Cycle 1(1): loaded http://localhost:55362/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55362/tests/dromaeo/cssquery-yui.html) 09:34:53 INFO - PROCESS | 379 | RSS: Main: 218611712 09:34:53 INFO - PROCESS | 379 | 09:37:56 INFO - PROCESS | 379 | Cycle 1(1): loaded http://localhost:55362/tests/dromaeo/cssquery-yui.html (next: http://localhost:55362/tests/dromaeo/cssquery-dojo.html) 09:37:56 INFO - PROCESS | 379 | RSS: Main: 305803264 09:37:56 INFO - PROCESS | 379 | 09:37:56 INFO - PROCESS | 379 | __start_tp_report 09:37:56 INFO - PROCESS | 379 | _x_x_mozilla_page_load 09:37:56 INFO - PROCESS | 379 | _x_x_mozilla_page_load_details 09:37:56 INFO - PROCESS | 379 | |i|pagename|runs| 09:37:56 INFO - PROCESS | 379 | |0;dojo.html;3031.1664292319615;3037.8177309361436;3046.1470788179304;3063.8927637532693;3106.8912588059425;5115.155999260127;5210.192420174874;5243.475652434755;5289.947100528993;5322.654027488211;5275.6043296752705;5333.786648534054;5336.332958380202;5375.3280839895015;5384.326959130109;4757.952420475803;4770.880727981794;4811;4819.036192761444;4821.011692603008;4698.224792909183;4842.346283251769;4873.853784386456;4902.65681402302;4906.018796240748;4839.758012099399;4840.661153719241;4854.029194161164;4877.51224877513;4879.170541008037;4695.3426520287185;4744.335792988984;4812.975935120337;4817.253325734517;4872.707637541741;4735.621150307967;4786.114568804747;4792.281157826354;4800.447948485934;4872.1473742094995;5293.232481290192;5307.416184219733;5340.012097761926;5351.25082488452;5355.839324820262;5516.282883225195;5723.484886360206;5723.685197314146;5726.599138060337;5781.739821708034;5682.602217844753;5744.4829965303325;5750.884982300372;5752.913706294409;5811.6803575803315;5363.249145119687;5363.731813409353;5367.409584945692;5371.248025276464;5428.185772134172;5688.544916406678;5873;5877.853053673693;5880.029795083763;5884.323302820145;5538.307711536058;5576.553875689935;5611;5624.128260119688;5692.459216374438;5623.887522249532;5681.431856814285;5684.687342196136;5694.572907031907;5700.743466543932;5560.749766260528;5636.830895073154;5644.125160600031;5674.432556744293;5691.430856914276;5435;5620.803271885547;5636.436356364331;5655.886882262414;5718.313802343662;4386.320120381282;4394.582514661102;4399.428074350314;4399.612412730726;4444.933326000112;3895.1820117775583;3899.6100389961343;3919.7060220483577;3928.759553554575;3965.1673148638533;5349.679019258857;5403.405625381205;5404.648697834628;5418.078926582491;5503.147012213113;5713.600047996601;5729.455701708331;5734.942650573525;5740.913886291709;5749.540036797046;5272.182811664198;5414.7834086636885;5429.160036513616;5440.319960004999;5448.509634132868;4889.315495830587;4913.557779799835;4930.457649658535;4936.777844996984;4986.12742770021;5771.971140144273;5773.769049238152;5802.4197580241635;5827.825165245049;5832.912506312408;5558.221848941071;5599;5606.074997625346;5608.46719561641;5680.545556355564;5836.649801011953;5891.410858914074;5922.230110085834;5999.730012149376;6013.368596297326;5615.354234263112;5616.6068375213345;5670.149477578396;5705.22979397776;5735.8566035849435;5714.342850572071;5723.8569035774435;5724;5725.08398656213;5730.341010783646;5445.83662490126;5496.340439147328;5561.360443549043;5586.38549759518;5588.469095435927;5585.944140558705;5633.88732225345;5646.717664116695;5658;5665.348484924287;5446.509814116748;5522.779088836402;5523.475269849358;5530.087535556749;5533.087040638411;5480.177973304037;5536.574157325763;5578.63738856973;5585.357683866408;5586.636868603528;5392.433794451526;5446.046941785251;5463.644863083887;5498.780048798163;5531.917021244765 09:37:56 INFO - PROCESS | 379 | |1;ext.html;557.9832605021851;604.3231580629695;616.645428878395;627.811656503049;631.4884943196015;32377;44174;44893.10213795722;45107;45360.77319613402;45211.773941130334;45753;45790.31314530277;45826.54173458264;45915;8971.820563588724;9136.588853501575;9174.54127293636;9192.770180745469;9199.264058875275;8076.798080047987;10608.575656973711;10834.783304333909;10853.565857365697;11253.943730281337;11033.613823516178;11125.27685700431;11128.05411540016;11129.666110016713;11130.16523760717;10908.34549927007;10918.672439826818;10961.068309193728;10985.121190304757;10986.670399888017;10796.2442629016;10854.565817367296;10893.618723344645;10895.83656245149;10896.455177241185;43634;43635.34546981798;43993;44051.77974110109;44078.33882491765;3512.350215210194;3578.1233597768455;3627.764195327295;3943.7042221833476;4182.581741825793;31862;32585.511217331758;32608.184795380068;32779.83610081958;32811.17972050694;4158.106007208465;4225.281702110648;4261.275583150872;4381.715188512769;4477.350784136314;272656;274025;274152;274847;275351.6232418845;58479.15208479118;59014;59267;59290;59324.703376482845;61703;62192.689036555435;62205.68897155485;62249;62297.37702623006;16859.24133413999;17016.829831701772;17051.062191579582;17085.145742712815;17087.658246835243;12059.21615095016;12606.495740170474;13065.346732663329;13120;13127.934360328138;16059.518214453585;16120.919395402949;16395;16778.74831877523;16866.32534698623;5752.338481074647;5837.562182836305;5870.178175055496;5979.4618484336615;5991.2510936132985;951.4861974533675;1035.7410647338165;1058.756486008207;1068.1775033224374;1080.443571560647;31738.841305793325;32381.51427728586;32448.513272300934;32709.473078030576;33116.503252451235;1066.3921564708196;1080.4597701149426;1090.4111779638906;1100.8403781451646;1128.9604863829727;16248.675026499404;16771.832281677027;16950.49148525546;17060.146992650567;17149;550905;551743;551986;552248;553093;58890;58986.705066474395;59044.98117659961;59063;59109;1144.5078616194949;1234.8456442944632;1315.6381994951273;1320.5312114199512;1346.9865301347056;31232.843835781583;32149.678503215604;32845.34309313848;33102;33177.83411082929;49397.753011234716;50084.74957625189;50263.246051309994;50309.24536132034;50311.245331320795;405002;405278;406375;407727;408735;27197.728022720312;28544.57183142296;28570.42866142057;29755.256118597208;29890.402191956473;48952.51047489479;48962.26556601725;49032;49276.75361623169;51157;39817.57655799446;40686.38970415505;40726.18547628971;42062.36906446467;42527.574724252365;40609.238551784394;41116.38325425181;41144.38283425811;42919;42964.35553466638;39067.6093239064;39264.41103383509;40631.1873762529;41531.79234103931;43636;35139.82430087833;35695.464568030984;37554.24891502209;38075;38340.61659383482;25936;27151.45697086087;27203.59194612043;27249.59125613157;27385 09:37:56 INFO - PROCESS | 379 | |2;jquery.html;374.16561068816554;395.18591701095744;408.8528129873245;409.70091832961936;415.6799264566284;15956;19081.427557173272;19110.71333929992;19286.614267714656;20481.07835147418;18645.90677046616;19318.903405482986;19555;19603.705944410845;19624.705629415534;5292.444293349201;5595.21666966625;5607.990561698893;5717.857053573653;5799.623024503415;5665.348484924245;5702.344230413514;5722.313322401317;5755.856103597402;5765.558610347413;5618.438156184389;5652.802151924683;5726.083826587746;5734.197212390269;5775.162601422791;5645.604807663444;5683.744231509592;5688.4311568842995;5691.516221121168;5691.630044047124;4932.605391568666;5139.486051394831;5176.767045482962;5178.430372659004;5181.274621552986;23117.190898318477;23477.41306467335;23562.882185589133;23649.645255321186;23816.523669526687;2424.9272521824373;2451.264620613809;2560.7567281108263;2564.689718342121;2675.4649070185847;14059;14712.351776680192;14738.852611473856;15231.847681523264;15365.846341536553;1917.8465722742287;1932.0436383989875;1945.445548018822;1948.4349538633778;1976.9901150494156;49395;71061.64469177621;77958.61020694861;79283;80230.99999999942;10562.894371056345;10601;10794.784104318027;11043.668689939315;11202.271852329572;15006.548493846258;15026;15114.244287785787;15128.243587820565;15138.243087845563;8190.344772418192;8319.542425166674;8475.957620211859;8638.265747411415;8644.524551149621;8218.164733167048;8260.380471464665;8275.393433259158;8409.243168114777;8455.323574114056;6501.284858665543;6548.770793022221;6615.735370585123;6662.766803161866;6688.130543029375;1926.4798504403732;1941.175000624729;1954.1792447172222;1961.507043095362;1962.087629252376;870.1516021878745;946.6639343033262;1018.8828284747201;1022.749426390539;1094.7427354571669;20106.396808095782;20280.49298767513;20300.695489567668;20307.796922030888;20339.186432542534;965.1169180200179;980.9362391444533;1004.0612027754073;1008;1028.9588416463407;10738.516766745515;11159.386233757059;11201.66395008151;11255.887441125647;11401.94299028516;456155;474594;481949;482241;489882;46904.765476172404;49629;55768;83080.50758477255;85106.5744671285;999.9400035997718;1049.2707568240153;1061.3207547169663;1068.7167900506372;1077.3912739302268;16712.74930876062;16740.665186695955;17407.21667524939;17790.555236119202;18111.275548977894;38878.805605971786;38952.41571376488;38976.415353769145;39823.402648960866;40361.59638403579;53102.4689753113;54430;54430.455695442535;54579.454205457434;55170.17244741412;8460.238578527962;8567.74296771098;8607.870881936651;8747.343949203963;8852.3803333766;12659.746805064031;12727.681807954876;12970.67573310637;13009.080017031176;13453.730925381633;11544.88455115438;11596.652100437;11623.360715160747;11968.581099661818;12054.09594280415;11659.76680466369;11669.008134308679;11686.532538698357;11734.178607497393;12370.381480925738;12047.096467764777;12087.214331068453;12100.878991209975;12206.877931220573;12249.387530623611;8247.711330103417;8448.746537603882;8580.613872375883;8681.563020350433;8683.088275730957;11633.47649355764;11793.174477786473;11835.822462662894;11964.341961192218;12457.813132803196 09:37:56 INFO - PROCESS | 379 | |3;mootools.html;1334.908505430855;1470.6764511807405;1498.370684312589;1647.653992661541;1791.9283228670845;8759.91240087599;9186.219171370432;9251.768705782359;9564.473953932531;9577.138057574817;9381.90618093819;9519.762005949855;9533.04669533048;9538.904610953889;9542.0935011174;2476.8142389320783;2504.261242933339;2505.285993491855;2506.736792636765;2509.0591028364365;2432.1609044879488;2512.6356678281636;2513.949721005579;2516.219971808736;2518.3955850595908;2457.3856535866034;2475.3811547113223;2498.4253621666935;2500.9124680636182;2504.586743187372;2430.2952143878256;2449.4121410861444;2452.730199678034;2459.495803360307;2463.1009681466135;2385.7137143542714;2441.633754936756;2449.7060352757603;2452.644366566838;2453.644221587878;9100.681476148304;9337;9397.859032114455;9487.810243795086;9489.383190092622;5456.427075157091;5670.3479099903625;5679.318481782213;5680.772769089232;5684.914726279109;3317.7511686623598;3365.6634336566394;3415.316936612687;3416.419208734521;3421.2473255883665;1044.4568824211444;1078.4338222433207;1088.5739286049734;1095.1840878545454;1103.5420300575252;13048.869511304956;13167.670808229776;13188.604341869759;13264.40310186044;13273.601791946257;4399.36209249657;4487.259602165672;4598.057398233354;4603.286490593896;4704.882377940579;10332.380057196593;10333.586656533655;10345.534450949724;10347.068763811143;10353.74115647115;5502.284702988666;5507.972460137674;5508.504234618904;5511.283533140746;5514.228008078872;4495.57292057254;4964.205727083649;5072.949270507322;5100.974495127501;5168.896622067613;3769.4345848123003;3790.1282704977457;3858.093348063203;3947.348687466536;3953.7034722395933;1205.9698507537382;1236.71555542224;1237;1247.5259401427581;1247.781638213309;999.1457304004971;1006.9697909062739;1013.7364285285731;1023.6468418395641;1030.8144533983955;6270.122182894398;6361.14124593174;6372.2353317601255;6461.8061458156335;6500.804975850732;481.04992639536636;481.7398604753394;482.93721816163674;488.4748894937956;492.7240745182709;4389.648828093745;4464.665150113755;4541.750203738826;4579.633629309647;4619.46876109245;11440.656780296604;11674.124440666985;11720;11750.529978800752;11757.353345565905;11004.669859904216;11648.88351116495;11656.88343116575;11658.475368608433;11659.125565582615;8339.8332033359;8754.080821513777;8760.605772740242;8762.780930476789;8770.912290877137;6439.388258115471;6549.508786841101;6569.868602627825;6679.365460281266;6817.2501024888215;10555.050045495942;10798.784024319626;10858.239923205616;10953.397563133785;11033.393163376091;11169.88830111721;11229.4385280734;11229.66311010671;11231.157663175458;11244.83132752993;7516.849663006818;8127.268545830903;8179.182081791773;8294.170582941657;8412.411131220755;9183.724488265363;9341.766455838659;9366.110219529133;9371.203447706748;9371.250299976122;8123.106458289465;8202.26179643835;8258.545779982158;8344.833103337778;8577.399582029198;7752.5348479091435;7781.572013539309;8128.715494957648;8177.182281771775;8331.541765202972;7469.850602988018;7603.88594171099;7658.2724641159;7677.846443071219;7744.49660772048;5382.192671099367;5419.10584753527;5443.510084092451;5444.1017232156255;5479.808206712746;5244.261447268911;5305.973470132624;5476.04169270384;5534;5749.798757043651 09:37:56 INFO - PROCESS | 379 | |4;prototype.html;330.5636559741143;345.3645292661502;345.9290845376698;347.284593736902;352.2163186909126;5199.740012999354;5318.680879147244;5413.566914646829;5423.891522169554;5428.647137936036;5262.657927234727;5310.176922576997;5311.362636483627;5314.76083576239;5332.773462103709;4197.874063778091;4202.894927626811;4203.180379825935;4222.451081359419;4249.511306199795;4156.054295388493;4168.874933751992;4185.476815398075;4192.454980852485;4229.936550951738;4156.916861662765;4160.39674247234;4163.979180104096;4175.269327867626;4191.622753952143;4152.854650087247;4170.749755014678;4172.248995180867;4198.454200953887;4203.3064544350145;3735.7758534488016;3742.850285988557;3752.831122599462;3761.9435708464393;3764.623537646241;5109.6678715883345;5238.73806309683;5242.895142097175;5273.973630131824;5297.549708274802;4816.133096042711;4829.541193586604;4831.975840120777;4846.660733748639;4848.696868987238;5408.188771684239;5566;5570.637908535973;5582.692951887645;5585.022621041342;4077.143799802045;4080.6123418275215;4104.692148088905;4128.855490057864;4133.545310015896;5782.681952492611;5785.62393444429;5803.129530570406;5819.9418005819825;5823.592348535604;4152.086540960984;4192.155451601286;4202.873913782591;4217.514985776614;4227.548022147147;4100.507939047334;4157.91684166315;4194.643455306272;4197.706160568792;4214.494260688737;4731.503192164842;4742.0083564902825;4746.477887432379;4757.785899634525;4779.187538118528;5605.439456054443;5605.775768969195;5615.775368985195;5618;5650.971745141248;1379.6412932637586;1410.964725881861;1417.1213847414463;1424.0885833066845;1424.3590384327094;909.3543584055395;911.544227886057;927.4852456886492;929.5631053404888;934.8924873639619;4775.355327030876;4787.92271738856;4794.640401969867;4795.400574928134;4812.735299558558;5000.924986125211;5013.1227035268685;5039.622028347815;5091.694498330112;5127.256547800548;4782.760861956888;4789;4855.32025516428;4859.902801943941;5097.643164978416;2991.925201869927;3021.5165573508134;3021.534555740508;3037.769703270179;3039.3465404938042;5912.817436512714;5916.171735956969;5918.822435326947;5933.258342707161;5934.703264836741;5631.267935168402;5849.239598852122;5862.032764593794;5868.853278668067;5886.6173698709445;5886.911696324473;5903.911441328383;5911.172435858984;5914.349421563625;5950.821475355746;5593.161025846156;5699.316082070178;5728.828135155952;5757.712114394348;5776.104703770922;5659.122835960433;5680.971595141998;5689.516391106802;5694.259746232963;5706.372299047019;5878.088896221093;5931.406859314034;5935.643861368331;5936.554758393224;5963.717800672876;3938.9212215756097;4053.1488387438967;4082.9795851021745;4107.096438783463;4147.129102888427;5612.410696876933;5683.050280055487;5695.746935674145;5714.428557144252;5722.2561067061015;5598.580106492111;5615.438456154352;5650.773969041193;5655.321361436654;5655.406182350794;5448.264484294728;5513.3108361454815;5515.420880807618;5562.471565201461;5592.804251851166;5513.393526711979;5520.86197845041;5529.419410961952;5533.833984980457;5537.473939975695;5460.590455715757;5566.805161819317;5628.352739435018;5635.267415235993;5646.124850648156;5465.508104270635;5496.9217238346655;5499.642523235977;5506.779728810803;5512.200730894078 09:37:56 INFO - PROCESS | 379 | |5;yui.html;742.5878637356271;768.8769796832507;789.1319548496655;791.8376732769783;829.4857188543104;15889.2849821758;16791.496255112335;16982.49052528423;17006.234719437638;17112.82887171128;14686.339114739836;14847.1091734496;15625.296861641225;15760.211989400541;15812.209389530506;788.668759121169;802.4463120446902;805.5730462854697;806.1173015547965;806.5765473126626;653.6535636112868;777.296546625305;802.1136644008375;803.6624617660567;806.3871457692167;847.1528471528471;850.1031411860484;851.059579165023;851.0723311590365;851.1148405658108;846.3440833354139;846.7417437681505;847.0809172048334;847.2036285891304;847.3687103108163;502.3845788908558;597.2146627185238;608.9299730530958;621.4531212532987;621.67983488503;13804.102733322403;14029.017968742191;14056.859431405657;14212.14727116366;14217.50238741639;12903;13238.933805331008;13348.132371395925;13401.597952061455;13982;11499.310041397543;11514.596989105425;11567.363794991272;11579.710507237301;11871.46578403974;4260.637845783112;4271.145770845843;4299.505556860939;4350.991990264635;4534.047849951514;83302;83898.58050709707;84103;85056.57471712664;85817.14182858155;10511.1591072714;10732.624358147428;10793.62222322215;10827.67516974492;11305.60430384949;21995.670064949038;22027.559448810935;22036;22116.447088822588;22126;8295.211954864279;8328.541930193898;8363.498190108612;8478.830423391497;8742.82514349722;4501.392312037899;4531.977340113344;4589.632829373709;4742.5731684148595;4883.438404583448;3226.790258633181;3338.4825352070466;3344.7324214062814;3349.1794510344635;3351.145457908218;576.826951914424;585.4964730331911;589.6167491130714;594.895893218685;596.5168213746879;532.6724064700259;646.6378827856415;651.667649498759;666.3602941176428;724.8477819657826;8916.598753056129;9107.134822191882;9264.305177111744;9418.058194180665;9453.385529940531;556.4824713016933;624.6845343101704;638.533870274702;659.4526542969325;666.3469799596422;4339.913201735948;4344.674149438804;4370.912581748347;4437.622802061861;4504.842330518416;69886;104764.47617761862;129573.35213324061;129734.35132824276;134785.326073369;79434;95176.52411737897;110312.4484377589;112910.43544782388;116635.41682291705;93806;93979.53010234905;99210;99917.50371233311;101975;9553.18797902186;9699.369540980097;9792.46141462198;9857.852132217879;10061.849072263776;52744.208836868245;53623.73188134035;53762.19356709574;54804.72597636986;56216.437835621124;75157;77063.61468192624;80320.59839700763;81904;83276.58361708153;11765.470553824927;12286.38568071575;12426.254424734545;12474.064445166467;13068.738625227252;13883.65290867696;14522.782158267422;14798.112113272808;14813.259337033322;14928.62678433048;13963.232022238875;14278;14528.782068268772;14679.266036698336;15137.772933405788;13878.514252001536;14008.719825603635;14133.434662613381;14186.432542698589;14389.352479138674;13511.324433778469;13536.796948045983;13729.45082196741;13891.166530007828;14068.507602233873;10674;11132.833007504732;11175.832362514406;11262.155338349492;11450.656480305604;10484.842727358942;11510.654680359603;11759.412029398667;11823.70440738954;12052.397380130784 09:37:56 INFO - PROCESS | 379 | __end_tp_report 09:37:56 INFO - PROCESS | 379 | __start_cc_report 09:37:56 INFO - PROCESS | 379 | _x_x_mozilla_cycle_collect,1082 09:37:56 INFO - PROCESS | 379 | __end_cc_report 09:37:56 INFO - PROCESS | 379 | __startTimestamp1472747876808__endTimestamp 09:37:56 INFO - PROCESS | 379 | 09:37:56 INFO - PROCESS | 379 | ------- Summary: start ------- 09:37:56 INFO - PROCESS | 379 | Number of tests: 6 09:37:56 INFO - PROCESS | 379 | 09:37:56 INFO - PROCESS | 379 | [#0] dojo.html Cycles:165 Average:5287.94 Median:5498.78 stddev:599.98 (10.9%) stddev-sans-first:575.11 09:37:56 INFO - PROCESS | 379 | Values: 3031.2 3037.8 3046.1 3063.9 3106.9 5115.2 5210.2 5243.5 5289.9 5322.7 5275.6 5333.8 5336.3 5375.3 5384.3 4758.0 4770.9 4811.0 4819.0 4821.0 4698.2 4842.3 4873.9 4902.7 4906.0 4839.8 4840.7 4854.0 4877.5 4879.2 4695.3 4744.3 4813.0 4817.3 4872.7 4735.6 4786.1 4792.3 4800.4 4872.1 5293.2 5307.4 5340.0 5351.3 5355.8 5516.3 5723.5 5723.7 5726.6 5781.7 5682.6 5744.5 5750.9 5752.9 5811.7 5363.2 5363.7 5367.4 5371.2 5428.2 5688.5 5873.0 5877.9 5880.0 5884.3 5538.3 5576.6 5611.0 5624.1 5692.5 5623.9 5681.4 5684.7 5694.6 5700.7 5560.7 5636.8 5644.1 5674.4 5691.4 5435.0 5620.8 5636.4 5655.9 5718.3 4386.3 4394.6 4399.4 4399.6 4444.9 3895.2 3899.6 3919.7 3928.8 3965.2 5349.7 5403.4 5404.6 5418.1 5503.1 5713.6 5729.5 5734.9 5740.9 5749.5 5272.2 5414.8 5429.2 5440.3 5448.5 4889.3 4913.6 4930.5 4936.8 4986.1 5772.0 5773.8 5802.4 5827.8 5832.9 5558.2 5599.0 5606.1 5608.5 5680.5 5836.6 5891.4 5922.2 5999.7 6013.4 5615.4 5616.6 5670.1 5705.2 5735.9 5714.3 5723.9 5724.0 5725.1 5730.3 5445.8 5496.3 5561.4 5586.4 5588.5 5585.9 5633.9 5646.7 5658.0 5665.3 5446.5 5522.8 5523.5 5530.1 5533.1 5480.2 5536.6 5578.6 5585.4 5586.6 5392.4 5446.0 5463.6 5498.8 5531.9 09:37:56 INFO - PROCESS | 379 | 09:37:56 INFO - PROCESS | 379 | [#1] ext.html Cycles:180 Average:58111.10 Median:38207.81 stddev:113123.21 (296.1%) stddev-sans-first:113358.02 09:37:56 INFO - PROCESS | 379 | Values: 558.0 604.3 616.6 627.8 631.5 32377.0 44174.0 44893.1 45107.0 45360.8 45211.8 45753.0 45790.3 45826.5 45915.0 8971.8 9136.6 9174.5 9192.8 9199.3 8076.8 10608.6 10834.8 10853.6 11253.9 11033.6 11125.3 11128.1 11129.7 11130.2 10908.3 10918.7 10961.1 10985.1 10986.7 10796.2 10854.6 10893.6 10895.8 10896.5 43634.0 43635.3 43993.0 44051.8 44078.3 3512.4 3578.1 3627.8 3943.7 4182.6 31862.0 32585.5 32608.2 32779.8 32811.2 4158.1 4225.3 4261.3 4381.7 4477.4 272656.0 274025.0 274152.0 274847.0 275351.6 58479.2 59014.0 59267.0 59290.0 59324.7 61703.0 62192.7 62205.7 62249.0 62297.4 16859.2 17016.8 17051.1 17085.1 17087.7 12059.2 12606.5 13065.3 13120.0 13127.9 16059.5 16120.9 16395.0 16778.7 16866.3 5752.3 5837.6 5870.2 5979.5 5991.3 951.5 1035.7 1058.8 1068.2 1080.4 31738.8 32381.5 32448.5 32709.5 33116.5 1066.4 1080.5 1090.4 1100.8 1129.0 16248.7 16771.8 16950.5 17060.1 17149.0 550905.0 551743.0 551986.0 552248.0 553093.0 58890.0 58986.7 59045.0 59063.0 59109.0 1144.5 1234.8 1315.6 1320.5 1347.0 31232.8 32149.7 32845.3 33102.0 33177.8 49397.8 50084.7 50263.2 50309.2 50311.2 405002.0 405278.0 406375.0 407727.0 408735.0 27197.7 28544.6 28570.4 29755.3 29890.4 48952.5 48962.3 49032.0 49276.8 51157.0 39817.6 40686.4 40726.2 42062.4 42527.6 40609.2 41116.4 41144.4 42919.0 42964.4 39067.6 39264.4 40631.2 41531.8 43636.0 35139.8 35695.5 37554.2 38075.0 38340.6 25936.0 27151.5 27203.6 27249.6 27385.0 09:37:56 INFO - PROCESS | 379 | 09:37:56 INFO - PROCESS | 379 | [#2] jquery.html Cycles:180 Average:27678.79 Median:2438.10 stddev:78055.90 (3201.5%) stddev-sans-first:78247.94 09:37:56 INFO - PROCESS | 379 | Values: 374.2 395.2 408.9 409.7 415.7 15956.0 19081.4 19110.7 19286.6 20481.1 18645.9 19318.9 19555.0 19603.7 19624.7 5292.4 5595.2 5608.0 5717.9 5799.6 5665.3 5702.3 5722.3 5755.9 5765.6 5618.4 5652.8 5726.1 5734.2 5775.2 5645.6 5683.7 5688.4 5691.5 5691.6 4932.6 5139.5 5176.8 5178.4 5181.3 23117.2 23477.4 23562.9 23649.6 23816.5 2424.9 2451.3 2560.8 2564.7 2675.5 14059.0 14712.4 14738.9 15231.8 15365.8 1917.8 1932.0 1945.4 1948.4 1977.0 49395.0 71061.6 77958.6 79283.0 80231.0 10562.9 10601.0 10794.8 11043.7 11202.3 15006.5 15026.0 15114.2 15128.2 15138.2 8190.3 8319.5 8476.0 8638.3 8644.5 8218.2 8260.4 8275.4 8409.2 8455.3 6501.3 6548.8 6615.7 6662.8 6688.1 1926.5 1941.2 1954.2 1961.5 1962.1 870.2 946.7 1018.9 1022.7 1094.7 20106.4 20280.5 20300.7 20307.8 20339.2 965.1 980.9 1004.1 1008.0 1029.0 10738.5 11159.4 11201.7 11255.9 11401.9 456155.0 474594.0 481949.0 482241.0 489882.0 46904.8 49629.0 55768.0 83080.5 85106.6 999.9 1049.3 1061.3 1068.7 1077.4 16712.7 16740.7 17407.2 17790.6 18111.3 38878.8 38952.4 38976.4 39823.4 40361.6 53102.5 54430.0 54430.5 54579.5 55170.2 8460.2 8567.7 8607.9 8747.3 8852.4 12659.7 12727.7 12970.7 13009.1 13453.7 11544.9 11596.7 11623.4 11968.6 12054.1 11659.8 11669.0 11686.5 11734.2 12370.4 12047.1 12087.2 12100.9 12206.9 12249.4 8247.7 8448.7 8580.6 8681.6 8683.1 11633.5 11793.2 11835.8 11964.3 12457.8 09:37:56 INFO - PROCESS | 379 | 09:37:56 INFO - PROCESS | 379 | [#3] mootools.html Cycles:180 Average:6140.80 Median:4588.85 stddev:3565.71 (77.7%) stddev-sans-first:3557.42 09:37:56 INFO - PROCESS | 379 | Values: 1334.9 1470.7 1498.4 1647.7 1791.9 8759.9 9186.2 9251.8 9564.5 9577.1 9381.9 9519.8 9533.0 9538.9 9542.1 2476.8 2504.3 2505.3 2506.7 2509.1 2432.2 2512.6 2513.9 2516.2 2518.4 2457.4 2475.4 2498.4 2500.9 2504.6 2430.3 2449.4 2452.7 2459.5 2463.1 2385.7 2441.6 2449.7 2452.6 2453.6 9100.7 9337.0 9397.9 9487.8 9489.4 5456.4 5670.3 5679.3 5680.8 5684.9 3317.8 3365.7 3415.3 3416.4 3421.2 1044.5 1078.4 1088.6 1095.2 1103.5 13048.9 13167.7 13188.6 13264.4 13273.6 4399.4 4487.3 4598.1 4603.3 4704.9 10332.4 10333.6 10345.5 10347.1 10353.7 5502.3 5508.0 5508.5 5511.3 5514.2 4495.6 4964.2 5072.9 5101.0 5168.9 3769.4 3790.1 3858.1 3947.3 3953.7 1206.0 1236.7 1237.0 1247.5 1247.8 999.1 1007.0 1013.7 1023.6 1030.8 6270.1 6361.1 6372.2 6461.8 6500.8 481.0 481.7 482.9 488.5 492.7 4389.6 4464.7 4541.8 4579.6 4619.5 11440.7 11674.1 11720.0 11750.5 11757.4 11004.7 11648.9 11656.9 11658.5 11659.1 8339.8 8754.1 8760.6 8762.8 8770.9 6439.4 6549.5 6569.9 6679.4 6817.3 10555.1 10798.8 10858.2 10953.4 11033.4 11169.9 11229.4 11229.7 11231.2 11244.8 7516.8 8127.3 8179.2 8294.2 8412.4 9183.7 9341.8 9366.1 9371.2 9371.3 8123.1 8202.3 8258.5 8344.8 8577.4 7752.5 7781.6 8128.7 8177.2 8331.5 7469.9 7603.9 7658.3 7677.8 7744.5 5382.2 5419.1 5443.5 5444.1 5479.8 5244.3 5306.0 5476.0 5534.0 5749.8 09:37:56 INFO - PROCESS | 379 | 09:37:56 INFO - PROCESS | 379 | [#4] prototype.html Cycles:180 Average:4676.57 Median:5285.76 stddev:1363.51 (25.8%) stddev-sans-first:1327.74 09:37:56 INFO - PROCESS | 379 | Values: 330.6 345.4 345.9 347.3 352.2 5199.7 5318.7 5413.6 5423.9 5428.6 5262.7 5310.2 5311.4 5314.8 5332.8 4197.9 4202.9 4203.2 4222.5 4249.5 4156.1 4168.9 4185.5 4192.5 4229.9 4156.9 4160.4 4164.0 4175.3 4191.6 4152.9 4170.7 4172.2 4198.5 4203.3 3735.8 3742.9 3752.8 3761.9 3764.6 5109.7 5238.7 5242.9 5274.0 5297.5 4816.1 4829.5 4832.0 4846.7 4848.7 5408.2 5566.0 5570.6 5582.7 5585.0 4077.1 4080.6 4104.7 4128.9 4133.5 5782.7 5785.6 5803.1 5819.9 5823.6 4152.1 4192.2 4202.9 4217.5 4227.5 4100.5 4157.9 4194.6 4197.7 4214.5 4731.5 4742.0 4746.5 4757.8 4779.2 5605.4 5605.8 5615.8 5618.0 5651.0 1379.6 1411.0 1417.1 1424.1 1424.4 909.4 911.5 927.5 929.6 934.9 4775.4 4787.9 4794.6 4795.4 4812.7 5000.9 5013.1 5039.6 5091.7 5127.3 4782.8 4789.0 4855.3 4859.9 5097.6 2991.9 3021.5 3021.5 3037.8 3039.3 5912.8 5916.2 5918.8 5933.3 5934.7 5631.3 5849.2 5862.0 5868.9 5886.6 5886.9 5903.9 5911.2 5914.3 5950.8 5593.2 5699.3 5728.8 5757.7 5776.1 5659.1 5681.0 5689.5 5694.3 5706.4 5878.1 5931.4 5935.6 5936.6 5963.7 3938.9 4053.1 4083.0 4107.1 4147.1 5612.4 5683.1 5695.7 5714.4 5722.3 5598.6 5615.4 5650.8 5655.3 5655.4 5448.3 5513.3 5515.4 5562.5 5592.8 5513.4 5520.9 5529.4 5533.8 5537.5 5460.6 5566.8 5628.4 5635.3 5646.1 5465.5 5496.9 5499.6 5506.8 5512.2 09:37:56 INFO - PROCESS | 379 | 09:37:56 INFO - PROCESS | 379 | [#5] yui.html Cycles:180 Average:21650.03 Median:4404.27 stddev:31973.17 (726.0%) stddev-sans-first:32024.33 09:37:56 INFO - PROCESS | 379 | Values: 742.6 768.9 789.1 791.8 829.5 15889.3 16791.5 16982.5 17006.2 17112.8 14686.3 14847.1 15625.3 15760.2 15812.2 788.7 802.4 805.6 806.1 806.6 653.7 777.3 802.1 803.7 806.4 847.2 850.1 851.1 851.1 851.1 846.3 846.7 847.1 847.2 847.4 502.4 597.2 608.9 621.5 621.7 13804.1 14029.0 14056.9 14212.1 14217.5 12903.0 13238.9 13348.1 13401.6 13982.0 11499.3 11514.6 11567.4 11579.7 11871.5 4260.6 4271.1 4299.5 4351.0 4534.0 83302.0 83898.6 84103.0 85056.6 85817.1 10511.2 10732.6 10793.6 10827.7 11305.6 21995.7 22027.6 22036.0 22116.4 22126.0 8295.2 8328.5 8363.5 8478.8 8742.8 4501.4 4532.0 4589.6 4742.6 4883.4 3226.8 3338.5 3344.7 3349.2 3351.1 576.8 585.5 589.6 594.9 596.5 532.7 646.6 651.7 666.4 724.8 8916.6 9107.1 9264.3 9418.1 9453.4 556.5 624.7 638.5 659.5 666.3 4339.9 4344.7 4370.9 4437.6 4504.8 69886.0 104764.5 129573.4 129734.4 134785.3 79434.0 95176.5 110312.4 112910.4 116635.4 93806.0 93979.5 99210.0 99917.5 101975.0 9553.2 9699.4 9792.5 9857.9 10061.8 52744.2 53623.7 53762.2 54804.7 56216.4 75157.0 77063.6 80320.6 81904.0 83276.6 11765.5 12286.4 12426.3 12474.1 13068.7 13883.7 14522.8 14798.1 14813.3 14928.6 13963.2 14278.0 14528.8 14679.3 15137.8 13878.5 14008.7 14133.4 14186.4 14389.4 13511.3 13536.8 13729.5 13891.2 14068.5 10674.0 11132.8 11175.8 11262.2 11450.7 10484.8 11510.7 11759.4 11823.7 12052.4 09:37:56 INFO - PROCESS | 379 | -------- Summary: end -------- 09:37:56 INFO - PROCESS | 379 | 09:37:57 INFO - TEST-INFO | 379: exit 0 09:37:57 INFO - TEST-OK | dromaeo_css | took 1115171ms 09:37:57 INFO - TEST-START | kraken 09:37:57 INFO - operating with platform_type : linux_ 09:37:57 INFO - Initialising browser for kraken test... 09:37:57 INFO - TEST-INFO | started process 691 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeVQfIL/profile http://localhost:55362/getInfo.html) 09:38:01 INFO - PROCESS | 691 | __metrics Screen width/height:1600/1200 09:38:01 INFO - PROCESS | 691 | colorDepth:24 09:38:01 INFO - PROCESS | 691 | Browser inner width/height: 1024/697 09:38:01 INFO - PROCESS | 691 | __metrics 09:38:02 INFO - PROCESS | 691 | 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" 09:38:02 INFO - PROCESS | 691 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:38:02 INFO - PROCESS | 691 | console.error: PushService: 09:38:02 INFO - PROCESS | 691 | stateChangeProcessEnqueue: Error transitioning state 09:38:02 INFO - PROCESS | 691 | UnknownError 09:38:03 INFO - TEST-INFO | 691: exit 0 09:38:03 INFO - Browser initialized. 09:38:03 INFO - Running cycle 1/1 for kraken test... 09:38:03 INFO - TEST-INFO | started process 779 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeVQfIL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:38:15 INFO - PROCESS | 779 | RSS: Main: 179634176 09:38:15 INFO - PROCESS | 779 | 09:38:17 INFO - PROCESS | 779 | Cycle 1(1): loaded http://localhost:55362/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55362/tests/kraken/driver.html?testName=audio-beat-detection) 09:38:18 INFO - PROCESS | 779 | RSS: Main: 233967616 09:38:18 INFO - PROCESS | 779 | 09:38:21 INFO - PROCESS | 779 | Cycle 1(1): loaded http://localhost:55362/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55362/tests/kraken/driver.html?testName=audio-dft) 09:38:21 INFO - PROCESS | 779 | RSS: Main: 225050624 09:38:21 INFO - PROCESS | 779 | 09:38:25 INFO - PROCESS | 779 | Cycle 1(1): loaded http://localhost:55362/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55362/tests/kraken/driver.html?testName=audio-fft) 09:38:25 INFO - PROCESS | 779 | RSS: Main: 302022656 09:38:25 INFO - PROCESS | 779 | 09:38:27 INFO - PROCESS | 779 | Cycle 1(1): loaded http://localhost:55362/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55362/tests/kraken/driver.html?testName=audio-oscillator) 09:38:28 INFO - PROCESS | 779 | RSS: Main: 212328448 09:38:28 INFO - PROCESS | 779 | 09:38:30 INFO - PROCESS | 779 | Cycle 1(1): loaded http://localhost:55362/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55362/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:38:31 INFO - PROCESS | 779 | RSS: Main: 214380544 09:38:31 INFO - PROCESS | 779 | 09:38:34 INFO - PROCESS | 779 | Cycle 1(1): loaded http://localhost:55362/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55362/tests/kraken/driver.html?testName=imaging-darkroom) 09:38:34 INFO - PROCESS | 779 | RSS: Main: 252817408 09:38:34 INFO - PROCESS | 779 | 09:38:38 INFO - PROCESS | 779 | Cycle 1(1): loaded http://localhost:55362/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55362/tests/kraken/driver.html?testName=imaging-desaturate) 09:38:38 INFO - PROCESS | 779 | RSS: Main: 251535360 09:38:38 INFO - PROCESS | 779 | 09:38:41 INFO - PROCESS | 779 | Cycle 1(1): loaded http://localhost:55362/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55362/tests/kraken/driver.html?testName=json-parse-financial) 09:38:42 INFO - PROCESS | 779 | RSS: Main: 251514880 09:38:42 INFO - PROCESS | 779 | 09:38:43 INFO - PROCESS | 779 | Cycle 1(1): loaded http://localhost:55362/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55362/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:38:44 INFO - PROCESS | 779 | RSS: Main: 214417408 09:38:44 INFO - PROCESS | 779 | 09:38:45 INFO - PROCESS | 779 | Cycle 1(1): loaded http://localhost:55362/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55362/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:38:46 INFO - PROCESS | 779 | RSS: Main: 222240768 09:38:46 INFO - PROCESS | 779 | 09:38:48 INFO - PROCESS | 779 | Cycle 1(1): loaded http://localhost:55362/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55362/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:38:49 INFO - PROCESS | 779 | RSS: Main: 222216192 09:38:49 INFO - PROCESS | 779 | 09:38:51 INFO - PROCESS | 779 | Cycle 1(1): loaded http://localhost:55362/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:38:52 INFO - PROCESS | 779 | RSS: Main: 223719424 09:38:52 INFO - PROCESS | 779 | 09:38:55 INFO - PROCESS | 779 | Cycle 1(1): loaded http://localhost:55362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:38:55 INFO - PROCESS | 779 | RSS: Main: 221417472 09:38:55 INFO - PROCESS | 779 | 09:38:57 INFO - PROCESS | 779 | Cycle 1(1): loaded http://localhost:55362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55362/tests/kraken/driver.html?testName=ai-astar) 09:38:57 INFO - PROCESS | 779 | RSS: Main: 273244160 09:38:57 INFO - PROCESS | 779 | 09:38:57 INFO - PROCESS | 779 | __start_tp_report 09:38:57 INFO - PROCESS | 779 | _x_x_mozilla_page_load 09:38:57 INFO - PROCESS | 779 | _x_x_mozilla_page_load_details 09:38:57 INFO - PROCESS | 779 | |i|pagename|runs| 09:38:57 INFO - PROCESS | 779 | |0;ai-astar;112;110;126;110;110;110;112;110;109;109 09:38:57 INFO - PROCESS | 779 | |1;audio-beat-detection;146;118;145;183;119;140;141;118;180;118 09:38:57 INFO - PROCESS | 779 | |2;audio-dft;160;162;161;162;161;160;162;162;162;160 09:38:57 INFO - PROCESS | 779 | |3;audio-fft;75;76;76;169;77;75;75;74;159;77 09:38:57 INFO - PROCESS | 779 | |4;audio-oscillator;83;82;157;82;83;82;145;82;81;138 09:38:57 INFO - PROCESS | 779 | |5;imaging-gaussian-blur;117;116;117;117;117;117;116;117;116;117 09:38:57 INFO - PROCESS | 779 | |6;imaging-darkroom;145;146;145;146;145;145;146;146;145;145 09:38:57 INFO - PROCESS | 779 | |7;imaging-desaturate;94;95;95;94;94;94;95;94;95;95 09:38:57 INFO - PROCESS | 779 | |8;json-parse-financial;56;52;52;53;52;54;52;53;52;52 09:38:57 INFO - PROCESS | 779 | |9;json-stringify-tinderbox;63;64;63;63;63;63;63;64;63;65 09:38:57 INFO - PROCESS | 779 | |10;stanford-crypto-aes;89;81;78;78;78;77;78;78;77;77 09:38:57 INFO - PROCESS | 779 | |11;stanford-crypto-ccm;137;125;124;126;133;136;126;130;179;123 09:38:57 INFO - PROCESS | 779 | |12;stanford-crypto-pbkdf2;163;163;163;165;161;162;162;164;166;163 09:38:57 INFO - PROCESS | 779 | |13;stanford-crypto-sha256-iterative;68;66;65;68;65;64;65;65;63;66 09:38:57 INFO - PROCESS | 779 | __end_tp_report 09:38:57 INFO - PROCESS | 779 | __start_cc_report 09:38:57 INFO - PROCESS | 779 | _x_x_mozilla_cycle_collect,1727 09:38:57 INFO - PROCESS | 779 | __end_cc_report 09:38:57 INFO - PROCESS | 779 | __startTimestamp1472747937829__endTimestamp 09:38:57 INFO - PROCESS | 779 | 09:38:57 INFO - PROCESS | 779 | ------- Summary: start ------- 09:38:57 INFO - PROCESS | 779 | Number of tests: 14 09:38:57 INFO - PROCESS | 779 | 09:38:57 INFO - PROCESS | 779 | [#0] ai-astar Cycles:10 Average:111.80 Median:110.00 stddev:5.09 (4.6%) stddev-sans-first:5.40 09:38:57 INFO - PROCESS | 779 | Values: 112.0 110.0 126.0 110.0 110.0 110.0 112.0 110.0 109.0 109.0 09:38:57 INFO - PROCESS | 779 | 09:38:57 INFO - PROCESS | 779 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:143.00 stddev:24.49 (17.1%) stddev-sans-first:25.90 09:38:57 INFO - PROCESS | 779 | Values: 146.0 118.0 145.0 183.0 119.0 140.0 141.0 118.0 180.0 118.0 09:38:57 INFO - PROCESS | 779 | 09:38:57 INFO - PROCESS | 779 | [#2] audio-dft Cycles:10 Average:161.20 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 09:38:57 INFO - PROCESS | 779 | Values: 160.0 162.0 161.0 162.0 161.0 160.0 162.0 162.0 162.0 160.0 09:38:57 INFO - PROCESS | 779 | 09:38:57 INFO - PROCESS | 779 | [#3] audio-fft Cycles:10 Average:93.30 Median:75.50 stddev:37.35 (49.5%) stddev-sans-first:39.02 09:38:57 INFO - PROCESS | 779 | Values: 75.0 76.0 76.0 169.0 77.0 75.0 75.0 74.0 159.0 77.0 09:38:57 INFO - PROCESS | 779 | 09:38:57 INFO - PROCESS | 779 | [#4] audio-oscillator Cycles:10 Average:101.50 Median:82.00 stddev:31.50 (38.4%) stddev-sans-first:32.69 09:38:57 INFO - PROCESS | 779 | Values: 83.0 82.0 157.0 82.0 83.0 82.0 145.0 82.0 81.0 138.0 09:38:57 INFO - PROCESS | 779 | 09:38:57 INFO - PROCESS | 779 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 09:38:57 INFO - PROCESS | 779 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 09:38:57 INFO - PROCESS | 779 | 09:38:57 INFO - PROCESS | 779 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 09:38:57 INFO - PROCESS | 779 | Values: 145.0 146.0 145.0 146.0 145.0 145.0 146.0 146.0 145.0 145.0 09:38:57 INFO - PROCESS | 779 | 09:38:57 INFO - PROCESS | 779 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 09:38:57 INFO - PROCESS | 779 | Values: 94.0 95.0 95.0 94.0 94.0 94.0 95.0 94.0 95.0 95.0 09:38:57 INFO - PROCESS | 779 | 09:38:57 INFO - PROCESS | 779 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:52.50 stddev:1.32 (2.5%) stddev-sans-first:0.73 09:38:57 INFO - PROCESS | 779 | Values: 56.0 52.0 52.0 53.0 52.0 54.0 52.0 53.0 52.0 52.0 09:38:57 INFO - PROCESS | 779 | 09:38:57 INFO - PROCESS | 779 | [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:63.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 09:38:57 INFO - PROCESS | 779 | Values: 63.0 64.0 63.0 63.0 63.0 63.0 63.0 64.0 63.0 65.0 09:38:57 INFO - PROCESS | 779 | 09:38:57 INFO - PROCESS | 779 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:78.00 stddev:3.67 (4.7%) stddev-sans-first:1.22 09:38:57 INFO - PROCESS | 779 | Values: 89.0 81.0 78.0 78.0 78.0 77.0 78.0 78.0 77.0 77.0 09:38:57 INFO - PROCESS | 779 | 09:38:57 INFO - PROCESS | 779 | [#11] stanford-crypto-ccm Cycles:10 Average:133.90 Median:131.50 stddev:16.62 (12.6%) stddev-sans-first:17.59 09:38:57 INFO - PROCESS | 779 | Values: 137.0 125.0 124.0 126.0 133.0 136.0 126.0 130.0 179.0 123.0 09:38:57 INFO - PROCESS | 779 | 09:38:57 INFO - PROCESS | 779 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.20 Median:163.00 stddev:1.48 (0.9%) stddev-sans-first:1.56 09:38:57 INFO - PROCESS | 779 | Values: 163.0 163.0 163.0 165.0 161.0 162.0 162.0 164.0 166.0 163.0 09:38:57 INFO - PROCESS | 779 | 09:38:57 INFO - PROCESS | 779 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.50 stddev:1.58 (2.4%) stddev-sans-first:1.39 09:38:57 INFO - PROCESS | 779 | Values: 68.0 66.0 65.0 68.0 65.0 64.0 65.0 65.0 63.0 66.0 09:38:57 INFO - PROCESS | 779 | -------- Summary: end -------- 09:38:57 INFO - PROCESS | 779 | 09:38:58 INFO - TEST-INFO | 779: exit 0 09:38:59 INFO - TEST-OK | kraken | took 61304ms 09:38:59 INFO - SUITE-END | took 1176s 09:38:59 INFO - Completed test suite (00:19:36) 09:38:59 INFO - javascript benchmark 09:38:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3031.1664292319615, 3037.8177309361436, 3046.1470788179304, 3063.8927637532693, 3106.8912588059425, 5115.155999260127, 5210.192420174874, 5243.475652434755, 5289.947100528993, 5322.654027488211, 5275.6043296752705, 5333.786648534054, 5336.332958380202, 5375.3280839895015, 5384.326959130109, 4757.952420475803, 4770.880727981794, 4811.0, 4819.036192761444, 4821.011692603008, 4698.224792909183, 4842.346283251769, 4873.853784386456, 4902.65681402302, 4906.018796240748, 4839.758012099399, 4840.661153719241, 4854.029194161164, 4877.51224877513, 4879.170541008037, 4695.3426520287185, 4744.335792988984, 4812.975935120337, 4817.253325734517, 4872.707637541741, 4735.621150307967, 4786.114568804747, 4792.281157826354, 4800.447948485934, 4872.1473742094995, 5293.232481290192, 5307.416184219733, 5340.012097761926, 5351.25082488452, 5355.839324820262, 5516.282883225195, 5723.484886360206, 5723.685197314146, 5726.599138060337, 5781.739821708034, 5682.602217844753, 5744.4829965303325, 5750.884982300372, 5752.913706294409, 5811.6803575803315, 5363.249145119687, 5363.731813409353, 5367.409584945692, 5371.248025276464, 5428.185772134172, 5688.544916406678, 5873.0, 5877.853053673693, 5880.029795083763, 5884.323302820145, 5538.307711536058, 5576.553875689935, 5611.0, 5624.128260119688, 5692.459216374438, 5623.887522249532, 5681.431856814285, 5684.687342196136, 5694.572907031907, 5700.743466543932, 5560.749766260528, 5636.830895073154, 5644.125160600031, 5674.432556744293, 5691.430856914276, 5435.0, 5620.803271885547, 5636.436356364331, 5655.886882262414, 5718.313802343662, 4386.320120381282, 4394.582514661102, 4399.428074350314, 4399.612412730726, 4444.933326000112, 3895.1820117775583, 3899.6100389961343, 3919.7060220483577, 3928.759553554575, 3965.1673148638533, 5349.679019258857, 5403.405625381205, 5404.648697834628, 5418.078926582491, 5503.147012213113, 5713.600047996601, 5729.455701708331, 5734.942650573525, 5740.913886291709, 5749.540036797046, 5272.182811664198, 5414.7834086636885, 5429.160036513616, 5440.319960004999, 5448.509634132868, 4889.315495830587, 4913.557779799835, 4930.457649658535, 4936.777844996984, 4986.12742770021, 5771.971140144273, 5773.769049238152, 5802.4197580241635, 5827.825165245049, 5832.912506312408, 5558.221848941071, 5599.0, 5606.074997625346, 5608.46719561641, 5680.545556355564, 5836.649801011953, 5891.410858914074, 5922.230110085834, 5999.730012149376, 6013.368596297326, 5615.354234263112, 5616.6068375213345, 5670.149477578396, 5705.22979397776, 5735.8566035849435, 5714.342850572071, 5723.8569035774435, 5724.0, 5725.08398656213, 5730.341010783646, 5445.83662490126, 5496.340439147328, 5561.360443549043, 5586.38549759518, 5588.469095435927, 5585.944140558705, 5633.88732225345, 5646.717664116695, 5658.0, 5665.348484924287, 5446.509814116748, 5522.779088836402, 5523.475269849358, 5530.087535556749, 5533.087040638411, 5480.177973304037, 5536.574157325763, 5578.63738856973, 5585.357683866408, 5586.636868603528, 5392.433794451526, 5446.046941785251, 5463.644863083887, 5498.780048798163, 5531.917021244765], "value": 5247.32547727284, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.9832605021851, 604.3231580629695, 616.645428878395, 627.811656503049, 631.4884943196015, 32377.0, 44174.0, 44893.10213795722, 45107.0, 45360.77319613402, 45211.773941130334, 45753.0, 45790.31314530277, 45826.54173458264, 45915.0, 8971.820563588724, 9136.588853501575, 9174.54127293636, 9192.770180745469, 9199.264058875275, 8076.798080047987, 10608.575656973711, 10834.783304333909, 10853.565857365697, 11253.943730281337, 11033.613823516178, 11125.27685700431, 11128.05411540016, 11129.666110016713, 11130.16523760717, 10908.34549927007, 10918.672439826818, 10961.068309193728, 10985.121190304757, 10986.670399888017, 10796.2442629016, 10854.565817367296, 10893.618723344645, 10895.83656245149, 10896.455177241185, 43634.0, 43635.34546981798, 43993.0, 44051.77974110109, 44078.33882491765, 3512.350215210194, 3578.1233597768455, 3627.764195327295, 3943.7042221833476, 4182.581741825793, 31862.0, 32585.511217331758, 32608.184795380068, 32779.83610081958, 32811.17972050694, 4158.106007208465, 4225.281702110648, 4261.275583150872, 4381.715188512769, 4477.350784136314, 272656.0, 274025.0, 274152.0, 274847.0, 275351.6232418845, 58479.15208479118, 59014.0, 59267.0, 59290.0, 59324.703376482845, 61703.0, 62192.689036555435, 62205.68897155485, 62249.0, 62297.37702623006, 16859.24133413999, 17016.829831701772, 17051.062191579582, 17085.145742712815, 17087.658246835243, 12059.21615095016, 12606.495740170474, 13065.346732663329, 13120.0, 13127.934360328138, 16059.518214453585, 16120.919395402949, 16395.0, 16778.74831877523, 16866.32534698623, 5752.338481074647, 5837.562182836305, 5870.178175055496, 5979.4618484336615, 5991.2510936132985, 951.4861974533675, 1035.7410647338165, 1058.756486008207, 1068.1775033224374, 1080.443571560647, 31738.841305793325, 32381.51427728586, 32448.513272300934, 32709.473078030576, 33116.503252451235, 1066.3921564708196, 1080.4597701149426, 1090.4111779638906, 1100.8403781451646, 1128.9604863829727, 16248.675026499404, 16771.832281677027, 16950.49148525546, 17060.146992650567, 17149.0, 550905.0, 551743.0, 551986.0, 552248.0, 553093.0, 58890.0, 58986.705066474395, 59044.98117659961, 59063.0, 59109.0, 1144.5078616194949, 1234.8456442944632, 1315.6381994951273, 1320.5312114199512, 1346.9865301347056, 31232.843835781583, 32149.678503215604, 32845.34309313848, 33102.0, 33177.83411082929, 49397.753011234716, 50084.74957625189, 50263.246051309994, 50309.24536132034, 50311.245331320795, 405002.0, 405278.0, 406375.0, 407727.0, 408735.0, 27197.728022720312, 28544.57183142296, 28570.42866142057, 29755.256118597208, 29890.402191956473, 48952.51047489479, 48962.26556601725, 49032.0, 49276.75361623169, 51157.0, 39817.57655799446, 40686.38970415505, 40726.18547628971, 42062.36906446467, 42527.574724252365, 40609.238551784394, 41116.38325425181, 41144.38283425811, 42919.0, 42964.35553466638, 39067.6093239064, 39264.41103383509, 40631.1873762529, 41531.79234103931, 43636.0, 35139.82430087833, 35695.464568030984, 37554.24891502209, 38075.0, 38340.61659383482, 25936.0, 27151.45697086087, 27203.59194612043, 27249.59125613157, 27385.0], "value": 20325.716938699585, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.16561068816554, 395.18591701095744, 408.8528129873245, 409.70091832961936, 415.6799264566284, 15956.0, 19081.427557173272, 19110.71333929992, 19286.614267714656, 20481.07835147418, 18645.90677046616, 19318.903405482986, 19555.0, 19603.705944410845, 19624.705629415534, 5292.444293349201, 5595.21666966625, 5607.990561698893, 5717.857053573653, 5799.623024503415, 5665.348484924245, 5702.344230413514, 5722.313322401317, 5755.856103597402, 5765.558610347413, 5618.438156184389, 5652.802151924683, 5726.083826587746, 5734.197212390269, 5775.162601422791, 5645.604807663444, 5683.744231509592, 5688.4311568842995, 5691.516221121168, 5691.630044047124, 4932.605391568666, 5139.486051394831, 5176.767045482962, 5178.430372659004, 5181.274621552986, 23117.190898318477, 23477.41306467335, 23562.882185589133, 23649.645255321186, 23816.523669526687, 2424.9272521824373, 2451.264620613809, 2560.7567281108263, 2564.689718342121, 2675.4649070185847, 14059.0, 14712.351776680192, 14738.852611473856, 15231.847681523264, 15365.846341536553, 1917.8465722742287, 1932.0436383989875, 1945.445548018822, 1948.4349538633778, 1976.9901150494156, 49395.0, 71061.64469177621, 77958.61020694861, 79283.0, 80230.99999999942, 10562.894371056345, 10601.0, 10794.784104318027, 11043.668689939315, 11202.271852329572, 15006.548493846258, 15026.0, 15114.244287785787, 15128.243587820565, 15138.243087845563, 8190.344772418192, 8319.542425166674, 8475.957620211859, 8638.265747411415, 8644.524551149621, 8218.164733167048, 8260.380471464665, 8275.393433259158, 8409.243168114777, 8455.323574114056, 6501.284858665543, 6548.770793022221, 6615.735370585123, 6662.766803161866, 6688.130543029375, 1926.4798504403732, 1941.175000624729, 1954.1792447172222, 1961.507043095362, 1962.087629252376, 870.1516021878745, 946.6639343033262, 1018.8828284747201, 1022.749426390539, 1094.7427354571669, 20106.396808095782, 20280.49298767513, 20300.695489567668, 20307.796922030888, 20339.186432542534, 965.1169180200179, 980.9362391444533, 1004.0612027754073, 1008.0, 1028.9588416463407, 10738.516766745515, 11159.386233757059, 11201.66395008151, 11255.887441125647, 11401.94299028516, 456155.0, 474594.0, 481949.0, 482241.0, 489882.0, 46904.765476172404, 49629.0, 55768.0, 83080.50758477255, 85106.5744671285, 999.9400035997718, 1049.2707568240153, 1061.3207547169663, 1068.7167900506372, 1077.3912739302268, 16712.74930876062, 16740.665186695955, 17407.21667524939, 17790.555236119202, 18111.275548977894, 38878.805605971786, 38952.41571376488, 38976.415353769145, 39823.402648960866, 40361.59638403579, 53102.4689753113, 54430.0, 54430.455695442535, 54579.454205457434, 55170.17244741412, 8460.238578527962, 8567.74296771098, 8607.870881936651, 8747.343949203963, 8852.3803333766, 12659.746805064031, 12727.681807954876, 12970.67573310637, 13009.080017031176, 13453.730925381633, 11544.88455115438, 11596.652100437, 11623.360715160747, 11968.581099661818, 12054.09594280415, 11659.76680466369, 11669.008134308679, 11686.532538698357, 11734.178607497393, 12370.381480925738, 12047.096467764777, 12087.214331068453, 12100.878991209975, 12206.877931220573, 12249.387530623611, 8247.711330103417, 8448.746537603882, 8580.613872375883, 8681.563020350433, 8683.088275730957, 11633.47649355764, 11793.174477786473, 11835.822462662894, 11964.341961192218, 12457.813132803196], "value": 9298.29533219376, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.908505430855, 1470.6764511807405, 1498.370684312589, 1647.653992661541, 1791.9283228670845, 8759.91240087599, 9186.219171370432, 9251.768705782359, 9564.473953932531, 9577.138057574817, 9381.90618093819, 9519.762005949855, 9533.04669533048, 9538.904610953889, 9542.0935011174, 2476.8142389320783, 2504.261242933339, 2505.285993491855, 2506.736792636765, 2509.0591028364365, 2432.1609044879488, 2512.6356678281636, 2513.949721005579, 2516.219971808736, 2518.3955850595908, 2457.3856535866034, 2475.3811547113223, 2498.4253621666935, 2500.9124680636182, 2504.586743187372, 2430.2952143878256, 2449.4121410861444, 2452.730199678034, 2459.495803360307, 2463.1009681466135, 2385.7137143542714, 2441.633754936756, 2449.7060352757603, 2452.644366566838, 2453.644221587878, 9100.681476148304, 9337.0, 9397.859032114455, 9487.810243795086, 9489.383190092622, 5456.427075157091, 5670.3479099903625, 5679.318481782213, 5680.772769089232, 5684.914726279109, 3317.7511686623598, 3365.6634336566394, 3415.316936612687, 3416.419208734521, 3421.2473255883665, 1044.4568824211444, 1078.4338222433207, 1088.5739286049734, 1095.1840878545454, 1103.5420300575252, 13048.869511304956, 13167.670808229776, 13188.604341869759, 13264.40310186044, 13273.601791946257, 4399.36209249657, 4487.259602165672, 4598.057398233354, 4603.286490593896, 4704.882377940579, 10332.380057196593, 10333.586656533655, 10345.534450949724, 10347.068763811143, 10353.74115647115, 5502.284702988666, 5507.972460137674, 5508.504234618904, 5511.283533140746, 5514.228008078872, 4495.57292057254, 4964.205727083649, 5072.949270507322, 5100.974495127501, 5168.896622067613, 3769.4345848123003, 3790.1282704977457, 3858.093348063203, 3947.348687466536, 3953.7034722395933, 1205.9698507537382, 1236.71555542224, 1237.0, 1247.5259401427581, 1247.781638213309, 999.1457304004971, 1006.9697909062739, 1013.7364285285731, 1023.6468418395641, 1030.8144533983955, 6270.122182894398, 6361.14124593174, 6372.2353317601255, 6461.8061458156335, 6500.804975850732, 481.04992639536636, 481.7398604753394, 482.93721816163674, 488.4748894937956, 492.7240745182709, 4389.648828093745, 4464.665150113755, 4541.750203738826, 4579.633629309647, 4619.46876109245, 11440.656780296604, 11674.124440666985, 11720.0, 11750.529978800752, 11757.353345565905, 11004.669859904216, 11648.88351116495, 11656.88343116575, 11658.475368608433, 11659.125565582615, 8339.8332033359, 8754.080821513777, 8760.605772740242, 8762.780930476789, 8770.912290877137, 6439.388258115471, 6549.508786841101, 6569.868602627825, 6679.365460281266, 6817.2501024888215, 10555.050045495942, 10798.784024319626, 10858.239923205616, 10953.397563133785, 11033.393163376091, 11169.88830111721, 11229.4385280734, 11229.66311010671, 11231.157663175458, 11244.83132752993, 7516.849663006818, 8127.268545830903, 8179.182081791773, 8294.170582941657, 8412.411131220755, 9183.724488265363, 9341.766455838659, 9366.110219529133, 9371.203447706748, 9371.250299976122, 8123.106458289465, 8202.26179643835, 8258.545779982158, 8344.833103337778, 8577.399582029198, 7752.5348479091435, 7781.572013539309, 8128.715494957648, 8177.182281771775, 8331.541765202972, 7469.850602988018, 7603.88594171099, 7658.2724641159, 7677.846443071219, 7744.49660772048, 5382.192671099367, 5419.10584753527, 5443.510084092451, 5444.1017232156255, 5479.808206712746, 5244.261447268911, 5305.973470132624, 5476.04169270384, 5534.0, 5749.798757043651], "value": 4787.097355807211, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.5636559741143, 345.3645292661502, 345.9290845376698, 347.284593736902, 352.2163186909126, 5199.740012999354, 5318.680879147244, 5413.566914646829, 5423.891522169554, 5428.647137936036, 5262.657927234727, 5310.176922576997, 5311.362636483627, 5314.76083576239, 5332.773462103709, 4197.874063778091, 4202.894927626811, 4203.180379825935, 4222.451081359419, 4249.511306199795, 4156.054295388493, 4168.874933751992, 4185.476815398075, 4192.454980852485, 4229.936550951738, 4156.916861662765, 4160.39674247234, 4163.979180104096, 4175.269327867626, 4191.622753952143, 4152.854650087247, 4170.749755014678, 4172.248995180867, 4198.454200953887, 4203.3064544350145, 3735.7758534488016, 3742.850285988557, 3752.831122599462, 3761.9435708464393, 3764.623537646241, 5109.6678715883345, 5238.73806309683, 5242.895142097175, 5273.973630131824, 5297.549708274802, 4816.133096042711, 4829.541193586604, 4831.975840120777, 4846.660733748639, 4848.696868987238, 5408.188771684239, 5566.0, 5570.637908535973, 5582.692951887645, 5585.022621041342, 4077.143799802045, 4080.6123418275215, 4104.692148088905, 4128.855490057864, 4133.545310015896, 5782.681952492611, 5785.62393444429, 5803.129530570406, 5819.9418005819825, 5823.592348535604, 4152.086540960984, 4192.155451601286, 4202.873913782591, 4217.514985776614, 4227.548022147147, 4100.507939047334, 4157.91684166315, 4194.643455306272, 4197.706160568792, 4214.494260688737, 4731.503192164842, 4742.0083564902825, 4746.477887432379, 4757.785899634525, 4779.187538118528, 5605.439456054443, 5605.775768969195, 5615.775368985195, 5618.0, 5650.971745141248, 1379.6412932637586, 1410.964725881861, 1417.1213847414463, 1424.0885833066845, 1424.3590384327094, 909.3543584055395, 911.544227886057, 927.4852456886492, 929.5631053404888, 934.8924873639619, 4775.355327030876, 4787.92271738856, 4794.640401969867, 4795.400574928134, 4812.735299558558, 5000.924986125211, 5013.1227035268685, 5039.622028347815, 5091.694498330112, 5127.256547800548, 4782.760861956888, 4789.0, 4855.32025516428, 4859.902801943941, 5097.643164978416, 2991.925201869927, 3021.5165573508134, 3021.534555740508, 3037.769703270179, 3039.3465404938042, 5912.817436512714, 5916.171735956969, 5918.822435326947, 5933.258342707161, 5934.703264836741, 5631.267935168402, 5849.239598852122, 5862.032764593794, 5868.853278668067, 5886.6173698709445, 5886.911696324473, 5903.911441328383, 5911.172435858984, 5914.349421563625, 5950.821475355746, 5593.161025846156, 5699.316082070178, 5728.828135155952, 5757.712114394348, 5776.104703770922, 5659.122835960433, 5680.971595141998, 5689.516391106802, 5694.259746232963, 5706.372299047019, 5878.088896221093, 5931.406859314034, 5935.643861368331, 5936.554758393224, 5963.717800672876, 3938.9212215756097, 4053.1488387438967, 4082.9795851021745, 4107.096438783463, 4147.129102888427, 5612.410696876933, 5683.050280055487, 5695.746935674145, 5714.428557144252, 5722.2561067061015, 5598.580106492111, 5615.438456154352, 5650.773969041193, 5655.321361436654, 5655.406182350794, 5448.264484294728, 5513.3108361454815, 5515.420880807618, 5562.471565201461, 5592.804251851166, 5513.393526711979, 5520.86197845041, 5529.419410961952, 5533.833984980457, 5537.473939975695, 5460.590455715757, 5566.805161819317, 5628.352739435018, 5635.267415235993, 5646.124850648156, 5465.508104270635, 5496.9217238346655, 5499.642523235977, 5506.779728810803, 5512.200730894078], "value": 4242.9471999274065, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.5878637356271, 768.8769796832507, 789.1319548496655, 791.8376732769783, 829.4857188543104, 15889.2849821758, 16791.496255112335, 16982.49052528423, 17006.234719437638, 17112.82887171128, 14686.339114739836, 14847.1091734496, 15625.296861641225, 15760.211989400541, 15812.209389530506, 788.668759121169, 802.4463120446902, 805.5730462854697, 806.1173015547965, 806.5765473126626, 653.6535636112868, 777.296546625305, 802.1136644008375, 803.6624617660567, 806.3871457692167, 847.1528471528471, 850.1031411860484, 851.059579165023, 851.0723311590365, 851.1148405658108, 846.3440833354139, 846.7417437681505, 847.0809172048334, 847.2036285891304, 847.3687103108163, 502.3845788908558, 597.2146627185238, 608.9299730530958, 621.4531212532987, 621.67983488503, 13804.102733322403, 14029.017968742191, 14056.859431405657, 14212.14727116366, 14217.50238741639, 12903.0, 13238.933805331008, 13348.132371395925, 13401.597952061455, 13982.0, 11499.310041397543, 11514.596989105425, 11567.363794991272, 11579.710507237301, 11871.46578403974, 4260.637845783112, 4271.145770845843, 4299.505556860939, 4350.991990264635, 4534.047849951514, 83302.0, 83898.58050709707, 84103.0, 85056.57471712664, 85817.14182858155, 10511.1591072714, 10732.624358147428, 10793.62222322215, 10827.67516974492, 11305.60430384949, 21995.670064949038, 22027.559448810935, 22036.0, 22116.447088822588, 22126.0, 8295.211954864279, 8328.541930193898, 8363.498190108612, 8478.830423391497, 8742.82514349722, 4501.392312037899, 4531.977340113344, 4589.632829373709, 4742.5731684148595, 4883.438404583448, 3226.790258633181, 3338.4825352070466, 3344.7324214062814, 3349.1794510344635, 3351.145457908218, 576.826951914424, 585.4964730331911, 589.6167491130714, 594.895893218685, 596.5168213746879, 532.6724064700259, 646.6378827856415, 651.667649498759, 666.3602941176428, 724.8477819657826, 8916.598753056129, 9107.134822191882, 9264.305177111744, 9418.058194180665, 9453.385529940531, 556.4824713016933, 624.6845343101704, 638.533870274702, 659.4526542969325, 666.3469799596422, 4339.913201735948, 4344.674149438804, 4370.912581748347, 4437.622802061861, 4504.842330518416, 69886.0, 104764.47617761862, 129573.35213324061, 129734.35132824276, 134785.326073369, 79434.0, 95176.52411737897, 110312.4484377589, 112910.43544782388, 116635.41682291705, 93806.0, 93979.53010234905, 99210.0, 99917.50371233311, 101975.0, 9553.18797902186, 9699.369540980097, 9792.46141462198, 9857.852132217879, 10061.849072263776, 52744.208836868245, 53623.73188134035, 53762.19356709574, 54804.72597636986, 56216.437835621124, 75157.0, 77063.61468192624, 80320.59839700763, 81904.0, 83276.58361708153, 11765.470553824927, 12286.38568071575, 12426.254424734545, 12474.064445166467, 13068.738625227252, 13883.65290867696, 14522.782158267422, 14798.112113272808, 14813.259337033322, 14928.62678433048, 13963.232022238875, 14278.0, 14528.782068268772, 14679.266036698336, 15137.772933405788, 13878.514252001536, 14008.719825603635, 14133.434662613381, 14186.432542698589, 14389.352479138674, 13511.324433778469, 13536.796948045983, 13729.45082196741, 13891.166530007828, 14068.507602233873, 10674.0, 11132.833007504732, 11175.832362514406, 11262.155338349492, 11450.656480305604, 10484.842727358942, 11510.654680359603, 11759.412029398667, 11823.70440738954, 12052.397380130784], "value": 7552.5863487779925, "unit": "score"}], "name": "dromaeo_css", "value": 7306.531516773644, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 110.0, 126.0, 110.0, 110.0, 110.0, 112.0, 110.0, 109.0, 109.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 118.0, 145.0, 183.0, 119.0, 140.0, 141.0, 118.0, 180.0, 118.0], "value": 140.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 162.0, 161.0, 160.0, 162.0, 162.0, 162.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 169.0, 77.0, 75.0, 75.0, 74.0, 159.0, 77.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 157.0, 82.0, 83.0, 82.0, 145.0, 82.0, 81.0, 138.0], "value": 101.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 52.0, 52.0, 53.0, 52.0, 54.0, 52.0, 53.0, 52.0, 52.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0, 64.0, 63.0, 65.0], "value": 63.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 81.0, 78.0, 78.0, 78.0, 77.0, 78.0, 78.0, 77.0, 77.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 125.0, 124.0, 126.0, 133.0, 136.0, 126.0, 130.0, 179.0, 123.0], "value": 133.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 165.0, 161.0, 162.0, 162.0, 164.0, 166.0, 163.0], "value": 163.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 65.0, 68.0, 65.0, 64.0, 65.0, 65.0, 63.0, 66.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1523.1000000000001, "alertThreshold": 2.0}]} 09:38:59 INFO - Return code: 0 09:38:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:38:59 INFO - # TBPL SUCCESS # 09:38:59 INFO - Running post-action listener: _resource_record_post_action 09:38:59 INFO - [mozharness: 2016-09-01 16:38:59.605398Z] Finished run-tests step (success) 09:38:59 INFO - Running post-run listener: _resource_record_post_run 09:38:59 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 304758784; Read time: 12; Write time: 255548 09:38:59 INFO - TinderboxPrint: CPU usage
13.1% 09:38:59 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:38:59 INFO - TinderboxPrint: I/O write bytes / time
304,758,784 / 255,548 09:38:59 INFO - TinderboxPrint: CPU idle
8,280.2 (86.9%) 09:38:59 INFO - TinderboxPrint: CPU user
1,198.1 (12.6%) 09:38:59 INFO - TinderboxPrint: Swap in / out
0 / 0 09:38:59 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 15015936; Read time: 0; Write time: 11816 09:38:59 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 289230848; Read time: 0; Write time: 243704 09:39:00 INFO - Running post-run listener: _upload_blobber_files 09:39:00 INFO - Blob upload gear active. 09:39:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:39:00 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 09:39:00 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'] 09:39:00 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 09:39:00 INFO - (blobuploader) - INFO - Open directory for files ... 09:39:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:39:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:39:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:01 INFO - (blobuploader) - INFO - Done attempting. 09:39:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:39:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:39:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:02 INFO - (blobuploader) - INFO - Done attempting. 09:39:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:39:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:39:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:06 INFO - (blobuploader) - INFO - Done attempting. 09:39:06 INFO - (blobuploader) - INFO - Iteration through files over. 09:39:06 INFO - Return code: 0 09:39:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:39:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:39:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b342a8257664617747fdc644c4005671e1a2328aa27547bbf4d57475e58370d57c0f19fb077352d80591581cad66b91a008b88db29789a7f0f944a66f16c3b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c443c3da70987d4983bc990e0d695c5797e5379759fd48b50239c23d2e660d2dae34682e455853c6015b52d0b893f7d80f80ca50c6849a1299c19c391cdab0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/22df21b0c2a436c16eb9dc5b00fcea2d7625000885b4d63f829c2ef2bb7656bd5d423f6e349c6301c0859a152faadec5276f9892bde840ac5f8c027e25365f20"} 09:39:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:39:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:39:06 INFO - Contents: 09:39:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b342a8257664617747fdc644c4005671e1a2328aa27547bbf4d57475e58370d57c0f19fb077352d80591581cad66b91a008b88db29789a7f0f944a66f16c3b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c443c3da70987d4983bc990e0d695c5797e5379759fd48b50239c23d2e660d2dae34682e455853c6015b52d0b893f7d80f80ca50c6849a1299c19c391cdab0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/22df21b0c2a436c16eb9dc5b00fcea2d7625000885b4d63f829c2ef2bb7656bd5d423f6e349c6301c0859a152faadec5276f9892bde840ac5f8c027e25365f20"} 09:39:06 INFO - Running post-run listener: copy_logs_to_upload_dir 09:39:06 INFO - Copying logs to upload dir... 09:39:06 INFO - mkdir: /builds/slave/test/build/upload/logs 09:39:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.332494 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-09-01 09:39:05.463243) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 09:39:05.467197) ========= 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=0333a256a5e4f052382dd180000001b1-1472746690.143193-1241331832 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/8b342a8257664617747fdc644c4005671e1a2328aa27547bbf4d57475e58370d57c0f19fb077352d80591581cad66b91a008b88db29789a7f0f944a66f16c3b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c443c3da70987d4983bc990e0d695c5797e5379759fd48b50239c23d2e660d2dae34682e455853c6015b52d0b893f7d80f80ca50c6849a1299c19c391cdab0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/22df21b0c2a436c16eb9dc5b00fcea2d7625000885b4d63f829c2ef2bb7656bd5d423f6e349c6301c0859a152faadec5276f9892bde840ac5f8c027e25365f20"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011170 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1472733002/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/8b342a8257664617747fdc644c4005671e1a2328aa27547bbf4d57475e58370d57c0f19fb077352d80591581cad66b91a008b88db29789a7f0f944a66f16c3b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6c443c3da70987d4983bc990e0d695c5797e5379759fd48b50239c23d2e660d2dae34682e455853c6015b52d0b893f7d80f80ca50c6849a1299c19c391cdab0a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/22df21b0c2a436c16eb9dc5b00fcea2d7625000885b4d63f829c2ef2bb7656bd5d423f6e349c6301c0859a152faadec5276f9892bde840ac5f8c027e25365f20"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 09:39:05.496282) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 09:39:05.497055) ========= 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=0333a256a5e4f052382dd180000001b1-1472746690.143193-1241331832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 09:39:05.581279) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 09:39:05.581641) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 09:39:05.581984) ========= ========= Total master_lag: 0.18 =========