builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1471087490.85 results: success (0) buildid: 20160813042438 builduid: 8cb3c333d95e46e197dead1fe44db4cd revision: 5b9a61e79b77412b0969cadb04290697ea9ebb38 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-13 04:24:50.846048) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-13 04:24:50.846658) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-13 04:24:50.846964) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-13 04:24:50.908219) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 04:24:50.908519) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1471087193.144881-132153633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-13 04:24:50-- 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% 104M=0s 2016-08-13 04:24:51 (104 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.242486 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 04:24:51.192304) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 04:24:51.192683) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1471087193.144881-132153633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.062471 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 04:24:51.268066) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-13 04:24:51.268498) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5b9a61e79b77412b0969cadb04290697ea9ebb38 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 5b9a61e79b77412b0969cadb04290697ea9ebb38 --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=516f8d7ca085b4d087ab0a71000001a4-1471087193.144881-132153633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-13 04:24:51,331 truncating revision to first 12 chars 2016-08-13 04:24:51,331 Setting DEBUG logging. 2016-08-13 04:24:51,331 attempt 1/10 2016-08-13 04:24:51,331 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/5b9a61e79b77?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-13 04:24:52,257 unpacking tar archive at: mozilla-inbound-5b9a61e79b77/testing/mozharness/ program finished with exit code 0 elapsedTime=1.262459 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-13 04:24:52.545221) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-13 04:24:52.545572) ========= script_repo_revision: 5b9a61e79b77412b0969cadb04290697ea9ebb38 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-13 04:24:52.546009) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-13 04:24:52.546340) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-13 04:24:52.558333) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-08-13 04:24:52.558808) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=516f8d7ca085b4d087ab0a71000001a4-1471087193.144881-132153633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:24:52 INFO - MultiFileLogger online at 20160813 04:24:52 in /builds/slave/test 04:24:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:24:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:24:52 INFO - {'append_to_log': False, 04:24:52 INFO - 'base_work_dir': '/builds/slave/test', 04:24:52 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:24:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:24:52 INFO - 'branch': 'Mozilla-Inbound', 04:24:52 INFO - 'buildbot_json_path': 'buildprops.json', 04:24:52 INFO - 'config_files': ('talos/linux_config.py',), 04:24:52 INFO - 'default_actions': ('clobber', 04:24:52 INFO - 'read-buildbot-config', 04:24:52 INFO - 'download-and-extract', 04:24:52 INFO - 'populate-webroot', 04:24:52 INFO - 'create-virtualenv', 04:24:52 INFO - 'install', 04:24:52 INFO - 'run-tests'), 04:24:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:24:52 INFO - 'download_minidump_stackwalk': True, 04:24:52 INFO - 'download_symbols': 'ondemand', 04:24:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:24:52 INFO - 'tooltool.py': '/tools/tooltool.py', 04:24:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:24:52 INFO - '/tools/misc-python/virtualenv.py')}, 04:24:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:24:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:24:52 INFO - 'installer_path': 'installer.exe', 04:24:52 INFO - 'log_level': 'info', 04:24:52 INFO - 'log_name': 'talos', 04:24:52 INFO - 'log_to_console': True, 04:24:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:24:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:24:52 INFO - 'opt_config_files': (), 04:24:52 INFO - 'pip_index': False, 04:24:52 INFO - 'sps_profile': False, 04:24:52 INFO - 'sps_profile_interval': 0, 04:24:52 INFO - 'suite': 'dromaeojs', 04:24:52 INFO - 'system_bits': '32', 04:24:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:24:52 INFO - 'title': 'talos-linux64-ix-061', 04:24:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:24:52 INFO - 'use_talos_json': True, 04:24:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:24:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:24:52 INFO - 'work_dir': 'build'} 04:24:52 INFO - [mozharness: 2016-08-13 11:24:52.828816Z] Running clobber step. 04:24:52 INFO - Running pre-action listener: _resource_record_pre_action 04:24:52 INFO - Running main action method: clobber 04:24:52 INFO - rmtree: /builds/slave/test/build 04:24:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:24:54 INFO - Running post-action listener: _resource_record_post_action 04:24:54 INFO - [mozharness: 2016-08-13 11:24:54.644814Z] Finished clobber step (success) 04:24:54 INFO - [mozharness: 2016-08-13 11:24:54.645138Z] Running read-buildbot-config step. 04:24:54 INFO - Running pre-action listener: _resource_record_pre_action 04:24:54 INFO - Running main action method: read_buildbot_config 04:24:54 INFO - Using buildbot properties: 04:24:54 INFO - { 04:24:54 INFO - "project": "", 04:24:54 INFO - "product": "firefox", 04:24:54 INFO - "script_repo_revision": "production", 04:24:54 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 04:24:54 INFO - "repository": "", 04:24:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 04:24:54 INFO - "buildid": "20160813042438", 04:24:54 INFO - "stage_platform": "linux64-pgo", 04:24:54 INFO - "basedir": "/builds/slave/test", 04:24:54 INFO - "buildnumber": 1509, 04:24:54 INFO - "platform": "ubuntu64_hw", 04:24:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:24:54 INFO - "slavebuilddir": "test", 04:24:54 INFO - "branch": "mozilla-inbound", 04:24:54 INFO - "revision": "5b9a61e79b77412b0969cadb04290697ea9ebb38", 04:24:54 INFO - "slavename": "talos-linux64-ix-061", 04:24:54 INFO - "builduid": "8cb3c333d95e46e197dead1fe44db4cd", 04:24:54 INFO - "repo_path": "integration/mozilla-inbound" 04:24:54 INFO - } 04:24:54 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471077002/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 04:24:54 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471077002/firefox-51.0a1.en-US.linux-x86_64.test_packages.json. 04:24:54 INFO - Running post-action listener: _resource_record_post_action 04:24:54 INFO - [mozharness: 2016-08-13 11:24:54.649122Z] Finished read-buildbot-config step (success) 04:24:54 INFO - [mozharness: 2016-08-13 11:24:54.649270Z] Running download-and-extract step. 04:24:54 INFO - Running pre-action listener: _resource_record_pre_action 04:24:54 INFO - Running main action method: download_and_extract 04:24:54 INFO - mkdir: /builds/slave/test/build/tests 04:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:54 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471077002/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:24:54 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471077002/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 04:24:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471077002/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 04:24:54 INFO - Downloaded 1361 bytes. 04:24:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:24:54 INFO - Using the following test package requirements: 04:24:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 04:24:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:24:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:24:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:54 INFO - u'jsshell-linux-x86_64.zip'], 04:24:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:24:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 04:24:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:24:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:24:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:24:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:24:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:54 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471077002/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:24:54 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471077002/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 04:24:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471077002/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 04:24:58 INFO - Downloaded 21834653 bytes. 04:24:58 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 04:25:02 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 04:25: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')]} 04:25:02 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471077002/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:25:02 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471077002/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 04:25:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471077002/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 04:25:03 INFO - Downloaded 21834653 bytes. 04:25:03 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 04:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:08 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471077002/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 04:25:08 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471077002/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 04:25:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471077002/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 04:25:10 INFO - Downloaded 14413719 bytes. 04:25:10 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 04:25:10 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')]} 04:25:10 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471077002/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:25:10 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471077002/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 04:25:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471077002/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 04:25:16 INFO - Downloaded 59389486 bytes. 04:25:16 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471077002/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:25:16 INFO - mkdir: /builds/slave/test/properties 04:25:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:25:16 INFO - Writing to file /builds/slave/test/properties/build_url 04:25:16 INFO - Contents: 04:25:16 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471077002/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:25:16 INFO - Running post-action listener: _resource_record_post_action 04:25:16 INFO - Running post-action listener: set_extra_try_arguments 04:25:16 INFO - [mozharness: 2016-08-13 11:25:16.721969Z] Finished download-and-extract step (success) 04:25:16 INFO - [mozharness: 2016-08-13 11:25:16.722198Z] Running populate-webroot step. 04:25:16 INFO - Running pre-action listener: _resource_record_pre_action 04:25:16 INFO - Running main action method: populate_webroot 04:25:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:25:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:25:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:25:16 INFO - '--tppagecycles', 04:25:16 INFO - '7'], 04:25:16 INFO - 'tests': ['tsvgm']}}, 04:25:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:25:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:25:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:25:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:25:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:25:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:25:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:16 INFO - 'talos_options': ['--disable-e10s'], 04:25:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:25:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:25:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:16 INFO - 'talos_options': ['--disable-e10s'], 04:25:16 INFO - 'tests': ['damp', 'tps']}, 04:25:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:16 INFO - 'tests': ['damp', 'tps']}, 04:25:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:25:16 INFO - 'tests': ['dromaeo_dom']}, 04:25:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:25:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:25:16 INFO - 'tests': ['basic_compositor_video']}, 04:25:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:25:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:25:16 INFO - 'tests': ['a11yr', 04:25:16 INFO - 'ts_paint', 04:25:16 INFO - 'tpaint', 04:25:16 INFO - 'sessionrestore', 04:25:16 INFO - 'sessionrestore_no_auto_restore', 04:25:16 INFO - 'tabpaint']}, 04:25:16 INFO - 'other-e10s': {'tests': ['a11yr', 04:25:16 INFO - 'ts_paint', 04:25:16 INFO - 'tpaint', 04:25:16 INFO - 'sessionrestore', 04:25:16 INFO - 'sessionrestore_no_auto_restore', 04:25:16 INFO - 'tabpaint']}, 04:25:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:25:16 INFO - 'ts_paint', 04:25:16 INFO - 'tpaint', 04:25:16 INFO - 'sessionrestore', 04:25:16 INFO - 'sessionrestore_no_auto_restore', 04:25:16 INFO - 'tabpaint']}, 04:25:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:25:16 INFO - 'ts_paint', 04:25:16 INFO - 'tpaint', 04:25:16 INFO - 'sessionrestore', 04:25:16 INFO - 'sessionrestore_no_auto_restore', 04:25:16 INFO - 'tabpaint']}, 04:25:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:25:16 INFO - 'tests': ['a11yr', 04:25:16 INFO - 'ts_paint', 04:25:16 INFO - 'tpaint', 04:25:16 INFO - 'sessionrestore', 04:25:16 INFO - 'sessionrestore_no_auto_restore', 04:25:16 INFO - 'tabpaint']}, 04:25:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:25:16 INFO - 'tests': ['a11yr', 04:25:16 INFO - 'ts_paint', 04:25:16 INFO - 'tpaint', 04:25:16 INFO - 'sessionrestore', 04:25:16 INFO - 'sessionrestore_no_auto_restore', 04:25:16 INFO - 'tabpaint']}, 04:25:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:25:16 INFO - 'tests': ['tsvgx', 04:25:16 INFO - 'tsvgr_opacity', 04:25:16 INFO - 'tart', 04:25:16 INFO - 'tscrollx', 04:25:16 INFO - 'cart']}, 04:25:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:25:16 INFO - 'tsvgr_opacity', 04:25:16 INFO - 'tart', 04:25:16 INFO - 'tscrollx', 04:25:16 INFO - 'cart']}, 04:25:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:16 INFO - 'talos_options': ['--disable-e10s'], 04:25:16 INFO - 'tests': ['tp5o']}, 04:25:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:16 INFO - 'tests': ['tp5o']}, 04:25:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:16 INFO - 'talos_options': ['--disable-e10s', 04:25:16 INFO - '--xperf_path', 04:25:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:25:16 INFO - 'tests': ['tp5n']}, 04:25:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:16 INFO - 'talos_options': ['--xperf_path', 04:25:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:25:16 INFO - 'tests': ['tp5n']}}, 04:25:16 INFO - 'talos.zip': {'path': '', 04:25:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:25:16 INFO - Running post-action listener: _resource_record_post_action 04:25:16 INFO - [mozharness: 2016-08-13 11:25:16.737321Z] Finished populate-webroot step (success) 04:25:16 INFO - [mozharness: 2016-08-13 11:25:16.737408Z] Running create-virtualenv step. 04:25:16 INFO - Running pre-action listener: _resource_record_pre_action 04:25:16 INFO - Running main action method: create_virtualenv 04:25:16 INFO - Creating virtualenv /builds/slave/test/build/venv 04:25:16 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 04:25:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:25:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:25:16 INFO - Using real prefix '/usr' 04:25:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:25:17 INFO - Installing distribute.............................................................................................................................................................................................done. 04:25:19 INFO - Installing pip.................done. 04:25:19 INFO - Return code: 0 04:25:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:19 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 0x7f7779149f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1293420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1321d20>, '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 0x1322c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13230b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471087193.144881-132153633', '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 04:25:19 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 04:25:19 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 04:25:19 INFO - Using env: {'DISPLAY': ':0', 04:25:19 INFO - 'HOME': '/home/cltbld', 04:25:19 INFO - 'LANG': 'en_US.UTF-8', 04:25:19 INFO - 'LANGUAGE': 'en_US:en', 04:25:19 INFO - 'LOGNAME': 'cltbld', 04:25:19 INFO - 'MAIL': '/var/mail/cltbld', 04:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:19 INFO - 'MOZ_NO_REMOTE': '1', 04:25:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:19 INFO - 'NO_EM_RESTART': '1', 04:25:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:19 INFO - 'PWD': '/builds/slave/test', 04:25:19 INFO - 'SHELL': '/bin/bash', 04:25:19 INFO - 'SHLVL': '1', 04:25:19 INFO - 'TERM': 'linux', 04:25:19 INFO - 'TMOUT': '86400', 04:25:19 INFO - 'USER': 'cltbld', 04:25:19 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471087193.144881-132153633', 04:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:19 INFO - '_': '/tools/buildbot/bin/python'} 04:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:19 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 04:25:19 INFO - Cleaning up... 04:25:19 INFO - Return code: 0 04:25:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:19 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 0x7f7779149f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1293420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1321d20>, '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 0x1322c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13230b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471087193.144881-132153633', '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 04:25:19 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 04:25:19 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 04:25:19 INFO - Using env: {'DISPLAY': ':0', 04:25:19 INFO - 'HOME': '/home/cltbld', 04:25:19 INFO - 'LANG': 'en_US.UTF-8', 04:25:19 INFO - 'LANGUAGE': 'en_US:en', 04:25:19 INFO - 'LOGNAME': 'cltbld', 04:25:19 INFO - 'MAIL': '/var/mail/cltbld', 04:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:19 INFO - 'MOZ_NO_REMOTE': '1', 04:25:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:19 INFO - 'NO_EM_RESTART': '1', 04:25:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:19 INFO - 'PWD': '/builds/slave/test', 04:25:19 INFO - 'SHELL': '/bin/bash', 04:25:19 INFO - 'SHLVL': '1', 04:25:19 INFO - 'TERM': 'linux', 04:25:19 INFO - 'TMOUT': '86400', 04:25:19 INFO - 'USER': 'cltbld', 04:25:19 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471087193.144881-132153633', 04:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:19 INFO - '_': '/tools/buildbot/bin/python'} 04:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:19 INFO - Downloading/unpacking psutil>=3.1.1 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:25:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:25:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:25:22 INFO - Installing collected packages: psutil 04:25:22 INFO - Running setup.py install for psutil 04:25:22 INFO - building 'psutil._psutil_linux' extension 04:25:22 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 04:25:23 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 04:25:23 INFO - building 'psutil._psutil_posix' extension 04:25:23 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 04:25:23 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 04:25:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:25:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:25:24 INFO - Successfully installed psutil 04:25:24 INFO - Cleaning up... 04:25:24 INFO - Return code: 0 04:25:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:25:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7779149f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1293420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1321d20>, '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 0x1322c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13230b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471087193.144881-132153633', '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 04:25:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:25:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:25:24 INFO - Using env: {'DISPLAY': ':0', 04:25:24 INFO - 'HOME': '/home/cltbld', 04:25:24 INFO - 'LANG': 'en_US.UTF-8', 04:25:24 INFO - 'LANGUAGE': 'en_US:en', 04:25:24 INFO - 'LOGNAME': 'cltbld', 04:25:24 INFO - 'MAIL': '/var/mail/cltbld', 04:25:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:24 INFO - 'MOZ_NO_REMOTE': '1', 04:25:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:24 INFO - 'NO_EM_RESTART': '1', 04:25:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:24 INFO - 'PWD': '/builds/slave/test', 04:25:24 INFO - 'SHELL': '/bin/bash', 04:25:24 INFO - 'SHLVL': '1', 04:25:24 INFO - 'TERM': 'linux', 04:25:24 INFO - 'TMOUT': '86400', 04:25:24 INFO - 'USER': 'cltbld', 04:25:24 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471087193.144881-132153633', 04:25:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:24 INFO - '_': '/tools/buildbot/bin/python'} 04:25:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:25:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:25:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:25:26 INFO - Installing collected packages: mozsystemmonitor 04:25:26 INFO - Running setup.py install for mozsystemmonitor 04:25:26 INFO - Successfully installed mozsystemmonitor 04:25:26 INFO - Cleaning up... 04:25:26 INFO - Return code: 0 04:25:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:26 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 0x7f7779149f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1293420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1321d20>, '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 0x1322c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13230b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471087193.144881-132153633', '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 04:25:26 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 04:25:26 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 04:25:26 INFO - Using env: {'DISPLAY': ':0', 04:25:26 INFO - 'HOME': '/home/cltbld', 04:25:26 INFO - 'LANG': 'en_US.UTF-8', 04:25:26 INFO - 'LANGUAGE': 'en_US:en', 04:25:26 INFO - 'LOGNAME': 'cltbld', 04:25:26 INFO - 'MAIL': '/var/mail/cltbld', 04:25:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:26 INFO - 'MOZ_NO_REMOTE': '1', 04:25:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:26 INFO - 'NO_EM_RESTART': '1', 04:25:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:26 INFO - 'PWD': '/builds/slave/test', 04:25:26 INFO - 'SHELL': '/bin/bash', 04:25:26 INFO - 'SHLVL': '1', 04:25:26 INFO - 'TERM': 'linux', 04:25:26 INFO - 'TMOUT': '86400', 04:25:26 INFO - 'USER': 'cltbld', 04:25:26 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471087193.144881-132153633', 04:25:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:26 INFO - '_': '/tools/buildbot/bin/python'} 04:25:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:26 INFO - Downloading/unpacking jsonschema==2.5.1 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25: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 04:25:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:25:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:25:28 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 04:25:28 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 04:25:28 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 04:25:28 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 04:25:28 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 04:25:28 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 04:25:28 INFO - Downloading functools32-3.2.3-2.tar.gz 04:25:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:25:28 INFO - warning: no files found matching '*.txt' 04:25:28 INFO - no previously-included directories found matching 'build' 04:25:28 INFO - no previously-included directories found matching 'dist' 04:25:28 INFO - no previously-included directories found matching '.git*' 04:25:28 INFO - Installing collected packages: jsonschema, functools32 04:25:28 INFO - Running setup.py install for functools32 04:25:28 INFO - warning: no files found matching '*.txt' 04:25:28 INFO - no previously-included directories found matching 'build' 04:25:28 INFO - no previously-included directories found matching 'dist' 04:25:28 INFO - no previously-included directories found matching '.git*' 04:25:28 INFO - Successfully installed jsonschema functools32 04:25:28 INFO - Cleaning up... 04:25:28 INFO - Return code: 0 04:25:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:25:28 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')]} 04:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:28 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')]} 04:25:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:28 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 0x7f7779149f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1293420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1321d20>, '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 0x1322c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13230b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471087193.144881-132153633', '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 04:25:28 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 04:25:28 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 04:25:28 INFO - Using env: {'DISPLAY': ':0', 04:25:28 INFO - 'HOME': '/home/cltbld', 04:25:28 INFO - 'LANG': 'en_US.UTF-8', 04:25:28 INFO - 'LANGUAGE': 'en_US:en', 04:25:28 INFO - 'LOGNAME': 'cltbld', 04:25:28 INFO - 'MAIL': '/var/mail/cltbld', 04:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:28 INFO - 'MOZ_NO_REMOTE': '1', 04:25:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:28 INFO - 'NO_EM_RESTART': '1', 04:25:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:28 INFO - 'PWD': '/builds/slave/test', 04:25:28 INFO - 'SHELL': '/bin/bash', 04:25:28 INFO - 'SHLVL': '1', 04:25:28 INFO - 'TERM': 'linux', 04:25:28 INFO - 'TMOUT': '86400', 04:25:28 INFO - 'USER': 'cltbld', 04:25:28 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471087193.144881-132153633', 04:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:28 INFO - '_': '/tools/buildbot/bin/python'} 04:25:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:25:29 INFO - Cleaning up... 04:25:29 INFO - Return code: 0 04:25:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:25:29 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')]} 04:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:29 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')]} 04:25:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:29 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 0x7f7779149f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1293420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1321d20>, '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 0x1322c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13230b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471087193.144881-132153633', '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 04:25:29 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 04:25:29 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 04:25:29 INFO - Using env: {'DISPLAY': ':0', 04:25:29 INFO - 'HOME': '/home/cltbld', 04:25:29 INFO - 'LANG': 'en_US.UTF-8', 04:25:29 INFO - 'LANGUAGE': 'en_US:en', 04:25:29 INFO - 'LOGNAME': 'cltbld', 04:25:29 INFO - 'MAIL': '/var/mail/cltbld', 04:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:29 INFO - 'MOZ_NO_REMOTE': '1', 04:25:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:29 INFO - 'NO_EM_RESTART': '1', 04:25:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:29 INFO - 'PWD': '/builds/slave/test', 04:25:29 INFO - 'SHELL': '/bin/bash', 04:25:29 INFO - 'SHLVL': '1', 04:25:29 INFO - 'TERM': 'linux', 04:25:29 INFO - 'TMOUT': '86400', 04:25:29 INFO - 'USER': 'cltbld', 04:25:29 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471087193.144881-132153633', 04:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:29 INFO - '_': '/tools/buildbot/bin/python'} 04:25:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:29 INFO - Downloading/unpacking blobuploader==1.2.4 04:25:29 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 04:25:29 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 04:25:29 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 04:25:29 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 04:25:29 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 04:25:29 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 04:25:31 INFO - Downloading blobuploader-1.2.4.tar.gz 04:25:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:25:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:25:31 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 04:25:31 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 04:25:31 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 04:25:31 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 04:25:31 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 04:25:31 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 04:25:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:25:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:25:31 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 04:25:31 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 04:25:31 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 04:25:31 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 04:25:31 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 04:25:31 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 04:25:31 INFO - Downloading docopt-0.6.1.tar.gz 04:25:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:25:32 INFO - Installing collected packages: blobuploader, requests, docopt 04:25:32 INFO - Running setup.py install for blobuploader 04:25:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:25:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:25:32 INFO - Running setup.py install for requests 04:25:32 INFO - Running setup.py install for docopt 04:25:32 INFO - Successfully installed blobuploader requests docopt 04:25:32 INFO - Cleaning up... 04:25:32 INFO - Return code: 0 04:25:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:32 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')]} 04:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:32 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')]} 04:25:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:32 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 0x7f7779149f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1293420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1321d20>, '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 0x1322c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13230b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471087193.144881-132153633', '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 04:25:32 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 04:25:32 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 04:25:32 INFO - Using env: {'DISPLAY': ':0', 04:25:32 INFO - 'HOME': '/home/cltbld', 04:25:32 INFO - 'LANG': 'en_US.UTF-8', 04:25:32 INFO - 'LANGUAGE': 'en_US:en', 04:25:32 INFO - 'LOGNAME': 'cltbld', 04:25:32 INFO - 'MAIL': '/var/mail/cltbld', 04:25:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:32 INFO - 'MOZ_NO_REMOTE': '1', 04:25:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:32 INFO - 'NO_EM_RESTART': '1', 04:25:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:32 INFO - 'PWD': '/builds/slave/test', 04:25:32 INFO - 'SHELL': '/bin/bash', 04:25:32 INFO - 'SHLVL': '1', 04:25:32 INFO - 'TERM': 'linux', 04:25:32 INFO - 'TMOUT': '86400', 04:25:32 INFO - 'USER': 'cltbld', 04:25:32 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471087193.144881-132153633', 04:25:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:32 INFO - '_': '/tools/buildbot/bin/python'} 04:25:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:25:32 INFO - Running setup.py (path:/tmp/pip-f2ggy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:25:32 INFO - Running setup.py (path:/tmp/pip-AX7PQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:25:32 INFO - Running setup.py (path:/tmp/pip-5s9VQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:25:33 INFO - Running setup.py (path:/tmp/pip-kd9eGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:25:33 INFO - Running setup.py (path:/tmp/pip-0gY_4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:25:33 INFO - Running setup.py (path:/tmp/pip-iXpnVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:25:33 INFO - Running setup.py (path:/tmp/pip-3Ruwfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:25:33 INFO - Running setup.py (path:/tmp/pip-snOYwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:25:33 INFO - Running setup.py (path:/tmp/pip-0K6baf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:25:33 INFO - Running setup.py (path:/tmp/pip-uCIRVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:25:33 INFO - Running setup.py (path:/tmp/pip-VAOGdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:25:33 INFO - Running setup.py (path:/tmp/pip-9gRbBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:25:33 INFO - Running setup.py (path:/tmp/pip-1sURZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:25:33 INFO - Running setup.py (path:/tmp/pip-OHkfEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:33 INFO - Running setup.py (path:/tmp/pip-7IVR_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:25:33 INFO - Running setup.py (path:/tmp/pip-RwHOTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:25:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:25:33 INFO - Running setup.py (path:/tmp/pip-E2ccZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:25:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:25:34 INFO - Running setup.py install for manifestparser 04:25:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:25:34 INFO - Running setup.py install for mozcrash 04:25:34 INFO - Running setup.py install for mozdebug 04:25:34 INFO - Running setup.py install for mozdevice 04:25:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:25:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:25:34 INFO - Running setup.py install for mozfile 04:25:34 INFO - Running setup.py install for mozhttpd 04:25:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:25:34 INFO - Running setup.py install for mozinfo 04:25:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:25:34 INFO - Running setup.py install for mozInstall 04:25:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:25:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:25:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:25:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:25:34 INFO - Running setup.py install for mozleak 04:25:34 INFO - Running setup.py install for mozlog 04:25:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:25:35 INFO - Running setup.py install for moznetwork 04:25:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:25:35 INFO - Running setup.py install for mozprocess 04:25:35 INFO - Running setup.py install for mozprofile 04:25:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:25:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:25:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:25:35 INFO - Running setup.py install for mozrunner 04:25:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:25:35 INFO - Running setup.py install for mozscreenshot 04:25:35 INFO - Running setup.py install for moztest 04:25:35 INFO - Running setup.py install for mozversion 04:25:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:25:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:25:35 INFO - Cleaning up... 04:25:35 INFO - Return code: 0 04:25:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:35 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')]} 04:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:35 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')]} 04:25:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:35 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 0x7f7779149f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1293420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1321d20>, '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 0x1322c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13230b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471087193.144881-132153633', '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 04:25:35 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 04:25:35 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 04:25:35 INFO - Using env: {'DISPLAY': ':0', 04:25:35 INFO - 'HOME': '/home/cltbld', 04:25:35 INFO - 'LANG': 'en_US.UTF-8', 04:25:35 INFO - 'LANGUAGE': 'en_US:en', 04:25:35 INFO - 'LOGNAME': 'cltbld', 04:25:35 INFO - 'MAIL': '/var/mail/cltbld', 04:25:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:35 INFO - 'MOZ_NO_REMOTE': '1', 04:25:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:35 INFO - 'NO_EM_RESTART': '1', 04:25:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:35 INFO - 'PWD': '/builds/slave/test', 04:25:35 INFO - 'SHELL': '/bin/bash', 04:25:35 INFO - 'SHLVL': '1', 04:25:35 INFO - 'TERM': 'linux', 04:25:35 INFO - 'TMOUT': '86400', 04:25:35 INFO - 'USER': 'cltbld', 04:25:35 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471087193.144881-132153633', 04:25:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:35 INFO - '_': '/tools/buildbot/bin/python'} 04:25:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:25:36 INFO - Running setup.py (path:/tmp/pip-MjrWPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:25:36 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)) 04:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:25:36 INFO - Running setup.py (path:/tmp/pip-Glxhgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:25:36 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)) 04:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:25:36 INFO - Running setup.py (path:/tmp/pip-8FaoJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:25:36 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)) 04:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:25:36 INFO - Running setup.py (path:/tmp/pip-bGqVI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:25:36 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)) 04:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:25:36 INFO - Running setup.py (path:/tmp/pip-wWEwmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:25:36 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)) 04:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:25:36 INFO - Running setup.py (path:/tmp/pip-_YX6w7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:25:36 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)) 04:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:25:36 INFO - Running setup.py (path:/tmp/pip-T9qJLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:25:36 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)) 04:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:25:36 INFO - Running setup.py (path:/tmp/pip-wvGUoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:25:36 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)) 04:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:25:36 INFO - Running setup.py (path:/tmp/pip-67J4TO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:25:36 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)) 04:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:25:36 INFO - Running setup.py (path:/tmp/pip-aLM2X1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:25:36 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)) 04:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:25:36 INFO - Running setup.py (path:/tmp/pip-weB6tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:25:36 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)) 04:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:25:36 INFO - Running setup.py (path:/tmp/pip-xV4Hoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:25:36 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)) 04:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:25:36 INFO - Running setup.py (path:/tmp/pip-lCdj4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:25:36 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)) 04:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:25:36 INFO - Running setup.py (path:/tmp/pip-Au1WBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:25:37 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)) 04:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:37 INFO - Running setup.py (path:/tmp/pip-lv2Ijh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:37 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)) 04:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:25:37 INFO - Running setup.py (path:/tmp/pip-bodwFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:25:37 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)) 04:25:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:25:37 INFO - Running setup.py (path:/tmp/pip-xl5ODu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:25:37 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)) 04:25:37 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)) 04:25:37 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)) 04:25:37 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)) 04:25:37 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)) 04:25:37 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)) 04:25:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:25:37 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 04:25:37 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 04:25:37 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 04:25:37 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 04:25:37 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 04:25:37 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 04:25:39 INFO - Downloading blessings-1.6.tar.gz 04:25:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:25:39 INFO - Installing collected packages: blessings 04:25:39 INFO - Running setup.py install for blessings 04:25:39 INFO - Successfully installed blessings 04:25:39 INFO - Cleaning up... 04:25:39 INFO - Return code: 0 04:25:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:25:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:25:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:25:39 INFO - Reading from file tmpfile_stdout 04:25:39 INFO - Current package versions: 04:25:39 INFO - argparse == 1.2.1 04:25:39 INFO - blessings == 1.6 04:25:39 INFO - blobuploader == 1.2.4 04:25:39 INFO - docopt == 0.6.1 04:25:39 INFO - functools32 == 3.2.3-2 04:25:39 INFO - jsonschema == 2.5.1 04:25:39 INFO - manifestparser == 1.1 04:25:39 INFO - mozInstall == 1.12 04:25:39 INFO - mozcrash == 0.17 04:25:39 INFO - mozdebug == 0.1 04:25:39 INFO - mozdevice == 0.48 04:25:39 INFO - mozfile == 1.2 04:25:39 INFO - mozhttpd == 0.7 04:25:39 INFO - mozinfo == 0.9 04:25:39 INFO - mozleak == 0.1 04:25:39 INFO - mozlog == 3.3 04:25:39 INFO - moznetwork == 0.27 04:25:39 INFO - mozprocess == 0.23 04:25:39 INFO - mozprofile == 0.28 04:25:39 INFO - mozrunner == 6.12 04:25:39 INFO - mozscreenshot == 0.1 04:25:39 INFO - mozsystemmonitor == 0.3 04:25:39 INFO - moztest == 0.7 04:25:39 INFO - mozversion == 1.4 04:25:39 INFO - psutil == 3.1.1 04:25:39 INFO - requests == 1.2.3 04:25:39 INFO - wsgiref == 0.1.2 04:25:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:39 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')]} 04:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:39 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')]} 04:25:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:39 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 0x7f7779149f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1293420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1321d20>, '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 0x1322c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13230b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471087193.144881-132153633', '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 04:25:39 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 04:25:39 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 04:25:39 INFO - Using env: {'DISPLAY': ':0', 04:25:39 INFO - 'HOME': '/home/cltbld', 04:25:39 INFO - 'LANG': 'en_US.UTF-8', 04:25:39 INFO - 'LANGUAGE': 'en_US:en', 04:25:39 INFO - 'LOGNAME': 'cltbld', 04:25:39 INFO - 'MAIL': '/var/mail/cltbld', 04:25:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:39 INFO - 'MOZ_NO_REMOTE': '1', 04:25:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:39 INFO - 'NO_EM_RESTART': '1', 04:25:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:39 INFO - 'PWD': '/builds/slave/test', 04:25:39 INFO - 'SHELL': '/bin/bash', 04:25:39 INFO - 'SHLVL': '1', 04:25:39 INFO - 'TERM': 'linux', 04:25:39 INFO - 'TMOUT': '86400', 04:25:39 INFO - 'USER': 'cltbld', 04:25:39 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471087193.144881-132153633', 04:25:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:39 INFO - '_': '/tools/buildbot/bin/python'} 04:25:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:39 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)) 04:25:39 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)) 04:25:39 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)) 04:25:39 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)) 04:25:39 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)) 04:25:39 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)) 04:25:39 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)) 04:25:39 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)) 04:25:39 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)) 04:25:39 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)) 04:25:39 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)) 04:25:39 INFO - Cleaning up... 04:25:39 INFO - Return code: 0 04:25:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:25:39 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')]} 04:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:39 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')]} 04:25:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:39 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 0x7f7779149f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1293420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1321d20>, '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 0x1322c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13230b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1471087193.144881-132153633', '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 04:25:39 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 04:25:39 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 04:25:39 INFO - Using env: {'DISPLAY': ':0', 04:25:39 INFO - 'HOME': '/home/cltbld', 04:25:39 INFO - 'LANG': 'en_US.UTF-8', 04:25:39 INFO - 'LANGUAGE': 'en_US:en', 04:25:39 INFO - 'LOGNAME': 'cltbld', 04:25:39 INFO - 'MAIL': '/var/mail/cltbld', 04:25:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:39 INFO - 'MOZ_NO_REMOTE': '1', 04:25:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:39 INFO - 'NO_EM_RESTART': '1', 04:25:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:39 INFO - 'PWD': '/builds/slave/test', 04:25:39 INFO - 'SHELL': '/bin/bash', 04:25:39 INFO - 'SHLVL': '1', 04:25:39 INFO - 'TERM': 'linux', 04:25:39 INFO - 'TMOUT': '86400', 04:25:39 INFO - 'USER': 'cltbld', 04:25:39 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471087193.144881-132153633', 04:25:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:39 INFO - '_': '/tools/buildbot/bin/python'} 04:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:25:40 INFO - Cleaning up... 04:25:40 INFO - Return code: 0 04:25:40 INFO - Running post-action listener: _resource_record_post_action 04:25:40 INFO - Running post-action listener: _start_resource_monitoring 04:25:40 INFO - Starting resource monitoring. 04:25:40 INFO - [mozharness: 2016-08-13 11:25:40.091089Z] Finished create-virtualenv step (success) 04:25:40 INFO - [mozharness: 2016-08-13 11:25:40.091544Z] Running install step. 04:25:40 INFO - Running pre-action listener: _resource_record_pre_action 04:25:40 INFO - Running main action method: install 04:25:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:25:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:25:40 INFO - Reading from file tmpfile_stdout 04:25:40 INFO - Detecting whether we're running mozinstall >=1.0... 04:25:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:25:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:25:40 INFO - Reading from file tmpfile_stdout 04:25:40 INFO - Output received: 04:25:40 INFO - Usage: mozinstall [options] installer 04:25:40 INFO - Options: 04:25:40 INFO - -h, --help show this help message and exit 04:25:40 INFO - -d DEST, --destination=DEST 04:25:40 INFO - Directory to install application into. [default: 04:25:40 INFO - "/builds/slave/test"] 04:25:40 INFO - --app=APP Application being installed. [default: firefox] 04:25:40 INFO - mkdir: /builds/slave/test/build/application 04:25:40 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'] 04:25:40 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 04:25:57 INFO - Reading from file tmpfile_stdout 04:25:57 INFO - Output received: 04:25:57 INFO - /builds/slave/test/build/application/firefox/firefox 04:25:57 INFO - Running post-action listener: _resource_record_post_action 04:25:57 INFO - [mozharness: 2016-08-13 11:25:57.291691Z] Finished install step (success) 04:25:57 INFO - [mozharness: 2016-08-13 11:25:57.291968Z] Running run-tests step. 04:25:57 INFO - Running pre-action listener: _resource_record_pre_action 04:25:57 INFO - Running main action method: run_tests 04:25:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:25:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:25:57 INFO - Python 2.7.3 04:25:57 INFO - Return code: 0 04:25:57 INFO - grabbing minidump binary from tooltool 04:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:57 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 0x1321d20>, '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 0x1322c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13230b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:25:57 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 04:25:57 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 04:25:57 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 04:25:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:25:57 INFO - Return code: 0 04:25:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:25:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:25:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:25:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:25:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:25:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471077002/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:25:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471077002/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:25:57 INFO - Using env: {'DISPLAY': ':0', 04:25:57 INFO - 'HOME': '/home/cltbld', 04:25:57 INFO - 'LANG': 'en_US.UTF-8', 04:25:57 INFO - 'LANGUAGE': 'en_US:en', 04:25:57 INFO - 'LOGNAME': 'cltbld', 04:25:57 INFO - 'MAIL': '/var/mail/cltbld', 04:25:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:25:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:57 INFO - 'MOZ_NO_REMOTE': '1', 04:25:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:25:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:57 INFO - 'NO_EM_RESTART': '1', 04:25:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:57 INFO - 'PWD': '/builds/slave/test', 04:25:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:25:57 INFO - 'SHELL': '/bin/bash', 04:25:57 INFO - 'SHLVL': '1', 04:25:57 INFO - 'TERM': 'linux', 04:25:57 INFO - 'TMOUT': '86400', 04:25:57 INFO - 'USER': 'cltbld', 04:25:57 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1471087193.144881-132153633', 04:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:57 INFO - '_': '/tools/buildbot/bin/python'} 04:25:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471077002/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:25:57 INFO - mozversion application_buildid: 20160813013002 04:25:57 INFO - mozversion application_changeset: 5b9a61e79b77412b0969cadb04290697ea9ebb38 04:25:57 INFO - mozversion application_display_name: Nightly 04:25:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:25:57 INFO - mozversion application_name: Firefox 04:25:57 INFO - mozversion application_remotingname: firefox 04:25:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:25:57 INFO - mozversion application_vendor: Mozilla 04:25:57 INFO - mozversion application_version: 51.0a1 04:25:57 INFO - mozversion platform_buildid: 20160813013002 04:25:57 INFO - mozversion platform_changeset: 5b9a61e79b77412b0969cadb04290697ea9ebb38 04:25:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:25:57 INFO - mozversion platform_version: 51.0a1 04:25:57 INFO - using testdate: 1471087557 04:25:57 INFO - actual date: 1471087557 04:25:57 INFO - starting webserver on 'localhost:57944' 04:25:57 INFO - SUITE-START | Running 2 tests 04:25:57 INFO - TEST-START | dromaeo_css 04:25:57 INFO - operating with platform_type : linux_ 04:25:57 INFO - Initialising browser for dromaeo_css test... 04:25:58 INFO - TEST-INFO | started process 3341 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUf6uqS/profile http://localhost:57944/getInfo.html) 04:26:03 INFO - PROCESS | 3341 | __metrics Screen width/height:1600/1200 04:26:03 INFO - PROCESS | 3341 | colorDepth:24 04:26:03 INFO - PROCESS | 3341 | Browser inner width/height: 1024/697 04:26:03 INFO - PROCESS | 3341 | __metrics 04:26:04 INFO - PROCESS | 3341 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:26:04 INFO - PROCESS | 3341 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:26:05 INFO - TEST-INFO | 3341: exit 0 04:26:05 INFO - Browser initialized. 04:26:05 INFO - Running cycle 1/1 for dromaeo_css test... 04:26:05 INFO - TEST-INFO | started process 3421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUf6uqS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:26:17 INFO - PROCESS | 3421 | RSS: Main: 155574272 04:26:17 INFO - PROCESS | 3421 | 04:27:09 INFO - PROCESS | 3421 | 1471087629050 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] 04:29:18 INFO - PROCESS | 3421 | Cycle 1(1): loaded http://localhost:57944/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57944/tests/dromaeo/cssquery-ext.html) 04:29:19 INFO - PROCESS | 3421 | RSS: Main: 261996544 04:29:19 INFO - PROCESS | 3421 | 04:32:21 INFO - PROCESS | 3421 | Cycle 1(1): loaded http://localhost:57944/tests/dromaeo/cssquery-ext.html (next: http://localhost:57944/tests/dromaeo/cssquery-jquery.html) 04:32:22 INFO - PROCESS | 3421 | RSS: Main: 245686272 04:32:22 INFO - PROCESS | 3421 | 04:35:24 INFO - PROCESS | 3421 | Cycle 1(1): loaded http://localhost:57944/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57944/tests/dromaeo/cssquery-mootools.html) 04:35:25 INFO - PROCESS | 3421 | RSS: Main: 237543424 04:35:25 INFO - PROCESS | 3421 | 04:38:27 INFO - PROCESS | 3421 | Cycle 1(1): loaded http://localhost:57944/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57944/tests/dromaeo/cssquery-prototype.html) 04:38:27 INFO - PROCESS | 3421 | RSS: Main: 197689344 04:38:27 INFO - PROCESS | 3421 | 04:41:30 INFO - PROCESS | 3421 | Cycle 1(1): loaded http://localhost:57944/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57944/tests/dromaeo/cssquery-yui.html) 04:41:31 INFO - PROCESS | 3421 | RSS: Main: 186630144 04:41:31 INFO - PROCESS | 3421 | 04:44:33 INFO - PROCESS | 3421 | Cycle 1(1): loaded http://localhost:57944/tests/dromaeo/cssquery-yui.html (next: http://localhost:57944/tests/dromaeo/cssquery-dojo.html) 04:44:34 INFO - PROCESS | 3421 | RSS: Main: 281952256 04:44:34 INFO - PROCESS | 3421 | 04:44:34 INFO - PROCESS | 3421 | __start_tp_report 04:44:34 INFO - PROCESS | 3421 | _x_x_mozilla_page_load 04:44:34 INFO - PROCESS | 3421 | _x_x_mozilla_page_load_details 04:44:34 INFO - PROCESS | 3421 | |i|pagename|runs| 04:44:34 INFO - PROCESS | 3421 | |0;dojo.html;3053.709897559732;3065.1724034510667;3086.768492363073;3086.861091250892;3090.1656552730765;5149.382074151098;5199.896002079956;5291.365036195657;5374.6506477078965;5431.619786614933;5285.709285989269;5321.547668448177;5339.038972984861;5354.705491197982;5381.81163659271;4761.47623761386;4811.061842940628;4834.879128021792;4842.564169224769;4988.725620090893;4890.584300334476;4896.143174944388;4930.531599498042;4942.159832828428;4955.677880937746;4758.595519380857;4791.257355109963;4814.7833347499445;4824.131656301899;4900.485449027854;4812.109759694433;4821;4828;4843.709377437365;4902.411710594716;4831.830885918976;4848.733319667417;4849.102915960523;4859.5383438573635;4895.828645997409;5176.456472070454;5209.47905209476;5253.238280449314;5257.526822585985;5359.115745901921;5591.049521581341;5613.578981576357;5627.296587926509;5633.774649014034;5638.267025286727;5609.27079479665;5643;5644.717764111819;5654.067078931971;5682.744276507526;5117.257997590365;5196.246544251062;5217.399999000126;5247.606429517801;5334.7065911374475;5769.365369809318;5811.680357580289;5818.359980402152;5820.447057529528;5826.009578371687;5503.587230957694;5547.306586676666;5558.944410555923;5589.301337332833;5608.775648974077;5373.704446255415;5561.6663000220115;5643.181738647873;5645.943540564624;5735.512481439125;5676.347220069662;5678.744456499468;5683.630564013326;5684.63049901755;5686.09022556389;5631.915521267184;5688.971555142198;5691.231683722727;5692.0608099663095;5693.202951586781;4194.496660400771;4282.272013757669;4287.249731297011;4290.678199135077;4342.891427714332;3881.068543549528;3889.3193691103943;3895.9610403896163;3906.8046597670004;3936.2127574485216;5348.384935732441;5359.196120581944;5364.436734142937;5393.946060539344;5403.9459605403445;5462.2079798429;5641.689707066069;5657.519110875622;5658.660480371191;5694.544436445074;5331.86670333237;5337.893242135136;5346;5389.0299746046085;5449.6730196188355;4771.165046116985;4810.326554282403;4812.51874812516;4813.350197723333;4858.659893807399;5659.745311460912;5830.650160990354;5857.736401861841;5859.267591551056;5863.824085277449;5680.77276908919;5690.4878560928055;5692.345380281321;5717.142428635738;5731.512821410227;5892.263467066617;5908.527317814651;5913.083472061838;5916.911246331222;5917.556183286185;5440.265564148789;5542.9168562472405;5575.247341608993;5585.050541407889;5604.8038318658655;5699.629524080921;5712.228849105484;5771.365149833431;5794.681292528783;5817.185594016756;5570.220169176399;5604.075327570905;5621.7189140542;5622.128570071645;5626.493615574618;5320.733963301896;5461.098918678374;5488.396276409671;5589.161625756169;5600.215969764317;5518.44815518461;5521.779128834802;5528.944710552843;5551.084071128219;5573.247611572386;5576.1356989666665;5590.440955904377;5594.916076258941;5623.044082506066;5643.068893632505;5267.3152490176035;5274.446183150714;5420.728963551728;5443.319585051869;5444.128939369682 04:44:34 INFO - PROCESS | 3421 | |1;ext.html;582.3128708124414;601.2544444888339;603.815836169968;615.0405367626506;622.4864486798391;32974.67025329746;33698.8315058425;36033.63966360335;36034.63965360346;36097.09757256067;47174.292385614244;48259.75870120645;48300.51699483004;48399.274010889865;48404.75797621016;9009.234215091708;9154.633814647406;9154.862677059817;9155.72532824013;9161.496117713523;9012.188902998729;9104.544772761368;9109.089091090904;9111.863322050174;9117.95441022794;9108.271338292954;9125.863112053325;9180.724578262663;9181.816363672722;9186.127317904822;9072.092790720908;9144.359894807367;9152.17630413266;9152.267818574499;9152.8627070594;8947;9027.187553120186;9029.638814447415;9029.729108126767;9033.05152958943;42293.57706422927;42528;42682.57317426817;42736.145277094285;42838.78580607077;3458.886574568874;4091.2431200227757;4123.237201117803;4172.123853990665;4208.684348673862;32980.83509582461;33061.41724455059;33454.64361771256;33471.6652833471;34104.82947585271;4172.165566886604;4268.786560671954;4273.081287523167;4310.978445107786;4458.71018383804;253554;254270;254564.63588410252;255076;255242;57614.42385576174;57751;58160.41839581635;58197;58235;61612.38387616067;61627.61048142306;61727;61767;61775.38224617786;17043.573910652085;17265.827341726672;17266.050367229673;17292.481225563253;17296.740548891776;12642.30467324306;12646;12653.746925061447;12654.367281636065;12658.936705316599;14671.706565868622;17177.570560735832;17334.65330693379;17342.913285433493;17499;6213.0221829456;6263.498920086382;6296.874062518724;6452.12896258999;6558.508111891627;978.9902100978899;991.965281215154;1068.9946550267355;1104.2160066352978;1205.3732059329275;32627.51058734121;32941.835290823394;33172.834135829165;33191.06828722179;34021.489677654856;1091.165258577189;1114.726891911487;1116.1555084157812;1192.4455128365178;1234.882686144815;16316.265768040466;17378.39175628847;17430.302787888595;17595.208215630326;17688.29246830138;521217;522911;523441;524104;524420;58444.70777646085;58557.41442585605;58693;58772.4122758767;58830;1209.3167360441323;1327.707904261061;1378.5933149720856;1384.1349156777014;1390.1311680199874;32089.518657220626;34461.31077378388;34557.654423455446;34696.653033469345;35174.296514069065;50147.74926125346;50550.747246263534;50692.239616405044;50700.74649626728;50728;382870;383768;383833;384139;384358;27830.582541261494;29113.417731645673;29133.271668208465;30000.69999299979;42065.78967105268;48106.75946620244;48179.277310839665;48260;48749.75625121852;49999.75000124976;36979.8151009254;37056.81471592733;37536.62463375441;37859;39072.80463597664;37603.62396376111;37765.4335184978;38013;38225.808870955465;38480.422793658676;41500.37749433701;42019;42324.78837605916;42465.575344246165;43182.13635727331;32019.67980320167;33884.66115338815;34174.0201923839;34445.65554344424;34535.481967771004;27673.754681039805;28008.14623485064;28136.859315703292;28184.85907570531;28196.577051344655 04:44:34 INFO - PROCESS | 3421 | |2;jquery.html;379.9924001519968;381.63935081348137;406.4289673009422;410.9876703698889;419.0926643816138;14235.644108897282;18725.812741872578;19573;19676.114574844112;19750.111244993976;18969.620607587873;19054.904725476354;19184.328548500805;19390.806091939077;19408.708869366936;5360.437154098822;5556.805511807088;5767.192593036978;5775.162601422791;6396.61620302781;6494.772682956098;6517.9674101629425;6517.9674101629425;6542.214934207902;6543.116679248312;5487.917681234785;5682.17608446775;5701;5876.177335173079;6500.252470965828;5717.799877004285;5899.882002359972;5911.142884281798;5914.378990206031;5933.13969474426;5709.77160913563;5723.71381430931;5724.8855022899725;5733.283339582552;5733.627314224562;14589;15007.624809379853;23262.60424374543;23498.64752028721;23569.528609427885;2130.989345053265;2196.4728465168405;2242.9102835886547;2280.3387017764994;2405.446747248143;10272.845907311395;10640.148788096934;10775.892241077567;10928.781424371467;11199.160062995308;1906.7997860224755;1960.5392732707803;2020.2525065725777;2053.1992522916075;2156.202205184092;85852.57073714654;87286;87608.99999999936;90216;91258.08741912563;11282.774344513227;11373.611541576196;11483.13876459269;11577.884221157849;11603.187776855539;16233.918830405772;16251.51245462638;16275.755863662054;16276.104814235094;16292;8308.335333173452;8415.789605259917;8450.408471407065;8660.26387757035;8687.956560217159;7959.602019898982;8189.672413103528;8213.589320534069;8448.493090414595;8514.31885449175;4805.927911081337;4909.656324057353;5008.198688209869;5012.824551140692;5119.257707632372;2006.6989951507098;2044.6830741235133;2064.834813214939;2069.182672844218;2089.1121273459025;896.6189369517929;945.7068308824287;980.632262901412;1071.4589132488043;1103.365564800243;19682.311119110764;20309.89845050765;20342.49143771388;20454;20772.169113235603;1024.774549599087;1025.3284098915221;1032.550840384435;1046.6075221791828;1069.395791377869;10493.527791249413;11326.490307935997;11385.37380444067;11390.145739069603;11394.886051139549;456000;457870;458968;460455;470072;85951;87978.56010719905;89059;89783.55108224417;90251.54874225587;1013.9239557033104;1019.4800651667703;1021.2544842265188;1042.1975079188983;1043.2801367056707;17125.57186070358;17452.019192323172;17916.104194789947;17942;18035.18841652155;41778.79110604428;42345;44365.77817110894;44781.77609111933;45298.77350613358;55181.724091379285;59018.409815901294;60072.39927600843;60414;61203.69398152981;8570.700025499078;8596;8624.353173511887;8653.307735381028;8891.73324800257;11879.346635935106;12013.279203247483;12220.572279970158;12357.814632780695;12709.491620335082;10166.847497287694;10820.945895270474;10833.458327083457;11502.044652408944;11720.355380454157;11056.668299951014;11126.388048657402;11165.218434709817;11424.885751142383;11835.467403967014;11568.710782230512;11644.88355116472;11649;11761.941190293994;12156.939215303866;7457.589832559044;8054.275115239657;8138.674453021813;8785;9213.309001824757;8987.938286134253;11157.330560166416;11351.772964540829;11988.820167697317;12208.084393670688 04:44:34 INFO - PROCESS | 3421 | |3;mootools.html;1329.4947919790477;1462.8317743459502;1476.475851072869;1597.5047735202088;1709.1027210714365;7548.9808875801755;7911.3670906327425;7989.0413150421955;8203.95898020509;8251.339892808575;8062.274395304421;8160.347172226223;8168.305694016001;8174.019117705883;8180.181981801817;1901.75277213962;2181.6073106840804;2206.8124209442217;2208.933731988043;2288.530851175505;2398.400399900025;2415.154695856445;2415.770501802335;2416.3113512648897;2419.0082066352797;2331.5103828196097;2337.614293641547;2338.205010296499;2339.1695947938492;2381.30942026812;2239.193890199535;2239.372975566828;2239.4065572623185;2245.517213799025;2322.094383190557;2361.244401791427;2362.9645555316683;2378.7621237876247;2379.7501262367377;2379.8215133864855;8732.170443807829;8793.472391656522;8797.208251257418;8809.207171354608;8819.426737262058;5076.670016448919;5161.148410512261;5173.094708426011;5223.895522089537;5226.451222621608;3222.7421806255443;3233.4643491710613;3407.9829600852086;3408.386490431721;3411.181316484026;1119.5857532712948;1146.1232157399595;2012.7282816819688;2105.473631592102;2116.354511873878;11277.49251283686;11348.035416989565;11372.943135284271;11403.714907127305;11410.600628977945;4301.333293339538;4535.659825513099;4594.724316541018;4613.284940834176;4637.350770892078;9394.389364691273;9401.200897923616;9401.858972115424;9401.905980940102;9414.199793017533;5152.3044389007755;5187.818426355135;5190.325257716473;5192.766325515361;5193.350831146106;4133.111381053088;4640.582347588733;4689.554492323224;4889.755512224375;4890.462049174588;3666.0834791302173;3726.2920045191327;3787.0532366908274;3814.4469051987307;3833.8083095845095;1143.9142064345208;1152.9884701153048;1156.7455159864817;1161.0653423993765;1170.5493385046818;910.5720311453606;930.2697382554662;933.1135421349609;942.7737343037759;977.3695966101825;5472.5348345391085;5607.551395888319;5702.087665973424;5758.712064396764;5798.188253644409;928.4429342394509;967.9467629280457;1018.055899084838;1023.923205759571;1040.15747244732;3759.1353988582778;3996.720229583901;4016.959830401717;4149.419081328617;4180.282816169514;10227.642032528825;10398.064174224357;10416.583336666448;10534.104601108838;10539.57841686324;10212.897871021194;10244.334118282288;10352.844707329396;10356.378617282988;10370.688879333633;8041.276285134366;8079.798005049921;8086.636101375452;8152.225538573826;8204.876926846102;5646.407127251579;5676.79955538361;5838.824835254949;5876.118582212703;5923.200367950271;9535.332526723063;9774.560144793359;9932.900670993198;9957.950210248902;10195.451137215696;10079.647212347825;10088.142507886912;10175.185985121321;10228;10238.641647542301;6161.845953851011;7107.289271072851;7227.421806255382;7356.595387253752;7497.062867141607;8498.53258070812;8543.957280213559;8562.229399354088;8569.914300857161;8572.785680358042;7283.8543229136185;7563.092428908346;7585.16563178061;7600.733974310872;7625.923740762521;7026;7108.147022357351;7225.385842203472;7321.414286856932;7521.2478752126535;6464.935350646433;6569.211694596679;6570.5729127606555;6572.572782769104;6576.868462630816;4700.482946875909;4766.976165119152;4850.781714822912;4852.417709874838;4866.1727506323305;4806.231003039637;4809.158397280392;4855.902881942412;4861.246506791453;5144.151215049475 04:44:34 INFO - PROCESS | 3421 | |4;prototype.html;322.4003353762001;326.56077575660737;338.5362053986039;340.804037678335;344.52283587231676;5159.380874295085;5251.212318152279;5280.392754833195;5299.682019078858;5319.20211968205;4946.356973593437;5083.618728595352;5089.720065396402;5091.516305950938;5236.136037553809;3977.840886364542;4064.1871625674908;4104.630583247507;4131.29767939451;4163.3130533461945;4120.773357465338;4144.606262405066;4147.979260103695;4164.167166566684;4197.307444271692;4087.4686290782306;4092.7953602319913;4131.256373852705;4133.875983720493;4177.289860723684;4121.361189015677;4140.875773726793;4145.585441455845;4145.8963525911795;4149.294619914622;3687.115092377837;3695.8891233263043;3699.9260014799825;3701.222743223926;3731.3097077040834;4998.900021999576;5050.97960815673;5122.410922743895;5138.203578445309;5138.537531622172;4721.622270218374;4735.384400028009;4746.5080832562835;4750.61995040396;4766.356541866839;5420.7018613976215;5466.9179962300595;5473.795764931709;5488.396276409591;5504.504594586467;3720.3816339892232;4043.777592232426;4057.69567282455;4062.614051665087;4076.266272071026;5590.385057643656;5648.091233015;5692.487676109128;5704.2299289595785;5705.286839145148;4051.372037334218;4067.7559346439307;4072.837086516506;4079.326911059642;4100.753954762724;4069.7761623111014;4071.714979951375;4149.024979129902;4153.563875793058;4157.168566286694;4442.911141777211;4641.605463535638;4661.370714953506;4662.673612847136;4674.345591617176;5529.834104976857;5533.501984821385;5534.52956498694;5540.335159780771;5545.279113715272;1344.683999260173;1411.2943528235883;1417.2417756500222;1419.1130543410368;1425.3728359521986;878.2754227762122;962.4658314635444;978.9525208027343;980.838161703311;991.3011327014437;5250.579953603703;5257.973710131425;5296.443873393316;5309.41596424393;5311.176767601028;5532.917006244909;5534.529564987021;5538.556915446755;5605.943940560624;5610.607257491936;5123.718195499283;5253.36959564847;5331.30693009914;5384.6769193848495;5396.460353964572;2950.4541659792576;2986.566947792558;2990.357073229266;3007.639083309973;3024.7731420143577;5801.969310741207;5905.486235689757;5915.438033386821;5925.911111333334;5941.187937679049;5702.743376547983;5732.369439361667;5747.310322761212;5751.539876809845;5765.769369225184;5813.244278243801;5815.9709201453725;5854.970725146347;5883.117532370179;5897.351291358033;5369.926014796978;5575.68246893098;5624.325080990144;5630.831075067755;5669.943300566942;5588.357338905916;5645;5646.3788983212635;5653.378128405954;5655.604107712421;5798.623089499169;5903.557233207441;5922.496587790086;5928.34788173292;5961.582689211714;4049.3116170250537;4054.695897807735;4056.371262454324;4064.1871625674394;4071.1247081877536;5390.919136213039;5400;5574.414686457863;5601.215829783752;5664.85837854057;5446.264754258283;5476.67139971603;5484.945150548443;5491.258680078138;5496.780128794803;5247.632665713363;5379.762654589388;5415.702136382379;5432.34811822568;5437.211604317431;5427.538659214011;5429.511343979061;5446.319210098738;5453.454654534674;5471.097268950579;5452.918206226989;5468.671879687232;5469.699166545878;5498.560115190695;5506.311711036121;5128.923066154085;5313.574914006947;5328.6802791832615;5335.359756829205;5358.437364076872 04:44:34 INFO - PROCESS | 3421 | |5;yui.html;700.9719611215552;712.333967740163;766.9424793140512;769.9538027718336;788.136989995955;14819.851801481982;15388.846111538882;15399.461018864342;15428.382864685413;15556.222188890566;15278.847211527882;15300.846991530081;15368.385264589402;15404.537863864101;15408.229588520586;669.6183175589915;803.7869964459423;822.4201937633953;824.8432797768405;825.3892119831312;785.937125029999;802.8956235689352;808.3654331349892;812.0215140755405;812.3785304242259;844.771911583872;845.8139209373959;846.5090247656375;846.6401779243828;846.8899043124385;686.9313068693141;840.0759164918541;842.8862103616025;843.228445971938;843.3506200225822;607.2955371768727;623.3112410786107;624.9218847644045;628.2774808969675;629.5781826176473;14704;14727.263636818223;14739.55781326562;14749;14753.631159221106;14022.649433764136;14101.435942562286;14254.786178207336;14621.6344591385;14857.777133343008;12810.55163069288;13026.153300035467;13158.276294803782;13267.933660331733;13806.102603330752;4414.31578105391;4414.448193975753;4445.399871017404;4468.2850743881145;4717.457492388351;81365;83199;83222.16777832265;83661;85217.57391213067;11406.885931140583;11491.138164637685;11618.430884184309;11627.59303424376;11662.067034637208;21324.89337553302;21491.355259341934;21523.246686365903;21538;21603.243886463897;8307.792305192297;8338.04112527055;8410.747677569683;8433.873491897626;8569.057403685589;4701.905961880743;4748.928766068511;4861.611071114302;4884.780184891689;5007.4241462231585;3135.608048993876;3232.2565809863863;3234.223786291273;3235.9676403235667;3244.3186930744337;583.2534356024296;588.0268156201494;588.8704485013291;589.6638915817942;590.1590233916652;566.3204155014;617.7683368736724;638.6008744534665;666.776629829003;690.8169335126196;9239.307051970995;9245.72262832116;9257.861132083024;9350.485723285285;9682.854757178648;571.3800526428871;583.6643929740417;590.8345663214307;671.633959492078;736.6574542837607;4717.646176536773;4815.22956326993;4922.212446008622;4979.427365852901;5041.117804384218;64892.35107648958;64998.67500662561;65236.34763652303;84195;111717;100619.49690251649;101044;101380.49309753404;101390;102714.91855244355;87959;89254.55372723224;89426.55286723525;91761;94751;8945.73162805117;9217.723468295962;9234.722958310993;9267.582958767007;9300.20948219409;49044;50461;50622.74688626533;51961.480385197174;52024;69351.65324173347;71911.28088719046;76747.46505069979;84621;89738;13271.336433178496;13323.733525329633;13508.189508629514;13767;14102.929485352508;15230.923845380703;15810.68378632398;16406.261718222948;16791.66416671684;16976.745348820026;14840.554783356516;15300.77048844246;15607.297671605033;15810.209489525249;15885.2851621675;13184.406701698255;14059.100752758815;15070.246487675791;15201.6199595011;15981.360745570048;14154;14439;14876;15016.399344026117;15429.768553471931;10751.516181771996;11187.72030699239;11226.607068752555;11320.490577923849;11418.885811142114;10463.267571270242;11889.762204756029;11951.50373143566;12244.816327754912;12333.260004399765 04:44:34 INFO - PROCESS | 3421 | __end_tp_report 04:44:34 INFO - PROCESS | 3421 | __start_cc_report 04:44:34 INFO - PROCESS | 3421 | _x_x_mozilla_cycle_collect,964 04:44:34 INFO - PROCESS | 3421 | __end_cc_report 04:44:34 INFO - PROCESS | 3421 | __startTimestamp1471088674180__endTimestamp 04:44:34 INFO - PROCESS | 3421 | 04:44:34 INFO - PROCESS | 3421 | ------- Summary: start ------- 04:44:34 INFO - PROCESS | 3421 | Number of tests: 6 04:44:34 INFO - PROCESS | 3421 | 04:44:34 INFO - PROCESS | 3421 | [#0] dojo.html Cycles:165 Average:5265.68 Median:5449.67 stddev:595.34 (10.9%) stddev-sans-first:571.31 04:44:34 INFO - PROCESS | 3421 | Values: 3053.7 3065.2 3086.8 3086.9 3090.2 5149.4 5199.9 5291.4 5374.7 5431.6 5285.7 5321.5 5339.0 5354.7 5381.8 4761.5 4811.1 4834.9 4842.6 4988.7 4890.6 4896.1 4930.5 4942.2 4955.7 4758.6 4791.3 4814.8 4824.1 4900.5 4812.1 4821.0 4828.0 4843.7 4902.4 4831.8 4848.7 4849.1 4859.5 4895.8 5176.5 5209.5 5253.2 5257.5 5359.1 5591.0 5613.6 5627.3 5633.8 5638.3 5609.3 5643.0 5644.7 5654.1 5682.7 5117.3 5196.2 5217.4 5247.6 5334.7 5769.4 5811.7 5818.4 5820.4 5826.0 5503.6 5547.3 5558.9 5589.3 5608.8 5373.7 5561.7 5643.2 5645.9 5735.5 5676.3 5678.7 5683.6 5684.6 5686.1 5631.9 5689.0 5691.2 5692.1 5693.2 4194.5 4282.3 4287.2 4290.7 4342.9 3881.1 3889.3 3896.0 3906.8 3936.2 5348.4 5359.2 5364.4 5393.9 5403.9 5462.2 5641.7 5657.5 5658.7 5694.5 5331.9 5337.9 5346.0 5389.0 5449.7 4771.2 4810.3 4812.5 4813.4 4858.7 5659.7 5830.7 5857.7 5859.3 5863.8 5680.8 5690.5 5692.3 5717.1 5731.5 5892.3 5908.5 5913.1 5916.9 5917.6 5440.3 5542.9 5575.2 5585.1 5604.8 5699.6 5712.2 5771.4 5794.7 5817.2 5570.2 5604.1 5621.7 5622.1 5626.5 5320.7 5461.1 5488.4 5589.2 5600.2 5518.4 5521.8 5528.9 5551.1 5573.2 5576.1 5590.4 5594.9 5623.0 5643.1 5267.3 5274.4 5420.7 5443.3 5444.1 04:44:34 INFO - PROCESS | 3421 | 04:44:34 INFO - PROCESS | 3421 | [#1] ext.html Cycles:180 Average:55706.69 Median:22836.25 stddev:106697.69 (467.2%) stddev-sans-first:106916.73 04:44:34 INFO - PROCESS | 3421 | Values: 582.3 601.3 603.8 615.0 622.5 32974.7 33698.8 36033.6 36034.6 36097.1 47174.3 48259.8 48300.5 48399.3 48404.8 9009.2 9154.6 9154.9 9155.7 9161.5 9012.2 9104.5 9109.1 9111.9 9118.0 9108.3 9125.9 9180.7 9181.8 9186.1 9072.1 9144.4 9152.2 9152.3 9152.9 8947.0 9027.2 9029.6 9029.7 9033.1 42293.6 42528.0 42682.6 42736.1 42838.8 3458.9 4091.2 4123.2 4172.1 4208.7 32980.8 33061.4 33454.6 33471.7 34104.8 4172.2 4268.8 4273.1 4311.0 4458.7 253554.0 254270.0 254564.6 255076.0 255242.0 57614.4 57751.0 58160.4 58197.0 58235.0 61612.4 61627.6 61727.0 61767.0 61775.4 17043.6 17265.8 17266.1 17292.5 17296.7 12642.3 12646.0 12653.7 12654.4 12658.9 14671.7 17177.6 17334.7 17342.9 17499.0 6213.0 6263.5 6296.9 6452.1 6558.5 979.0 992.0 1069.0 1104.2 1205.4 32627.5 32941.8 33172.8 33191.1 34021.5 1091.2 1114.7 1116.2 1192.4 1234.9 16316.3 17378.4 17430.3 17595.2 17688.3 521217.0 522911.0 523441.0 524104.0 524420.0 58444.7 58557.4 58693.0 58772.4 58830.0 1209.3 1327.7 1378.6 1384.1 1390.1 32089.5 34461.3 34557.7 34696.7 35174.3 50147.7 50550.7 50692.2 50700.7 50728.0 382870.0 383768.0 383833.0 384139.0 384358.0 27830.6 29113.4 29133.3 30000.7 42065.8 48106.8 48179.3 48260.0 48749.8 49999.8 36979.8 37056.8 37536.6 37859.0 39072.8 37603.6 37765.4 38013.0 38225.8 38480.4 41500.4 42019.0 42324.8 42465.6 43182.1 32019.7 33884.7 34174.0 34445.7 34535.5 27673.8 28008.1 28136.9 28184.9 28196.6 04:44:34 INFO - PROCESS | 3421 | 04:44:34 INFO - PROCESS | 3421 | [#2] jquery.html Cycles:180 Average:28378.54 Median:2261.62 stddev:76225.64 (3370.4%) stddev-sans-first:76410.49 04:44:34 INFO - PROCESS | 3421 | Values: 380.0 381.6 406.4 411.0 419.1 14235.6 18725.8 19573.0 19676.1 19750.1 18969.6 19054.9 19184.3 19390.8 19408.7 5360.4 5556.8 5767.2 5775.2 6396.6 6494.8 6518.0 6518.0 6542.2 6543.1 5487.9 5682.2 5701.0 5876.2 6500.3 5717.8 5899.9 5911.1 5914.4 5933.1 5709.8 5723.7 5724.9 5733.3 5733.6 14589.0 15007.6 23262.6 23498.6 23569.5 2131.0 2196.5 2242.9 2280.3 2405.4 10272.8 10640.1 10775.9 10928.8 11199.2 1906.8 1960.5 2020.3 2053.2 2156.2 85852.6 87286.0 87609.0 90216.0 91258.1 11282.8 11373.6 11483.1 11577.9 11603.2 16233.9 16251.5 16275.8 16276.1 16292.0 8308.3 8415.8 8450.4 8660.3 8688.0 7959.6 8189.7 8213.6 8448.5 8514.3 4805.9 4909.7 5008.2 5012.8 5119.3 2006.7 2044.7 2064.8 2069.2 2089.1 896.6 945.7 980.6 1071.5 1103.4 19682.3 20309.9 20342.5 20454.0 20772.2 1024.8 1025.3 1032.6 1046.6 1069.4 10493.5 11326.5 11385.4 11390.1 11394.9 456000.0 457870.0 458968.0 460455.0 470072.0 85951.0 87978.6 89059.0 89783.6 90251.5 1013.9 1019.5 1021.3 1042.2 1043.3 17125.6 17452.0 17916.1 17942.0 18035.2 41778.8 42345.0 44365.8 44781.8 45298.8 55181.7 59018.4 60072.4 60414.0 61203.7 8570.7 8596.0 8624.4 8653.3 8891.7 11879.3 12013.3 12220.6 12357.8 12709.5 10166.8 10820.9 10833.5 11502.0 11720.4 11056.7 11126.4 11165.2 11424.9 11835.5 11568.7 11644.9 11649.0 11761.9 12156.9 7457.6 8054.3 8138.7 8785.0 9213.3 8987.9 11157.3 11351.8 11988.8 12208.1 04:44:34 INFO - PROCESS | 3421 | 04:44:34 INFO - PROCESS | 3421 | [#3] mootools.html Cycles:180 Average:5588.65 Median:4829.97 stddev:3096.18 (64.1%) stddev-sans-first:3088.32 04:44:34 INFO - PROCESS | 3421 | Values: 1329.5 1462.8 1476.5 1597.5 1709.1 7549.0 7911.4 7989.0 8204.0 8251.3 8062.3 8160.3 8168.3 8174.0 8180.2 1901.8 2181.6 2206.8 2208.9 2288.5 2398.4 2415.2 2415.8 2416.3 2419.0 2331.5 2337.6 2338.2 2339.2 2381.3 2239.2 2239.4 2239.4 2245.5 2322.1 2361.2 2363.0 2378.8 2379.8 2379.8 8732.2 8793.5 8797.2 8809.2 8819.4 5076.7 5161.1 5173.1 5223.9 5226.5 3222.7 3233.5 3408.0 3408.4 3411.2 1119.6 1146.1 2012.7 2105.5 2116.4 11277.5 11348.0 11372.9 11403.7 11410.6 4301.3 4535.7 4594.7 4613.3 4637.4 9394.4 9401.2 9401.9 9401.9 9414.2 5152.3 5187.8 5190.3 5192.8 5193.4 4133.1 4640.6 4689.6 4889.8 4890.5 3666.1 3726.3 3787.1 3814.4 3833.8 1143.9 1153.0 1156.7 1161.1 1170.5 910.6 930.3 933.1 942.8 977.4 5472.5 5607.6 5702.1 5758.7 5798.2 928.4 967.9 1018.1 1023.9 1040.2 3759.1 3996.7 4017.0 4149.4 4180.3 10227.6 10398.1 10416.6 10534.1 10539.6 10212.9 10244.3 10352.8 10356.4 10370.7 8041.3 8079.8 8086.6 8152.2 8204.9 5646.4 5676.8 5838.8 5876.1 5923.2 9535.3 9774.6 9932.9 9958.0 10195.5 10079.6 10088.1 10175.2 10228.0 10238.6 6161.8 7107.3 7227.4 7356.6 7497.1 8498.5 8544.0 8562.2 8569.9 8572.8 7283.9 7563.1 7585.2 7600.7 7625.9 7026.0 7108.1 7225.4 7321.4 7521.2 6464.9 6569.2 6570.6 6572.6 6576.9 4700.5 4767.0 4850.8 4852.4 4866.2 4806.2 4809.2 4855.9 4861.2 5144.2 04:44:34 INFO - PROCESS | 3421 | 04:44:34 INFO - PROCESS | 3421 | [#4] prototype.html Cycles:180 Average:4638.40 Median:5304.55 stddev:1350.34 (25.5%) stddev-sans-first:1314.70 04:44:34 INFO - PROCESS | 3421 | Values: 322.4 326.6 338.5 340.8 344.5 5159.4 5251.2 5280.4 5299.7 5319.2 4946.4 5083.6 5089.7 5091.5 5236.1 3977.8 4064.2 4104.6 4131.3 4163.3 4120.8 4144.6 4148.0 4164.2 4197.3 4087.5 4092.8 4131.3 4133.9 4177.3 4121.4 4140.9 4145.6 4145.9 4149.3 3687.1 3695.9 3699.9 3701.2 3731.3 4998.9 5051.0 5122.4 5138.2 5138.5 4721.6 4735.4 4746.5 4750.6 4766.4 5420.7 5466.9 5473.8 5488.4 5504.5 3720.4 4043.8 4057.7 4062.6 4076.3 5590.4 5648.1 5692.5 5704.2 5705.3 4051.4 4067.8 4072.8 4079.3 4100.8 4069.8 4071.7 4149.0 4153.6 4157.2 4442.9 4641.6 4661.4 4662.7 4674.3 5529.8 5533.5 5534.5 5540.3 5545.3 1344.7 1411.3 1417.2 1419.1 1425.4 878.3 962.5 979.0 980.8 991.3 5250.6 5258.0 5296.4 5309.4 5311.2 5532.9 5534.5 5538.6 5605.9 5610.6 5123.7 5253.4 5331.3 5384.7 5396.5 2950.5 2986.6 2990.4 3007.6 3024.8 5802.0 5905.5 5915.4 5925.9 5941.2 5702.7 5732.4 5747.3 5751.5 5765.8 5813.2 5816.0 5855.0 5883.1 5897.4 5369.9 5575.7 5624.3 5630.8 5669.9 5588.4 5645.0 5646.4 5653.4 5655.6 5798.6 5903.6 5922.5 5928.3 5961.6 4049.3 4054.7 4056.4 4064.2 4071.1 5390.9 5400.0 5574.4 5601.2 5664.9 5446.3 5476.7 5484.9 5491.3 5496.8 5247.6 5379.8 5415.7 5432.3 5437.2 5427.5 5429.5 5446.3 5453.5 5471.1 5452.9 5468.7 5469.7 5498.6 5506.3 5128.9 5313.6 5328.7 5335.4 5358.4 04:44:34 INFO - PROCESS | 3421 | 04:44:34 INFO - PROCESS | 3421 | [#5] yui.html Cycles:180 Average:20488.71 Median:4873.20 stddev:28448.91 (583.8%) stddev-sans-first:28489.91 04:44:34 INFO - PROCESS | 3421 | Values: 701.0 712.3 766.9 770.0 788.1 14819.9 15388.8 15399.5 15428.4 15556.2 15278.8 15300.8 15368.4 15404.5 15408.2 669.6 803.8 822.4 824.8 825.4 785.9 802.9 808.4 812.0 812.4 844.8 845.8 846.5 846.6 846.9 686.9 840.1 842.9 843.2 843.4 607.3 623.3 624.9 628.3 629.6 14704.0 14727.3 14739.6 14749.0 14753.6 14022.6 14101.4 14254.8 14621.6 14857.8 12810.6 13026.2 13158.3 13267.9 13806.1 4414.3 4414.4 4445.4 4468.3 4717.5 81365.0 83199.0 83222.2 83661.0 85217.6 11406.9 11491.1 11618.4 11627.6 11662.1 21324.9 21491.4 21523.2 21538.0 21603.2 8307.8 8338.0 8410.7 8433.9 8569.1 4701.9 4748.9 4861.6 4884.8 5007.4 3135.6 3232.3 3234.2 3236.0 3244.3 583.3 588.0 588.9 589.7 590.2 566.3 617.8 638.6 666.8 690.8 9239.3 9245.7 9257.9 9350.5 9682.9 571.4 583.7 590.8 671.6 736.7 4717.6 4815.2 4922.2 4979.4 5041.1 64892.4 64998.7 65236.3 84195.0 111717.0 100619.5 101044.0 101380.5 101390.0 102714.9 87959.0 89254.6 89426.6 91761.0 94751.0 8945.7 9217.7 9234.7 9267.6 9300.2 49044.0 50461.0 50622.7 51961.5 52024.0 69351.7 71911.3 76747.5 84621.0 89738.0 13271.3 13323.7 13508.2 13767.0 14102.9 15230.9 15810.7 16406.3 16791.7 16976.7 14840.6 15300.8 15607.3 15810.2 15885.3 13184.4 14059.1 15070.2 15201.6 15981.4 14154.0 14439.0 14876.0 15016.4 15429.8 10751.5 11187.7 11226.6 11320.5 11418.9 10463.3 11889.8 11951.5 12244.8 12333.3 04:44:34 INFO - PROCESS | 3421 | -------- Summary: end -------- 04:44:34 INFO - PROCESS | 3421 | 04:44:34 INFO - TEST-INFO | 3421: exit 0 04:44:34 INFO - TEST-OK | dromaeo_css | took 1116991ms 04:44:34 INFO - TEST-START | kraken 04:44:34 INFO - operating with platform_type : linux_ 04:44:34 INFO - Initialising browser for kraken test... 04:44:34 INFO - TEST-INFO | started process 3722 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpChRVPg/profile http://localhost:57944/getInfo.html) 04:44:39 INFO - PROCESS | 3722 | __metrics Screen width/height:1600/1200 04:44:39 INFO - PROCESS | 3722 | colorDepth:24 04:44:39 INFO - PROCESS | 3722 | Browser inner width/height: 1024/697 04:44:39 INFO - PROCESS | 3722 | __metrics 04:44:39 INFO - PROCESS | 3722 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:44:39 INFO - PROCESS | 3722 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:44:40 INFO - TEST-INFO | 3722: exit 0 04:44:40 INFO - Browser initialized. 04:44:40 INFO - Running cycle 1/1 for kraken test... 04:44:40 INFO - TEST-INFO | started process 3803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpChRVPg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:44:52 INFO - PROCESS | 3803 | RSS: Main: 156000256 04:44:52 INFO - PROCESS | 3803 | 04:44:55 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:57944/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57944/tests/kraken/driver.html?testName=audio-beat-detection) 04:44:55 INFO - PROCESS | 3803 | RSS: Main: 204365824 04:44:55 INFO - PROCESS | 3803 | 04:44:58 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:57944/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57944/tests/kraken/driver.html?testName=audio-dft) 04:44:59 INFO - PROCESS | 3803 | RSS: Main: 194813952 04:44:59 INFO - PROCESS | 3803 | 04:45:02 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:57944/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57944/tests/kraken/driver.html?testName=audio-fft) 04:45:02 INFO - PROCESS | 3803 | RSS: Main: 275828736 04:45:02 INFO - PROCESS | 3803 | 04:45:04 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:57944/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57944/tests/kraken/driver.html?testName=audio-oscillator) 04:45:05 INFO - PROCESS | 3803 | RSS: Main: 186048512 04:45:05 INFO - PROCESS | 3803 | 04:45:07 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:57944/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57944/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:45:08 INFO - PROCESS | 3803 | RSS: Main: 190468096 04:45:08 INFO - PROCESS | 3803 | 04:45:11 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:57944/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57944/tests/kraken/driver.html?testName=imaging-darkroom) 04:45:11 INFO - PROCESS | 3803 | RSS: Main: 225849344 04:45:11 INFO - PROCESS | 3803 | 04:45:15 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:57944/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57944/tests/kraken/driver.html?testName=imaging-desaturate) 04:45:15 INFO - PROCESS | 3803 | RSS: Main: 226402304 04:45:15 INFO - PROCESS | 3803 | 04:45:18 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:57944/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57944/tests/kraken/driver.html?testName=json-parse-financial) 04:45:19 INFO - PROCESS | 3803 | RSS: Main: 226144256 04:45:19 INFO - PROCESS | 3803 | 04:45:20 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:57944/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57944/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:45:21 INFO - PROCESS | 3803 | RSS: Main: 188702720 04:45:21 INFO - PROCESS | 3803 | 04:45:23 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:57944/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57944/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:45:23 INFO - PROCESS | 3803 | RSS: Main: 195178496 04:45:23 INFO - PROCESS | 3803 | 04:45:25 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:57944/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57944/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:45:26 INFO - PROCESS | 3803 | RSS: Main: 193773568 04:45:26 INFO - PROCESS | 3803 | 04:45:29 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:57944/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57944/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:45:29 INFO - PROCESS | 3803 | RSS: Main: 186634240 04:45:29 INFO - PROCESS | 3803 | 04:45:32 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:57944/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57944/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:45:32 INFO - PROCESS | 3803 | RSS: Main: 192307200 04:45:32 INFO - PROCESS | 3803 | 04:45:34 INFO - PROCESS | 3803 | Cycle 1(1): loaded http://localhost:57944/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57944/tests/kraken/driver.html?testName=ai-astar) 04:45:34 INFO - PROCESS | 3803 | RSS: Main: 243101696 04:45:34 INFO - PROCESS | 3803 | 04:45:34 INFO - PROCESS | 3803 | __start_tp_report 04:45:34 INFO - PROCESS | 3803 | _x_x_mozilla_page_load 04:45:34 INFO - PROCESS | 3803 | _x_x_mozilla_page_load_details 04:45:34 INFO - PROCESS | 3803 | |i|pagename|runs| 04:45:34 INFO - PROCESS | 3803 | |0;ai-astar;104;112;111;113;107;112;111;111;110;112 04:45:34 INFO - PROCESS | 3803 | |1;audio-beat-detection;148;116;125;177;121;121;143;118;151;118 04:45:34 INFO - PROCESS | 3803 | |2;audio-dft;161;160;160;160;160;159;161;162;160;160 04:45:34 INFO - PROCESS | 3803 | |3;audio-fft;75;75;76;102;75;76;75;74;100;75 04:45:34 INFO - PROCESS | 3803 | |4;audio-oscillator;85;84;136;85;85;85;121;85;85;126 04:45:34 INFO - PROCESS | 3803 | |5;imaging-gaussian-blur;116;117;117;117;117;116;117;118;118;117 04:45:34 INFO - PROCESS | 3803 | |6;imaging-darkroom;146;146;146;152;146;146;146;146;146;146 04:45:34 INFO - PROCESS | 3803 | |7;imaging-desaturate;95;95;95;95;96;95;95;96;95;96 04:45:34 INFO - PROCESS | 3803 | |8;json-parse-financial;53;50;53;51;52;54;52;60;53;52 04:45:34 INFO - PROCESS | 3803 | |9;json-stringify-tinderbox;62;62;61;62;62;62;62;62;62;61 04:45:34 INFO - PROCESS | 3803 | |10;stanford-crypto-aes;79;78;79;80;78;77;80;79;78;78 04:45:34 INFO - PROCESS | 3803 | |11;stanford-crypto-ccm;124;122;123;123;121;124;132;136;140;129 04:45:34 INFO - PROCESS | 3803 | |12;stanford-crypto-pbkdf2;163;162;166;162;159;158;159;158;161;162 04:45:34 INFO - PROCESS | 3803 | |13;stanford-crypto-sha256-iterative;66;66;65;63;63;65;63;68;64;62 04:45:34 INFO - PROCESS | 3803 | __end_tp_report 04:45:34 INFO - PROCESS | 3803 | __start_cc_report 04:45:34 INFO - PROCESS | 3803 | _x_x_mozilla_cycle_collect,1663 04:45:34 INFO - PROCESS | 3803 | __end_cc_report 04:45:34 INFO - PROCESS | 3803 | __startTimestamp1471088734881__endTimestamp 04:45:34 INFO - PROCESS | 3803 | 04:45:34 INFO - PROCESS | 3803 | ------- Summary: start ------- 04:45:34 INFO - PROCESS | 3803 | Number of tests: 14 04:45:34 INFO - PROCESS | 3803 | 04:45:34 INFO - PROCESS | 3803 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:2.75 (2.5%) stddev-sans-first:1.73 04:45:34 INFO - PROCESS | 3803 | Values: 104.0 112.0 111.0 113.0 107.0 112.0 111.0 111.0 110.0 112.0 04:45:34 INFO - PROCESS | 3803 | 04:45:34 INFO - PROCESS | 3803 | [#1] audio-beat-detection Cycles:10 Average:133.80 Median:134.00 stddev:20.19 (15.1%) stddev-sans-first:20.75 04:45:34 INFO - PROCESS | 3803 | Values: 148.0 116.0 125.0 177.0 121.0 121.0 143.0 118.0 151.0 118.0 04:45:34 INFO - PROCESS | 3803 | 04:45:34 INFO - PROCESS | 3803 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 04:45:34 INFO - PROCESS | 3803 | Values: 161.0 160.0 160.0 160.0 160.0 159.0 161.0 162.0 160.0 160.0 04:45:34 INFO - PROCESS | 3803 | 04:45:34 INFO - PROCESS | 3803 | [#3] audio-fft Cycles:10 Average:80.30 Median:75.00 stddev:10.93 (14.6%) stddev-sans-first:11.43 04:45:34 INFO - PROCESS | 3803 | Values: 75.0 75.0 76.0 102.0 75.0 76.0 75.0 74.0 100.0 75.0 04:45:34 INFO - PROCESS | 3803 | 04:45:34 INFO - PROCESS | 3803 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:85.00 stddev:20.99 (24.7%) stddev-sans-first:21.76 04:45:34 INFO - PROCESS | 3803 | Values: 85.0 84.0 136.0 85.0 85.0 85.0 121.0 85.0 85.0 126.0 04:45:34 INFO - PROCESS | 3803 | 04:45:34 INFO - PROCESS | 3803 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 04:45:34 INFO - PROCESS | 3803 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 117.0 118.0 118.0 117.0 04:45:34 INFO - PROCESS | 3803 | 04:45:34 INFO - PROCESS | 3803 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.00 stddev:1.90 (1.3%) stddev-sans-first:2.00 04:45:34 INFO - PROCESS | 3803 | Values: 146.0 146.0 146.0 152.0 146.0 146.0 146.0 146.0 146.0 146.0 04:45:34 INFO - PROCESS | 3803 | 04:45:34 INFO - PROCESS | 3803 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 04:45:34 INFO - PROCESS | 3803 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 96.0 04:45:34 INFO - PROCESS | 3803 | 04:45:34 INFO - PROCESS | 3803 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:2.71 (5.1%) stddev-sans-first:2.87 04:45:34 INFO - PROCESS | 3803 | Values: 53.0 50.0 53.0 51.0 52.0 54.0 52.0 60.0 53.0 52.0 04:45:34 INFO - PROCESS | 3803 | 04:45:34 INFO - PROCESS | 3803 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 04:45:34 INFO - PROCESS | 3803 | Values: 62.0 62.0 61.0 62.0 62.0 62.0 62.0 62.0 62.0 61.0 04:45:34 INFO - PROCESS | 3803 | 04:45:34 INFO - PROCESS | 3803 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:79.00 stddev:0.97 (1.2%) stddev-sans-first:1.01 04:45:34 INFO - PROCESS | 3803 | Values: 79.0 78.0 79.0 80.0 78.0 77.0 80.0 79.0 78.0 78.0 04:45:34 INFO - PROCESS | 3803 | 04:45:34 INFO - PROCESS | 3803 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:126.50 stddev:6.57 (5.2%) stddev-sans-first:6.85 04:45:34 INFO - PROCESS | 3803 | Values: 124.0 122.0 123.0 123.0 121.0 124.0 132.0 136.0 140.0 129.0 04:45:34 INFO - PROCESS | 3803 | 04:45:34 INFO - PROCESS | 3803 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.00 Median:162.00 stddev:2.54 (1.6%) stddev-sans-first:2.59 04:45:34 INFO - PROCESS | 3803 | Values: 163.0 162.0 166.0 162.0 159.0 158.0 159.0 158.0 161.0 162.0 04:45:34 INFO - PROCESS | 3803 | 04:45:34 INFO - PROCESS | 3803 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:65.00 stddev:1.84 (2.8%) stddev-sans-first:1.87 04:45:34 INFO - PROCESS | 3803 | Values: 66.0 66.0 65.0 63.0 63.0 65.0 63.0 68.0 64.0 62.0 04:45:34 INFO - PROCESS | 3803 | -------- Summary: end -------- 04:45:34 INFO - PROCESS | 3803 | 04:45:35 INFO - TEST-INFO | 3803: exit 0 04:45:35 INFO - TEST-OK | kraken | took 60991ms 04:45:35 INFO - SUITE-END | took 1177s 04:45:36 INFO - Completed test suite (00:19:38) 04:45:36 INFO - javascript benchmark 04:45:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3053.709897559732, 3065.1724034510667, 3086.768492363073, 3086.861091250892, 3090.1656552730765, 5149.382074151098, 5199.896002079956, 5291.365036195657, 5374.6506477078965, 5431.619786614933, 5285.709285989269, 5321.547668448177, 5339.038972984861, 5354.705491197982, 5381.81163659271, 4761.47623761386, 4811.061842940628, 4834.879128021792, 4842.564169224769, 4988.725620090893, 4890.584300334476, 4896.143174944388, 4930.531599498042, 4942.159832828428, 4955.677880937746, 4758.595519380857, 4791.257355109963, 4814.7833347499445, 4824.131656301899, 4900.485449027854, 4812.109759694433, 4821.0, 4828.0, 4843.709377437365, 4902.411710594716, 4831.830885918976, 4848.733319667417, 4849.102915960523, 4859.5383438573635, 4895.828645997409, 5176.456472070454, 5209.47905209476, 5253.238280449314, 5257.526822585985, 5359.115745901921, 5591.049521581341, 5613.578981576357, 5627.296587926509, 5633.774649014034, 5638.267025286727, 5609.27079479665, 5643.0, 5644.717764111819, 5654.067078931971, 5682.744276507526, 5117.257997590365, 5196.246544251062, 5217.399999000126, 5247.606429517801, 5334.7065911374475, 5769.365369809318, 5811.680357580289, 5818.359980402152, 5820.447057529528, 5826.009578371687, 5503.587230957694, 5547.306586676666, 5558.944410555923, 5589.301337332833, 5608.775648974077, 5373.704446255415, 5561.6663000220115, 5643.181738647873, 5645.943540564624, 5735.512481439125, 5676.347220069662, 5678.744456499468, 5683.630564013326, 5684.63049901755, 5686.09022556389, 5631.915521267184, 5688.971555142198, 5691.231683722727, 5692.0608099663095, 5693.202951586781, 4194.496660400771, 4282.272013757669, 4287.249731297011, 4290.678199135077, 4342.891427714332, 3881.068543549528, 3889.3193691103943, 3895.9610403896163, 3906.8046597670004, 3936.2127574485216, 5348.384935732441, 5359.196120581944, 5364.436734142937, 5393.946060539344, 5403.9459605403445, 5462.2079798429, 5641.689707066069, 5657.519110875622, 5658.660480371191, 5694.544436445074, 5331.86670333237, 5337.893242135136, 5346.0, 5389.0299746046085, 5449.6730196188355, 4771.165046116985, 4810.326554282403, 4812.51874812516, 4813.350197723333, 4858.659893807399, 5659.745311460912, 5830.650160990354, 5857.736401861841, 5859.267591551056, 5863.824085277449, 5680.77276908919, 5690.4878560928055, 5692.345380281321, 5717.142428635738, 5731.512821410227, 5892.263467066617, 5908.527317814651, 5913.083472061838, 5916.911246331222, 5917.556183286185, 5440.265564148789, 5542.9168562472405, 5575.247341608993, 5585.050541407889, 5604.8038318658655, 5699.629524080921, 5712.228849105484, 5771.365149833431, 5794.681292528783, 5817.185594016756, 5570.220169176399, 5604.075327570905, 5621.7189140542, 5622.128570071645, 5626.493615574618, 5320.733963301896, 5461.098918678374, 5488.396276409671, 5589.161625756169, 5600.215969764317, 5518.44815518461, 5521.779128834802, 5528.944710552843, 5551.084071128219, 5573.247611572386, 5576.1356989666665, 5590.440955904377, 5594.916076258941, 5623.044082506066, 5643.068893632505, 5267.3152490176035, 5274.446183150714, 5420.728963551728, 5443.319585051869, 5444.128939369682], "value": 5225.743706808198, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.3128708124414, 601.2544444888339, 603.815836169968, 615.0405367626506, 622.4864486798391, 32974.67025329746, 33698.8315058425, 36033.63966360335, 36034.63965360346, 36097.09757256067, 47174.292385614244, 48259.75870120645, 48300.51699483004, 48399.274010889865, 48404.75797621016, 9009.234215091708, 9154.633814647406, 9154.862677059817, 9155.72532824013, 9161.496117713523, 9012.188902998729, 9104.544772761368, 9109.089091090904, 9111.863322050174, 9117.95441022794, 9108.271338292954, 9125.863112053325, 9180.724578262663, 9181.816363672722, 9186.127317904822, 9072.092790720908, 9144.359894807367, 9152.17630413266, 9152.267818574499, 9152.8627070594, 8947.0, 9027.187553120186, 9029.638814447415, 9029.729108126767, 9033.05152958943, 42293.57706422927, 42528.0, 42682.57317426817, 42736.145277094285, 42838.78580607077, 3458.886574568874, 4091.2431200227757, 4123.237201117803, 4172.123853990665, 4208.684348673862, 32980.83509582461, 33061.41724455059, 33454.64361771256, 33471.6652833471, 34104.82947585271, 4172.165566886604, 4268.786560671954, 4273.081287523167, 4310.978445107786, 4458.71018383804, 253554.0, 254270.0, 254564.63588410252, 255076.0, 255242.0, 57614.42385576174, 57751.0, 58160.41839581635, 58197.0, 58235.0, 61612.38387616067, 61627.61048142306, 61727.0, 61767.0, 61775.38224617786, 17043.573910652085, 17265.827341726672, 17266.050367229673, 17292.481225563253, 17296.740548891776, 12642.30467324306, 12646.0, 12653.746925061447, 12654.367281636065, 12658.936705316599, 14671.706565868622, 17177.570560735832, 17334.65330693379, 17342.913285433493, 17499.0, 6213.0221829456, 6263.498920086382, 6296.874062518724, 6452.12896258999, 6558.508111891627, 978.9902100978899, 991.965281215154, 1068.9946550267355, 1104.2160066352978, 1205.3732059329275, 32627.51058734121, 32941.835290823394, 33172.834135829165, 33191.06828722179, 34021.489677654856, 1091.165258577189, 1114.726891911487, 1116.1555084157812, 1192.4455128365178, 1234.882686144815, 16316.265768040466, 17378.39175628847, 17430.302787888595, 17595.208215630326, 17688.29246830138, 521217.0, 522911.0, 523441.0, 524104.0, 524420.0, 58444.70777646085, 58557.41442585605, 58693.0, 58772.4122758767, 58830.0, 1209.3167360441323, 1327.707904261061, 1378.5933149720856, 1384.1349156777014, 1390.1311680199874, 32089.518657220626, 34461.31077378388, 34557.654423455446, 34696.653033469345, 35174.296514069065, 50147.74926125346, 50550.747246263534, 50692.239616405044, 50700.74649626728, 50728.0, 382870.0, 383768.0, 383833.0, 384139.0, 384358.0, 27830.582541261494, 29113.417731645673, 29133.271668208465, 30000.69999299979, 42065.78967105268, 48106.75946620244, 48179.277310839665, 48260.0, 48749.75625121852, 49999.75000124976, 36979.8151009254, 37056.81471592733, 37536.62463375441, 37859.0, 39072.80463597664, 37603.62396376111, 37765.4335184978, 38013.0, 38225.808870955465, 38480.422793658676, 41500.37749433701, 42019.0, 42324.78837605916, 42465.575344246165, 43182.13635727331, 32019.67980320167, 33884.66115338815, 34174.0201923839, 34445.65554344424, 34535.481967771004, 27673.754681039805, 28008.14623485064, 28136.859315703292, 28184.85907570531, 28196.577051344655], "value": 19892.68516015948, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.9924001519968, 381.63935081348137, 406.4289673009422, 410.9876703698889, 419.0926643816138, 14235.644108897282, 18725.812741872578, 19573.0, 19676.114574844112, 19750.111244993976, 18969.620607587873, 19054.904725476354, 19184.328548500805, 19390.806091939077, 19408.708869366936, 5360.437154098822, 5556.805511807088, 5767.192593036978, 5775.162601422791, 6396.61620302781, 6494.772682956098, 6517.9674101629425, 6517.9674101629425, 6542.214934207902, 6543.116679248312, 5487.917681234785, 5682.17608446775, 5701.0, 5876.177335173079, 6500.252470965828, 5717.799877004285, 5899.882002359972, 5911.142884281798, 5914.378990206031, 5933.13969474426, 5709.77160913563, 5723.71381430931, 5724.8855022899725, 5733.283339582552, 5733.627314224562, 14589.0, 15007.624809379853, 23262.60424374543, 23498.64752028721, 23569.528609427885, 2130.989345053265, 2196.4728465168405, 2242.9102835886547, 2280.3387017764994, 2405.446747248143, 10272.845907311395, 10640.148788096934, 10775.892241077567, 10928.781424371467, 11199.160062995308, 1906.7997860224755, 1960.5392732707803, 2020.2525065725777, 2053.1992522916075, 2156.202205184092, 85852.57073714654, 87286.0, 87608.99999999936, 90216.0, 91258.08741912563, 11282.774344513227, 11373.611541576196, 11483.13876459269, 11577.884221157849, 11603.187776855539, 16233.918830405772, 16251.51245462638, 16275.755863662054, 16276.104814235094, 16292.0, 8308.335333173452, 8415.789605259917, 8450.408471407065, 8660.26387757035, 8687.956560217159, 7959.602019898982, 8189.672413103528, 8213.589320534069, 8448.493090414595, 8514.31885449175, 4805.927911081337, 4909.656324057353, 5008.198688209869, 5012.824551140692, 5119.257707632372, 2006.6989951507098, 2044.6830741235133, 2064.834813214939, 2069.182672844218, 2089.1121273459025, 896.6189369517929, 945.7068308824287, 980.632262901412, 1071.4589132488043, 1103.365564800243, 19682.311119110764, 20309.89845050765, 20342.49143771388, 20454.0, 20772.169113235603, 1024.774549599087, 1025.3284098915221, 1032.550840384435, 1046.6075221791828, 1069.395791377869, 10493.527791249413, 11326.490307935997, 11385.37380444067, 11390.145739069603, 11394.886051139549, 456000.0, 457870.0, 458968.0, 460455.0, 470072.0, 85951.0, 87978.56010719905, 89059.0, 89783.55108224417, 90251.54874225587, 1013.9239557033104, 1019.4800651667703, 1021.2544842265188, 1042.1975079188983, 1043.2801367056707, 17125.57186070358, 17452.019192323172, 17916.104194789947, 17942.0, 18035.18841652155, 41778.79110604428, 42345.0, 44365.77817110894, 44781.77609111933, 45298.77350613358, 55181.724091379285, 59018.409815901294, 60072.39927600843, 60414.0, 61203.69398152981, 8570.700025499078, 8596.0, 8624.353173511887, 8653.307735381028, 8891.73324800257, 11879.346635935106, 12013.279203247483, 12220.572279970158, 12357.814632780695, 12709.491620335082, 10166.847497287694, 10820.945895270474, 10833.458327083457, 11502.044652408944, 11720.355380454157, 11056.668299951014, 11126.388048657402, 11165.218434709817, 11424.885751142383, 11835.467403967014, 11568.710782230512, 11644.88355116472, 11649.0, 11761.941190293994, 12156.939215303866, 7457.589832559044, 8054.275115239657, 8138.674453021813, 8785.0, 9213.309001824757, 8987.938286134253, 11157.330560166416, 11351.772964540829, 11988.820167697317, 12208.084393670688], "value": 9321.490319242337, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1329.4947919790477, 1462.8317743459502, 1476.475851072869, 1597.5047735202088, 1709.1027210714365, 7548.9808875801755, 7911.3670906327425, 7989.0413150421955, 8203.95898020509, 8251.339892808575, 8062.274395304421, 8160.347172226223, 8168.305694016001, 8174.019117705883, 8180.181981801817, 1901.75277213962, 2181.6073106840804, 2206.8124209442217, 2208.933731988043, 2288.530851175505, 2398.400399900025, 2415.154695856445, 2415.770501802335, 2416.3113512648897, 2419.0082066352797, 2331.5103828196097, 2337.614293641547, 2338.205010296499, 2339.1695947938492, 2381.30942026812, 2239.193890199535, 2239.372975566828, 2239.4065572623185, 2245.517213799025, 2322.094383190557, 2361.244401791427, 2362.9645555316683, 2378.7621237876247, 2379.7501262367377, 2379.8215133864855, 8732.170443807829, 8793.472391656522, 8797.208251257418, 8809.207171354608, 8819.426737262058, 5076.670016448919, 5161.148410512261, 5173.094708426011, 5223.895522089537, 5226.451222621608, 3222.7421806255443, 3233.4643491710613, 3407.9829600852086, 3408.386490431721, 3411.181316484026, 1119.5857532712948, 1146.1232157399595, 2012.7282816819688, 2105.473631592102, 2116.354511873878, 11277.49251283686, 11348.035416989565, 11372.943135284271, 11403.714907127305, 11410.600628977945, 4301.333293339538, 4535.659825513099, 4594.724316541018, 4613.284940834176, 4637.350770892078, 9394.389364691273, 9401.200897923616, 9401.858972115424, 9401.905980940102, 9414.199793017533, 5152.3044389007755, 5187.818426355135, 5190.325257716473, 5192.766325515361, 5193.350831146106, 4133.111381053088, 4640.582347588733, 4689.554492323224, 4889.755512224375, 4890.462049174588, 3666.0834791302173, 3726.2920045191327, 3787.0532366908274, 3814.4469051987307, 3833.8083095845095, 1143.9142064345208, 1152.9884701153048, 1156.7455159864817, 1161.0653423993765, 1170.5493385046818, 910.5720311453606, 930.2697382554662, 933.1135421349609, 942.7737343037759, 977.3695966101825, 5472.5348345391085, 5607.551395888319, 5702.087665973424, 5758.712064396764, 5798.188253644409, 928.4429342394509, 967.9467629280457, 1018.055899084838, 1023.923205759571, 1040.15747244732, 3759.1353988582778, 3996.720229583901, 4016.959830401717, 4149.419081328617, 4180.282816169514, 10227.642032528825, 10398.064174224357, 10416.583336666448, 10534.104601108838, 10539.57841686324, 10212.897871021194, 10244.334118282288, 10352.844707329396, 10356.378617282988, 10370.688879333633, 8041.276285134366, 8079.798005049921, 8086.636101375452, 8152.225538573826, 8204.876926846102, 5646.407127251579, 5676.79955538361, 5838.824835254949, 5876.118582212703, 5923.200367950271, 9535.332526723063, 9774.560144793359, 9932.900670993198, 9957.950210248902, 10195.451137215696, 10079.647212347825, 10088.142507886912, 10175.185985121321, 10228.0, 10238.641647542301, 6161.845953851011, 7107.289271072851, 7227.421806255382, 7356.595387253752, 7497.062867141607, 8498.53258070812, 8543.957280213559, 8562.229399354088, 8569.914300857161, 8572.785680358042, 7283.8543229136185, 7563.092428908346, 7585.16563178061, 7600.733974310872, 7625.923740762521, 7026.0, 7108.147022357351, 7225.385842203472, 7321.414286856932, 7521.2478752126535, 6464.935350646433, 6569.211694596679, 6570.5729127606555, 6572.572782769104, 6576.868462630816, 4700.482946875909, 4766.976165119152, 4850.781714822912, 4852.417709874838, 4866.1727506323305, 4806.231003039637, 4809.158397280392, 4855.902881942412, 4861.246506791453, 5144.151215049475], "value": 4543.93535212786, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.4003353762001, 326.56077575660737, 338.5362053986039, 340.804037678335, 344.52283587231676, 5159.380874295085, 5251.212318152279, 5280.392754833195, 5299.682019078858, 5319.20211968205, 4946.356973593437, 5083.618728595352, 5089.720065396402, 5091.516305950938, 5236.136037553809, 3977.840886364542, 4064.1871625674908, 4104.630583247507, 4131.29767939451, 4163.3130533461945, 4120.773357465338, 4144.606262405066, 4147.979260103695, 4164.167166566684, 4197.307444271692, 4087.4686290782306, 4092.7953602319913, 4131.256373852705, 4133.875983720493, 4177.289860723684, 4121.361189015677, 4140.875773726793, 4145.585441455845, 4145.8963525911795, 4149.294619914622, 3687.115092377837, 3695.8891233263043, 3699.9260014799825, 3701.222743223926, 3731.3097077040834, 4998.900021999576, 5050.97960815673, 5122.410922743895, 5138.203578445309, 5138.537531622172, 4721.622270218374, 4735.384400028009, 4746.5080832562835, 4750.61995040396, 4766.356541866839, 5420.7018613976215, 5466.9179962300595, 5473.795764931709, 5488.396276409591, 5504.504594586467, 3720.3816339892232, 4043.777592232426, 4057.69567282455, 4062.614051665087, 4076.266272071026, 5590.385057643656, 5648.091233015, 5692.487676109128, 5704.2299289595785, 5705.286839145148, 4051.372037334218, 4067.7559346439307, 4072.837086516506, 4079.326911059642, 4100.753954762724, 4069.7761623111014, 4071.714979951375, 4149.024979129902, 4153.563875793058, 4157.168566286694, 4442.911141777211, 4641.605463535638, 4661.370714953506, 4662.673612847136, 4674.345591617176, 5529.834104976857, 5533.501984821385, 5534.52956498694, 5540.335159780771, 5545.279113715272, 1344.683999260173, 1411.2943528235883, 1417.2417756500222, 1419.1130543410368, 1425.3728359521986, 878.2754227762122, 962.4658314635444, 978.9525208027343, 980.838161703311, 991.3011327014437, 5250.579953603703, 5257.973710131425, 5296.443873393316, 5309.41596424393, 5311.176767601028, 5532.917006244909, 5534.529564987021, 5538.556915446755, 5605.943940560624, 5610.607257491936, 5123.718195499283, 5253.36959564847, 5331.30693009914, 5384.6769193848495, 5396.460353964572, 2950.4541659792576, 2986.566947792558, 2990.357073229266, 3007.639083309973, 3024.7731420143577, 5801.969310741207, 5905.486235689757, 5915.438033386821, 5925.911111333334, 5941.187937679049, 5702.743376547983, 5732.369439361667, 5747.310322761212, 5751.539876809845, 5765.769369225184, 5813.244278243801, 5815.9709201453725, 5854.970725146347, 5883.117532370179, 5897.351291358033, 5369.926014796978, 5575.68246893098, 5624.325080990144, 5630.831075067755, 5669.943300566942, 5588.357338905916, 5645.0, 5646.3788983212635, 5653.378128405954, 5655.604107712421, 5798.623089499169, 5903.557233207441, 5922.496587790086, 5928.34788173292, 5961.582689211714, 4049.3116170250537, 4054.695897807735, 4056.371262454324, 4064.1871625674394, 4071.1247081877536, 5390.919136213039, 5400.0, 5574.414686457863, 5601.215829783752, 5664.85837854057, 5446.264754258283, 5476.67139971603, 5484.945150548443, 5491.258680078138, 5496.780128794803, 5247.632665713363, 5379.762654589388, 5415.702136382379, 5432.34811822568, 5437.211604317431, 5427.538659214011, 5429.511343979061, 5446.319210098738, 5453.454654534674, 5471.097268950579, 5452.918206226989, 5468.671879687232, 5469.699166545878, 5498.560115190695, 5506.311711036121, 5128.923066154085, 5313.574914006947, 5328.6802791832615, 5335.359756829205, 5358.437364076872], "value": 4210.091923053766, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.9719611215552, 712.333967740163, 766.9424793140512, 769.9538027718336, 788.136989995955, 14819.851801481982, 15388.846111538882, 15399.461018864342, 15428.382864685413, 15556.222188890566, 15278.847211527882, 15300.846991530081, 15368.385264589402, 15404.537863864101, 15408.229588520586, 669.6183175589915, 803.7869964459423, 822.4201937633953, 824.8432797768405, 825.3892119831312, 785.937125029999, 802.8956235689352, 808.3654331349892, 812.0215140755405, 812.3785304242259, 844.771911583872, 845.8139209373959, 846.5090247656375, 846.6401779243828, 846.8899043124385, 686.9313068693141, 840.0759164918541, 842.8862103616025, 843.228445971938, 843.3506200225822, 607.2955371768727, 623.3112410786107, 624.9218847644045, 628.2774808969675, 629.5781826176473, 14704.0, 14727.263636818223, 14739.55781326562, 14749.0, 14753.631159221106, 14022.649433764136, 14101.435942562286, 14254.786178207336, 14621.6344591385, 14857.777133343008, 12810.55163069288, 13026.153300035467, 13158.276294803782, 13267.933660331733, 13806.102603330752, 4414.31578105391, 4414.448193975753, 4445.399871017404, 4468.2850743881145, 4717.457492388351, 81365.0, 83199.0, 83222.16777832265, 83661.0, 85217.57391213067, 11406.885931140583, 11491.138164637685, 11618.430884184309, 11627.59303424376, 11662.067034637208, 21324.89337553302, 21491.355259341934, 21523.246686365903, 21538.0, 21603.243886463897, 8307.792305192297, 8338.04112527055, 8410.747677569683, 8433.873491897626, 8569.057403685589, 4701.905961880743, 4748.928766068511, 4861.611071114302, 4884.780184891689, 5007.4241462231585, 3135.608048993876, 3232.2565809863863, 3234.223786291273, 3235.9676403235667, 3244.3186930744337, 583.2534356024296, 588.0268156201494, 588.8704485013291, 589.6638915817942, 590.1590233916652, 566.3204155014, 617.7683368736724, 638.6008744534665, 666.776629829003, 690.8169335126196, 9239.307051970995, 9245.72262832116, 9257.861132083024, 9350.485723285285, 9682.854757178648, 571.3800526428871, 583.6643929740417, 590.8345663214307, 671.633959492078, 736.6574542837607, 4717.646176536773, 4815.22956326993, 4922.212446008622, 4979.427365852901, 5041.117804384218, 64892.35107648958, 64998.67500662561, 65236.34763652303, 84195.0, 111717.0, 100619.49690251649, 101044.0, 101380.49309753404, 101390.0, 102714.91855244355, 87959.0, 89254.55372723224, 89426.55286723525, 91761.0, 94751.0, 8945.73162805117, 9217.723468295962, 9234.722958310993, 9267.582958767007, 9300.20948219409, 49044.0, 50461.0, 50622.74688626533, 51961.480385197174, 52024.0, 69351.65324173347, 71911.28088719046, 76747.46505069979, 84621.0, 89738.0, 13271.336433178496, 13323.733525329633, 13508.189508629514, 13767.0, 14102.929485352508, 15230.923845380703, 15810.68378632398, 16406.261718222948, 16791.66416671684, 16976.745348820026, 14840.554783356516, 15300.77048844246, 15607.297671605033, 15810.209489525249, 15885.2851621675, 13184.406701698255, 14059.100752758815, 15070.246487675791, 15201.6199595011, 15981.360745570048, 14154.0, 14439.0, 14876.0, 15016.399344026117, 15429.768553471931, 10751.516181771996, 11187.72030699239, 11226.607068752555, 11320.490577923849, 11418.885811142114, 10463.267571270242, 11889.762204756029, 11951.50373143566, 12244.816327754912, 12333.260004399765], "value": 7576.529664612213, "unit": "score"}], "name": "dromaeo_css", "value": 7209.876827909655, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 111.0, 113.0, 107.0, 112.0, 111.0, 111.0, 110.0, 112.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 116.0, 125.0, 177.0, 121.0, 121.0, 143.0, 118.0, 151.0, 118.0], "value": 133.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 160.0, 160.0, 159.0, 161.0, 162.0, 160.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 102.0, 75.0, 76.0, 75.0, 74.0, 100.0, 75.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 136.0, 85.0, 85.0, 85.0, 121.0, 85.0, 85.0, 126.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0, 118.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 152.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 50.0, 53.0, 51.0, 52.0, 54.0, 52.0, 60.0, 53.0, 52.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 61.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 80.0, 78.0, 77.0, 80.0, 79.0, 78.0, 78.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 122.0, 123.0, 123.0, 121.0, 124.0, 132.0, 136.0, 140.0, 129.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 166.0, 162.0, 159.0, 158.0, 159.0, 158.0, 161.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 63.0, 63.0, 65.0, 63.0, 68.0, 64.0, 62.0], "value": 64.5, "unit": "score"}], "name": "kraken", "value": 1487.6000000000001, "alertThreshold": 2.0}]} 04:45:36 INFO - Return code: 0 04:45:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:45:36 INFO - # TBPL SUCCESS # 04:45:36 INFO - Running post-action listener: _resource_record_post_action 04:45:36 INFO - [mozharness: 2016-08-13 11:45:36.191180Z] Finished run-tests step (success) 04:45:36 INFO - Running post-run listener: _resource_record_post_run 04:45:36 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 7774208; Write bytes: 434475008; Read time: 2036; Write time: 447068 04:45:36 INFO - TinderboxPrint: CPU usage
13.0% 04:45:36 INFO - TinderboxPrint: I/O read bytes / time
7,774,208 / 2,036 04:45:36 INFO - TinderboxPrint: I/O write bytes / time
434,475,008 / 447,068 04:45:36 INFO - TinderboxPrint: CPU idle
8,302.4 (87.0%) 04:45:36 INFO - TinderboxPrint: CPU user
1,194.9 (12.5%) 04:45:36 INFO - TinderboxPrint: Swap in / out
0 / 0 04:45:36 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 19308544; Read time: 136; Write time: 7592 04:45:36 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 5578752; Write bytes: 350941184; Read time: 1436; Write time: 372312 04:45:36 INFO - Running post-run listener: _upload_blobber_files 04:45:36 INFO - Blob upload gear active. 04:45:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:45:36 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 04:45:36 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:45:36 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:45:37 INFO - (blobuploader) - INFO - Open directory for files ... 04:45:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:45:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:45:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:45:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:45:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:45:38 INFO - (blobuploader) - INFO - Done attempting. 04:45:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:45:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:45:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:45:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:45:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:45:41 INFO - (blobuploader) - INFO - Done attempting. 04:45:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:45:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:45:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:45:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:45:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:45:42 INFO - (blobuploader) - INFO - Done attempting. 04:45:42 INFO - (blobuploader) - INFO - Iteration through files over. 04:45:42 INFO - Return code: 0 04:45:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:45:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:45:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d815e255f1fab4a28eca95ac298278daf0b4974777915c8ba317061e77b251778781819610cf797fffe6b6cf8008359f18f8c56e7f5a4b1d9a0784495d111c34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8f8ac7c3f659774aff24a682b6452d3c79cf73ebed91c00dad0bf5968208e115262478f3607853f5d8b7eec3dfe6acfd224bab0212d19087a56a998dc2efd761", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3458c638dfc99782f5590cebeca02eb1d98c239514affdd3d72ff7c3a5007e037b8397cf268cf0cc414883411ba6f471470d341d346c322dcb1f6a098320a56f"} 04:45:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:45:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:45:42 INFO - Contents: 04:45:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d815e255f1fab4a28eca95ac298278daf0b4974777915c8ba317061e77b251778781819610cf797fffe6b6cf8008359f18f8c56e7f5a4b1d9a0784495d111c34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8f8ac7c3f659774aff24a682b6452d3c79cf73ebed91c00dad0bf5968208e115262478f3607853f5d8b7eec3dfe6acfd224bab0212d19087a56a998dc2efd761", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3458c638dfc99782f5590cebeca02eb1d98c239514affdd3d72ff7c3a5007e037b8397cf268cf0cc414883411ba6f471470d341d346c322dcb1f6a098320a56f"} 04:45:42 INFO - Running post-run listener: copy_logs_to_upload_dir 04:45:42 INFO - Copying logs to upload dir... 04:45:42 INFO - mkdir: /builds/slave/test/build/upload/logs 04:45:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.512045 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-08-13 04:45:42.075965) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-13 04:45:42.079570) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1471087193.144881-132153633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d815e255f1fab4a28eca95ac298278daf0b4974777915c8ba317061e77b251778781819610cf797fffe6b6cf8008359f18f8c56e7f5a4b1d9a0784495d111c34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8f8ac7c3f659774aff24a682b6452d3c79cf73ebed91c00dad0bf5968208e115262478f3607853f5d8b7eec3dfe6acfd224bab0212d19087a56a998dc2efd761", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3458c638dfc99782f5590cebeca02eb1d98c239514affdd3d72ff7c3a5007e037b8397cf268cf0cc414883411ba6f471470d341d346c322dcb1f6a098320a56f"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471077002/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011107 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1471077002/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d815e255f1fab4a28eca95ac298278daf0b4974777915c8ba317061e77b251778781819610cf797fffe6b6cf8008359f18f8c56e7f5a4b1d9a0784495d111c34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8f8ac7c3f659774aff24a682b6452d3c79cf73ebed91c00dad0bf5968208e115262478f3607853f5d8b7eec3dfe6acfd224bab0212d19087a56a998dc2efd761", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3458c638dfc99782f5590cebeca02eb1d98c239514affdd3d72ff7c3a5007e037b8397cf268cf0cc414883411ba6f471470d341d346c322dcb1f6a098320a56f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-13 04:45:42.104713) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 04:45:42.105037) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1471087193.144881-132153633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004350 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-13 04:45:42.193359) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-13 04:45:42.193870) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-13 04:45:42.194218) ========= ========= Total master_lag: 0.17 =========