builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-066 starttime: 1472746918.76 results: success (0) buildid: 20160901082434 builduid: bb5ba4b994124b019fcaa22835b885f4 revision: 9d715b38e5f094c63df4fa560fd00b6ff6852f9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 09:21:58.760338) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 09:21:58.760771) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 09:21:58.761061) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 09:21:58.775444) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 09:21:58.775717) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1472746918.100354-1854005061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-01 09:21:58-- 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% 103M=0s 2016-09-01 09:21:58 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128477 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 09:21:58.917824) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 09:21:58.918151) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1472746918.100354-1854005061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020001 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 09:21:58.967928) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-01 09:21:58.968284) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1472746918.100354-1854005061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-01 09:21:59,090 truncating revision to first 12 chars 2016-09-01 09:21:59,090 Setting DEBUG logging. 2016-09-01 09:21:59,090 attempt 1/10 2016-09-01 09:21:59,090 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:22:00,527 unpacking tar archive at: fx-team-9d715b38e5f0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.803660 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-01 09:22:00.788087) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 09:22:00.788650) ========= script_repo_revision: 9d715b38e5f094c63df4fa560fd00b6ff6852f9b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 09:22:00.789335) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 09:22:00.789818) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 09:22:00.802325) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-09-01 09:22:00.802912) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=82c74bd3bc9a11c5833d2010000001e6-1472746918.100354-1854005061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:22:01 INFO - MultiFileLogger online at 20160901 09:22:01 in /builds/slave/test 09:22:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:22:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:22:01 INFO - {'append_to_log': False, 09:22:01 INFO - 'base_work_dir': '/builds/slave/test', 09:22:01 INFO - 'blob_upload_branch': 'Fx-Team', 09:22:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:22:01 INFO - 'branch': 'Fx-Team', 09:22:01 INFO - 'buildbot_json_path': 'buildprops.json', 09:22:01 INFO - 'config_files': ('talos/linux_config.py',), 09:22:01 INFO - 'default_actions': ('clobber', 09:22:01 INFO - 'read-buildbot-config', 09:22:01 INFO - 'download-and-extract', 09:22:01 INFO - 'populate-webroot', 09:22:01 INFO - 'create-virtualenv', 09:22:01 INFO - 'install', 09:22:01 INFO - 'run-tests'), 09:22:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:22:01 INFO - 'download_minidump_stackwalk': True, 09:22:01 INFO - 'download_symbols': 'ondemand', 09:22:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:22:01 INFO - 'tooltool.py': '/tools/tooltool.py', 09:22:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:22:01 INFO - '/tools/misc-python/virtualenv.py')}, 09:22:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:22:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:22:01 INFO - 'installer_path': 'installer.exe', 09:22:01 INFO - 'log_level': 'info', 09:22:01 INFO - 'log_name': 'talos', 09:22:01 INFO - 'log_to_console': True, 09:22:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:22:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:22:01 INFO - 'opt_config_files': (), 09:22:01 INFO - 'pip_index': False, 09:22:01 INFO - 'sps_profile': False, 09:22:01 INFO - 'sps_profile_interval': 0, 09:22:01 INFO - 'suite': 'dromaeojs-e10s', 09:22:01 INFO - 'system_bits': '32', 09:22:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:22:01 INFO - 'title': 'talos-linux64-ix-066', 09:22:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:22:01 INFO - 'use_talos_json': True, 09:22:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:22:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:22:01 INFO - 'work_dir': 'build'} 09:22:01 INFO - [mozharness: 2016-09-01 16:22:01.016589Z] Running clobber step. 09:22:01 INFO - Running pre-action listener: _resource_record_pre_action 09:22:01 INFO - Running main action method: clobber 09:22:01 INFO - rmtree: /builds/slave/test/build 09:22:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:22:01 INFO - Running post-action listener: _resource_record_post_action 09:22:01 INFO - [mozharness: 2016-09-01 16:22:01.969227Z] Finished clobber step (success) 09:22:01 INFO - [mozharness: 2016-09-01 16:22:01.969330Z] Running read-buildbot-config step. 09:22:01 INFO - Running pre-action listener: _resource_record_pre_action 09:22:01 INFO - Running main action method: read_buildbot_config 09:22:01 INFO - Using buildbot properties: 09:22:01 INFO - { 09:22:01 INFO - "project": "", 09:22:01 INFO - "product": "firefox", 09:22:01 INFO - "script_repo_revision": "production", 09:22:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:22:01 INFO - "repository": "", 09:22:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 09:22:01 INFO - "buildid": "20160901082434", 09:22:01 INFO - "stage_platform": "linux64-pgo", 09:22:01 INFO - "basedir": "/builds/slave/test", 09:22:01 INFO - "buildnumber": 725, 09:22:01 INFO - "platform": "ubuntu64_hw", 09:22:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:22:01 INFO - "slavebuilddir": "test", 09:22:01 INFO - "branch": "fx-team", 09:22:01 INFO - "revision": "9d715b38e5f094c63df4fa560fd00b6ff6852f9b", 09:22:01 INFO - "slavename": "talos-linux64-ix-066", 09:22:01 INFO - "builduid": "bb5ba4b994124b019fcaa22835b885f4", 09:22:01 INFO - "repo_path": "integration/fx-team" 09:22:01 INFO - } 09:22:01 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:22:01 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:22:01 INFO - Running post-action listener: _resource_record_post_action 09:22:01 INFO - [mozharness: 2016-09-01 16:22:01.972181Z] Finished read-buildbot-config step (success) 09:22:01 INFO - [mozharness: 2016-09-01 16:22:01.972272Z] Running download-and-extract step. 09:22:01 INFO - Running pre-action listener: _resource_record_pre_action 09:22:01 INFO - Running main action method: download_and_extract 09:22:01 INFO - mkdir: /builds/slave/test/build/tests 09:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:01 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:22:01 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:22:01 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:22:01 INFO - Downloaded 1361 bytes. 09:22:01 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:22:02 INFO - Using the following test package requirements: 09:22:02 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:22:02 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:22:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:22:02 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:22:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:22:02 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:22:02 INFO - u'jsshell-linux-x86_64.zip'], 09:22:02 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:22:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:22:02 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:22:02 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:22:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:22:02 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:22:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:22:02 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:22:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:22:02 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:22:02 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:22:02 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:22:02 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:22:02 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:22:02 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:22:02 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:22:02 INFO - Downloaded 21905498 bytes. 09:22:02 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:22:06 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:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:06 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:22:06 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:22:06 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:22:06 INFO - Downloaded 21905498 bytes. 09:22:06 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:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:11 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:22:11 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:22:11 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:22:11 INFO - Downloaded 14413998 bytes. 09:22:11 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:22: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:22:12 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:22:12 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:22: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.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:22:12 INFO - Downloaded 59733953 bytes. 09:22:12 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:22:12 INFO - mkdir: /builds/slave/test/properties 09:22:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:22:12 INFO - Writing to file /builds/slave/test/properties/build_url 09:22:12 INFO - Contents: 09:22:12 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:22:13 INFO - Running post-action listener: _resource_record_post_action 09:22:13 INFO - Running post-action listener: set_extra_try_arguments 09:22:13 INFO - [mozharness: 2016-09-01 16:22:13.255970Z] Finished download-and-extract step (success) 09:22:13 INFO - [mozharness: 2016-09-01 16:22:13.256201Z] Running populate-webroot step. 09:22:13 INFO - Running pre-action listener: _resource_record_pre_action 09:22:13 INFO - Running main action method: populate_webroot 09:22:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:22:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:22:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:22:13 INFO - '--tppagecycles', 09:22:13 INFO - '7'], 09:22:13 INFO - 'tests': ['tsvgm']}}, 09:22:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:22:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:22:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:22:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:22:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:22:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:22:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:13 INFO - 'talos_options': ['--disable-e10s'], 09:22:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:22:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:22:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:13 INFO - 'talos_options': ['--disable-e10s'], 09:22:13 INFO - 'tests': ['damp', 'tps']}, 09:22:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:13 INFO - 'tests': ['damp', 'tps']}, 09:22:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:22:13 INFO - 'tests': ['dromaeo_dom']}, 09:22:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:22:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:22:13 INFO - 'tests': ['basic_compositor_video']}, 09:22:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:22:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:22:13 INFO - 'tests': ['a11yr', 09:22:13 INFO - 'ts_paint', 09:22:13 INFO - 'tpaint', 09:22:13 INFO - 'sessionrestore', 09:22:13 INFO - 'sessionrestore_no_auto_restore', 09:22:13 INFO - 'tabpaint']}, 09:22:13 INFO - 'other-e10s': {'tests': ['a11yr', 09:22:13 INFO - 'ts_paint', 09:22:13 INFO - 'tpaint', 09:22:13 INFO - 'sessionrestore', 09:22:13 INFO - 'sessionrestore_no_auto_restore', 09:22:13 INFO - 'tabpaint']}, 09:22:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:22:13 INFO - 'ts_paint', 09:22:13 INFO - 'tpaint', 09:22:13 INFO - 'sessionrestore', 09:22:13 INFO - 'sessionrestore_no_auto_restore', 09:22:13 INFO - 'tabpaint']}, 09:22:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:22:13 INFO - 'ts_paint', 09:22:13 INFO - 'tpaint', 09:22:13 INFO - 'sessionrestore', 09:22:13 INFO - 'sessionrestore_no_auto_restore', 09:22:13 INFO - 'tabpaint']}, 09:22:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:22:13 INFO - 'tests': ['a11yr', 09:22:13 INFO - 'ts_paint', 09:22:13 INFO - 'tpaint', 09:22:13 INFO - 'sessionrestore', 09:22:13 INFO - 'sessionrestore_no_auto_restore', 09:22:13 INFO - 'tabpaint']}, 09:22:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:22:13 INFO - 'tests': ['a11yr', 09:22:13 INFO - 'ts_paint', 09:22:13 INFO - 'tpaint', 09:22:13 INFO - 'sessionrestore', 09:22:13 INFO - 'sessionrestore_no_auto_restore', 09:22:13 INFO - 'tabpaint']}, 09:22:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:22:13 INFO - 'tests': ['tsvgx', 09:22:13 INFO - 'tsvgr_opacity', 09:22:13 INFO - 'tart', 09:22:13 INFO - 'tscrollx', 09:22:13 INFO - 'cart']}, 09:22:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:22:13 INFO - 'tsvgr_opacity', 09:22:13 INFO - 'tart', 09:22:13 INFO - 'tscrollx', 09:22:13 INFO - 'cart']}, 09:22:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:13 INFO - 'talos_options': ['--disable-e10s'], 09:22:13 INFO - 'tests': ['tp5o']}, 09:22:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:13 INFO - 'tests': ['tp5o']}, 09:22:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:13 INFO - 'talos_options': ['--disable-e10s', 09:22:13 INFO - '--xperf_path', 09:22:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:22:13 INFO - 'tests': ['tp5n']}, 09:22:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:22:13 INFO - 'talos_options': ['--xperf_path', 09:22:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:22:13 INFO - 'tests': ['tp5n']}}, 09:22:13 INFO - 'talos.zip': {'path': '', 09:22:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:22:13 INFO - Running post-action listener: _resource_record_post_action 09:22:13 INFO - [mozharness: 2016-09-01 16:22:13.276521Z] Finished populate-webroot step (success) 09:22:13 INFO - [mozharness: 2016-09-01 16:22:13.276610Z] Running create-virtualenv step. 09:22:13 INFO - Running pre-action listener: _resource_record_pre_action 09:22:13 INFO - Running main action method: create_virtualenv 09:22:13 INFO - Creating virtualenv /builds/slave/test/build/venv 09:22:13 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:22:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:22:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:22:13 INFO - Using real prefix '/usr' 09:22:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:22:13 INFO - Installing distribute.............................................................................................................................................................................................done. 09:22:15 INFO - Installing pip.................done. 09:22:15 INFO - Return code: 0 09:22:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:15 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 0x7fdd00decf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd48d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c63760>, '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 0x2c64660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c64af0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472746918.100354-1854005061', '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:22:15 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:22:15 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:22:15 INFO - Using env: {'DISPLAY': ':0', 09:22:15 INFO - 'HOME': '/home/cltbld', 09:22:15 INFO - 'LANG': 'en_US.UTF-8', 09:22:15 INFO - 'LANGUAGE': 'en_US:en', 09:22:15 INFO - 'LOGNAME': 'cltbld', 09:22:15 INFO - 'MAIL': '/var/mail/cltbld', 09:22:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:15 INFO - 'MOZ_NO_REMOTE': '1', 09:22:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:15 INFO - 'NO_EM_RESTART': '1', 09:22:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:15 INFO - 'PWD': '/builds/slave/test', 09:22:15 INFO - 'SHELL': '/bin/bash', 09:22:15 INFO - 'SHLVL': '1', 09:22:15 INFO - 'TERM': 'linux', 09:22:15 INFO - 'TMOUT': '86400', 09:22:15 INFO - 'USER': 'cltbld', 09:22:15 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472746918.100354-1854005061', 09:22:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:15 INFO - '_': '/tools/buildbot/bin/python'} 09:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:16 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:22:16 INFO - Cleaning up... 09:22:16 INFO - Return code: 0 09:22:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:22:16 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:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:16 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:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:16 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 0x7fdd00decf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd48d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c63760>, '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 0x2c64660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c64af0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472746918.100354-1854005061', '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:22:16 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:22:16 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:22:16 INFO - Using env: {'DISPLAY': ':0', 09:22:16 INFO - 'HOME': '/home/cltbld', 09:22:16 INFO - 'LANG': 'en_US.UTF-8', 09:22:16 INFO - 'LANGUAGE': 'en_US:en', 09:22:16 INFO - 'LOGNAME': 'cltbld', 09:22:16 INFO - 'MAIL': '/var/mail/cltbld', 09:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:16 INFO - 'MOZ_NO_REMOTE': '1', 09:22:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:16 INFO - 'NO_EM_RESTART': '1', 09:22:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:16 INFO - 'PWD': '/builds/slave/test', 09:22:16 INFO - 'SHELL': '/bin/bash', 09:22:16 INFO - 'SHLVL': '1', 09:22:16 INFO - 'TERM': 'linux', 09:22:16 INFO - 'TMOUT': '86400', 09:22:16 INFO - 'USER': 'cltbld', 09:22:16 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472746918.100354-1854005061', 09:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:16 INFO - '_': '/tools/buildbot/bin/python'} 09:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:16 INFO - Downloading/unpacking psutil>=3.1.1 09:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:22:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:22:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:22:18 INFO - Installing collected packages: psutil 09:22:18 INFO - Running setup.py install for psutil 09:22:18 INFO - building 'psutil._psutil_linux' extension 09:22:18 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:22:18 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:22:18 INFO - building 'psutil._psutil_posix' extension 09:22:18 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:22:18 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:22:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:22:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:22:18 INFO - Successfully installed psutil 09:22:18 INFO - Cleaning up... 09:22:18 INFO - Return code: 0 09:22:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:22:18 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:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:18 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:22:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:18 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 0x7fdd00decf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd48d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c63760>, '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 0x2c64660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c64af0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472746918.100354-1854005061', '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:22:18 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:22:18 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:22:18 INFO - Using env: {'DISPLAY': ':0', 09:22:18 INFO - 'HOME': '/home/cltbld', 09:22:18 INFO - 'LANG': 'en_US.UTF-8', 09:22:18 INFO - 'LANGUAGE': 'en_US:en', 09:22:18 INFO - 'LOGNAME': 'cltbld', 09:22:18 INFO - 'MAIL': '/var/mail/cltbld', 09:22:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:18 INFO - 'MOZ_NO_REMOTE': '1', 09:22:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:18 INFO - 'NO_EM_RESTART': '1', 09:22:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:18 INFO - 'PWD': '/builds/slave/test', 09:22:18 INFO - 'SHELL': '/bin/bash', 09:22:18 INFO - 'SHLVL': '1', 09:22:18 INFO - 'TERM': 'linux', 09:22:18 INFO - 'TMOUT': '86400', 09:22:18 INFO - 'USER': 'cltbld', 09:22:18 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472746918.100354-1854005061', 09:22:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:18 INFO - '_': '/tools/buildbot/bin/python'} 09:22:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:22:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:22:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:22:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:22:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:22:21 INFO - Installing collected packages: mozsystemmonitor 09:22:21 INFO - Running setup.py install for mozsystemmonitor 09:22:21 INFO - Successfully installed mozsystemmonitor 09:22:21 INFO - Cleaning up... 09:22:21 INFO - Return code: 0 09:22:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:22: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:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22: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:22:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:21 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 0x7fdd00decf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd48d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c63760>, '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 0x2c64660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c64af0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472746918.100354-1854005061', '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:22:21 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:22:21 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:22:21 INFO - Using env: {'DISPLAY': ':0', 09:22:21 INFO - 'HOME': '/home/cltbld', 09:22:21 INFO - 'LANG': 'en_US.UTF-8', 09:22:21 INFO - 'LANGUAGE': 'en_US:en', 09:22:21 INFO - 'LOGNAME': 'cltbld', 09:22:21 INFO - 'MAIL': '/var/mail/cltbld', 09:22:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:21 INFO - 'MOZ_NO_REMOTE': '1', 09:22:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:21 INFO - 'NO_EM_RESTART': '1', 09:22:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:21 INFO - 'PWD': '/builds/slave/test', 09:22:21 INFO - 'SHELL': '/bin/bash', 09:22:21 INFO - 'SHLVL': '1', 09:22:21 INFO - 'TERM': 'linux', 09:22:21 INFO - 'TMOUT': '86400', 09:22:21 INFO - 'USER': 'cltbld', 09:22:21 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472746918.100354-1854005061', 09:22:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:21 INFO - '_': '/tools/buildbot/bin/python'} 09:22:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:21 INFO - Downloading/unpacking jsonschema==2.5.1 09:22:21 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:22:21 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:22:21 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:22:21 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:22:21 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:22:21 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:22:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:22:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:22:23 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:22:23 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:22:23 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:22:23 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:22:23 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:22:23 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:22:23 INFO - Downloading functools32-3.2.3-2.tar.gz 09:22:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:22:23 INFO - warning: no files found matching '*.txt' 09:22:23 INFO - no previously-included directories found matching 'build' 09:22:23 INFO - no previously-included directories found matching 'dist' 09:22:23 INFO - no previously-included directories found matching '.git*' 09:22:23 INFO - Installing collected packages: jsonschema, functools32 09:22:23 INFO - Running setup.py install for functools32 09:22:23 INFO - warning: no files found matching '*.txt' 09:22:23 INFO - no previously-included directories found matching 'build' 09:22:23 INFO - no previously-included directories found matching 'dist' 09:22:23 INFO - no previously-included directories found matching '.git*' 09:22:23 INFO - Successfully installed jsonschema functools32 09:22:23 INFO - Cleaning up... 09:22:23 INFO - Return code: 0 09:22:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:22:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdd00decf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd48d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c63760>, '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 0x2c64660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c64af0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472746918.100354-1854005061', '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:22:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:22:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:22:23 INFO - Using env: {'DISPLAY': ':0', 09:22:23 INFO - 'HOME': '/home/cltbld', 09:22:23 INFO - 'LANG': 'en_US.UTF-8', 09:22:23 INFO - 'LANGUAGE': 'en_US:en', 09:22:23 INFO - 'LOGNAME': 'cltbld', 09:22:23 INFO - 'MAIL': '/var/mail/cltbld', 09:22:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:23 INFO - 'MOZ_NO_REMOTE': '1', 09:22:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:23 INFO - 'NO_EM_RESTART': '1', 09:22:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:23 INFO - 'PWD': '/builds/slave/test', 09:22:23 INFO - 'SHELL': '/bin/bash', 09:22:23 INFO - 'SHLVL': '1', 09:22:23 INFO - 'TERM': 'linux', 09:22:23 INFO - 'TMOUT': '86400', 09:22:23 INFO - 'USER': 'cltbld', 09:22:23 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472746918.100354-1854005061', 09:22:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:23 INFO - '_': '/tools/buildbot/bin/python'} 09:22:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:22:23 INFO - Cleaning up... 09:22:23 INFO - Return code: 0 09:22:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:22:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdd00decf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd48d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c63760>, '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 0x2c64660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c64af0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472746918.100354-1854005061', '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:22:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:22:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:22:23 INFO - Using env: {'DISPLAY': ':0', 09:22:23 INFO - 'HOME': '/home/cltbld', 09:22:23 INFO - 'LANG': 'en_US.UTF-8', 09:22:23 INFO - 'LANGUAGE': 'en_US:en', 09:22:23 INFO - 'LOGNAME': 'cltbld', 09:22:23 INFO - 'MAIL': '/var/mail/cltbld', 09:22:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:23 INFO - 'MOZ_NO_REMOTE': '1', 09:22:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:23 INFO - 'NO_EM_RESTART': '1', 09:22:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:23 INFO - 'PWD': '/builds/slave/test', 09:22:23 INFO - 'SHELL': '/bin/bash', 09:22:23 INFO - 'SHLVL': '1', 09:22:23 INFO - 'TERM': 'linux', 09:22:23 INFO - 'TMOUT': '86400', 09:22:23 INFO - 'USER': 'cltbld', 09:22:23 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472746918.100354-1854005061', 09:22:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:23 INFO - '_': '/tools/buildbot/bin/python'} 09:22:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:24 INFO - Downloading/unpacking blobuploader==1.2.4 09:22:24 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:22:24 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:22:24 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:22:24 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:22:24 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:22:24 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:22:26 INFO - Downloading blobuploader-1.2.4.tar.gz 09:22:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:22:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:22:26 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:22:26 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:22:26 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:22:26 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:22:26 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:22:26 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:22:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:22:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:22:26 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:22:26 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:22:26 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:22:26 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:22:26 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:22:26 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:22:26 INFO - Downloading docopt-0.6.1.tar.gz 09:22:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:22:26 INFO - Installing collected packages: blobuploader, requests, docopt 09:22:26 INFO - Running setup.py install for blobuploader 09:22:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:22:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:22:26 INFO - Running setup.py install for requests 09:22:27 INFO - Running setup.py install for docopt 09:22:27 INFO - Successfully installed blobuploader requests docopt 09:22:27 INFO - Cleaning up... 09:22:27 INFO - Return code: 0 09:22:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:22:27 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:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:27 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:22:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:27 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 0x7fdd00decf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd48d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c63760>, '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 0x2c64660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c64af0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472746918.100354-1854005061', '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:22:27 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:22:27 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:22:27 INFO - Using env: {'DISPLAY': ':0', 09:22:27 INFO - 'HOME': '/home/cltbld', 09:22:27 INFO - 'LANG': 'en_US.UTF-8', 09:22:27 INFO - 'LANGUAGE': 'en_US:en', 09:22:27 INFO - 'LOGNAME': 'cltbld', 09:22:27 INFO - 'MAIL': '/var/mail/cltbld', 09:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:27 INFO - 'MOZ_NO_REMOTE': '1', 09:22:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:27 INFO - 'NO_EM_RESTART': '1', 09:22:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:27 INFO - 'PWD': '/builds/slave/test', 09:22:27 INFO - 'SHELL': '/bin/bash', 09:22:27 INFO - 'SHLVL': '1', 09:22:27 INFO - 'TERM': 'linux', 09:22:27 INFO - 'TMOUT': '86400', 09:22:27 INFO - 'USER': 'cltbld', 09:22:27 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472746918.100354-1854005061', 09:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:27 INFO - '_': '/tools/buildbot/bin/python'} 09:22:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:22:27 INFO - Running setup.py (path:/tmp/pip-uSUZEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:22:27 INFO - Running setup.py (path:/tmp/pip-WLFjpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:22:27 INFO - Running setup.py (path:/tmp/pip-54rfRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:22:27 INFO - Running setup.py (path:/tmp/pip-tWKERC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:22:27 INFO - Running setup.py (path:/tmp/pip-d4ZzVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:22:27 INFO - Running setup.py (path:/tmp/pip-DLCPu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:22:28 INFO - Running setup.py (path:/tmp/pip-Fe8L8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:22:28 INFO - Running setup.py (path:/tmp/pip-G7xgu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:22:28 INFO - Running setup.py (path:/tmp/pip-RHr7zZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:22:28 INFO - Running setup.py (path:/tmp/pip-S7Ia0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:22:28 INFO - Running setup.py (path:/tmp/pip-6PCIED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:22:28 INFO - Running setup.py (path:/tmp/pip-Q_vjtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:22:28 INFO - Running setup.py (path:/tmp/pip-tFnyG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:22:28 INFO - Running setup.py (path:/tmp/pip-opt7Rz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:22:28 INFO - Running setup.py (path:/tmp/pip-LtfvGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:22:28 INFO - Running setup.py (path:/tmp/pip-s8ENsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:22:28 INFO - Running setup.py (path:/tmp/pip-bri22F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:22:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:22:28 INFO - Running setup.py install for manifestparser 09:22:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:22:28 INFO - Running setup.py install for mozcrash 09:22:29 INFO - Running setup.py install for mozdebug 09:22:29 INFO - Running setup.py install for mozdevice 09:22:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:22:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:22:29 INFO - Running setup.py install for mozfile 09:22:29 INFO - Running setup.py install for mozhttpd 09:22:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:22:29 INFO - Running setup.py install for mozinfo 09:22:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:22:29 INFO - Running setup.py install for mozInstall 09:22:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:22:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:22:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:22:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:22:29 INFO - Running setup.py install for mozleak 09:22:29 INFO - Running setup.py install for mozlog 09:22:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:22:29 INFO - Running setup.py install for moznetwork 09:22:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:22:29 INFO - Running setup.py install for mozprocess 09:22:30 INFO - Running setup.py install for mozprofile 09:22:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:22:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:22:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:22:30 INFO - Running setup.py install for mozrunner 09:22:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:22:30 INFO - Running setup.py install for mozscreenshot 09:22:30 INFO - Running setup.py install for moztest 09:22:30 INFO - Running setup.py install for mozversion 09:22:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:22:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:22:30 INFO - Cleaning up... 09:22:30 INFO - Return code: 0 09:22:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:22: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:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22: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:22:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:30 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 0x7fdd00decf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd48d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c63760>, '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 0x2c64660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c64af0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472746918.100354-1854005061', '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:22:30 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:22:30 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:22:30 INFO - Using env: {'DISPLAY': ':0', 09:22:30 INFO - 'HOME': '/home/cltbld', 09:22:30 INFO - 'LANG': 'en_US.UTF-8', 09:22:30 INFO - 'LANGUAGE': 'en_US:en', 09:22:30 INFO - 'LOGNAME': 'cltbld', 09:22:30 INFO - 'MAIL': '/var/mail/cltbld', 09:22:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:30 INFO - 'MOZ_NO_REMOTE': '1', 09:22:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:30 INFO - 'NO_EM_RESTART': '1', 09:22:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:30 INFO - 'PWD': '/builds/slave/test', 09:22:30 INFO - 'SHELL': '/bin/bash', 09:22:30 INFO - 'SHLVL': '1', 09:22:30 INFO - 'TERM': 'linux', 09:22:30 INFO - 'TMOUT': '86400', 09:22:30 INFO - 'USER': 'cltbld', 09:22:30 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472746918.100354-1854005061', 09:22:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:30 INFO - '_': '/tools/buildbot/bin/python'} 09:22:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:22:30 INFO - Running setup.py (path:/tmp/pip-TwQFaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:22:30 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:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:22:30 INFO - Running setup.py (path:/tmp/pip-Hn4BjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:22:30 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:22:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:22:30 INFO - Running setup.py (path:/tmp/pip-xua13C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:22:31 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:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:22:31 INFO - Running setup.py (path:/tmp/pip-VqtlnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:22:31 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:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:22:31 INFO - Running setup.py (path:/tmp/pip-hQqsZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:22:31 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:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:22:31 INFO - Running setup.py (path:/tmp/pip-xwsh17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:22:31 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:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:22:31 INFO - Running setup.py (path:/tmp/pip-csvwQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:22:31 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:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:22:31 INFO - Running setup.py (path:/tmp/pip-HUALFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:22:31 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:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:22:31 INFO - Running setup.py (path:/tmp/pip-9ATtVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:22:31 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:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:22:31 INFO - Running setup.py (path:/tmp/pip-AYiU8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:22:31 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:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:22:31 INFO - Running setup.py (path:/tmp/pip-2X_Qgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:22:31 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:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:22:31 INFO - Running setup.py (path:/tmp/pip-DOqau7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:22:31 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:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:22:31 INFO - Running setup.py (path:/tmp/pip-DqU2lL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:22:31 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:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:22:31 INFO - Running setup.py (path:/tmp/pip-FvEeno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:22:31 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:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:22:31 INFO - Running setup.py (path:/tmp/pip-JpGkKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:22:31 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:22:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:22:31 INFO - Running setup.py (path:/tmp/pip-1a0xaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:22:32 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:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:22:32 INFO - Running setup.py (path:/tmp/pip-WW9UQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:22:32 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:22:32 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:22:32 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:22:32 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:22:32 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:22:32 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:22:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:22:32 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:22:32 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:22:32 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:22:32 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:22:32 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:22:32 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:22:33 INFO - Downloading blessings-1.6.tar.gz 09:22:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:22:34 INFO - Installing collected packages: blessings 09:22:34 INFO - Running setup.py install for blessings 09:22:34 INFO - Successfully installed blessings 09:22:34 INFO - Cleaning up... 09:22:34 INFO - Return code: 0 09:22:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:22:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:22:34 INFO - Reading from file tmpfile_stdout 09:22:34 INFO - Current package versions: 09:22:34 INFO - argparse == 1.2.1 09:22:34 INFO - blessings == 1.6 09:22:34 INFO - blobuploader == 1.2.4 09:22:34 INFO - docopt == 0.6.1 09:22:34 INFO - functools32 == 3.2.3-2 09:22:34 INFO - jsonschema == 2.5.1 09:22:34 INFO - manifestparser == 1.1 09:22:34 INFO - mozInstall == 1.12 09:22:34 INFO - mozcrash == 0.17 09:22:34 INFO - mozdebug == 0.1 09:22:34 INFO - mozdevice == 0.48 09:22:34 INFO - mozfile == 1.2 09:22:34 INFO - mozhttpd == 0.7 09:22:34 INFO - mozinfo == 0.9 09:22:34 INFO - mozleak == 0.1 09:22:34 INFO - mozlog == 3.3 09:22:34 INFO - moznetwork == 0.27 09:22:34 INFO - mozprocess == 0.23 09:22:34 INFO - mozprofile == 0.28 09:22:34 INFO - mozrunner == 6.12 09:22:34 INFO - mozscreenshot == 0.1 09:22:34 INFO - mozsystemmonitor == 0.3 09:22:34 INFO - moztest == 0.7 09:22:34 INFO - mozversion == 1.4 09:22:34 INFO - psutil == 3.1.1 09:22:34 INFO - requests == 1.2.3 09:22:34 INFO - wsgiref == 0.1.2 09:22:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:22:34 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:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:34 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:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:34 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 0x7fdd00decf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd48d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c63760>, '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 0x2c64660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c64af0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472746918.100354-1854005061', '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:22:34 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:22:34 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:22:34 INFO - Using env: {'DISPLAY': ':0', 09:22:34 INFO - 'HOME': '/home/cltbld', 09:22:34 INFO - 'LANG': 'en_US.UTF-8', 09:22:34 INFO - 'LANGUAGE': 'en_US:en', 09:22:34 INFO - 'LOGNAME': 'cltbld', 09:22:34 INFO - 'MAIL': '/var/mail/cltbld', 09:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:34 INFO - 'MOZ_NO_REMOTE': '1', 09:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:34 INFO - 'NO_EM_RESTART': '1', 09:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:34 INFO - 'PWD': '/builds/slave/test', 09:22:34 INFO - 'SHELL': '/bin/bash', 09:22:34 INFO - 'SHLVL': '1', 09:22:34 INFO - 'TERM': 'linux', 09:22:34 INFO - 'TMOUT': '86400', 09:22:34 INFO - 'USER': 'cltbld', 09:22:34 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472746918.100354-1854005061', 09:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:34 INFO - '_': '/tools/buildbot/bin/python'} 09:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:34 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:22:34 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:22:34 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:22:34 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:22:34 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:22:34 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:22:34 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:22:34 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:22:34 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:22:34 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:22:34 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:22:34 INFO - Cleaning up... 09:22:34 INFO - Return code: 0 09:22:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:22:34 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:22:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:22:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:34 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:22:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:22:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:22:34 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 0x7fdd00decf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bd48d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c63760>, '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 0x2c64660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c64af0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472746918.100354-1854005061', '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:22:34 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:22:34 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:22:34 INFO - Using env: {'DISPLAY': ':0', 09:22:34 INFO - 'HOME': '/home/cltbld', 09:22:34 INFO - 'LANG': 'en_US.UTF-8', 09:22:34 INFO - 'LANGUAGE': 'en_US:en', 09:22:34 INFO - 'LOGNAME': 'cltbld', 09:22:34 INFO - 'MAIL': '/var/mail/cltbld', 09:22:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:34 INFO - 'MOZ_NO_REMOTE': '1', 09:22:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:34 INFO - 'NO_EM_RESTART': '1', 09:22:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:34 INFO - 'PWD': '/builds/slave/test', 09:22:34 INFO - 'SHELL': '/bin/bash', 09:22:34 INFO - 'SHLVL': '1', 09:22:34 INFO - 'TERM': 'linux', 09:22:34 INFO - 'TMOUT': '86400', 09:22:34 INFO - 'USER': 'cltbld', 09:22:34 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472746918.100354-1854005061', 09:22:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:34 INFO - '_': '/tools/buildbot/bin/python'} 09:22:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:22:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:22:34 INFO - Cleaning up... 09:22:34 INFO - Return code: 0 09:22:34 INFO - Running post-action listener: _resource_record_post_action 09:22:34 INFO - Running post-action listener: _start_resource_monitoring 09:22:34 INFO - Starting resource monitoring. 09:22:34 INFO - [mozharness: 2016-09-01 16:22:34.898341Z] Finished create-virtualenv step (success) 09:22:34 INFO - [mozharness: 2016-09-01 16:22:34.898796Z] Running install step. 09:22:34 INFO - Running pre-action listener: _resource_record_pre_action 09:22:34 INFO - Running main action method: install 09:22:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:22:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:22:35 INFO - Reading from file tmpfile_stdout 09:22:35 INFO - Detecting whether we're running mozinstall >=1.0... 09:22:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:22:35 INFO - Reading from file tmpfile_stdout 09:22:35 INFO - Output received: 09:22:35 INFO - Usage: mozinstall [options] installer 09:22:35 INFO - Options: 09:22:35 INFO - -h, --help show this help message and exit 09:22:35 INFO - -d DEST, --destination=DEST 09:22:35 INFO - Directory to install application into. [default: 09:22:35 INFO - "/builds/slave/test"] 09:22:35 INFO - --app=APP Application being installed. [default: firefox] 09:22:35 INFO - mkdir: /builds/slave/test/build/application 09:22:35 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:22:35 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:22:52 INFO - Reading from file tmpfile_stdout 09:22:52 INFO - Output received: 09:22:52 INFO - /builds/slave/test/build/application/firefox/firefox 09:22:52 INFO - Running post-action listener: _resource_record_post_action 09:22:52 INFO - [mozharness: 2016-09-01 16:22:52.188020Z] Finished install step (success) 09:22:52 INFO - [mozharness: 2016-09-01 16:22:52.188272Z] Running run-tests step. 09:22:52 INFO - Running pre-action listener: _resource_record_pre_action 09:22:52 INFO - Running main action method: run_tests 09:22:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:22:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:22:52 INFO - Python 2.7.3 09:22:52 INFO - Return code: 0 09:22:52 INFO - grabbing minidump binary from tooltool 09:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:52 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 0x2c63760>, '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 0x2c64660>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c64af0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:22:52 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:22:52 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:22:52 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:22:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:22:52 INFO - Return code: 0 09:22:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:22:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:22:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:22:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:22:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:22:52 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-e10s', '--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-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:22:52 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-e10s --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-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:22:52 INFO - Using env: {'DISPLAY': ':0', 09:22:52 INFO - 'HOME': '/home/cltbld', 09:22:52 INFO - 'LANG': 'en_US.UTF-8', 09:22:52 INFO - 'LANGUAGE': 'en_US:en', 09:22:52 INFO - 'LOGNAME': 'cltbld', 09:22:52 INFO - 'MAIL': '/var/mail/cltbld', 09:22:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:22:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:22:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:52 INFO - 'MOZ_NO_REMOTE': '1', 09:22:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:22:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:52 INFO - 'NO_EM_RESTART': '1', 09:22:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:52 INFO - 'PWD': '/builds/slave/test', 09:22:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:22:52 INFO - 'SHELL': '/bin/bash', 09:22:52 INFO - 'SHLVL': '1', 09:22:52 INFO - 'TERM': 'linux', 09:22:52 INFO - 'TMOUT': '86400', 09:22:52 INFO - 'USER': 'cltbld', 09:22:52 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472746918.100354-1854005061', 09:22:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:52 INFO - '_': '/tools/buildbot/bin/python'} 09:22:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--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-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:22:52 INFO - mozversion application_buildid: 20160901053002 09:22:52 INFO - mozversion application_changeset: 9d715b38e5f094c63df4fa560fd00b6ff6852f9b 09:22:52 INFO - mozversion application_display_name: Nightly 09:22:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:22:52 INFO - mozversion application_name: Firefox 09:22:52 INFO - mozversion application_remotingname: firefox 09:22:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:22:52 INFO - mozversion application_vendor: Mozilla 09:22:52 INFO - mozversion application_version: 51.0a1 09:22:52 INFO - mozversion platform_buildid: 20160901053002 09:22:52 INFO - mozversion platform_changeset: 9d715b38e5f094c63df4fa560fd00b6ff6852f9b 09:22:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:22:52 INFO - mozversion platform_version: 51.0a1 09:22:52 INFO - using testdate: 1472746972 09:22:52 INFO - actual date: 1472746972 09:22:52 INFO - starting webserver on 'localhost:59497' 09:22:52 INFO - SUITE-START | Running 2 tests 09:22:52 INFO - TEST-START | dromaeo_css 09:22:52 INFO - operating with platform_type : linux_ 09:22:52 INFO - Initialising browser for dromaeo_css test... 09:22:52 INFO - TEST-INFO | started process 10842 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmEYDmJ/profile http://localhost:59497/getInfo.html) 09:22:57 INFO - PROCESS | 10842 | __metrics Screen width/height:1600/1200 09:22:57 INFO - PROCESS | 10842 | colorDepth:24 09:22:57 INFO - PROCESS | 10842 | Browser inner width/height: 1024/697 09:22:57 INFO - PROCESS | 10842 | __metrics 09:22:58 ERROR - PROCESS | 10842 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 09:22:59 INFO - TEST-INFO | 10842: exit 0 09:22:59 INFO - Browser initialized. 09:22:59 INFO - Running cycle 1/1 for dromaeo_css test... 09:22:59 INFO - TEST-INFO | started process 10963 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmEYDmJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:23:11 INFO - PROCESS | 10963 | RSS: Main: 192323584 09:23:11 INFO - PROCESS | 10963 | 09:24:01 INFO - PROCESS | 10963 | 1472747041032 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:26:10 INFO - PROCESS | 10963 | Cycle 1(1): loaded http://localhost:59497/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59497/tests/dromaeo/cssquery-ext.html) 09:26:12 INFO - PROCESS | 10963 | RSS: Main: 212156416 09:26:12 INFO - PROCESS | 10963 | 09:29:14 INFO - PROCESS | 10963 | Cycle 1(1): loaded http://localhost:59497/tests/dromaeo/cssquery-ext.html (next: http://localhost:59497/tests/dromaeo/cssquery-jquery.html) 09:29:14 INFO - PROCESS | 10963 | RSS: Main: 205910016 09:29:14 INFO - PROCESS | 10963 | 09:32:16 INFO - PROCESS | 10963 | Cycle 1(1): loaded http://localhost:59497/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59497/tests/dromaeo/cssquery-mootools.html) 09:32:17 INFO - PROCESS | 10963 | RSS: Main: 201793536 09:32:17 INFO - PROCESS | 10963 | 09:35:19 INFO - PROCESS | 10963 | Cycle 1(1): loaded http://localhost:59497/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59497/tests/dromaeo/cssquery-prototype.html) 09:35:20 INFO - PROCESS | 10963 | RSS: Main: 194203648 09:35:20 INFO - PROCESS | 10963 | 09:38:22 INFO - PROCESS | 10963 | Cycle 1(1): loaded http://localhost:59497/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59497/tests/dromaeo/cssquery-yui.html) 09:38:23 INFO - PROCESS | 10963 | RSS: Main: 197459968 09:38:23 INFO - PROCESS | 10963 | 09:41:26 INFO - PROCESS | 10963 | Cycle 1(1): loaded http://localhost:59497/tests/dromaeo/cssquery-yui.html (next: http://localhost:59497/tests/dromaeo/cssquery-dojo.html) 09:41:26 INFO - PROCESS | 10963 | RSS: Main: 197976064 09:41:26 INFO - PROCESS | 10963 | 09:41:26 INFO - PROCESS | 10963 | __start_tp_report 09:41:26 INFO - PROCESS | 10963 | _x_x_mozilla_page_load 09:41:26 INFO - PROCESS | 10963 | _x_x_mozilla_page_load_details 09:41:26 INFO - PROCESS | 10963 | |i|pagename|runs| 09:41:26 INFO - PROCESS | 10963 | |0;dojo.html;3120.60992375953;3125.1562078238876;3136.858841352139;3168.572242747229;3181.8568164432613;5375.301210842585;5482.862928426792;5482.972585137074;5541.889162216753;5613.915791263134;5410.702411367373;5411.83764487065;5449.182622606601;5449.754761035753;5514.6691198528115;4848.612111031118;4886.071646387175;4931.26031095335;4989.65072444929;5065.696058236499;4913.680610760307;4973.452920178777;4978.402591688984;5036.672616279949;5091.338126043609;4861.173600487926;4883.658143929926;4907.779149938226;4931.556159945622;4975.577075948549;4904.705717656916;4922.360093187863;4923.77842997066;4928.67963582366;4985.700857948535;4848.29699693546;4880.585150262232;4886.315915771795;4942.382202224722;4959.330490383824;5372.838814835562;5390.110631745757;5445.1832225166145;5454.10007348787;5498.092814685572;5802.82591522255;5813.302403711539;5821.476067153976;5831.183634291203;5831.825045248607;5717.142428635696;5844.503217226498;5868.76524939002;5876.353601103875;5879.294484661825;5442.91835622466;5473.863153421156;5489.313835770528;5492.340919089695;5572.498475137257;6025.0661147522205;6034.426729460694;6043.274807023097;6047;6047.697615119227;5497.36780270274;5768.711564421762;5786.88426231473;5787.218725472091;5796.275465566804;5732.426757324234;5802.912956305659;5820.35976042635;5839.124131380242;5939.198208241918;5694.686792226385;5792.82621521355;5796.246487956539;5808.244928159313;5817.7382017809305;5780.046292361797;5834.183214349994;5838.883222335529;5849.064149736022;5849.210356601804;4452.109578084396;4488.910221795546;4512.9774351128035;4524.389207457017;4532.138893610204;4005.739626924299;4008.4788977432745;4011.7592944423427;4026.899327516777;4051.8784436466954;5595.916061259084;5624.831255062355;5625.521830644359;5644.6613203207935;5703.372629010805;5697.800576979786;5706.28671416073;5790.536757059425;5805.303363596311;5832.825015249549;5572.832815015556;5590.385057643656;5598.86002849932;5601.719914004365;5623.887522249532;5011.949880501221;5020.849374518771;5035.597152227813;5072.010957863181;5077.441481437039;5841.766329346863;5877.9118313225335;5913.9112913306335;5932.228810254639;5936.257967754031;5726.79956201531;5736.368999409978;5746.339170995222;5768.7404066817935;5774.653520788766;5964.165016897551;5980.5514586405325;5981.312149102909;5981.581289309881;5991.2510936132985;5555.333359996826;5649.54803615718;5650.0959846424375;5657.943420565906;5696.8006119785605;5791.478766910998;5820.1560773688425;5820.476157145878;5833.358330583547;5874.412558744091;5653.293338332708;5657.5473962082115;5659.717014149359;5660.575456840836;5680.829575112753;5539.667619942817;5614.578906581941;5652;5673.914891276551;5683.1759394886685;5649;5656.377798442086;5658.321001479849;5663.57523185771;5699.800506982236;5712.34308054579;5714.79998200061;5781.710914454176;5784.161296612052;5786.247787787729;5481.506664400223;5516.475934786189;5572.637778544382;5597.328320601554;5598.496135347838 09:41:26 INFO - PROCESS | 10963 | |1;ext.html;578.8060999565146;590.147237242185;591.579978215467;594.8542607061271;605.5791225098553;39692;44329.335059974124;44409;44435.55564444354;44491.555084449144;44522;44571.77714111433;44624.330635040504;45087;45100;8778.078301778301;8920.28637708985;8961.50711710859;8991.370604057718;9008.234300084501;8762.167594078584;8804.559772011375;8839.911600883974;8857.95571022144;8885.822283554326;8895.599698013573;8908.064653211417;8929.95535022324;8952.507612081334;8965.372423930328;8799.516026618534;8891.066438024043;8906.55467226636;8907.198352148338;8909.242714369318;8801.647934082628;8821.647134114628;8877.245434138105;8889.244414224799;8902.910970890272;40534.39198412026;40616.79691601523;40830.795846020876;40982.38526422106;41103.794481027704;3494.9650503494895;3572.499850020999;3591.766535175231;3610.7291953103622;3625.2568223514118;31755.682443175505;32427.351452970808;32613.51079733806;32726;32757;4084.4077608746566;4229.302165142748;4311.13593743764;4332.675049371278;4437.889052773674;346973;347929;357063.21468392754;360318;362734;58106;58703.41296586979;58772.4122758767;58959.41040589625;59030;59719.402805972255;60075.69962150161;60274;60287.69856150779;60412.697936510915;17039.744403833705;17262.82737172612;17289.308427663003;17770.733438998424;17775.200115994812;12904.16122952024;12957.676058098623;13061.608151755463;13099.428068631825;13110.885574726064;18951.90524047371;18997.90501047486;19019.61960760777;19076.809231907504;19224.327148549735;7035.859282814315;7043.859122817515;7097.609631470319;7176.856462870714;7187.232915327637;885.9867101993475;1034.270839058462;1058.6718117383637;1120.467777805552;1124.8987591116838;31697;32249.58128140399;32277.677223227936;32571.51142732861;32786.836065819996;921.9769505762275;1047.5076713944434;1057.931234469757;1094.9233553651168;1157.4097210422576;16130.75803862943;16822;16953.660926781395;18362.81637183638;18391.90804045971;519620;526633;527304;527901;527905;61514;62311.688441557504;62368.37631623716;62659.37340626535;62667.686661566404;1250.5498020712537;1331.3875617216188;1331.8468376136675;1332.213993743696;1337.2177276293282;31322.68677313289;33258.334833303685;33417.16457088592;33706.157346066546;33927.830360849024;53142.73428632832;53216.2017569729;53699.657508562595;53786.731066344415;53820;474942;476906;478202;478994;481221;43019.35470968;43565.07914287729;44072.33891491566;44120.33819492646;44280.11439771251;48109;48955;49070;49167.754161228964;50290.74854625703;41313;42178.789106054275;42212.1557568853;42213.57786422219;43533.78233108941;41632.16735665209;41821.58178418177;42272;42828.57171428246;43463.78268108766;40243.1951360977;40936.181276374904;40989.10603492663;41133.382999254434;41627.1674566513;35926.28147437089;36531.81734091419;38514.24701465011;38753.612463876125;39100.413493797045;26242;28693.569596456487;29009.274768130967;29095.854520727262;29181.562276565444 09:41:26 INFO - PROCESS | 10963 | |2;jquery.html;385.36799648576323;395.59451562148814;404.7025436304316;408.22437368998897;422.82030137191686;14128.364223609937;18567.535811604717;19544.804551954476;19980.800191998074;20087.497812554695;19148.904255478737;19517.902410487928;19640.70538941917;19767.110480028397;19924.900375498102;5707.914381284284;5711.543076553866;5773.653580785145;5829.213056237396;5835.941640583604;5759.539236861041;5783.10361893905;5801.680907550083;5804.100364443518;5811.418858114176;5682.147677848315;5708.029634962046;5800.303963524383;5813.563982701293;5814.680192589406;5617.550595952314;5779.884402311951;5804;5827.446392592718;5835.970820145893;5172.741362931876;5194.818181363634;5197.8440646780655;5197.870053248661;5218.634695571312;23764;23901.282961511184;24134.879325603437;24278;24446.633300500507;2427.1747605814107;2429.53838770633;2490.8007359411204;2956.704329567048;2992.1023692892263;13895.235762033084;14730.70538589233;14848.554543363716;15454.922725386301;15506.379744810194;1785.9107044647847;1850.528115330582;1866.686631229565;1877.8122187781248;1944.2028768204968;86902;91257.54371228101;91487.54256228743;91565;93895;11093.278936869077;11192.216544841784;11244.100471962223;11432.88567114335;11665.24175928562;15823.762643560356;15989.440369587008;15991.120488373252;16074.67850643004;16133.919330403272;8117.959410202911;8501.992189822962;8518.829623407497;8544.74365769028;8723.52020638871;7899.644515996794;8102.351811855037;8120.959395203105;8403.15968403167;8472.068072512018;4573.725576465423;4613.95386046142;4678.1813182692895;4821.879453013703;4930.704157750546;1914.339552854263;1969.3894892583346;2011.2960463837833;2020.1616329223502;2025.2911480981834;885.349268287808;899.7840518275567;947.8436058050345;969.2246203037541;975.8975307592742;18647.627047459246;19788.109535070955;19866.940583122;19869.801301986794;20033.499162520762;916.4272329793879;963.802420503795;980.0150848397458;1003.3227571389283;1054.6572363981736;10216.037349168659;10643.41461219625;11287.774244515227;11436.256643318158;11932.821007684892;489684;497917.71863954485;499496;501579;504038;101494;101524;105468.47265763622;106678;108059.45970270099;987.4519641598981;1019.2559431614815;1043.3687618990552;1044.2324891204958;1065.6643157405238;16728.832711672727;17816.23848303515;18475;18568.81431185671;19114.33099841499;44104.55895441133;44727.77636111798;44992.55007449884;45286.77356613196;45748.771256143504;61256.693716532915;61677;62416.37583624287;63273.36726632675;64039.35960640334;8069;8186;8296.792580185544;8456.450330728483;8678.349123815866;11301.71745706364;12859.228446293253;12869.520005199522;13024;13381.464741410235;11445.42772861337;11488.310701357945;11489.942550287195;11534.538618455168;11929.463174157358;11249.943750281196;11422.31466112036;11443.198976071595;11577.421128943352;11824.40877956116;11549;11763.353015584225;11895.929366356724;12032.879671203176;12350.197237179555;8140.267375936194;8338.332933365195;8411.789705257417;8572.099929507562;8650.78373040679;10204.846927295948;11640.88359116398;11702.648920532398;11866.110041746731;12099.213551119148 09:41:26 INFO - PROCESS | 10963 | |3;mootools.html;1423.5586968039909;1480.8815294776418;1596.616811965128;1718.7765590473236;1757.042411885523;8149.714759983402;8819.91180088199;9019.864702029476;9541.61833526659;9560.76098097548;9113.863292050624;9393.95303023484;9405.529723513813;9430.33987620865;9431.717048488556;2442.6091825308;2465.90136394544;2491.9377015574573;2494.9251522454265;2498.300475866751;2380.6071998120287;2484.5155194737035;2491.5266099441046;2498.537770512461;2503.036331012564;2478.652988581591;2486.17956074495;2493.4140476987895;2515.0819950718037;2522.6594409754725;2407.1574948767966;2411.6985376827897;2417.404513021415;2424.212131057405;2426.138720754142;2378.2984019714227;2387.152560840894;2391.1152873436768;2393.258089992108;2447.0823441209545;9402.905970940272;9411.811763764756;9431.717048488556;9434.05659434058;9446.291528135418;5426.5116139547235;5591.7483713233005;5608.158776183564;5608.270924779793;5634.098544232903;3374.240553820817;3519.3841077811535;3537.876174333912;3549.5923913043507;3577.910552236189;1108.1744100645071;1124.8425220469142;1125.4766533561933;1131.0781712903956;1171.1216587559331;13290.933545332307;13291.069625126245;13303.068785185042;13307.600771976857;13322.866771332356;4488.438945131858;4649.814007439664;4747.8100875965265;4782.760861956888;4852.102361063215;11067.778644427066;11085.390303533222;11085.889141108648;11131.833022504668;11156.776864462827;5461.508464238238;5475.206095116266;5499.202615620793;5515.448455154533;5553.944460555343;4440.777961101932;4869.63477739171;5020.949790502122;5027.522385373383;5042;4013.9197216055513;4028.738132021409;4131.566185550474;4232.153569286155;4263.914721705549;1295.151675652449;1315.3492367079446;1341.6042267531102;1346.670065833877;1348.1035111650838;831.846108469935;976.584951395654;984.6898227058454;992.2111921022804;1000.8298589239702;6057.121717350959;6067.848303792441;6178.814635560941;6184.072389141665;6423.5503514754455;452.9932051019237;468.11526215452824;484.75277608419253;487.5782448182297;490.619769678502;4124.216398884202;4303.182395344875;4310.525842157423;4318.265894797829;4330.761808100585;11245.943770281096;11495.770084598262;11722.296662200295;11770.411479425995;11776.234544754563;11583.594574190032;11611.419429028514;11630.76738465226;11649.99999999983;11657.417129143509;8288.958555207306;8482.830343393098;8546.572671366532;8559.101294364002;8598.226159645661;6361.554691171574;6433.099366088658;6469.741210351722;6572.572782769104;6612.206535215805;10059.195264378686;10519.579216831242;10642.73393165177;10772.515236814206;10836.891631083903;10173.491325433552;10625.096866766411;10746.355218686904;10909.727256818644;10932.344059356465;7231.49379543448;7515;7683.270089341504;7974.641141148778;8235.38234632393;8504.53225072627;8594.527300998505;8611.913880861111;8631.39580229403;8644.956775216084;7612.581308028111;7643.4267429941865;7879.645415956181;7924.366050715814;7954.761357159295;7620;7671.961640191764;7673.117591477052;7714.421418393531;7719.382449403922;6875.037494750639;7021.262767409348;7036.437085033287;7039.507234493536;7065.6113913735235;5155.742212889266;5205.739713014258;5206;5293.576513878804;5535.640183388067;5273.6572122811895;5297.145998900354;5361.4370491099435;5443.346798384061;5533.501984821385 09:41:26 INFO - PROCESS | 10963 | |4;prototype.html;327.9652695744924;344.4626382842765;345.85616743798863;345.8616553378648;347.54992284990936;5388.353397592295;5399.595030372718;5538.390777014531;5603.719814009299;5634.126710359896;5431.21247419124;5468.332158691597;5486.3690675572325;5490.286262785832;5493.862653433666;4334.284843000901;4339.370791235269;4345.78271086446;4358.193734159191;4364.585364390377;4196.685248606352;4232.936505952413;4307.569243075699;4337.392765012901;4375.956240437603;4236.406903033578;4252.489701235856;4254.808533615979;4258.105797782469;4258.701890867641;4292.549282325358;4298.355246713002;4304.031592891605;4321.524632290446;4335.978320108411;3730.5150330457136;3852.152526444178;3856.267309211241;3874.3219936511277;3874.670652994499;5370.087085195526;5384.623076384654;5401.5948803839865;5416.647917885325;5417.53277902143;4904.754762261872;4944.208926571731;4961.231009193581;4972.005598880239;4973.875653108665;5525.751341189656;5736.770529178828;5745.793383389493;5781.335146458169;5810.4770570648425;4173.833046678129;4176.248275310443;4179.707420480568;4185.330347144472;4185.853495127656;5978.312494063195;6006.609570377956;6017.699115044274;6025.487833534155;6027.005544085221;4122.9381559276635;4279.272523670983;4308.267594508941;4328.11273688893;4350.847720329773;4355.607995280377;4357.433533640607;4358.629516491071;4360.7601581913295;4373.497047839539;4961.82633607822;4966.404031516241;4984.526469985346;4984.651074424755;4999.150144475448;5562.749676264578;5812.273465816773;5814.825555233349;5822.689894773642;5852.180694702745;1528.7706843973492;1537.2467490929364;1543.5523698127643;1544.5906834688817;1549.4964136655406;929.1034152043311;966.5747071288611;970.315927271272;971.5142428785607;979.8726165598426;4903.975480122576;4958.231474121517;4986.204966212161;4993.925091123636;5050.898982020339;5152.845414637567;5161.4322424533275;5175.59334909269;5187.535920437837;5272.156454967187;4629.930551041737;4843.418789745253;4951.653384263139;4970.676906001098;4973.925391119136;2732.7565957489296;2734.7948903832294;2740.2190375742816;2750.2161883863005;2751.5184842652457;5281.39263984639;5321.733913304397;5375.865603359947;5393.27190829233;5422.5119739223655;5218.817341393109;5294.782200094;5536.252605898233;6015.639061656315;6049.758009679564;6105.450509454082;6109.8391305651785;6113.205283313141;6170.167027451326;6173.444390004831;5643.802466913638;5882.970585147047;5907.616004959664;5930.881382372415;5938.8218353449465;5907.409259074058;5921.822345329475;5926.259217597801;5936.703164841827;5942.1978032965;6208.379162083756;6210.472109870531;6215.358472649196;6221.657808820558;6246.187995560548;4037.7375470594316;4087.959120408877;4145.8963525910885;4162.62536371728;4179.080602267496;5849.064149736022;5880.852978675567;5896.70516474166;5921.378255283305;5978;5693.8861222774485;5713.8285851424525;5770.5095066919785;5834.591578589458;5845.649261044351;5683.2895888014;5713.800101978631;5720.48515633595;5741.885162296647;5750.281214848144;5686.744096515749;5713.371529131875;5717;5721.370649228498;5755.5683323750045;5727.341355744143;5761.617211869037;5768.346560582011;5795.884082318415;5811.302643682785;5652.208690783212;5654.604177707521;5668.433156684298;5670.206171136127;5698.515626171822 09:41:26 INFO - PROCESS | 10963 | |5;yui.html;702.448577866375;709.9290070992904;728.0353531570669;750.0736590310966;759.3924860111916;13740.862591374083;15154.242287885616;15163.696726065473;15233.238338083107;15270.312835922383;14162.575122746308;14442.783358249608;14457.349419276132;14467.78298325526;14518.201498917555;651.9022146678012;759.1952530317881;786.0685088170536;788.329919568368;793.8372633610096;768.8961990131345;776.9922300777005;778.2762031310879;784.945053846231;785.8585454618167;832.6086739232551;833.4957350802738;834.0408530190269;835.5154010673795;836.4061516323387;824.1387749801472;824.1428913929506;825.6449726617552;827.0736774812219;827.7061643116697;608.0453687710296;609.20194545146;610.9022556391001;611.6666416802854;612.1796792298297;13878.93060534701;13923.512677056357;13950.581482555539;13996.860031399658;14016.92991535046;13003.674908127277;13495.66260843477;13555.322233888266;13727.313634318343;13735.519256825963;11317.71705707364;11380.658580242605;11423.143264255214;11487.597934072268;11609.941950290278;3674.0998455378335;3704.814759262026;3705.2959937611768;3736.8878933632036;3805.0297174220673;87883.56058219667;88736.55631721865;89074.5546272271;90247;90666;10397.168226541859;10488.213383996232;10611.84082238767;10721.088707459798;10721.463926803628;19433.31983380575;19929.402117936195;20094.69857952132;20125.49686257855;20205.494862628257;7589.203133670995;7604.049493813273;7623;7759.7672069838;7995.120536740954;3972.324704800191;4244.554321796167;4266.978665106717;4328.696991210648;4411.00752330723;3242.902712918616;3305.983470082634;3321.7840840345784;3345.2473193531746;3353.245519758035;568.6673296121816;578.1385735254524;593.7773334999375;622.327885883245;630.9652969086744;647.0746832030148;659.5745743995096;669.5848573884223;675.3887731602907;679.4869873245668;9626.278029147841;9720.61117555304;9728.221742260603;9860.556274967643;9895.851562226573;573.6242760991557;577.3389469057989;587.5094296262583;587.806024012075;659.7295109005285;4273.91452170961;4917.385326834145;4966;5147.150720131136;5363.919541206885;120803;121083.39458302829;125308;125387.3730631341;126170;86110.56944715236;89162.55418722995;107602;108859;109429.45285273522;88602.55698721464;89199.55400223087;89259.55370223237;89749.10250897538;90471.54764226137;9366.718998430058;10057.521265965044;10116.949415252877;10155.847662284923;10262.332948358333;49002.50997490122;52624;53059.73470132625;53204.46795531995;55137.44862551323;72131.63934180296;72513;81208;81270.59364703139;84150.57924710338;12409.06931980087;12434.191777534794;12637.431315591004;12715.682107947376;12746.68133296675;13167.576430128043;13491.325433728078;13529;13572.321383930566;14010.64973375633;11879.524819007143;12307.138500304893;12317.260964342167;12333.136680432284;12667;11432.256903301259;11503.597374091867;11927.522899084286;13201.352816800341;13359.666008349868;11631.88368116308;12404.689882753004;12669.683257918627;12730.711343472956;12771.233725976472;10370.00099730715;10958;11324.660260192208;11328.94335528317;11379.146564007568;10442.477876106012;10785;11107.611233606785;11268.492917818554;11287.43562821872 09:41:26 INFO - PROCESS | 10963 | __end_tp_report 09:41:26 INFO - PROCESS | 10963 | __start_cc_report 09:41:26 INFO - PROCESS | 10963 | _x_x_mozilla_cycle_collect,325 09:41:26 INFO - PROCESS | 10963 | __end_cc_report 09:41:26 INFO - PROCESS | 10963 | __startTimestamp1472748086571__endTimestamp 09:41:26 INFO - PROCESS | 10963 | 09:41:26 INFO - PROCESS | 10963 | ------- Summary: start ------- 09:41:26 INFO - PROCESS | 10963 | Number of tests: 6 09:41:26 INFO - PROCESS | 10963 | 09:41:26 INFO - PROCESS | 10963 | [#0] dojo.html Cycles:165 Average:5409.51 Median:5644.66 stddev:604.68 (10.7%) stddev-sans-first:579.26 09:41:26 INFO - PROCESS | 10963 | Values: 3120.6 3125.2 3136.9 3168.6 3181.9 5375.3 5482.9 5483.0 5541.9 5613.9 5410.7 5411.8 5449.2 5449.8 5514.7 4848.6 4886.1 4931.3 4989.7 5065.7 4913.7 4973.5 4978.4 5036.7 5091.3 4861.2 4883.7 4907.8 4931.6 4975.6 4904.7 4922.4 4923.8 4928.7 4985.7 4848.3 4880.6 4886.3 4942.4 4959.3 5372.8 5390.1 5445.2 5454.1 5498.1 5802.8 5813.3 5821.5 5831.2 5831.8 5717.1 5844.5 5868.8 5876.4 5879.3 5442.9 5473.9 5489.3 5492.3 5572.5 6025.1 6034.4 6043.3 6047.0 6047.7 5497.4 5768.7 5786.9 5787.2 5796.3 5732.4 5802.9 5820.4 5839.1 5939.2 5694.7 5792.8 5796.2 5808.2 5817.7 5780.0 5834.2 5838.9 5849.1 5849.2 4452.1 4488.9 4513.0 4524.4 4532.1 4005.7 4008.5 4011.8 4026.9 4051.9 5595.9 5624.8 5625.5 5644.7 5703.4 5697.8 5706.3 5790.5 5805.3 5832.8 5572.8 5590.4 5598.9 5601.7 5623.9 5011.9 5020.8 5035.6 5072.0 5077.4 5841.8 5877.9 5913.9 5932.2 5936.3 5726.8 5736.4 5746.3 5768.7 5774.7 5964.2 5980.6 5981.3 5981.6 5991.3 5555.3 5649.5 5650.1 5657.9 5696.8 5791.5 5820.2 5820.5 5833.4 5874.4 5653.3 5657.5 5659.7 5660.6 5680.8 5539.7 5614.6 5652.0 5673.9 5683.2 5649.0 5656.4 5658.3 5663.6 5699.8 5712.3 5714.8 5781.7 5784.2 5786.2 5481.5 5516.5 5572.6 5597.3 5598.5 09:41:26 INFO - PROCESS | 10963 | 09:41:26 INFO - PROCESS | 10963 | [#1] ext.html Cycles:180 Average:62101.92 Median:4321.91 stddev:121484.34 (2810.9%) stddev-sans-first:121737.31 09:41:26 INFO - PROCESS | 10963 | Values: 578.8 590.1 591.6 594.9 605.6 39692.0 44329.3 44409.0 44435.6 44491.6 44522.0 44571.8 44624.3 45087.0 45100.0 8778.1 8920.3 8961.5 8991.4 9008.2 8762.2 8804.6 8839.9 8858.0 8885.8 8895.6 8908.1 8930.0 8952.5 8965.4 8799.5 8891.1 8906.6 8907.2 8909.2 8801.6 8821.6 8877.2 8889.2 8902.9 40534.4 40616.8 40830.8 40982.4 41103.8 3495.0 3572.5 3591.8 3610.7 3625.3 31755.7 32427.4 32613.5 32726.0 32757.0 4084.4 4229.3 4311.1 4332.7 4437.9 346973.0 347929.0 357063.2 360318.0 362734.0 58106.0 58703.4 58772.4 58959.4 59030.0 59719.4 60075.7 60274.0 60287.7 60412.7 17039.7 17262.8 17289.3 17770.7 17775.2 12904.2 12957.7 13061.6 13099.4 13110.9 18951.9 18997.9 19019.6 19076.8 19224.3 7035.9 7043.9 7097.6 7176.9 7187.2 886.0 1034.3 1058.7 1120.5 1124.9 31697.0 32249.6 32277.7 32571.5 32786.8 922.0 1047.5 1057.9 1094.9 1157.4 16130.8 16822.0 16953.7 18362.8 18391.9 519620.0 526633.0 527304.0 527901.0 527905.0 61514.0 62311.7 62368.4 62659.4 62667.7 1250.5 1331.4 1331.8 1332.2 1337.2 31322.7 33258.3 33417.2 33706.2 33927.8 53142.7 53216.2 53699.7 53786.7 53820.0 474942.0 476906.0 478202.0 478994.0 481221.0 43019.4 43565.1 44072.3 44120.3 44280.1 48109.0 48955.0 49070.0 49167.8 50290.7 41313.0 42178.8 42212.2 42213.6 43533.8 41632.2 41821.6 42272.0 42828.6 43463.8 40243.2 40936.2 40989.1 41133.4 41627.2 35926.3 36531.8 38514.2 38753.6 39100.4 26242.0 28693.6 29009.3 29095.9 29181.6 09:41:26 INFO - PROCESS | 10963 | 09:41:26 INFO - PROCESS | 10963 | [#2] jquery.html Cycles:180 Average:30291.62 Median:13353.77 stddev:82668.12 (619.1%) stddev-sans-first:82869.53 09:41:26 INFO - PROCESS | 10963 | Values: 385.4 395.6 404.7 408.2 422.8 14128.4 18567.5 19544.8 19980.8 20087.5 19148.9 19517.9 19640.7 19767.1 19924.9 5707.9 5711.5 5773.7 5829.2 5835.9 5759.5 5783.1 5801.7 5804.1 5811.4 5682.1 5708.0 5800.3 5813.6 5814.7 5617.6 5779.9 5804.0 5827.4 5836.0 5172.7 5194.8 5197.8 5197.9 5218.6 23764.0 23901.3 24134.9 24278.0 24446.6 2427.2 2429.5 2490.8 2956.7 2992.1 13895.2 14730.7 14848.6 15454.9 15506.4 1785.9 1850.5 1866.7 1877.8 1944.2 86902.0 91257.5 91487.5 91565.0 93895.0 11093.3 11192.2 11244.1 11432.9 11665.2 15823.8 15989.4 15991.1 16074.7 16133.9 8118.0 8502.0 8518.8 8544.7 8723.5 7899.6 8102.4 8121.0 8403.2 8472.1 4573.7 4614.0 4678.2 4821.9 4930.7 1914.3 1969.4 2011.3 2020.2 2025.3 885.3 899.8 947.8 969.2 975.9 18647.6 19788.1 19866.9 19869.8 20033.5 916.4 963.8 980.0 1003.3 1054.7 10216.0 10643.4 11287.8 11436.3 11932.8 489684.0 497917.7 499496.0 501579.0 504038.0 101494.0 101524.0 105468.5 106678.0 108059.5 987.5 1019.3 1043.4 1044.2 1065.7 16728.8 17816.2 18475.0 18568.8 19114.3 44104.6 44727.8 44992.6 45286.8 45748.8 61256.7 61677.0 62416.4 63273.4 64039.4 8069.0 8186.0 8296.8 8456.5 8678.3 11301.7 12859.2 12869.5 13024.0 13381.5 11445.4 11488.3 11489.9 11534.5 11929.5 11249.9 11422.3 11443.2 11577.4 11824.4 11549.0 11763.4 11895.9 12032.9 12350.2 8140.3 8338.3 8411.8 8572.1 8650.8 10204.8 11640.9 11702.6 11866.1 12099.2 09:41:26 INFO - PROCESS | 10963 | 09:41:26 INFO - PROCESS | 10963 | [#3] mootools.html Cycles:180 Average:6046.21 Median:2607.96 stddev:3513.72 (134.7%) stddev-sans-first:3506.40 09:41:26 INFO - PROCESS | 10963 | Values: 1423.6 1480.9 1596.6 1718.8 1757.0 8149.7 8819.9 9019.9 9541.6 9560.8 9113.9 9394.0 9405.5 9430.3 9431.7 2442.6 2465.9 2491.9 2494.9 2498.3 2380.6 2484.5 2491.5 2498.5 2503.0 2478.7 2486.2 2493.4 2515.1 2522.7 2407.2 2411.7 2417.4 2424.2 2426.1 2378.3 2387.2 2391.1 2393.3 2447.1 9402.9 9411.8 9431.7 9434.1 9446.3 5426.5 5591.7 5608.2 5608.3 5634.1 3374.2 3519.4 3537.9 3549.6 3577.9 1108.2 1124.8 1125.5 1131.1 1171.1 13290.9 13291.1 13303.1 13307.6 13322.9 4488.4 4649.8 4747.8 4782.8 4852.1 11067.8 11085.4 11085.9 11131.8 11156.8 5461.5 5475.2 5499.2 5515.4 5553.9 4440.8 4869.6 5020.9 5027.5 5042.0 4013.9 4028.7 4131.6 4232.2 4263.9 1295.2 1315.3 1341.6 1346.7 1348.1 831.8 976.6 984.7 992.2 1000.8 6057.1 6067.8 6178.8 6184.1 6423.6 453.0 468.1 484.8 487.6 490.6 4124.2 4303.2 4310.5 4318.3 4330.8 11245.9 11495.8 11722.3 11770.4 11776.2 11583.6 11611.4 11630.8 11650.0 11657.4 8289.0 8482.8 8546.6 8559.1 8598.2 6361.6 6433.1 6469.7 6572.6 6612.2 10059.2 10519.6 10642.7 10772.5 10836.9 10173.5 10625.1 10746.4 10909.7 10932.3 7231.5 7515.0 7683.3 7974.6 8235.4 8504.5 8594.5 8611.9 8631.4 8645.0 7612.6 7643.4 7879.6 7924.4 7954.8 7620.0 7672.0 7673.1 7714.4 7719.4 6875.0 7021.3 7036.4 7039.5 7065.6 5155.7 5205.7 5206.0 5293.6 5535.6 5273.7 5297.1 5361.4 5443.3 5533.5 09:41:26 INFO - PROCESS | 10963 | 09:41:26 INFO - PROCESS | 10963 | [#4] prototype.html Cycles:180 Average:4780.97 Median:5380.24 stddev:1402.92 (26.1%) stddev-sans-first:1366.47 09:41:26 INFO - PROCESS | 10963 | Values: 328.0 344.5 345.9 345.9 347.5 5388.4 5399.6 5538.4 5603.7 5634.1 5431.2 5468.3 5486.4 5490.3 5493.9 4334.3 4339.4 4345.8 4358.2 4364.6 4196.7 4232.9 4307.6 4337.4 4376.0 4236.4 4252.5 4254.8 4258.1 4258.7 4292.5 4298.4 4304.0 4321.5 4336.0 3730.5 3852.2 3856.3 3874.3 3874.7 5370.1 5384.6 5401.6 5416.6 5417.5 4904.8 4944.2 4961.2 4972.0 4973.9 5525.8 5736.8 5745.8 5781.3 5810.5 4173.8 4176.2 4179.7 4185.3 4185.9 5978.3 6006.6 6017.7 6025.5 6027.0 4122.9 4279.3 4308.3 4328.1 4350.8 4355.6 4357.4 4358.6 4360.8 4373.5 4961.8 4966.4 4984.5 4984.7 4999.2 5562.7 5812.3 5814.8 5822.7 5852.2 1528.8 1537.2 1543.6 1544.6 1549.5 929.1 966.6 970.3 971.5 979.9 4904.0 4958.2 4986.2 4993.9 5050.9 5152.8 5161.4 5175.6 5187.5 5272.2 4629.9 4843.4 4951.7 4970.7 4973.9 2732.8 2734.8 2740.2 2750.2 2751.5 5281.4 5321.7 5375.9 5393.3 5422.5 5218.8 5294.8 5536.3 6015.6 6049.8 6105.5 6109.8 6113.2 6170.2 6173.4 5643.8 5883.0 5907.6 5930.9 5938.8 5907.4 5921.8 5926.3 5936.7 5942.2 6208.4 6210.5 6215.4 6221.7 6246.2 4037.7 4088.0 4145.9 4162.6 4179.1 5849.1 5880.9 5896.7 5921.4 5978.0 5693.9 5713.8 5770.5 5834.6 5845.6 5683.3 5713.8 5720.5 5741.9 5750.3 5686.7 5713.4 5717.0 5721.4 5755.6 5727.3 5761.6 5768.3 5795.9 5811.3 5652.2 5654.6 5668.4 5670.2 5698.5 09:41:26 INFO - PROCESS | 10963 | 09:41:26 INFO - PROCESS | 10963 | [#5] yui.html Cycles:180 Average:21324.94 Median:3770.96 stddev:32071.61 (850.5%) stddev-sans-first:32124.20 09:41:26 INFO - PROCESS | 10963 | Values: 702.4 709.9 728.0 750.1 759.4 13740.9 15154.2 15163.7 15233.2 15270.3 14162.6 14442.8 14457.3 14467.8 14518.2 651.9 759.2 786.1 788.3 793.8 768.9 777.0 778.3 784.9 785.9 832.6 833.5 834.0 835.5 836.4 824.1 824.1 825.6 827.1 827.7 608.0 609.2 610.9 611.7 612.2 13878.9 13923.5 13950.6 13996.9 14016.9 13003.7 13495.7 13555.3 13727.3 13735.5 11317.7 11380.7 11423.1 11487.6 11609.9 3674.1 3704.8 3705.3 3736.9 3805.0 87883.6 88736.6 89074.6 90247.0 90666.0 10397.2 10488.2 10611.8 10721.1 10721.5 19433.3 19929.4 20094.7 20125.5 20205.5 7589.2 7604.0 7623.0 7759.8 7995.1 3972.3 4244.6 4267.0 4328.7 4411.0 3242.9 3306.0 3321.8 3345.2 3353.2 568.7 578.1 593.8 622.3 631.0 647.1 659.6 669.6 675.4 679.5 9626.3 9720.6 9728.2 9860.6 9895.9 573.6 577.3 587.5 587.8 659.7 4273.9 4917.4 4966.0 5147.2 5363.9 120803.0 121083.4 125308.0 125387.4 126170.0 86110.6 89162.6 107602.0 108859.0 109429.5 88602.6 89199.6 89259.6 89749.1 90471.5 9366.7 10057.5 10116.9 10155.8 10262.3 49002.5 52624.0 53059.7 53204.5 55137.4 72131.6 72513.0 81208.0 81270.6 84150.6 12409.1 12434.2 12637.4 12715.7 12746.7 13167.6 13491.3 13529.0 13572.3 14010.6 11879.5 12307.1 12317.3 12333.1 12667.0 11432.3 11503.6 11927.5 13201.4 13359.7 11631.9 12404.7 12669.7 12730.7 12771.2 10370.0 10958.0 11324.7 11328.9 11379.1 10442.5 10785.0 11107.6 11268.5 11287.4 09:41:26 INFO - PROCESS | 10963 | -------- Summary: end -------- 09:41:26 INFO - PROCESS | 10963 | 09:41:27 INFO - TEST-INFO | 10963: exit 0 09:41:27 INFO - TEST-OK | dromaeo_css | took 1115178ms 09:41:27 INFO - TEST-START | kraken 09:41:27 INFO - operating with platform_type : linux_ 09:41:27 INFO - Initialising browser for kraken test... 09:41:27 INFO - TEST-INFO | started process 11325 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2F4QkQ/profile http://localhost:59497/getInfo.html) 09:41:32 INFO - PROCESS | 11325 | __metrics Screen width/height:1600/1200 09:41:32 INFO - PROCESS | 11325 | colorDepth:24 09:41:32 INFO - PROCESS | 11325 | Browser inner width/height: 1024/697 09:41:32 INFO - PROCESS | 11325 | __metrics 09:41:33 ERROR - PROCESS | 11325 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 09:41:34 INFO - TEST-INFO | 11325: exit 0 09:41:34 INFO - Browser initialized. 09:41:34 INFO - Running cycle 1/1 for kraken test... 09:41:34 INFO - TEST-INFO | started process 11451 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2F4QkQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:41:46 INFO - PROCESS | 11451 | RSS: Main: 191606784 09:41:46 INFO - PROCESS | 11451 | 09:41:48 INFO - PROCESS | 11451 | Cycle 1(1): loaded http://localhost:59497/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59497/tests/kraken/driver.html?testName=audio-beat-detection) 09:41:49 INFO - PROCESS | 11451 | RSS: Main: 205062144 09:41:49 INFO - PROCESS | 11451 | 09:41:52 INFO - PROCESS | 11451 | Cycle 1(1): loaded http://localhost:59497/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59497/tests/kraken/driver.html?testName=audio-dft) 09:41:53 INFO - PROCESS | 11451 | RSS: Main: 203878400 09:41:53 INFO - PROCESS | 11451 | 09:41:55 INFO - PROCESS | 11451 | Cycle 1(1): loaded http://localhost:59497/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59497/tests/kraken/driver.html?testName=audio-fft) 09:41:56 INFO - PROCESS | 11451 | RSS: Main: 195481600 09:41:56 INFO - PROCESS | 11451 | 09:41:58 INFO - PROCESS | 11451 | Cycle 1(1): loaded http://localhost:59497/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59497/tests/kraken/driver.html?testName=audio-oscillator) 09:41:59 INFO - PROCESS | 11451 | RSS: Main: 196411392 09:41:59 INFO - PROCESS | 11451 | 09:42:01 INFO - PROCESS | 11451 | Cycle 1(1): loaded http://localhost:59497/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59497/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:42:02 INFO - PROCESS | 11451 | RSS: Main: 196358144 09:42:02 INFO - PROCESS | 11451 | 09:42:05 INFO - PROCESS | 11451 | Cycle 1(1): loaded http://localhost:59497/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59497/tests/kraken/driver.html?testName=imaging-darkroom) 09:42:05 INFO - PROCESS | 11451 | RSS: Main: 196702208 09:42:05 INFO - PROCESS | 11451 | 09:42:09 INFO - PROCESS | 11451 | Cycle 1(1): loaded http://localhost:59497/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59497/tests/kraken/driver.html?testName=imaging-desaturate) 09:42:09 INFO - PROCESS | 11451 | RSS: Main: 194412544 09:42:09 INFO - PROCESS | 11451 | 09:42:12 INFO - PROCESS | 11451 | Cycle 1(1): loaded http://localhost:59497/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59497/tests/kraken/driver.html?testName=json-parse-financial) 09:42:13 INFO - PROCESS | 11451 | RSS: Main: 196050944 09:42:13 INFO - PROCESS | 11451 | 09:42:14 INFO - PROCESS | 11451 | Cycle 1(1): loaded http://localhost:59497/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59497/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:42:15 INFO - PROCESS | 11451 | RSS: Main: 196419584 09:42:15 INFO - PROCESS | 11451 | 09:42:17 INFO - PROCESS | 11451 | Cycle 1(1): loaded http://localhost:59497/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59497/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:42:18 INFO - PROCESS | 11451 | RSS: Main: 196714496 09:42:18 INFO - PROCESS | 11451 | 09:42:20 INFO - PROCESS | 11451 | Cycle 1(1): loaded http://localhost:59497/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59497/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:42:20 INFO - PROCESS | 11451 | RSS: Main: 197128192 09:42:20 INFO - PROCESS | 11451 | 09:42:23 INFO - PROCESS | 11451 | Cycle 1(1): loaded http://localhost:59497/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59497/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:42:24 INFO - PROCESS | 11451 | RSS: Main: 197091328 09:42:24 INFO - PROCESS | 11451 | 09:42:27 INFO - PROCESS | 11451 | Cycle 1(1): loaded http://localhost:59497/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59497/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:42:27 INFO - PROCESS | 11451 | RSS: Main: 197709824 09:42:27 INFO - PROCESS | 11451 | 09:42:29 INFO - PROCESS | 11451 | Cycle 1(1): loaded http://localhost:59497/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59497/tests/kraken/driver.html?testName=ai-astar) 09:42:29 INFO - PROCESS | 11451 | RSS: Main: 199237632 09:42:29 INFO - PROCESS | 11451 | 09:42:29 INFO - PROCESS | 11451 | __start_tp_report 09:42:29 INFO - PROCESS | 11451 | _x_x_mozilla_page_load 09:42:29 INFO - PROCESS | 11451 | _x_x_mozilla_page_load_details 09:42:29 INFO - PROCESS | 11451 | |i|pagename|runs| 09:42:29 INFO - PROCESS | 11451 | |0;ai-astar;105;112;112;114;111;111;111;114;111;130 09:42:29 INFO - PROCESS | 11451 | |1;audio-beat-detection;159;121;153;171;124;157;144;123;183;119 09:42:29 INFO - PROCESS | 11451 | |2;audio-dft;163;164;165;174;164;161;163;163;161;164 09:42:29 INFO - PROCESS | 11451 | |3;audio-fft;76;78;76;193;76;75;75;85;162;75 09:42:29 INFO - PROCESS | 11451 | |4;audio-oscillator;82;82;143;83;82;84;143;83;82;145 09:42:29 INFO - PROCESS | 11451 | |5;imaging-gaussian-blur;118;120;119;118;119;118;119;118;120;119 09:42:29 INFO - PROCESS | 11451 | |6;imaging-darkroom;146;148;147;148;148;148;148;148;149;148 09:42:29 INFO - PROCESS | 11451 | |7;imaging-desaturate;96;95;96;95;97;96;97;96;97;96 09:42:29 INFO - PROCESS | 11451 | |8;json-parse-financial;52;54;57;54;54;54;54;54;55;54 09:42:29 INFO - PROCESS | 11451 | |9;json-stringify-tinderbox;63;63;63;63;67;63;64;62;64;63 09:42:29 INFO - PROCESS | 11451 | |10;stanford-crypto-aes;81;79;79;79;80;80;79;79;81;79 09:42:29 INFO - PROCESS | 11451 | |11;stanford-crypto-ccm;142;127;138;142;128;131;127;138;165;142 09:42:29 INFO - PROCESS | 11451 | |12;stanford-crypto-pbkdf2;161;170;164;172;168;166;166;167;164;165 09:42:29 INFO - PROCESS | 11451 | |13;stanford-crypto-sha256-iterative;67;68;71;72;65;66;69;66;65;67 09:42:29 INFO - PROCESS | 11451 | __end_tp_report 09:42:29 INFO - PROCESS | 11451 | __start_cc_report 09:42:29 INFO - PROCESS | 11451 | _x_x_mozilla_cycle_collect,804 09:42:29 INFO - PROCESS | 11451 | __end_cc_report 09:42:29 INFO - PROCESS | 11451 | __startTimestamp1472748149611__endTimestamp 09:42:29 INFO - PROCESS | 11451 | 09:42:29 INFO - PROCESS | 11451 | ------- Summary: start ------- 09:42:29 INFO - PROCESS | 11451 | Number of tests: 14 09:42:29 INFO - PROCESS | 11451 | 09:42:29 INFO - PROCESS | 11451 | [#0] ai-astar Cycles:10 Average:113.10 Median:112.00 stddev:6.44 (5.7%) stddev-sans-first:6.12 09:42:29 INFO - PROCESS | 11451 | Values: 105.0 112.0 112.0 114.0 111.0 111.0 111.0 114.0 111.0 130.0 09:42:29 INFO - PROCESS | 11451 | 09:42:29 INFO - PROCESS | 11451 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:155.00 stddev:22.85 (14.7%) stddev-sans-first:23.70 09:42:29 INFO - PROCESS | 11451 | Values: 159.0 121.0 153.0 171.0 124.0 157.0 144.0 123.0 183.0 119.0 09:42:29 INFO - PROCESS | 11451 | 09:42:29 INFO - PROCESS | 11451 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:3.68 (2.2%) stddev-sans-first:3.87 09:42:29 INFO - PROCESS | 11451 | Values: 163.0 164.0 165.0 174.0 164.0 161.0 163.0 163.0 161.0 164.0 09:42:29 INFO - PROCESS | 11451 | 09:42:29 INFO - PROCESS | 11451 | [#3] audio-fft Cycles:10 Average:97.10 Median:76.00 stddev:43.10 (56.7%) stddev-sans-first:45.04 09:42:29 INFO - PROCESS | 11451 | Values: 76.0 78.0 76.0 193.0 76.0 75.0 75.0 85.0 162.0 75.0 09:42:29 INFO - PROCESS | 11451 | 09:42:29 INFO - PROCESS | 11451 | [#4] audio-oscillator Cycles:10 Average:100.90 Median:82.00 stddev:29.52 (36.0%) stddev-sans-first:30.51 09:42:29 INFO - PROCESS | 11451 | Values: 82.0 82.0 143.0 83.0 82.0 84.0 143.0 83.0 82.0 145.0 09:42:29 INFO - PROCESS | 11451 | 09:42:29 INFO - PROCESS | 11451 | [#5] imaging-gaussian-blur Cycles:10 Average:118.80 Median:119.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 09:42:29 INFO - PROCESS | 11451 | Values: 118.0 120.0 119.0 118.0 119.0 118.0 119.0 118.0 120.0 119.0 09:42:29 INFO - PROCESS | 11451 | 09:42:29 INFO - PROCESS | 11451 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.50 09:42:29 INFO - PROCESS | 11451 | Values: 146.0 148.0 147.0 148.0 148.0 148.0 148.0 148.0 149.0 148.0 09:42:29 INFO - PROCESS | 11451 | 09:42:29 INFO - PROCESS | 11451 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 09:42:29 INFO - PROCESS | 11451 | Values: 96.0 95.0 96.0 95.0 97.0 96.0 97.0 96.0 97.0 96.0 09:42:29 INFO - PROCESS | 11451 | 09:42:29 INFO - PROCESS | 11451 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:1.23 (2.3%) stddev-sans-first:1.01 09:42:29 INFO - PROCESS | 11451 | Values: 52.0 54.0 57.0 54.0 54.0 54.0 54.0 54.0 55.0 54.0 09:42:29 INFO - PROCESS | 11451 | 09:42:29 INFO - PROCESS | 11451 | [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:63.00 stddev:1.35 (2.1%) stddev-sans-first:1.42 09:42:29 INFO - PROCESS | 11451 | Values: 63.0 63.0 63.0 63.0 67.0 63.0 64.0 62.0 64.0 63.0 09:42:29 INFO - PROCESS | 11451 | 09:42:29 INFO - PROCESS | 11451 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.50 stddev:0.84 (1.1%) stddev-sans-first:0.73 09:42:29 INFO - PROCESS | 11451 | Values: 81.0 79.0 79.0 79.0 80.0 80.0 79.0 79.0 81.0 79.0 09:42:29 INFO - PROCESS | 11451 | 09:42:29 INFO - PROCESS | 11451 | [#11] stanford-crypto-ccm Cycles:10 Average:138.00 Median:140.00 stddev:11.39 (8.1%) stddev-sans-first:11.99 09:42:29 INFO - PROCESS | 11451 | Values: 142.0 127.0 138.0 142.0 128.0 131.0 127.0 138.0 165.0 142.0 09:42:29 INFO - PROCESS | 11451 | 09:42:29 INFO - PROCESS | 11451 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:166.50 stddev:3.16 (1.9%) stddev-sans-first:2.71 09:42:29 INFO - PROCESS | 11451 | Values: 161.0 170.0 164.0 172.0 168.0 166.0 166.0 167.0 164.0 165.0 09:42:29 INFO - PROCESS | 11451 | 09:42:29 INFO - PROCESS | 11451 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:2.41 (3.6%) stddev-sans-first:2.55 09:42:29 INFO - PROCESS | 11451 | Values: 67.0 68.0 71.0 72.0 65.0 66.0 69.0 66.0 65.0 67.0 09:42:29 INFO - PROCESS | 11451 | -------- Summary: end -------- 09:42:29 INFO - PROCESS | 11451 | 09:42:30 INFO - TEST-INFO | 11451: exit 0 09:42:30 INFO - TEST-OK | kraken | took 63142ms 09:42:30 INFO - SUITE-END | took 1178s 09:42:31 INFO - Completed test suite (00:19:38) 09:42:31 INFO - javascript benchmark 09:42:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7348.411091181467, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3120.60992375953, 3125.1562078238876, 3136.858841352139, 3168.572242747229, 3181.8568164432613, 5375.301210842585, 5482.862928426792, 5482.972585137074, 5541.889162216753, 5613.915791263134, 5410.702411367373, 5411.83764487065, 5449.182622606601, 5449.754761035753, 5514.6691198528115, 4848.612111031118, 4886.071646387175, 4931.26031095335, 4989.65072444929, 5065.696058236499, 4913.680610760307, 4973.452920178777, 4978.402591688984, 5036.672616279949, 5091.338126043609, 4861.173600487926, 4883.658143929926, 4907.779149938226, 4931.556159945622, 4975.577075948549, 4904.705717656916, 4922.360093187863, 4923.77842997066, 4928.67963582366, 4985.700857948535, 4848.29699693546, 4880.585150262232, 4886.315915771795, 4942.382202224722, 4959.330490383824, 5372.838814835562, 5390.110631745757, 5445.1832225166145, 5454.10007348787, 5498.092814685572, 5802.82591522255, 5813.302403711539, 5821.476067153976, 5831.183634291203, 5831.825045248607, 5717.142428635696, 5844.503217226498, 5868.76524939002, 5876.353601103875, 5879.294484661825, 5442.91835622466, 5473.863153421156, 5489.313835770528, 5492.340919089695, 5572.498475137257, 6025.0661147522205, 6034.426729460694, 6043.274807023097, 6047.0, 6047.697615119227, 5497.36780270274, 5768.711564421762, 5786.88426231473, 5787.218725472091, 5796.275465566804, 5732.426757324234, 5802.912956305659, 5820.35976042635, 5839.124131380242, 5939.198208241918, 5694.686792226385, 5792.82621521355, 5796.246487956539, 5808.244928159313, 5817.7382017809305, 5780.046292361797, 5834.183214349994, 5838.883222335529, 5849.064149736022, 5849.210356601804, 4452.109578084396, 4488.910221795546, 4512.9774351128035, 4524.389207457017, 4532.138893610204, 4005.739626924299, 4008.4788977432745, 4011.7592944423427, 4026.899327516777, 4051.8784436466954, 5595.916061259084, 5624.831255062355, 5625.521830644359, 5644.6613203207935, 5703.372629010805, 5697.800576979786, 5706.28671416073, 5790.536757059425, 5805.303363596311, 5832.825015249549, 5572.832815015556, 5590.385057643656, 5598.86002849932, 5601.719914004365, 5623.887522249532, 5011.949880501221, 5020.849374518771, 5035.597152227813, 5072.010957863181, 5077.441481437039, 5841.766329346863, 5877.9118313225335, 5913.9112913306335, 5932.228810254639, 5936.257967754031, 5726.79956201531, 5736.368999409978, 5746.339170995222, 5768.7404066817935, 5774.653520788766, 5964.165016897551, 5980.5514586405325, 5981.312149102909, 5981.581289309881, 5991.2510936132985, 5555.333359996826, 5649.54803615718, 5650.0959846424375, 5657.943420565906, 5696.8006119785605, 5791.478766910998, 5820.1560773688425, 5820.476157145878, 5833.358330583547, 5874.412558744091, 5653.293338332708, 5657.5473962082115, 5659.717014149359, 5660.575456840836, 5680.829575112753, 5539.667619942817, 5614.578906581941, 5652.0, 5673.914891276551, 5683.1759394886685, 5649.0, 5656.377798442086, 5658.321001479849, 5663.57523185771, 5699.800506982236, 5712.34308054579, 5714.79998200061, 5781.710914454176, 5784.161296612052, 5786.247787787729, 5481.506664400223, 5516.475934786189, 5572.637778544382, 5597.328320601554, 5598.496135347838], "value": 5369.100053452463, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.8060999565146, 590.147237242185, 591.579978215467, 594.8542607061271, 605.5791225098553, 39692.0, 44329.335059974124, 44409.0, 44435.55564444354, 44491.555084449144, 44522.0, 44571.77714111433, 44624.330635040504, 45087.0, 45100.0, 8778.078301778301, 8920.28637708985, 8961.50711710859, 8991.370604057718, 9008.234300084501, 8762.167594078584, 8804.559772011375, 8839.911600883974, 8857.95571022144, 8885.822283554326, 8895.599698013573, 8908.064653211417, 8929.95535022324, 8952.507612081334, 8965.372423930328, 8799.516026618534, 8891.066438024043, 8906.55467226636, 8907.198352148338, 8909.242714369318, 8801.647934082628, 8821.647134114628, 8877.245434138105, 8889.244414224799, 8902.910970890272, 40534.39198412026, 40616.79691601523, 40830.795846020876, 40982.38526422106, 41103.794481027704, 3494.9650503494895, 3572.499850020999, 3591.766535175231, 3610.7291953103622, 3625.2568223514118, 31755.682443175505, 32427.351452970808, 32613.51079733806, 32726.0, 32757.0, 4084.4077608746566, 4229.302165142748, 4311.13593743764, 4332.675049371278, 4437.889052773674, 346973.0, 347929.0, 357063.21468392754, 360318.0, 362734.0, 58106.0, 58703.41296586979, 58772.4122758767, 58959.41040589625, 59030.0, 59719.402805972255, 60075.69962150161, 60274.0, 60287.69856150779, 60412.697936510915, 17039.744403833705, 17262.82737172612, 17289.308427663003, 17770.733438998424, 17775.200115994812, 12904.16122952024, 12957.676058098623, 13061.608151755463, 13099.428068631825, 13110.885574726064, 18951.90524047371, 18997.90501047486, 19019.61960760777, 19076.809231907504, 19224.327148549735, 7035.859282814315, 7043.859122817515, 7097.609631470319, 7176.856462870714, 7187.232915327637, 885.9867101993475, 1034.270839058462, 1058.6718117383637, 1120.467777805552, 1124.8987591116838, 31697.0, 32249.58128140399, 32277.677223227936, 32571.51142732861, 32786.836065819996, 921.9769505762275, 1047.5076713944434, 1057.931234469757, 1094.9233553651168, 1157.4097210422576, 16130.75803862943, 16822.0, 16953.660926781395, 18362.81637183638, 18391.90804045971, 519620.0, 526633.0, 527304.0, 527901.0, 527905.0, 61514.0, 62311.688441557504, 62368.37631623716, 62659.37340626535, 62667.686661566404, 1250.5498020712537, 1331.3875617216188, 1331.8468376136675, 1332.213993743696, 1337.2177276293282, 31322.68677313289, 33258.334833303685, 33417.16457088592, 33706.157346066546, 33927.830360849024, 53142.73428632832, 53216.2017569729, 53699.657508562595, 53786.731066344415, 53820.0, 474942.0, 476906.0, 478202.0, 478994.0, 481221.0, 43019.35470968, 43565.07914287729, 44072.33891491566, 44120.33819492646, 44280.11439771251, 48109.0, 48955.0, 49070.0, 49167.754161228964, 50290.74854625703, 41313.0, 42178.789106054275, 42212.1557568853, 42213.57786422219, 43533.78233108941, 41632.16735665209, 41821.58178418177, 42272.0, 42828.57171428246, 43463.78268108766, 40243.1951360977, 40936.181276374904, 40989.10603492663, 41133.382999254434, 41627.1674566513, 35926.28147437089, 36531.81734091419, 38514.24701465011, 38753.612463876125, 39100.413493797045, 26242.0, 28693.569596456487, 29009.274768130967, 29095.854520727262, 29181.562276565444], "value": 20581.258137222845, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.36799648576323, 395.59451562148814, 404.7025436304316, 408.22437368998897, 422.82030137191686, 14128.364223609937, 18567.535811604717, 19544.804551954476, 19980.800191998074, 20087.497812554695, 19148.904255478737, 19517.902410487928, 19640.70538941917, 19767.110480028397, 19924.900375498102, 5707.914381284284, 5711.543076553866, 5773.653580785145, 5829.213056237396, 5835.941640583604, 5759.539236861041, 5783.10361893905, 5801.680907550083, 5804.100364443518, 5811.418858114176, 5682.147677848315, 5708.029634962046, 5800.303963524383, 5813.563982701293, 5814.680192589406, 5617.550595952314, 5779.884402311951, 5804.0, 5827.446392592718, 5835.970820145893, 5172.741362931876, 5194.818181363634, 5197.8440646780655, 5197.870053248661, 5218.634695571312, 23764.0, 23901.282961511184, 24134.879325603437, 24278.0, 24446.633300500507, 2427.1747605814107, 2429.53838770633, 2490.8007359411204, 2956.704329567048, 2992.1023692892263, 13895.235762033084, 14730.70538589233, 14848.554543363716, 15454.922725386301, 15506.379744810194, 1785.9107044647847, 1850.528115330582, 1866.686631229565, 1877.8122187781248, 1944.2028768204968, 86902.0, 91257.54371228101, 91487.54256228743, 91565.0, 93895.0, 11093.278936869077, 11192.216544841784, 11244.100471962223, 11432.88567114335, 11665.24175928562, 15823.762643560356, 15989.440369587008, 15991.120488373252, 16074.67850643004, 16133.919330403272, 8117.959410202911, 8501.992189822962, 8518.829623407497, 8544.74365769028, 8723.52020638871, 7899.644515996794, 8102.351811855037, 8120.959395203105, 8403.15968403167, 8472.068072512018, 4573.725576465423, 4613.95386046142, 4678.1813182692895, 4821.879453013703, 4930.704157750546, 1914.339552854263, 1969.3894892583346, 2011.2960463837833, 2020.1616329223502, 2025.2911480981834, 885.349268287808, 899.7840518275567, 947.8436058050345, 969.2246203037541, 975.8975307592742, 18647.627047459246, 19788.109535070955, 19866.940583122, 19869.801301986794, 20033.499162520762, 916.4272329793879, 963.802420503795, 980.0150848397458, 1003.3227571389283, 1054.6572363981736, 10216.037349168659, 10643.41461219625, 11287.774244515227, 11436.256643318158, 11932.821007684892, 489684.0, 497917.71863954485, 499496.0, 501579.0, 504038.0, 101494.0, 101524.0, 105468.47265763622, 106678.0, 108059.45970270099, 987.4519641598981, 1019.2559431614815, 1043.3687618990552, 1044.2324891204958, 1065.6643157405238, 16728.832711672727, 17816.23848303515, 18475.0, 18568.81431185671, 19114.33099841499, 44104.55895441133, 44727.77636111798, 44992.55007449884, 45286.77356613196, 45748.771256143504, 61256.693716532915, 61677.0, 62416.37583624287, 63273.36726632675, 64039.35960640334, 8069.0, 8186.0, 8296.792580185544, 8456.450330728483, 8678.349123815866, 11301.71745706364, 12859.228446293253, 12869.520005199522, 13024.0, 13381.464741410235, 11445.42772861337, 11488.310701357945, 11489.942550287195, 11534.538618455168, 11929.463174157358, 11249.943750281196, 11422.31466112036, 11443.198976071595, 11577.421128943352, 11824.40877956116, 11549.0, 11763.353015584225, 11895.929366356724, 12032.879671203176, 12350.197237179555, 8140.267375936194, 8338.332933365195, 8411.789705257417, 8572.099929507562, 8650.78373040679, 10204.846927295948, 11640.88359116398, 11702.648920532398, 11866.110041746731, 12099.213551119148], "value": 9479.352271159636, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1423.5586968039909, 1480.8815294776418, 1596.616811965128, 1718.7765590473236, 1757.042411885523, 8149.714759983402, 8819.91180088199, 9019.864702029476, 9541.61833526659, 9560.76098097548, 9113.863292050624, 9393.95303023484, 9405.529723513813, 9430.33987620865, 9431.717048488556, 2442.6091825308, 2465.90136394544, 2491.9377015574573, 2494.9251522454265, 2498.300475866751, 2380.6071998120287, 2484.5155194737035, 2491.5266099441046, 2498.537770512461, 2503.036331012564, 2478.652988581591, 2486.17956074495, 2493.4140476987895, 2515.0819950718037, 2522.6594409754725, 2407.1574948767966, 2411.6985376827897, 2417.404513021415, 2424.212131057405, 2426.138720754142, 2378.2984019714227, 2387.152560840894, 2391.1152873436768, 2393.258089992108, 2447.0823441209545, 9402.905970940272, 9411.811763764756, 9431.717048488556, 9434.05659434058, 9446.291528135418, 5426.5116139547235, 5591.7483713233005, 5608.158776183564, 5608.270924779793, 5634.098544232903, 3374.240553820817, 3519.3841077811535, 3537.876174333912, 3549.5923913043507, 3577.910552236189, 1108.1744100645071, 1124.8425220469142, 1125.4766533561933, 1131.0781712903956, 1171.1216587559331, 13290.933545332307, 13291.069625126245, 13303.068785185042, 13307.600771976857, 13322.866771332356, 4488.438945131858, 4649.814007439664, 4747.8100875965265, 4782.760861956888, 4852.102361063215, 11067.778644427066, 11085.390303533222, 11085.889141108648, 11131.833022504668, 11156.776864462827, 5461.508464238238, 5475.206095116266, 5499.202615620793, 5515.448455154533, 5553.944460555343, 4440.777961101932, 4869.63477739171, 5020.949790502122, 5027.522385373383, 5042.0, 4013.9197216055513, 4028.738132021409, 4131.566185550474, 4232.153569286155, 4263.914721705549, 1295.151675652449, 1315.3492367079446, 1341.6042267531102, 1346.670065833877, 1348.1035111650838, 831.846108469935, 976.584951395654, 984.6898227058454, 992.2111921022804, 1000.8298589239702, 6057.121717350959, 6067.848303792441, 6178.814635560941, 6184.072389141665, 6423.5503514754455, 452.9932051019237, 468.11526215452824, 484.75277608419253, 487.5782448182297, 490.619769678502, 4124.216398884202, 4303.182395344875, 4310.525842157423, 4318.265894797829, 4330.761808100585, 11245.943770281096, 11495.770084598262, 11722.296662200295, 11770.411479425995, 11776.234544754563, 11583.594574190032, 11611.419429028514, 11630.76738465226, 11649.99999999983, 11657.417129143509, 8288.958555207306, 8482.830343393098, 8546.572671366532, 8559.101294364002, 8598.226159645661, 6361.554691171574, 6433.099366088658, 6469.741210351722, 6572.572782769104, 6612.206535215805, 10059.195264378686, 10519.579216831242, 10642.73393165177, 10772.515236814206, 10836.891631083903, 10173.491325433552, 10625.096866766411, 10746.355218686904, 10909.727256818644, 10932.344059356465, 7231.49379543448, 7515.0, 7683.270089341504, 7974.641141148778, 8235.38234632393, 8504.53225072627, 8594.527300998505, 8611.913880861111, 8631.39580229403, 8644.956775216084, 7612.581308028111, 7643.4267429941865, 7879.645415956181, 7924.366050715814, 7954.761357159295, 7620.0, 7671.961640191764, 7673.117591477052, 7714.421418393531, 7719.382449403922, 6875.037494750639, 7021.262767409348, 7036.437085033287, 7039.507234493536, 7065.6113913735235, 5155.742212889266, 5205.739713014258, 5206.0, 5293.576513878804, 5535.640183388067, 5273.6572122811895, 5297.145998900354, 5361.4370491099435, 5443.346798384061, 5533.501984821385], "value": 4735.883993194798, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.9652695744924, 344.4626382842765, 345.85616743798863, 345.8616553378648, 347.54992284990936, 5388.353397592295, 5399.595030372718, 5538.390777014531, 5603.719814009299, 5634.126710359896, 5431.21247419124, 5468.332158691597, 5486.3690675572325, 5490.286262785832, 5493.862653433666, 4334.284843000901, 4339.370791235269, 4345.78271086446, 4358.193734159191, 4364.585364390377, 4196.685248606352, 4232.936505952413, 4307.569243075699, 4337.392765012901, 4375.956240437603, 4236.406903033578, 4252.489701235856, 4254.808533615979, 4258.105797782469, 4258.701890867641, 4292.549282325358, 4298.355246713002, 4304.031592891605, 4321.524632290446, 4335.978320108411, 3730.5150330457136, 3852.152526444178, 3856.267309211241, 3874.3219936511277, 3874.670652994499, 5370.087085195526, 5384.623076384654, 5401.5948803839865, 5416.647917885325, 5417.53277902143, 4904.754762261872, 4944.208926571731, 4961.231009193581, 4972.005598880239, 4973.875653108665, 5525.751341189656, 5736.770529178828, 5745.793383389493, 5781.335146458169, 5810.4770570648425, 4173.833046678129, 4176.248275310443, 4179.707420480568, 4185.330347144472, 4185.853495127656, 5978.312494063195, 6006.609570377956, 6017.699115044274, 6025.487833534155, 6027.005544085221, 4122.9381559276635, 4279.272523670983, 4308.267594508941, 4328.11273688893, 4350.847720329773, 4355.607995280377, 4357.433533640607, 4358.629516491071, 4360.7601581913295, 4373.497047839539, 4961.82633607822, 4966.404031516241, 4984.526469985346, 4984.651074424755, 4999.150144475448, 5562.749676264578, 5812.273465816773, 5814.825555233349, 5822.689894773642, 5852.180694702745, 1528.7706843973492, 1537.2467490929364, 1543.5523698127643, 1544.5906834688817, 1549.4964136655406, 929.1034152043311, 966.5747071288611, 970.315927271272, 971.5142428785607, 979.8726165598426, 4903.975480122576, 4958.231474121517, 4986.204966212161, 4993.925091123636, 5050.898982020339, 5152.845414637567, 5161.4322424533275, 5175.59334909269, 5187.535920437837, 5272.156454967187, 4629.930551041737, 4843.418789745253, 4951.653384263139, 4970.676906001098, 4973.925391119136, 2732.7565957489296, 2734.7948903832294, 2740.2190375742816, 2750.2161883863005, 2751.5184842652457, 5281.39263984639, 5321.733913304397, 5375.865603359947, 5393.27190829233, 5422.5119739223655, 5218.817341393109, 5294.782200094, 5536.252605898233, 6015.639061656315, 6049.758009679564, 6105.450509454082, 6109.8391305651785, 6113.205283313141, 6170.167027451326, 6173.444390004831, 5643.802466913638, 5882.970585147047, 5907.616004959664, 5930.881382372415, 5938.8218353449465, 5907.409259074058, 5921.822345329475, 5926.259217597801, 5936.703164841827, 5942.1978032965, 6208.379162083756, 6210.472109870531, 6215.358472649196, 6221.657808820558, 6246.187995560548, 4037.7375470594316, 4087.959120408877, 4145.8963525910885, 4162.62536371728, 4179.080602267496, 5849.064149736022, 5880.852978675567, 5896.70516474166, 5921.378255283305, 5978.0, 5693.8861222774485, 5713.8285851424525, 5770.5095066919785, 5834.591578589458, 5845.649261044351, 5683.2895888014, 5713.800101978631, 5720.48515633595, 5741.885162296647, 5750.281214848144, 5686.744096515749, 5713.371529131875, 5717.0, 5721.370649228498, 5755.5683323750045, 5727.341355744143, 5761.617211869037, 5768.346560582011, 5795.884082318415, 5811.302643682785, 5652.208690783212, 5654.604177707521, 5668.433156684298, 5670.206171136127, 5698.515626171822], "value": 4336.203335241766, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.448577866375, 709.9290070992904, 728.0353531570669, 750.0736590310966, 759.3924860111916, 13740.862591374083, 15154.242287885616, 15163.696726065473, 15233.238338083107, 15270.312835922383, 14162.575122746308, 14442.783358249608, 14457.349419276132, 14467.78298325526, 14518.201498917555, 651.9022146678012, 759.1952530317881, 786.0685088170536, 788.329919568368, 793.8372633610096, 768.8961990131345, 776.9922300777005, 778.2762031310879, 784.945053846231, 785.8585454618167, 832.6086739232551, 833.4957350802738, 834.0408530190269, 835.5154010673795, 836.4061516323387, 824.1387749801472, 824.1428913929506, 825.6449726617552, 827.0736774812219, 827.7061643116697, 608.0453687710296, 609.20194545146, 610.9022556391001, 611.6666416802854, 612.1796792298297, 13878.93060534701, 13923.512677056357, 13950.581482555539, 13996.860031399658, 14016.92991535046, 13003.674908127277, 13495.66260843477, 13555.322233888266, 13727.313634318343, 13735.519256825963, 11317.71705707364, 11380.658580242605, 11423.143264255214, 11487.597934072268, 11609.941950290278, 3674.0998455378335, 3704.814759262026, 3705.2959937611768, 3736.8878933632036, 3805.0297174220673, 87883.56058219667, 88736.55631721865, 89074.5546272271, 90247.0, 90666.0, 10397.168226541859, 10488.213383996232, 10611.84082238767, 10721.088707459798, 10721.463926803628, 19433.31983380575, 19929.402117936195, 20094.69857952132, 20125.49686257855, 20205.494862628257, 7589.203133670995, 7604.049493813273, 7623.0, 7759.7672069838, 7995.120536740954, 3972.324704800191, 4244.554321796167, 4266.978665106717, 4328.696991210648, 4411.00752330723, 3242.902712918616, 3305.983470082634, 3321.7840840345784, 3345.2473193531746, 3353.245519758035, 568.6673296121816, 578.1385735254524, 593.7773334999375, 622.327885883245, 630.9652969086744, 647.0746832030148, 659.5745743995096, 669.5848573884223, 675.3887731602907, 679.4869873245668, 9626.278029147841, 9720.61117555304, 9728.221742260603, 9860.556274967643, 9895.851562226573, 573.6242760991557, 577.3389469057989, 587.5094296262583, 587.806024012075, 659.7295109005285, 4273.91452170961, 4917.385326834145, 4966.0, 5147.150720131136, 5363.919541206885, 120803.0, 121083.39458302829, 125308.0, 125387.3730631341, 126170.0, 86110.56944715236, 89162.55418722995, 107602.0, 108859.0, 109429.45285273522, 88602.55698721464, 89199.55400223087, 89259.55370223237, 89749.10250897538, 90471.54764226137, 9366.718998430058, 10057.521265965044, 10116.949415252877, 10155.847662284923, 10262.332948358333, 49002.50997490122, 52624.0, 53059.73470132625, 53204.46795531995, 55137.44862551323, 72131.63934180296, 72513.0, 81208.0, 81270.59364703139, 84150.57924710338, 12409.06931980087, 12434.191777534794, 12637.431315591004, 12715.682107947376, 12746.68133296675, 13167.576430128043, 13491.325433728078, 13529.0, 13572.321383930566, 14010.64973375633, 11879.524819007143, 12307.138500304893, 12317.260964342167, 12333.136680432284, 12667.0, 11432.256903301259, 11503.597374091867, 11927.522899084286, 13201.352816800341, 13359.666008349868, 11631.88368116308, 12404.689882753004, 12669.683257918627, 12730.711343472956, 12771.233725976472, 10370.00099730715, 10958.0, 11324.660260192208, 11328.94335528317, 11379.146564007568, 10442.477876106012, 10785.0, 11107.611233606785, 11268.492917818554, 11287.43562821872], "value": 7319.029602177178, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 112.0, 114.0, 111.0, 111.0, 111.0, 114.0, 111.0, 130.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 121.0, 153.0, 171.0, 124.0, 157.0, 144.0, 123.0, 183.0, 119.0], "value": 145.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 165.0, 174.0, 164.0, 161.0, 163.0, 163.0, 161.0, 164.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 76.0, 193.0, 76.0, 75.0, 75.0, 85.0, 162.0, 75.0], "value": 97.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 143.0, 83.0, 82.0, 84.0, 143.0, 83.0, 82.0, 145.0], "value": 100.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 120.0, 119.0, 118.0, 119.0, 118.0, 119.0, 118.0, 120.0, 119.0], "value": 118.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 149.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 97.0, 96.0, 97.0, 96.0, 97.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 57.0, 54.0, 54.0, 54.0, 54.0, 54.0, 55.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 67.0, 63.0, 64.0, 62.0, 64.0, 63.0], "value": 63.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 79.0, 79.0, 80.0, 80.0, 79.0, 79.0, 81.0, 79.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 127.0, 138.0, 142.0, 128.0, 131.0, 127.0, 138.0, 165.0, 142.0], "value": 138.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 170.0, 164.0, 172.0, 168.0, 166.0, 166.0, 167.0, 164.0, 165.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 71.0, 72.0, 65.0, 66.0, 69.0, 66.0, 65.0, 67.0], "value": 67.6, "unit": "score"}]}]} 09:42:31 INFO - Return code: 0 09:42:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:42:31 ERROR - # TBPL SUCCESS # 09:42:31 INFO - Running post-action listener: _resource_record_post_action 09:42:31 INFO - [mozharness: 2016-09-01 16:42:31.437479Z] Finished run-tests step (success) 09:42:31 INFO - Running post-run listener: _resource_record_post_run 09:42:31 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 408469504; Read time: 12; Write time: 316480 09:42:31 INFO - TinderboxPrint: CPU usage
13.4% 09:42:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:42:31 INFO - TinderboxPrint: I/O write bytes / time
408,469,504 / 316,480 09:42:31 INFO - TinderboxPrint: CPU idle
8,256.5 (86.6%) 09:42:31 INFO - TinderboxPrint: CPU user
1,217.6 (12.8%) 09:42:31 INFO - TinderboxPrint: Swap in / out
0 / 0 09:42:31 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118341632; Read time: 0; Write time: 107568 09:42:31 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 289677312; Read time: 0; Write time: 208900 09:42:32 INFO - Running post-run listener: _upload_blobber_files 09:42:32 INFO - Blob upload gear active. 09:42:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:42:32 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:42:32 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:42:32 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:42:32 INFO - (blobuploader) - INFO - Open directory for files ... 09:42:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:42:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:42:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:42:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:42:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:42:34 INFO - (blobuploader) - INFO - Done attempting. 09:42:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:42:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:42:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:42:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:42:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:42:42 INFO - (blobuploader) - INFO - Done attempting. 09:42:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:42:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:42:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:42:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:42:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:42:42 INFO - (blobuploader) - INFO - Done attempting. 09:42:42 INFO - (blobuploader) - INFO - Iteration through files over. 09:42:42 INFO - Return code: 0 09:42:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:42:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:42:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79dd4328cfb266e4fef59a27941f1a8c6ca3103fb3e72b2fe24f665b80efad955748c8bd10ea98ff83c36ea21af407cfb06758ceb9ab4165c7304bbafdd82a37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7fcd01a9b4fcf25e0537138692e1162cf138708389768eb5ff1e1564721587fcd03c17cd6320ea525fe62bc04883eb5917aaf1bdb0264924a04cf0dcd5206a08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c637d2ab4ecdddbec6a02bb67442804ac70155187456355e3a73a8195e349090464335d6d40e9976d0b7bdc01aed8942e299d35851cbbeab2e79a6518c7608d"} 09:42:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:42:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:42:42 INFO - Contents: 09:42:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79dd4328cfb266e4fef59a27941f1a8c6ca3103fb3e72b2fe24f665b80efad955748c8bd10ea98ff83c36ea21af407cfb06758ceb9ab4165c7304bbafdd82a37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7fcd01a9b4fcf25e0537138692e1162cf138708389768eb5ff1e1564721587fcd03c17cd6320ea525fe62bc04883eb5917aaf1bdb0264924a04cf0dcd5206a08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c637d2ab4ecdddbec6a02bb67442804ac70155187456355e3a73a8195e349090464335d6d40e9976d0b7bdc01aed8942e299d35851cbbeab2e79a6518c7608d"} 09:42:42 INFO - Running post-run listener: copy_logs_to_upload_dir 09:42:42 INFO - Copying logs to upload dir... 09:42:42 INFO - mkdir: /builds/slave/test/build/upload/logs 09:42:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.138239 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-09-01 09:42:42.952950) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 09:42:42.956519) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1472746918.100354-1854005061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79dd4328cfb266e4fef59a27941f1a8c6ca3103fb3e72b2fe24f665b80efad955748c8bd10ea98ff83c36ea21af407cfb06758ceb9ab4165c7304bbafdd82a37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7fcd01a9b4fcf25e0537138692e1162cf138708389768eb5ff1e1564721587fcd03c17cd6320ea525fe62bc04883eb5917aaf1bdb0264924a04cf0dcd5206a08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c637d2ab4ecdddbec6a02bb67442804ac70155187456355e3a73a8195e349090464335d6d40e9976d0b7bdc01aed8942e299d35851cbbeab2e79a6518c7608d"} 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.011299 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79dd4328cfb266e4fef59a27941f1a8c6ca3103fb3e72b2fe24f665b80efad955748c8bd10ea98ff83c36ea21af407cfb06758ceb9ab4165c7304bbafdd82a37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7fcd01a9b4fcf25e0537138692e1162cf138708389768eb5ff1e1564721587fcd03c17cd6320ea525fe62bc04883eb5917aaf1bdb0264924a04cf0dcd5206a08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c637d2ab4ecdddbec6a02bb67442804ac70155187456355e3a73a8195e349090464335d6d40e9976d0b7bdc01aed8942e299d35851cbbeab2e79a6518c7608d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 09:42:42.981705) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 09:42:42.982059) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1472746918.100354-1854005061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 09:42:43.067896) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 09:42:43.068214) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 09:42:43.068511) ========= ========= Total master_lag: 0.17 =========