builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1480460464.28 results: success (0) buildid: 20161129150058 builduid: 99b98021a78b435487b74645c0ed54de revision: d254eb61360d3c20172eb7aba1154e2779850263 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 15:01:04.285045) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 15:01:04.286196) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 15:01:04.286574) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 15:01:04.301843) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 15:01:04.302356) ========= 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=5cf47e208febbcd81da23b2e0000026f-1480452856.452689-1637564807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-29 15:01:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-11-29 15:01:04 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.088985 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 15:01:04.406119) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 15:01:04.406599) ========= 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=5cf47e208febbcd81da23b2e0000026f-1480452856.452689-1637564807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020454 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 15:01:04.457842) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 15:01:04.458370) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d254eb61360d3c20172eb7aba1154e2779850263 --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 d254eb61360d3c20172eb7aba1154e2779850263 --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=5cf47e208febbcd81da23b2e0000026f-1480452856.452689-1637564807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-29 15:01:05,002 truncating revision to first 12 chars 2016-11-29 15:01:05,002 Setting DEBUG logging. 2016-11-29 15:01:05,002 attempt 1/10 2016-11-29 15:01:05,002 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d254eb61360d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-29 15:01:05,407 unpacking tar archive at: mozilla-inbound-d254eb61360d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.714285 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 15:01:05.188038) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 15:01:05.188356) ========= script_repo_revision: d254eb61360d3c20172eb7aba1154e2779850263 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 15:01:05.188747) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 15:01:05.189101) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 15:01:05.198223) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-11-29 15:01:05.198588) ========= /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=5cf47e208febbcd81da23b2e0000026f-1480452856.452689-1637564807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:01:05 INFO - MultiFileLogger online at 20161129 15:01:05 in /builds/slave/test 15:01:05 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 15:01:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:01:05 INFO - {'append_to_log': False, 15:01:05 INFO - 'base_work_dir': '/builds/slave/test', 15:01:05 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:01:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:01:05 INFO - 'branch': 'Mozilla-Inbound', 15:01:05 INFO - 'buildbot_json_path': 'buildprops.json', 15:01:05 INFO - 'config_files': ('talos/linux_config.py',), 15:01:05 INFO - 'default_actions': ('clobber', 15:01:05 INFO - 'read-buildbot-config', 15:01:05 INFO - 'download-and-extract', 15:01:05 INFO - 'populate-webroot', 15:01:05 INFO - 'create-virtualenv', 15:01:05 INFO - 'install', 15:01:05 INFO - 'run-tests'), 15:01:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:01:05 INFO - 'download_minidump_stackwalk': True, 15:01:05 INFO - 'download_symbols': 'ondemand', 15:01:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:01:05 INFO - 'tooltool.py': '/tools/tooltool.py', 15:01:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:01:05 INFO - '/tools/misc-python/virtualenv.py')}, 15:01:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:01:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:01:05 INFO - 'installer_path': 'installer.exe', 15:01:05 INFO - 'log_level': 'info', 15:01:05 INFO - 'log_name': 'talos', 15:01:05 INFO - 'log_to_console': True, 15:01:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:01:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:01:05 INFO - 'opt_config_files': (), 15:01:05 INFO - 'pip_index': False, 15:01:05 INFO - 'sps_profile': False, 15:01:05 INFO - 'sps_profile_interval': 0, 15:01:05 INFO - 'suite': 'dromaeojs', 15:01:05 INFO - 'system_bits': '32', 15:01:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:01:05 INFO - 'title': 'talos-linux64-ix-011', 15:01:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:01:05 INFO - 'use_talos_json': True, 15:01:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:01:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:01:05 INFO - 'work_dir': 'build'} 15:01:05 INFO - [mozharness: 2016-11-29 23:01:05.834899Z] Running clobber step. 15:01:05 INFO - Running pre-action listener: _resource_record_pre_action 15:01:05 INFO - Running main action method: clobber 15:01:05 INFO - rmtree: /builds/slave/test/build 15:01:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:01:06 INFO - Running post-action listener: _resource_record_post_action 15:01:06 INFO - [mozharness: 2016-11-29 23:01:06.295577Z] Finished clobber step (success) 15:01:06 INFO - [mozharness: 2016-11-29 23:01:06.295676Z] Running read-buildbot-config step. 15:01:06 INFO - Running pre-action listener: _resource_record_pre_action 15:01:06 INFO - Running main action method: read_buildbot_config 15:01:06 INFO - Using buildbot properties: 15:01:06 INFO - { 15:01:06 INFO - "project": "", 15:01:06 INFO - "product": "firefox", 15:01:06 INFO - "script_repo_revision": "production", 15:01:06 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 15:01:06 INFO - "repository": "", 15:01:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 15:01:06 INFO - "buildid": "20161129150058", 15:01:06 INFO - "stage_platform": "linux64-pgo", 15:01:06 INFO - "basedir": "/builds/slave/test", 15:01:06 INFO - "buildnumber": 2186, 15:01:06 INFO - "platform": "ubuntu64_hw", 15:01:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:01:06 INFO - "slavebuilddir": "test", 15:01:06 INFO - "branch": "mozilla-inbound", 15:01:06 INFO - "revision": "d254eb61360d3c20172eb7aba1154e2779850263", 15:01:06 INFO - "slavename": "talos-linux64-ix-011", 15:01:06 INFO - "builduid": "99b98021a78b435487b74645c0ed54de", 15:01:06 INFO - "repo_path": "integration/mozilla-inbound" 15:01:06 INFO - } 15:01:06 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 15:01:06 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 15:01:06 INFO - Running post-action listener: _resource_record_post_action 15:01:06 INFO - [mozharness: 2016-11-29 23:01:06.298017Z] Finished read-buildbot-config step (success) 15:01:06 INFO - [mozharness: 2016-11-29 23:01:06.298104Z] Running download-and-extract step. 15:01:06 INFO - Running pre-action listener: _resource_record_pre_action 15:01:06 INFO - Running main action method: download_and_extract 15:01:06 INFO - mkdir: /builds/slave/test/build/tests 15:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:06 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:01:06 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:01:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:01:06 INFO - Downloaded 1361 bytes. 15:01:06 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:01:06 INFO - Using the following test package requirements: 15:01:06 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 15:01:06 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:01:06 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:01:06 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:06 INFO - u'jsshell-linux-x86_64.zip'], 15:01:06 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:01:06 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 15:01:06 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:01:06 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:01:06 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:01:06 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:01:06 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:01:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 15:01:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:01:06 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:01:07 INFO - Http code: 200 15:01:07 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 15:01:07 INFO - x-amz-cf-id: 9Qn3ht53ixIcPJ9tQHGiC3hGeOtdOHI49iaxiOmj7luMd_kRz5hAyw== 15:01:07 INFO - x-amz-replication-status: COMPLETED 15:01:07 INFO - x-amz-version-id: NgAiTSUg5NHjTlSrCie7lvcJ.WvdJU8t 15:01:10 INFO - Expected file size: 21781655 15:01:10 INFO - Obtained file size: 21781655 15:01:14 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:01:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 15:01:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:01:14 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:01:14 INFO - Http code: 200 15:01:14 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 15:01:14 INFO - x-amz-cf-id: wuSGOV9Sd4mkEqO3n3foVlTJ9sO1ylQMatC_Vjhsr8y86uLrfKbI-w== 15:01:14 INFO - x-amz-replication-status: COMPLETED 15:01:14 INFO - x-amz-version-id: NgAiTSUg5NHjTlSrCie7lvcJ.WvdJU8t 15:01:14 INFO - Expected file size: 21781655 15:01:14 INFO - Obtained file size: 21781655 15:01:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 15:01:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:01:19 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:01:19 INFO - Http code: 200 15:01:19 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 15:01:19 INFO - x-amz-cf-id: 749dqAVxOBdazkOUKCkMioQdVFjzBYr7i489C9FmmA0qKAJ16es9mg== 15:01:19 INFO - x-amz-replication-status: COMPLETED 15:01:19 INFO - x-amz-version-id: RDqRDktZfsVtVrHlr1W8TlvdGi6tGcpa 15:01:22 INFO - Expected file size: 14409702 15:01:22 INFO - Obtained file size: 14409702 15:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:23 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:01:23 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:01:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:01:28 INFO - Downloaded 59787803 bytes. 15:01:28 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:01:28 INFO - mkdir: /builds/slave/test/properties 15:01:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:01:28 INFO - Writing to file /builds/slave/test/properties/build_url 15:01:28 INFO - Contents: 15:01:28 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:01:28 INFO - Running post-action listener: _resource_record_post_action 15:01:28 INFO - Running post-action listener: set_extra_try_arguments 15:01:28 INFO - [mozharness: 2016-11-29 23:01:28.488148Z] Finished download-and-extract step (success) 15:01:28 INFO - [mozharness: 2016-11-29 23:01:28.488375Z] Running populate-webroot step. 15:01:28 INFO - Running pre-action listener: _resource_record_pre_action 15:01:28 INFO - Running main action method: populate_webroot 15:01:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:01:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:01:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:01:28 INFO - '--tppagecycles', 15:01:28 INFO - '7'], 15:01:28 INFO - 'tests': ['tsvgm']}}, 15:01:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:01:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:01:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:01:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:01:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:01:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:01:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:01:28 INFO - 'talos_options': ['--disable-e10s'], 15:01:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:01:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:01:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:01:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:01:28 INFO - 'talos_options': ['--disable-e10s'], 15:01:28 INFO - 'tests': ['damp', 'tps']}, 15:01:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:01:28 INFO - 'tests': ['damp', 'tps']}, 15:01:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:01:28 INFO - 'tests': ['dromaeo_dom']}, 15:01:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:01:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:01:28 INFO - 'tests': ['basic_compositor_video']}, 15:01:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:01:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:01:28 INFO - 'tests': ['a11yr', 15:01:28 INFO - 'ts_paint', 15:01:28 INFO - 'tpaint', 15:01:28 INFO - 'sessionrestore', 15:01:28 INFO - 'sessionrestore_no_auto_restore', 15:01:28 INFO - 'tabpaint']}, 15:01:28 INFO - 'other-e10s': {'tests': ['a11yr', 15:01:28 INFO - 'ts_paint', 15:01:28 INFO - 'tpaint', 15:01:28 INFO - 'sessionrestore', 15:01:28 INFO - 'sessionrestore_no_auto_restore', 15:01:28 INFO - 'tabpaint']}, 15:01:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:01:28 INFO - 'ts_paint', 15:01:28 INFO - 'tpaint', 15:01:28 INFO - 'sessionrestore', 15:01:28 INFO - 'sessionrestore_no_auto_restore', 15:01:28 INFO - 'tabpaint']}, 15:01:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:01:28 INFO - 'ts_paint', 15:01:28 INFO - 'tpaint', 15:01:28 INFO - 'sessionrestore', 15:01:28 INFO - 'sessionrestore_no_auto_restore', 15:01:28 INFO - 'tabpaint']}, 15:01:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:01:28 INFO - 'tests': ['a11yr', 15:01:28 INFO - 'ts_paint', 15:01:28 INFO - 'tpaint', 15:01:28 INFO - 'sessionrestore', 15:01:28 INFO - 'sessionrestore_no_auto_restore', 15:01:28 INFO - 'tabpaint']}, 15:01:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:01:28 INFO - 'tests': ['a11yr', 15:01:28 INFO - 'ts_paint', 15:01:28 INFO - 'tpaint', 15:01:28 INFO - 'sessionrestore', 15:01:28 INFO - 'sessionrestore_no_auto_restore', 15:01:28 INFO - 'tabpaint']}, 15:01:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:01:28 INFO - 'tests': ['tsvgx', 15:01:28 INFO - 'tsvgr_opacity', 15:01:28 INFO - 'tart', 15:01:28 INFO - 'tscrollx', 15:01:28 INFO - 'cart', 15:01:28 INFO - 'tsvg_static']}, 15:01:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:01:28 INFO - 'tsvgr_opacity', 15:01:28 INFO - 'tart', 15:01:28 INFO - 'tscrollx', 15:01:28 INFO - 'cart', 15:01:28 INFO - 'tsvg_static']}, 15:01:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:01:28 INFO - 'talos_options': ['--disable-e10s'], 15:01:28 INFO - 'tests': ['tp5o']}, 15:01:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:01:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:01:28 INFO - 'talos_options': ['--disable-e10s', 15:01:28 INFO - '--xperf_path', 15:01:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:01:28 INFO - 'tests': ['tp5n']}, 15:01:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:01:28 INFO - 'talos_options': ['--xperf_path', 15:01:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:01:28 INFO - 'tests': ['tp5n']}}, 15:01:28 INFO - 'talos.zip': {'path': '', 15:01:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:01:28 INFO - Running post-action listener: _resource_record_post_action 15:01:28 INFO - [mozharness: 2016-11-29 23:01:28.507801Z] Finished populate-webroot step (success) 15:01:28 INFO - [mozharness: 2016-11-29 23:01:28.507889Z] Running create-virtualenv step. 15:01:28 INFO - Running pre-action listener: _resource_record_pre_action 15:01:28 INFO - Running main action method: create_virtualenv 15:01:28 INFO - Creating virtualenv /builds/slave/test/build/venv 15:01:28 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 15:01:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:01:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:01:28 INFO - Using real prefix '/usr' 15:01:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:01:29 INFO - Installing distribute.............................................................................................................................................................................................done. 15:01:31 INFO - Installing pip.................done. 15:01:31 INFO - Return code: 0 15:01:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:01:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:01:31 INFO - Reading from file tmpfile_stdout 15:01:31 INFO - Output received: 15:01:31 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:01:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:01:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:31 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 0x7f359ef21e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe44130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed2fc0>, '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 0xed3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed4350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480452856.452689-1637564807', '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 15:01:31 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 15:01:31 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 15:01:31 INFO - Using env: {'DISPLAY': ':0', 15:01:31 INFO - 'HOME': '/home/cltbld', 15:01:31 INFO - 'LANG': 'en_US.UTF-8', 15:01:31 INFO - 'LANGUAGE': 'en_US:en', 15:01:31 INFO - 'LOGNAME': 'cltbld', 15:01:31 INFO - 'MAIL': '/var/mail/cltbld', 15:01:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:31 INFO - 'MOZ_NO_REMOTE': '1', 15:01:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:31 INFO - 'NO_EM_RESTART': '1', 15:01:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:31 INFO - 'PWD': '/builds/slave/test', 15:01:31 INFO - 'SHELL': '/bin/bash', 15:01:31 INFO - 'SHLVL': '1', 15:01:31 INFO - 'TERM': 'linux', 15:01:31 INFO - 'TMOUT': '86400', 15:01:31 INFO - 'USER': 'cltbld', 15:01:31 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480452856.452689-1637564807', 15:01:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:31 INFO - '_': '/tools/buildbot/bin/python'} 15:01:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:31 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 15:01:31 INFO - Cleaning up... 15:01:31 INFO - Return code: 0 15:01:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:01:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:31 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 0x7f359ef21e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe44130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed2fc0>, '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 0xed3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed4350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480452856.452689-1637564807', '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 15:01:31 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 15:01:31 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 15:01:31 INFO - Using env: {'DISPLAY': ':0', 15:01:31 INFO - 'HOME': '/home/cltbld', 15:01:31 INFO - 'LANG': 'en_US.UTF-8', 15:01:31 INFO - 'LANGUAGE': 'en_US:en', 15:01:31 INFO - 'LOGNAME': 'cltbld', 15:01:31 INFO - 'MAIL': '/var/mail/cltbld', 15:01:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:31 INFO - 'MOZ_NO_REMOTE': '1', 15:01:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:31 INFO - 'NO_EM_RESTART': '1', 15:01:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:31 INFO - 'PWD': '/builds/slave/test', 15:01:31 INFO - 'SHELL': '/bin/bash', 15:01:31 INFO - 'SHLVL': '1', 15:01:31 INFO - 'TERM': 'linux', 15:01:31 INFO - 'TMOUT': '86400', 15:01:31 INFO - 'USER': 'cltbld', 15:01:31 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480452856.452689-1637564807', 15:01:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:31 INFO - '_': '/tools/buildbot/bin/python'} 15:01:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:31 INFO - Downloading/unpacking psutil>=3.1.1 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:01:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:01:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:01:33 INFO - Installing collected packages: psutil 15:01:33 INFO - Running setup.py install for psutil 15:01:33 INFO - building 'psutil._psutil_linux' extension 15:01:33 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 15:01:34 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 15:01:34 INFO - building 'psutil._psutil_posix' extension 15:01:34 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 15:01:34 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 15:01:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:01:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:01:34 INFO - Successfully installed psutil 15:01:34 INFO - Cleaning up... 15:01:34 INFO - Return code: 0 15:01:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:01:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f359ef21e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe44130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed2fc0>, '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 0xed3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed4350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480452856.452689-1637564807', '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 15:01:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:01:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:01:34 INFO - Using env: {'DISPLAY': ':0', 15:01:34 INFO - 'HOME': '/home/cltbld', 15:01:34 INFO - 'LANG': 'en_US.UTF-8', 15:01:34 INFO - 'LANGUAGE': 'en_US:en', 15:01:34 INFO - 'LOGNAME': 'cltbld', 15:01:34 INFO - 'MAIL': '/var/mail/cltbld', 15:01:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:34 INFO - 'MOZ_NO_REMOTE': '1', 15:01:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:34 INFO - 'NO_EM_RESTART': '1', 15:01:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:34 INFO - 'PWD': '/builds/slave/test', 15:01:34 INFO - 'SHELL': '/bin/bash', 15:01:34 INFO - 'SHLVL': '1', 15:01:34 INFO - 'TERM': 'linux', 15:01:34 INFO - 'TMOUT': '86400', 15:01:34 INFO - 'USER': 'cltbld', 15:01:34 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480452856.452689-1637564807', 15:01:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:34 INFO - '_': '/tools/buildbot/bin/python'} 15:01:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:01:34 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 15:01:34 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 15:01:34 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 15:01:34 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 15:01:34 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 15:01:34 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 15:01:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:01:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:01:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:01:36 INFO - Installing collected packages: mozsystemmonitor 15:01:36 INFO - Running setup.py install for mozsystemmonitor 15:01:36 INFO - Successfully installed mozsystemmonitor 15:01:36 INFO - Cleaning up... 15:01:36 INFO - Return code: 0 15:01:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:36 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 0x7f359ef21e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe44130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed2fc0>, '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 0xed3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed4350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480452856.452689-1637564807', '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 15:01:36 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 15:01:36 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 15:01:36 INFO - Using env: {'DISPLAY': ':0', 15:01:36 INFO - 'HOME': '/home/cltbld', 15:01:36 INFO - 'LANG': 'en_US.UTF-8', 15:01:36 INFO - 'LANGUAGE': 'en_US:en', 15:01:36 INFO - 'LOGNAME': 'cltbld', 15:01:36 INFO - 'MAIL': '/var/mail/cltbld', 15:01:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:36 INFO - 'MOZ_NO_REMOTE': '1', 15:01:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:36 INFO - 'NO_EM_RESTART': '1', 15:01:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:36 INFO - 'PWD': '/builds/slave/test', 15:01:36 INFO - 'SHELL': '/bin/bash', 15:01:36 INFO - 'SHLVL': '1', 15:01:36 INFO - 'TERM': 'linux', 15:01:36 INFO - 'TMOUT': '86400', 15:01:36 INFO - 'USER': 'cltbld', 15:01:36 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480452856.452689-1637564807', 15:01:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:36 INFO - '_': '/tools/buildbot/bin/python'} 15:01:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:37 INFO - Downloading/unpacking jsonschema==2.5.1 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:01:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:01:38 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 15:01:38 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 15:01:38 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 15:01:38 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 15:01:38 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 15:01:38 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 15:01:39 INFO - Downloading functools32-3.2.3-2.tar.gz 15:01:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:01:39 INFO - warning: no files found matching '*.txt' 15:01:39 INFO - no previously-included directories found matching 'build' 15:01:39 INFO - no previously-included directories found matching 'dist' 15:01:39 INFO - no previously-included directories found matching '.git*' 15:01:39 INFO - Installing collected packages: jsonschema, functools32 15:01:39 INFO - Running setup.py install for functools32 15:01:39 INFO - warning: no files found matching '*.txt' 15:01:39 INFO - no previously-included directories found matching 'build' 15:01:39 INFO - no previously-included directories found matching 'dist' 15:01:39 INFO - no previously-included directories found matching '.git*' 15:01:39 INFO - Successfully installed jsonschema functools32 15:01:39 INFO - Cleaning up... 15:01:39 INFO - Return code: 0 15:01:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:01: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')]} 15:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01: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')]} 15:01:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01: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', '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 0x7f359ef21e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe44130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed2fc0>, '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 0xed3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed4350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480452856.452689-1637564807', '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 15:01: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:01: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 functools32==3.2.3-2 15:01:39 INFO - Using env: {'DISPLAY': ':0', 15:01:39 INFO - 'HOME': '/home/cltbld', 15:01:39 INFO - 'LANG': 'en_US.UTF-8', 15:01:39 INFO - 'LANGUAGE': 'en_US:en', 15:01:39 INFO - 'LOGNAME': 'cltbld', 15:01:39 INFO - 'MAIL': '/var/mail/cltbld', 15:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:39 INFO - 'MOZ_NO_REMOTE': '1', 15:01:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:39 INFO - 'NO_EM_RESTART': '1', 15:01:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:39 INFO - 'PWD': '/builds/slave/test', 15:01:39 INFO - 'SHELL': '/bin/bash', 15:01:39 INFO - 'SHLVL': '1', 15:01:39 INFO - 'TERM': 'linux', 15:01:39 INFO - 'TMOUT': '86400', 15:01:39 INFO - 'USER': 'cltbld', 15:01:39 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480452856.452689-1637564807', 15:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:39 INFO - '_': '/tools/buildbot/bin/python'} 15:01:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:01:39 INFO - Cleaning up... 15:01:39 INFO - Return code: 0 15:01:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:01: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')]} 15:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01: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')]} 15:01:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01: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', '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 0x7f359ef21e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe44130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed2fc0>, '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 0xed3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed4350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480452856.452689-1637564807', '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 15:01: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:01: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 blobuploader==1.2.4 15:01:39 INFO - Using env: {'DISPLAY': ':0', 15:01:39 INFO - 'HOME': '/home/cltbld', 15:01:39 INFO - 'LANG': 'en_US.UTF-8', 15:01:39 INFO - 'LANGUAGE': 'en_US:en', 15:01:39 INFO - 'LOGNAME': 'cltbld', 15:01:39 INFO - 'MAIL': '/var/mail/cltbld', 15:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:39 INFO - 'MOZ_NO_REMOTE': '1', 15:01:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:39 INFO - 'NO_EM_RESTART': '1', 15:01:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:39 INFO - 'PWD': '/builds/slave/test', 15:01:39 INFO - 'SHELL': '/bin/bash', 15:01:39 INFO - 'SHLVL': '1', 15:01:39 INFO - 'TERM': 'linux', 15:01:39 INFO - 'TMOUT': '86400', 15:01:39 INFO - 'USER': 'cltbld', 15:01:39 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480452856.452689-1637564807', 15:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:39 INFO - '_': '/tools/buildbot/bin/python'} 15:01:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:39 INFO - Downloading/unpacking blobuploader==1.2.4 15:01:39 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 15:01:39 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 15:01:39 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 15:01:39 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 15:01:39 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 15:01:39 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 15:01:41 INFO - Downloading blobuploader-1.2.4.tar.gz 15:01:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:01:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:01:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:01:42 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 15:01:42 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 15:01:42 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 15:01:42 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 15:01:42 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 15:01:42 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 15:01:42 INFO - Downloading docopt-0.6.1.tar.gz 15:01:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:01:42 INFO - Installing collected packages: blobuploader, requests, docopt 15:01:42 INFO - Running setup.py install for blobuploader 15:01:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:01:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:01:42 INFO - Running setup.py install for requests 15:01:43 INFO - Running setup.py install for docopt 15:01:43 INFO - Successfully installed blobuploader requests docopt 15:01:43 INFO - Cleaning up... 15:01:43 INFO - Return code: 0 15:01:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:43 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 0x7f359ef21e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe44130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed2fc0>, '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 0xed3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed4350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480452856.452689-1637564807', '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 15:01:43 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 15:01:43 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 15:01:43 INFO - Using env: {'DISPLAY': ':0', 15:01:43 INFO - 'HOME': '/home/cltbld', 15:01:43 INFO - 'LANG': 'en_US.UTF-8', 15:01:43 INFO - 'LANGUAGE': 'en_US:en', 15:01:43 INFO - 'LOGNAME': 'cltbld', 15:01:43 INFO - 'MAIL': '/var/mail/cltbld', 15:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:43 INFO - 'MOZ_NO_REMOTE': '1', 15:01:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:43 INFO - 'NO_EM_RESTART': '1', 15:01:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:43 INFO - 'PWD': '/builds/slave/test', 15:01:43 INFO - 'SHELL': '/bin/bash', 15:01:43 INFO - 'SHLVL': '1', 15:01:43 INFO - 'TERM': 'linux', 15:01:43 INFO - 'TMOUT': '86400', 15:01:43 INFO - 'USER': 'cltbld', 15:01:43 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480452856.452689-1637564807', 15:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:43 INFO - '_': '/tools/buildbot/bin/python'} 15:01:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:01:43 INFO - Running setup.py (path:/tmp/pip-AyjDb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:01:43 INFO - Running setup.py (path:/tmp/pip-EM0pEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:01:43 INFO - Running setup.py (path:/tmp/pip-jbigos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:01:43 INFO - Running setup.py (path:/tmp/pip-a_u2_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:01:43 INFO - Running setup.py (path:/tmp/pip-fpdmSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:01:43 INFO - Running setup.py (path:/tmp/pip-h7AB3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:01:43 INFO - Running setup.py (path:/tmp/pip-bDOd1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:01:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:01:43 INFO - Running setup.py (path:/tmp/pip-lUUHIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:01:44 INFO - Running setup.py (path:/tmp/pip-Vtfzjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:01:44 INFO - Running setup.py (path:/tmp/pip-dB4yVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:01:44 INFO - Running setup.py (path:/tmp/pip-W5jYOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:01:44 INFO - Running setup.py (path:/tmp/pip-F0d_on-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:01:44 INFO - Running setup.py (path:/tmp/pip-zxuWoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:01:44 INFO - Running setup.py (path:/tmp/pip-umAt1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:44 INFO - Running setup.py (path:/tmp/pip-q3dlg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:01:44 INFO - Running setup.py (path:/tmp/pip-wmXja8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:01:44 INFO - Running setup.py (path:/tmp/pip-ked00Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:01:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:01:44 INFO - Running setup.py install for manifestparser 15:01:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:01:44 INFO - Running setup.py install for mozcrash 15:01:44 INFO - Running setup.py install for mozdebug 15:01:45 INFO - Running setup.py install for mozdevice 15:01:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:01:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:01:45 INFO - Running setup.py install for mozfile 15:01:45 INFO - Running setup.py install for mozhttpd 15:01:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:01:45 INFO - Running setup.py install for mozinfo 15:01:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:01:45 INFO - Running setup.py install for mozInstall 15:01:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:01:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:01:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:01:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:01:45 INFO - Running setup.py install for mozleak 15:01:45 INFO - Running setup.py install for mozlog 15:01:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:01:45 INFO - Running setup.py install for moznetwork 15:01:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:01:45 INFO - Running setup.py install for mozprocess 15:01:45 INFO - Running setup.py install for mozprofile 15:01:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:01:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:01:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:01:46 INFO - Running setup.py install for mozrunner 15:01:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:01:46 INFO - Running setup.py install for mozscreenshot 15:01:46 INFO - Running setup.py install for moztest 15:01:46 INFO - Running setup.py install for mozversion 15:01:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:01:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:01:46 INFO - Cleaning up... 15:01:46 INFO - Return code: 0 15:01:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:46 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 0x7f359ef21e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe44130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed2fc0>, '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 0xed3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed4350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480452856.452689-1637564807', '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 15:01:46 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 15:01:46 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 15:01:46 INFO - Using env: {'DISPLAY': ':0', 15:01:46 INFO - 'HOME': '/home/cltbld', 15:01:46 INFO - 'LANG': 'en_US.UTF-8', 15:01:46 INFO - 'LANGUAGE': 'en_US:en', 15:01:46 INFO - 'LOGNAME': 'cltbld', 15:01:46 INFO - 'MAIL': '/var/mail/cltbld', 15:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:46 INFO - 'MOZ_NO_REMOTE': '1', 15:01:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:46 INFO - 'NO_EM_RESTART': '1', 15:01:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:46 INFO - 'PWD': '/builds/slave/test', 15:01:46 INFO - 'SHELL': '/bin/bash', 15:01:46 INFO - 'SHLVL': '1', 15:01:46 INFO - 'TERM': 'linux', 15:01:46 INFO - 'TMOUT': '86400', 15:01:46 INFO - 'USER': 'cltbld', 15:01:46 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480452856.452689-1637564807', 15:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:46 INFO - '_': '/tools/buildbot/bin/python'} 15:01:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:01:46 INFO - Running setup.py (path:/tmp/pip-3sTZkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:01:46 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)) 15:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:01:46 INFO - Running setup.py (path:/tmp/pip-rXmwP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:01:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 15:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:01:46 INFO - Running setup.py (path:/tmp/pip-vO4fn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:01:46 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)) 15:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:01:46 INFO - Running setup.py (path:/tmp/pip-XG7ggV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:01:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 15:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:01:47 INFO - Running setup.py (path:/tmp/pip-l3xOu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:01:47 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)) 15:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:01:47 INFO - Running setup.py (path:/tmp/pip-LEYn9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:01:47 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)) 15:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:01:47 INFO - Running setup.py (path:/tmp/pip-ByP5m0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:01:47 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)) 15:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:01:47 INFO - Running setup.py (path:/tmp/pip-E9KBP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:01:47 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)) 15:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:01:47 INFO - Running setup.py (path:/tmp/pip-QgEUnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:01:47 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)) 15:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:01:47 INFO - Running setup.py (path:/tmp/pip-4yEKyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:01:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 15:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:01:47 INFO - Running setup.py (path:/tmp/pip-PBT3_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:01:47 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)) 15:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:01:47 INFO - Running setup.py (path:/tmp/pip-uvIFo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:01:47 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)) 15:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:01:47 INFO - Running setup.py (path:/tmp/pip-AgfIBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:01:47 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)) 15:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:01:47 INFO - Running setup.py (path:/tmp/pip-oNb2nx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:01:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 15:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:47 INFO - Running setup.py (path:/tmp/pip-GEzEBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:47 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)) 15:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:01:47 INFO - Running setup.py (path:/tmp/pip-nXVbJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:01:47 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)) 15:01:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:01:47 INFO - Running setup.py (path:/tmp/pip-TZY5er-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:01:48 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)) 15:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:01:48 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)) 15:01:48 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:01:48 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:01:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:49 INFO - Downloading blessings-1.6.tar.gz 15:01:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:01:50 INFO - Installing collected packages: blessings 15:01:50 INFO - Running setup.py install for blessings 15:01:50 INFO - Successfully installed blessings 15:01:50 INFO - Cleaning up... 15:01:50 INFO - Return code: 0 15:01:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:01:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:01:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:01:50 INFO - Reading from file tmpfile_stdout 15:01:50 INFO - Current package versions: 15:01:50 INFO - argparse == 1.2.1 15:01:50 INFO - blessings == 1.6 15:01:50 INFO - blobuploader == 1.2.4 15:01:50 INFO - docopt == 0.6.1 15:01:50 INFO - functools32 == 3.2.3-2 15:01:50 INFO - jsonschema == 2.5.1 15:01:50 INFO - manifestparser == 1.1 15:01:50 INFO - mozInstall == 1.12 15:01:50 INFO - mozcrash == 1.0 15:01:50 INFO - mozdebug == 0.1 15:01:50 INFO - mozdevice == 0.49 15:01:50 INFO - mozfile == 1.2 15:01:50 INFO - mozhttpd == 0.7 15:01:50 INFO - mozinfo == 0.9 15:01:50 INFO - mozleak == 0.1 15:01:50 INFO - mozlog == 3.4 15:01:50 INFO - moznetwork == 0.27 15:01:50 INFO - mozprocess == 0.23 15:01:50 INFO - mozprofile == 0.28 15:01:50 INFO - mozrunner == 6.13 15:01:50 INFO - mozscreenshot == 0.1 15:01:50 INFO - mozsystemmonitor == 0.3 15:01:50 INFO - moztest == 0.7 15:01:50 INFO - mozversion == 1.4 15:01:50 INFO - psutil == 3.1.1 15:01:50 INFO - requests == 1.2.3 15:01:50 INFO - wsgiref == 0.1.2 15:01:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:50 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 0x7f359ef21e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe44130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed2fc0>, '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 0xed3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed4350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480452856.452689-1637564807', '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 15:01:50 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 15:01:50 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 15:01:50 INFO - Using env: {'DISPLAY': ':0', 15:01:50 INFO - 'HOME': '/home/cltbld', 15:01:50 INFO - 'LANG': 'en_US.UTF-8', 15:01:50 INFO - 'LANGUAGE': 'en_US:en', 15:01:50 INFO - 'LOGNAME': 'cltbld', 15:01:50 INFO - 'MAIL': '/var/mail/cltbld', 15:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:50 INFO - 'MOZ_NO_REMOTE': '1', 15:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:50 INFO - 'NO_EM_RESTART': '1', 15:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:50 INFO - 'PWD': '/builds/slave/test', 15:01:50 INFO - 'SHELL': '/bin/bash', 15:01:50 INFO - 'SHLVL': '1', 15:01:50 INFO - 'TERM': 'linux', 15:01:50 INFO - 'TMOUT': '86400', 15:01:50 INFO - 'USER': 'cltbld', 15:01:50 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480452856.452689-1637564807', 15:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:50 INFO - '_': '/tools/buildbot/bin/python'} 15:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:50 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)) 15:01:50 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)) 15:01:50 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)) 15:01:50 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)) 15:01:50 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)) 15:01:50 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)) 15:01:50 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)) 15:01:50 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)) 15:01:50 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)) 15:01:50 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)) 15:01:50 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)) 15:01:50 INFO - Cleaning up... 15:01:50 INFO - Return code: 0 15:01:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f359ef21e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca8b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe44130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed2fc0>, '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 0xed3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed4350>, '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': '5cf47e208febbcd81da23b2e0000026f-1480452856.452689-1637564807', '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 15:01:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:01:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:01:50 INFO - Using env: {'DISPLAY': ':0', 15:01:50 INFO - 'HOME': '/home/cltbld', 15:01:50 INFO - 'LANG': 'en_US.UTF-8', 15:01:50 INFO - 'LANGUAGE': 'en_US:en', 15:01:50 INFO - 'LOGNAME': 'cltbld', 15:01:50 INFO - 'MAIL': '/var/mail/cltbld', 15:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:50 INFO - 'MOZ_NO_REMOTE': '1', 15:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:50 INFO - 'NO_EM_RESTART': '1', 15:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:50 INFO - 'PWD': '/builds/slave/test', 15:01:50 INFO - 'SHELL': '/bin/bash', 15:01:50 INFO - 'SHLVL': '1', 15:01:50 INFO - 'TERM': 'linux', 15:01:50 INFO - 'TMOUT': '86400', 15:01:50 INFO - 'USER': 'cltbld', 15:01:50 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480452856.452689-1637564807', 15:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:50 INFO - '_': '/tools/buildbot/bin/python'} 15:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:01:50 INFO - Cleaning up... 15:01:50 INFO - Return code: 0 15:01:50 INFO - Running post-action listener: _resource_record_post_action 15:01:50 INFO - Running post-action listener: _start_resource_monitoring 15:01:50 INFO - Starting resource monitoring. 15:01:50 INFO - [mozharness: 2016-11-29 23:01:50.943987Z] Finished create-virtualenv step (success) 15:01:50 INFO - [mozharness: 2016-11-29 23:01:50.944460Z] Running install step. 15:01:50 INFO - Running pre-action listener: _resource_record_pre_action 15:01:50 INFO - Running main action method: install 15:01:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:01:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:01:51 INFO - Reading from file tmpfile_stdout 15:01:51 INFO - Detecting whether we're running mozinstall >=1.0... 15:01:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:01:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:01:51 INFO - Reading from file tmpfile_stdout 15:01:51 INFO - Output received: 15:01:51 INFO - Usage: mozinstall [options] installer 15:01:51 INFO - Options: 15:01:51 INFO - -h, --help show this help message and exit 15:01:51 INFO - -d DEST, --destination=DEST 15:01:51 INFO - Directory to install application into. [default: 15:01:51 INFO - "/builds/slave/test"] 15:01:51 INFO - --app=APP Application being installed. [default: firefox] 15:01:51 INFO - mkdir: /builds/slave/test/build/application 15:01:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:01:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:02:08 INFO - Reading from file tmpfile_stdout 15:02:08 INFO - Output received: 15:02:08 INFO - /builds/slave/test/build/application/firefox/firefox 15:02:08 INFO - Running post-action listener: _resource_record_post_action 15:02:08 INFO - [mozharness: 2016-11-29 23:02:08.220182Z] Finished install step (success) 15:02:08 INFO - [mozharness: 2016-11-29 23:02:08.220451Z] Running run-tests step. 15:02:08 INFO - Running pre-action listener: _resource_record_pre_action 15:02:08 INFO - Running main action method: run_tests 15:02:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:02:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:02:08 INFO - Python 2.7.3 15:02:08 INFO - Return code: 0 15:02:08 INFO - grabbing minidump binary from tooltool 15:02: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')]} 15:02:08 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 0xed2fc0>, '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 0xed3ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed4350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:02:08 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 15:02:08 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 15:02:08 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 15:02:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:02:08 INFO - Return code: 0 15:02:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:02:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:02:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:02:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:02:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:02:08 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/1480450312/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 15:02:08 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/1480450312/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 15:02:08 INFO - Using env: {'DISPLAY': ':0', 15:02:08 INFO - 'HOME': '/home/cltbld', 15:02:08 INFO - 'LANG': 'en_US.UTF-8', 15:02:08 INFO - 'LANGUAGE': 'en_US:en', 15:02:08 INFO - 'LOGNAME': 'cltbld', 15:02:08 INFO - 'MAIL': '/var/mail/cltbld', 15:02:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:02:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:08 INFO - 'MOZ_NO_REMOTE': '1', 15:02:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:08 INFO - 'NO_EM_RESTART': '1', 15:02:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:08 INFO - 'PWD': '/builds/slave/test', 15:02:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:02:08 INFO - 'SHELL': '/bin/bash', 15:02:08 INFO - 'SHLVL': '1', 15:02:08 INFO - 'TERM': 'linux', 15:02:08 INFO - 'TMOUT': '86400', 15:02:08 INFO - 'USER': 'cltbld', 15:02:08 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1480452856.452689-1637564807', 15:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:08 INFO - '_': '/tools/buildbot/bin/python'} 15:02:08 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/1480450312/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 15:02:08 INFO - mozversion application_buildid: 20161129121152 15:02:08 INFO - mozversion application_changeset: d254eb61360d3c20172eb7aba1154e2779850263 15:02:08 INFO - mozversion application_display_name: Nightly 15:02:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:02:08 INFO - mozversion application_name: Firefox 15:02:08 INFO - mozversion application_remotingname: firefox 15:02:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:02:08 INFO - mozversion application_vendor: Mozilla 15:02:08 INFO - mozversion application_version: 53.0a1 15:02:08 INFO - mozversion platform_buildid: 20161129121152 15:02:08 INFO - mozversion platform_changeset: d254eb61360d3c20172eb7aba1154e2779850263 15:02:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:02:08 INFO - mozversion platform_version: 53.0a1 15:02:08 INFO - using testdate: 1480460528 15:02:08 INFO - actual date: 1480460528 15:02:08 INFO - starting webserver on 'localhost:55931' 15:02:08 INFO - SUITE-START | Running 2 tests 15:02:08 INFO - TEST-START | dromaeo_css 15:02:08 INFO - operating with platform_type : linux_ 15:02:08 INFO - Initialising browser for dromaeo_css test... 15:02:08 INFO - TEST-INFO | started process 24843 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoXQvud/profile http://localhost:55931/getInfo.html) 15:02:12 INFO - PROCESS | 24843 | __metrics Screen width/height:1600/1200 15:02:12 INFO - PROCESS | 24843 | colorDepth:24 15:02:12 INFO - PROCESS | 24843 | Browser inner width/height: 1024/697 15:02:12 INFO - PROCESS | 24843 | __metrics 15:02:13 INFO - PROCESS | 24843 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:02:13 INFO - PROCESS | 24843 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:02:14 INFO - PROCESS | 24843 | console.error: PushService: 15:02:14 INFO - PROCESS | 24843 | stateChangeProcessEnqueue: Error transitioning state 15:02:14 INFO - PROCESS | 24843 | UnknownError 15:02:14 INFO - TEST-INFO | 24843: exit 0 15:02:14 INFO - Browser initialized. 15:02:14 INFO - Running cycle 1/1 for dromaeo_css test... 15:02:14 INFO - TEST-INFO | started process 24930 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoXQvud/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:02:26 INFO - PROCESS | 24930 | RSS: Main: 172990464 15:02:26 INFO - PROCESS | 24930 | 15:03:17 INFO - PROCESS | 24930 | 1480460597916 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] 15:05:28 INFO - PROCESS | 24930 | Cycle 1(1): loaded http://localhost:55931/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55931/tests/dromaeo/cssquery-ext.html) 15:05:31 INFO - PROCESS | 24930 | RSS: Main: 417611776 15:05:31 INFO - PROCESS | 24930 | 15:08:34 INFO - PROCESS | 24930 | Cycle 1(1): loaded http://localhost:55931/tests/dromaeo/cssquery-ext.html (next: http://localhost:55931/tests/dromaeo/cssquery-jquery.html) 15:08:34 INFO - PROCESS | 24930 | RSS: Main: 292216832 15:08:34 INFO - PROCESS | 24930 | 15:11:36 INFO - PROCESS | 24930 | Cycle 1(1): loaded http://localhost:55931/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55931/tests/dromaeo/cssquery-mootools.html) 15:11:37 INFO - PROCESS | 24930 | RSS: Main: 272445440 15:11:37 INFO - PROCESS | 24930 | 15:14:39 INFO - PROCESS | 24930 | Cycle 1(1): loaded http://localhost:55931/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55931/tests/dromaeo/cssquery-prototype.html) 15:14:39 INFO - PROCESS | 24930 | RSS: Main: 260501504 15:14:39 INFO - PROCESS | 24930 | 15:17:42 INFO - PROCESS | 24930 | Cycle 1(1): loaded http://localhost:55931/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55931/tests/dromaeo/cssquery-yui.html) 15:17:43 INFO - PROCESS | 24930 | RSS: Main: 229085184 15:17:43 INFO - PROCESS | 24930 | 15:20:46 INFO - PROCESS | 24930 | Cycle 1(1): loaded http://localhost:55931/tests/dromaeo/cssquery-yui.html (next: http://localhost:55931/tests/dromaeo/cssquery-dojo.html) 15:20:46 INFO - PROCESS | 24930 | RSS: Main: 321933312 15:20:46 INFO - PROCESS | 24930 | 15:20:46 INFO - PROCESS | 24930 | __start_tp_report 15:20:46 INFO - PROCESS | 24930 | _x_x_mozilla_page_load 15:20:46 INFO - PROCESS | 24930 | _x_x_mozilla_page_load_details 15:20:46 INFO - PROCESS | 24930 | |i|pagename|runs| 15:20:46 INFO - PROCESS | 24930 | |0;dojo.html;3114.657387687355;3136.6392864820546;3137.8901738439145;3162.4623813951625;3183.347413780174;5313.442088580701;5411.864703382413;5423.105187644044;5429.321334833146;5491.643043202189;5411.756470958807;5426.348838139419;5428.67427954323;5436.075867102592;5436.510714035736;4899.975500122503;4915.5821755150855;4931.630127740415;4935.901281974358;4973.278874563204;4969.8012079516775;5031.748412579356;5033.597312215014;5035.169197082477;5042.092423363793;4934.432540257881;4962.503749625027;4986;4987.576056035223;5023.899522009558;5006.899862002758;5024.924626130611;5034.84895453137;5036.219385995177;5082.593392528589;4821.807127714887;4843.636727245471;4874;4944.258361245806;4945.109880221558;5321.600879934021;5323.441038690959;5351.57187425005;5380.058489764276;5411.053065713524;5742;5774.769009239625;5778.162166485878;5789;5789.507891829199;5688.544916406678;5758.683272420015;5759.68321742304;5841.561882858802;5843.357230704619;5386.3536375634785;5420.728963551806;5422.945770542244;5457.918131228074;5466.9179962300595;5915.467607915309;5928.67392293428;5931;5932.228810254639;5936.614120082181;5564.443555644403;5605.887882242332;5703.800366987219;5709.8287051388525;5710.828675139753;5708.686022268732;5761;5780.248567686258;5795.217645617788;5857.355690874;5743.655380677173;5748.6838223898085;5795.971020144957;5796.362400135981;5811.912821307684;5620.353659329147;5811.88376232473;5812.505936995318;5820.185174075633;5857.4435428634215;4389.1660584488845;4431.446069241345;4434.401355816924;4460.286354183315;4460.955390446119;4009.398590211433;4010.8997275068355;4034.91930161401;4040.6363427291685;4057.7159598827798;5485.835424937259;5503.229547863302;5503.422140675251;5507.862303442446;5510.448955104538;5668.26312579362;5702.486776190163;5738.512226460714;5834.862201870595;5850.063989761617;5403.378611459654;5460.481254280837;5472.781088756485;5485.341758988867;5501.889962200734;5001.524855138756;5007;5026.52248036436;5037.974810125926;5045.747712614355;6009.248843894513;6016.608920420159;6019.428154325332;6021.608595441195;6057.333693293646;5583.330000399978;5677.489025987681;5687.77248910039;5753;5815.156802263564;5916.881662366814;5918.201042859159;5919.644821310735;5922.052471604695;5923.111533270044;5636.88726225465;5639.605227634026;5639.746211420414;5641.548676105819;5642.85892852682;5707.743151558273;5742.19609254713;5744.281964754406;5744.913826292693;5757.683327417032;5588.664680119044;5590.5248053915875;5597.160425936142;5600.915986260128;5631.774729010957;5543.473370029841;5560.332760068818;5562.749676264659;5564.91652625219;5566.443355664401;5545.805896793593;5552.056150454513;5601.747921343468;5605.299337582802;5608.971955140199;5709.600327977002;5714.485696287354;5729.312482502127;5733.369329373682;5735;5485.588580856532;5534.280543529316;5585.720713964367;5596.580256480862;5602.159676048625 15:20:46 INFO - PROCESS | 24930 | |1;ext.html;578.026026145944;595.7736060297086;607.6870411737953;621.6891554222891;622.3061286665367;40085.398719019235;40857;41272.79363603181;41344.58655413441;43862.56137438625;42268.36597451041;42922.570774292246;42931.14137717244;42938;43000.784996075054;7795.649195786204;7991.081025682034;8607.440516366432;8761.56192190391;8766.211041006309;9836.360636558637;10109.292349535535;10109.494525273743;10350;10364.740881477948;10386.688399347993;10451.163906887468;10462.633807816728;10464.790704185913;10466.895331046668;10312.071913527781;10395.84406233907;10401.635942742043;10401.687949361494;10407.635732749393;10275.075243228146;10331.586736530606;10400.739981500446;10400.739981500446;10403.635872744419;39989.60010399888;40305.395419068445;40313.79843100795;40336.39495407571;40346.79826600877;3620.6560376764164;3758.537057151773;3903.512060992376;4038.2125485530332;4045.9797701011603;29962.850185748932;30072.84963575168;30278.24304392386;30310.393792124036;30326.090217293517;4166.958330416717;4179.665626749853;4204.474440694913;4261.339492378686;4367.956320436819;306475;321287;324919;328433;456855;53168;53813.192802108;54247;54274.728626357406;54350.45649543454;57848.42151578431;57978.71010645004;58069.41930580725;58397.416025840044;58411.707941460874;15653.765193522106;15769.526914192364;15800.130992795506;15817.367305307658;15830.44593439224;10460.058594726359;10494.842577361345;10501.21240906935;10614.89385106139;12690;19202.90398548026;19511.272205847104;20074.39776806698;20323.79676203219;20361;7219.783406497813;7272.818179545554;7279.781606551812;7440.702371905063;7500.849983000309;922.3405265235389;1011.367895065584;1040.2302296300834;1147.0536807134147;1150.269578817457;31026.534601980988;31133.844330778655;31497.52753708696;31616.525752113736;31828;1086.1039642295138;1090.2150451674781;1106.7952428800697;1154.2901115813881;1162.6802629277017;15745;16443.424480143138;16541.66916661684;16620.168991550618;16913.492595222164;491077;491775;499123;502633;779198;53373;53782.19326710102;53825.730871346175;54349.1847622286;54377.72811135919;1305.5430599290362;1311.1346511302495;1357.0907491980595;1360.8911287097008;1373.9038267321191;29236.26909327284;30456.543151852296;30584.235394114436;30701;31116.688833112286;45371.31943020923;46014;46054.30918536158;46130;46131;356447;357483;358606;358951;360505;24062;24571.50856982886;26301.34246643849;26306.4738705221;26687.33281667974;38134.2373152541;43820.34269485896;44024;44273.33589996088;44426;36785.63214367929;36903;37001.814990924875;37655.43516847304;37667;36306.22419451939;37670.8116459416;37766.622333777406;38657.806710966266;38951.80524097475;33708.146051966396;33868.49197261994;33924.3215135691;34173.48739768856;34728.958131256106;31248.375032498767;33269.334613308085;33496.33007339888;33818.66181338155;33959.83020084884;26038.218853434428;26116.73883261219;26291.21126366212;26421.73578264193;26685.455979913742 15:20:46 INFO - PROCESS | 24930 | |2;jquery.html;376.46965086921654;377.1909254648777;391.45392177911816;393.13314142316216;400.6454287955159;14300;15720.921395393021;18152.727709084375;18862;18883.527911802194;18399.172037258322;18467.538311542183;18545.35091271806;18677;18679;4132.607402296777;5404.216388623657;5628.690422026787;5629.183768353586;5631.324241091075;4178.080822219122;5879.176915231871;6126.479249263818;6168.352323006065;6260.841744277301;6027.849303767419;6177.536684748639;6187.783427580036;6198.256209254896;6206.875862482771;6217.658028808413;6239.906401403982;6246.812595622138;6249.96875015622;6250.874982500347;5357.1696387060065;5512.173174023928;5547.25112109864;5552.972235138839;5562.415946325658;17500.912495437442;17614.735778963197;19609.705854412194;22142.22502212415;22377.664335034988;2224.9777502224933;2272.704548408713;2297.9195728149602;2574.382148284398;2751.55975043994;13191.340432978408;13766.587002389944;14076;14452.421903123863;14586.34361453737;1793.1213705284317;1808.9005104719236;1817.3003393693523;1826.4246762269975;1907.6184763047445;68334;75078;75761;77545;90727;10761.677149685365;10899.182561307935;11169.609063682732;11290.943545282385;11443.313401195956;15496;15500.379984800707;15516;15522.301496432689;15529.767053494206;7877.527348359117;8224;8272;8323.791905202419;8436.957815210884;7902.723404680809;7915.960420197862;7950.522968621901;8168.959155204186;8205.056418511947;4685;4706.694064885772;4746.377168526945;4805.951940480621;4837.105135549935;1922.7596550431197;1964.3714011516463;1981.6631172700675;2014.3956812956055;2060.3509894383224;719.442432115115;803.6642314712095;814.7352110564091;958.8322043642474;1007.7178390050798;18352.63294734098;19377.903110484356;19441.12514936803;19592.689608286153;19667;945.5697657565792;976.7362812040709;981.2689546288061;1010.2978429991233;1013.807376598444;7951.960240198878;10770.838437423445;10784.460776961121;10839.891601084046;10846.349219046882;431897;434765;435517;435914;435952;91309;93309.53345233231;93664.53167734118;94021;94604.52697736467;975.707287813653;989.8218320702342;1009.742515658517;1017.1151098544166;1020.4744556553381;16245.918770406071;16566.66866662636;17032.74450883213;17107.65784684324;17115.486535403958;32817;42244.1551168981;43586.56413435952;44196.337054944845;44333.77833110814;57993.71003145126;58265.417345826;58309.708451457474;59342;61648.383516164264;8102.189781021851;8413.411061225655;8507.191816777397;8629.525376104375;8801.735947921572;9523.428594284365;12795.232286062866;13211.273379964194;13285.335733213495;13493.527726529524;11310.83033754478;11469.827952580885;11631.76736465283;11725.41372931367;11736.647900562997;11014.339139651647;11021.228514003942;11031.889681103086;11112.888871111509;11434.249093348104;11374.715632109264;11388.430578471209;11566.132540059361;11660.941695291469;11697.122715796178;8391.790205244917;8417.957910210409;8505.914940850513;8600.13998600135;8714.869276960977;9324.393914395543;11482.13883958723;11675.591354302898;11769.823452648046;11951.521939122338 15:20:46 INFO - PROCESS | 24930 | |3;mootools.html;1433.2547075520733;1461.9122852628843;1564.7496400575903;1688.6707092117042;1747.6679430908127;7359;7624.390048796097;7909.367250619951;8332.541710205936;8399.87400188997;7958.283754462097;8205;8205.261526462617;8402.621882015308;8410.705625303115;2248.955020899581;2282.669012993115;2291.6218823894037;2292.747797742247;2294.0250393582746;2051.4871282179456;2270.6821045053707;2290.3815969688176;2315.8031567316716;2323.5236776460783;2027;2166.750823655284;2212.557488502306;2221.4335344487213;2233.486298151426;2171.4788450771857;2175.2930297653324;2175.673648952654;2181.3564998325533;2227.610168220555;2240.2271216430304;2255.492514184312;2258.8080013198896;2260.5930932432157;2261.2198791416936;8298.460600060977;8346.207110324509;8346.248837604644;8362.16378362165;8369.121242269595;4975.925361119586;5141.997310524449;5147.150720131174;5149.665271757362;5152.433232344477;3002.6396832380256;3058.189579761365;3299.6535363786697;3302.488114342281;3309.3712194682935;1016.5767924905192;1032.6643840751785;1041.3075304922218;1043.7234132954773;1070.0904231403322;11424.314541127476;11539.942300288445;11586.131040171937;11609;11621.186516943817;4426.977865110718;4524.547545245449;4635.23518619424;4651.232546629836;4662.067586482717;9672;9683;9687.079727425884;9689.806203875884;9692.51537423126;5141.460146684619;5144.6398752087;5148.433672296044;5148.536631703165;5149.201873709581;4612.815487380534;4648.465426475998;4672.6261899047995;4739.5307454689155;4742.264948932921;3715;3745.138618117848;3821.9617803821607;3854.7494412863075;3871.4192871069563;1131.8189089745601;1281.1736430002595;1284.4733659199683;1286.8327117474855;1293.1012946002627;794.5987276425484;849.2738708404349;877;879.134052957836;920.0615372320196;5448.91826622601;5456.727163641882;5556;5561.944380556142;5660.5471562274915;886.1404437695425;890.8218356328761;894.2845723421237;916.8441364967971;924.5977999570208;3537.8231088445473;3586.5158203642695;3591.838367273479;3790.9431358529646;3823.617638236154;9684.128428441474;10215.131713804261;10267.640632577824;10276.691699249035;10281.845772313422;9982.850257246002;10200.591976320864;10209.591616335263;10219.437930913722;10294.536745846455;7749.496282741717;7905.762827115196;7911.248431399008;7917.920820791718;7941.404394670423;5374.48942350476;5387.649802762808;5398.892022159614;5451.236826844324;5611.130274807411;8893.4663920165;9226.169644732006;9353.859692104488;9471.526423678652;9549.809003820024;9079.773005674911;9284.675036373694;9398.01320861327;9434.575444105169;9539.666111686058;7124.536905101152;7412.777616671508;7569.243075692387;7574.431917606092;7580.658870350958;7930.682772689028;8106.39202059836;8174.509529428254;8182.672693092448;8182.959085204536;7022.543534670434;7112.466565007749;7179.748708795167;7187.640617969185;7226.168990565942;7046.929530704628;7087.255838136922;7090.751823686146;7147.892781608384;7171.605561694157;6473.8705225896165;6579.243387010555;6617.933820661732;6625.138731964814;6625.138731964814;4500.977495112504;4505.887352816206;4532.342810292555;4559.977200113978;4685.5782979532005;4708.223143181337;4813.470518242921;4815.22956326986;4853.369062021915;4919.827806026772 15:20:46 INFO - PROCESS | 24930 | |4;prototype.html;322.9504597897408;344.2220581485842;345.6129135368388;349.5997083339575;350.76323481649894;5184.418752280553;5248.160294352909;5254.92117618236;5261.605379596526;5302.674331417145;5143.717095559743;5158.767855446505;5209.479052094798;5214.243934629477;5262.710550919698;4182.247195504808;4193.5387107418155;4200.390943313218;4205.264078786216;4210.789460526977;3921.960780392188;3929.7052721045893;4173.499180098393;4190.559991200926;4192.895177620553;4127.772972486512;4135.648469880064;4155.896102597429;4156.812943417538;4163.791810409482;4132.442120313749;4132.834686612532;4151.377293405983;4153.626173644371;4154.397612346208;3695.2424752925585;3707.888763337104;3710.7402481826284;3713.1274150574595;3717.553893532793;5035.84892453227;5096.694198348111;5106.361704786902;5127.743612819344;5146.511081447256;4675.696079754839;4719.716816990992;4732.219183834698;4746.928796068028;4752.643551733634;5353.57171426285;5395.919061214085;5433.293671822637;5434.3207099112615;5436.695193153654;4029.005642207097;4043.0903046814524;4053.250148722496;4055.762992287351;4067.2678917794783;5577.494076599295;5593.8321850344555;5630.943690563083;5638.126090455986;5650.434956504358;4099.61053699904;4117.773522456294;4128.545859955402;4135.97932010338;4141.378793180987;3889.4749208857006;4088.407180958804;4142.233686767958;4169.749815011109;4184.853530126431;4674.579287864109;4678.508756580578;4684.625229981593;4689.20283551797;4697.271922851964;5491.505764481216;5513.61404701667;5514.889702205934;5550.639208451437;5553.4724201200825;1337.8996575256895;1350.4328182163515;1378.6415531961761;1380.751464736357;1386.5355106039387;943.9575219115156;957.913787759105;962.8651988721584;964.0985678390728;968.9418634881789;5046.1926091825135;5050.873728156826;5064.696118232918;5106.540411362921;5121.743912804345;5344.706041167696;5355.196720491879;5361.463853614685;5399.811006614828;5407.810726624549;4835.782389792468;4993.775280112403;5026.89946201074;5041.218611115283;5047.97476012625;2857.3713782967716;2860.9427811443657;2862.2128914548666;2867.5842002909462;2868.770498360126;5552.361478430033;5554.638948468418;5557.833265002057;5566.443355664401;5571.888562228733;5253.870417860178;5420.376656684453;5450.91823622646;5456.345238571317;5515.117581187071;5482.862928426821;5525.198846167364;5535.889282214333;5540.612157148961;5544.807866308683;5350.713231677324;5376.865578360573;5395.946040539701;5400.7569659364635;5406.648567843077;5173.3533308336455;5302.257683924331;5311.203319502106;5321.7073060980465;5340.2256672783005;5486.396496385315;5487.2317875496665;5520.447955204608;5560.13735398646;5568.832935011957;3785.9399368176955;3953.723239373216;3954;3955.8417663293144;3957.149212919121;5154.57734864613;5576.581756368208;5576.665400076008;5600.4959553640365;5600.691961942132;5487.670739755627;5493.340799103973;5494.835154945358;5503.697296648723;5504.587155963239;5217.961063844531;5393.9730301348245;5452.146270268128;5478.479544443271;5499.230107784993;5420.972895135499;5444;5447.618666693452;5455.454454554513;5456.217329162077;5430.076886929152;5505.834824955257;5548.9722551386985;5568.582356323373;5572.108462645957;5308.416074231909;5433.212184233343;5435.266239057677;5447.55639755473;5463.07127788269 15:20:46 INFO - PROCESS | 24930 | |5;yui.html;733.7065173930428;740.0490369874713;745.0537816972445;784.0982869699844;809.4091313341264;15850.76223856643;16816.83183168168;16822.83177168228;16880.155992200373;16887.240074196674;14851.108933464;14877.702445951074;14966.625834354147;14975.326110325035;14999.400023999027;652.9151210342649;672.6166085331363;765.7587859824165;767.4244316762442;789.940754443419;788.1566723605744;798.6126728536655;799.160881074872;799.5842162075717;799.7800604833689;848.8132610825609;849.8215374771274;850.1880703927765;850.4174640371334;850.5024560632038;690.1511141296234;708.2563308526027;798.253632853284;841.8484672758901;841.8568843296624;603.704184949376;604.6644112517552;604.8518113062283;605.1104875832563;605.267626172332;13761.31193440324;13917;13918.09532380392;13971.371288292052;14001.439942402292;14385.208813515252;14409.207493587848;14425.422983080663;14463.13221206731;14540.345684444226;12560.434780434902;12600.117991740583;12637.304948227844;12806.61580152597;13037.413316400785;4156.792160391999;4200.285951388271;4210.200061988243;4317.4819021717285;4364.803583838703;82346;83320.99999999939;84361.57819210926;84479.57760211221;84584.57707711423;10807.567697292177;11172.497237624326;11177.83233251502;11194.216404851744;11194.44027798623;21324.89337553302;21409.571808564055;21410.678839817414;21506.677399839016;21586.46033849135;7989.440739148204;8026.799330016796;8036;8173.427860049858;8457.238848503664;4205.5794420557695;4340.197063543254;4344.500382456058;4355.128974205171;4385.824567017347;3446.483027545838;3543.8582456701442;3577.123604716861;3583.498310236569;3586.278586278601;595.7348979703991;613.098744845077;621.8476473263988;621.9813405597839;638.996805015972;566.4165909113619;602.810114813841;626.5113211694885;645.3836586060302;649.8245473722163;8494.575271236414;8971.685990990283;8986.505742184112;9065.501397423204;9152.90847091534;604.5556515960766;623.1120653069358;640.2764875690533;643.9774607888795;702.4240123099112;4266.914661706811;4339.7830108494445;4412.33814927757;4453.131639330364;4576.542345765463;61498.38501614927;74658.6267068672;76332.61833690797;83086;87166.12833871707;54477.182842257396;68167.81986161692;71110;73071.26928730645;73566.89649655152;64695;66045.66977165084;66750.66624666845;67393.32606673871;67695;8293;8455.196756308142;8525.658973640984;8805.295576353748;8842.119990206698;36970.44544331783;42301.153976919675;43213.48752793637;44635.553644463136;45122.77438612786;58060.419395805504;59983.70008150106;60520.69739651273;60832;61497;10824.296420732628;10960.56157753681;11154.665360039211;11315.660530184108;11799.941000295286;11451.656450306504;11502.654920352403;11543.36511491876;11810.645680629596;12051.276923384625;11501.424928753362;11863.406829658656;12026.15816892809;12192.634220973385;12244.204126731735;12272.631821045383;12555;12904.612861614167;13009.869901301245;13137.146085504412;11635.941820290844;12039.398030098635;12057;12293.75412491763;12683.175593586388;9792.902070979198;9974.202063834731;10122.746931326776;10215;10305.53625086888;10241.283110182216;10359.63741269052;10992.010719035325;11575.189736718348;11917.82123268169 15:20:46 INFO - PROCESS | 24930 | __end_tp_report 15:20:46 INFO - PROCESS | 24930 | __start_cc_report 15:20:46 INFO - PROCESS | 24930 | _x_x_mozilla_cycle_collect,2469 15:20:46 INFO - PROCESS | 24930 | __end_cc_report 15:20:46 INFO - PROCESS | 24930 | __startTimestamp1480461646647__endTimestamp 15:20:46 INFO - PROCESS | 24930 | 15:20:46 INFO - PROCESS | 24930 | ------- Summary: start ------- 15:20:46 INFO - PROCESS | 24930 | Number of tests: 6 15:20:46 INFO - PROCESS | 24930 | 15:20:46 INFO - PROCESS | 24930 | [#0] dojo.html Cycles:165 Average:5375.47 Median:5564.44 stddev:588.40 (10.6%) stddev-sans-first:562.84 15:20:46 INFO - PROCESS | 24930 | Values: 3114.7 3136.6 3137.9 3162.5 3183.3 5313.4 5411.9 5423.1 5429.3 5491.6 5411.8 5426.3 5428.7 5436.1 5436.5 4900.0 4915.6 4931.6 4935.9 4973.3 4969.8 5031.7 5033.6 5035.2 5042.1 4934.4 4962.5 4986.0 4987.6 5023.9 5006.9 5024.9 5034.8 5036.2 5082.6 4821.8 4843.6 4874.0 4944.3 4945.1 5321.6 5323.4 5351.6 5380.1 5411.1 5742.0 5774.8 5778.2 5789.0 5789.5 5688.5 5758.7 5759.7 5841.6 5843.4 5386.4 5420.7 5422.9 5457.9 5466.9 5915.5 5928.7 5931.0 5932.2 5936.6 5564.4 5605.9 5703.8 5709.8 5710.8 5708.7 5761.0 5780.2 5795.2 5857.4 5743.7 5748.7 5796.0 5796.4 5811.9 5620.4 5811.9 5812.5 5820.2 5857.4 4389.2 4431.4 4434.4 4460.3 4461.0 4009.4 4010.9 4034.9 4040.6 4057.7 5485.8 5503.2 5503.4 5507.9 5510.4 5668.3 5702.5 5738.5 5834.9 5850.1 5403.4 5460.5 5472.8 5485.3 5501.9 5001.5 5007.0 5026.5 5038.0 5045.7 6009.2 6016.6 6019.4 6021.6 6057.3 5583.3 5677.5 5687.8 5753.0 5815.2 5916.9 5918.2 5919.6 5922.1 5923.1 5636.9 5639.6 5639.7 5641.5 5642.9 5707.7 5742.2 5744.3 5744.9 5757.7 5588.7 5590.5 5597.2 5600.9 5631.8 5543.5 5560.3 5562.7 5564.9 5566.4 5545.8 5552.1 5601.7 5605.3 5609.0 5709.6 5714.5 5729.3 5733.4 5735.0 5485.6 5534.3 5585.7 5596.6 5602.2 15:20:46 INFO - PROCESS | 24930 | 15:20:46 INFO - PROCESS | 24930 | [#1] ext.html Cycles:180 Average:57134.83 Median:34451.22 stddev:116080.87 (336.9%) stddev-sans-first:116328.84 15:20:46 INFO - PROCESS | 24930 | Values: 578.0 595.8 607.7 621.7 622.3 40085.4 40857.0 41272.8 41344.6 43862.6 42268.4 42922.6 42931.1 42938.0 43000.8 7795.6 7991.1 8607.4 8761.6 8766.2 9836.4 10109.3 10109.5 10350.0 10364.7 10386.7 10451.2 10462.6 10464.8 10466.9 10312.1 10395.8 10401.6 10401.7 10407.6 10275.1 10331.6 10400.7 10400.7 10403.6 39989.6 40305.4 40313.8 40336.4 40346.8 3620.7 3758.5 3903.5 4038.2 4046.0 29962.9 30072.8 30278.2 30310.4 30326.1 4167.0 4179.7 4204.5 4261.3 4368.0 306475.0 321287.0 324919.0 328433.0 456855.0 53168.0 53813.2 54247.0 54274.7 54350.5 57848.4 57978.7 58069.4 58397.4 58411.7 15653.8 15769.5 15800.1 15817.4 15830.4 10460.1 10494.8 10501.2 10614.9 12690.0 19202.9 19511.3 20074.4 20323.8 20361.0 7219.8 7272.8 7279.8 7440.7 7500.8 922.3 1011.4 1040.2 1147.1 1150.3 31026.5 31133.8 31497.5 31616.5 31828.0 1086.1 1090.2 1106.8 1154.3 1162.7 15745.0 16443.4 16541.7 16620.2 16913.5 491077.0 491775.0 499123.0 502633.0 779198.0 53373.0 53782.2 53825.7 54349.2 54377.7 1305.5 1311.1 1357.1 1360.9 1373.9 29236.3 30456.5 30584.2 30701.0 31116.7 45371.3 46014.0 46054.3 46130.0 46131.0 356447.0 357483.0 358606.0 358951.0 360505.0 24062.0 24571.5 26301.3 26306.5 26687.3 38134.2 43820.3 44024.0 44273.3 44426.0 36785.6 36903.0 37001.8 37655.4 37667.0 36306.2 37670.8 37766.6 38657.8 38951.8 33708.1 33868.5 33924.3 34173.5 34729.0 31248.4 33269.3 33496.3 33818.7 33959.8 26038.2 26116.7 26291.2 26421.7 26685.5 15:20:46 INFO - PROCESS | 24930 | 15:20:46 INFO - PROCESS | 24930 | [#2] jquery.html Cycles:180 Average:27309.85 Median:384.32 stddev:72030.93 (18742.3%) stddev-sans-first:72204.60 15:20:46 INFO - PROCESS | 24930 | Values: 376.5 377.2 391.5 393.1 400.6 14300.0 15720.9 18152.7 18862.0 18883.5 18399.2 18467.5 18545.4 18677.0 18679.0 4132.6 5404.2 5628.7 5629.2 5631.3 4178.1 5879.2 6126.5 6168.4 6260.8 6027.8 6177.5 6187.8 6198.3 6206.9 6217.7 6239.9 6246.8 6250.0 6250.9 5357.2 5512.2 5547.3 5553.0 5562.4 17500.9 17614.7 19609.7 22142.2 22377.7 2225.0 2272.7 2297.9 2574.4 2751.6 13191.3 13766.6 14076.0 14452.4 14586.3 1793.1 1808.9 1817.3 1826.4 1907.6 68334.0 75078.0 75761.0 77545.0 90727.0 10761.7 10899.2 11169.6 11290.9 11443.3 15496.0 15500.4 15516.0 15522.3 15529.8 7877.5 8224.0 8272.0 8323.8 8437.0 7902.7 7916.0 7950.5 8169.0 8205.1 4685.0 4706.7 4746.4 4806.0 4837.1 1922.8 1964.4 1981.7 2014.4 2060.4 719.4 803.7 814.7 958.8 1007.7 18352.6 19377.9 19441.1 19592.7 19667.0 945.6 976.7 981.3 1010.3 1013.8 7952.0 10770.8 10784.5 10839.9 10846.3 431897.0 434765.0 435517.0 435914.0 435952.0 91309.0 93309.5 93664.5 94021.0 94604.5 975.7 989.8 1009.7 1017.1 1020.5 16245.9 16566.7 17032.7 17107.7 17115.5 32817.0 42244.2 43586.6 44196.3 44333.8 57993.7 58265.4 58309.7 59342.0 61648.4 8102.2 8413.4 8507.2 8629.5 8801.7 9523.4 12795.2 13211.3 13285.3 13493.5 11310.8 11469.8 11631.8 11725.4 11736.6 11014.3 11021.2 11031.9 11112.9 11434.2 11374.7 11388.4 11566.1 11660.9 11697.1 8391.8 8418.0 8505.9 8600.1 8714.9 9324.4 11482.1 11675.6 11769.8 11951.5 15:20:46 INFO - PROCESS | 24930 | 15:20:46 INFO - PROCESS | 24930 | [#3] mootools.html Cycles:180 Average:5454.04 Median:5143.32 stddev:3062.30 (59.5%) stddev-sans-first:3055.98 15:20:46 INFO - PROCESS | 24930 | Values: 1433.3 1461.9 1564.7 1688.7 1747.7 7359.0 7624.4 7909.4 8332.5 8399.9 7958.3 8205.0 8205.3 8402.6 8410.7 2249.0 2282.7 2291.6 2292.7 2294.0 2051.5 2270.7 2290.4 2315.8 2323.5 2027.0 2166.8 2212.6 2221.4 2233.5 2171.5 2175.3 2175.7 2181.4 2227.6 2240.2 2255.5 2258.8 2260.6 2261.2 8298.5 8346.2 8346.2 8362.2 8369.1 4975.9 5142.0 5147.2 5149.7 5152.4 3002.6 3058.2 3299.7 3302.5 3309.4 1016.6 1032.7 1041.3 1043.7 1070.1 11424.3 11539.9 11586.1 11609.0 11621.2 4427.0 4524.5 4635.2 4651.2 4662.1 9672.0 9683.0 9687.1 9689.8 9692.5 5141.5 5144.6 5148.4 5148.5 5149.2 4612.8 4648.5 4672.6 4739.5 4742.3 3715.0 3745.1 3822.0 3854.7 3871.4 1131.8 1281.2 1284.5 1286.8 1293.1 794.6 849.3 877.0 879.1 920.1 5448.9 5456.7 5556.0 5561.9 5660.5 886.1 890.8 894.3 916.8 924.6 3537.8 3586.5 3591.8 3790.9 3823.6 9684.1 10215.1 10267.6 10276.7 10281.8 9982.9 10200.6 10209.6 10219.4 10294.5 7749.5 7905.8 7911.2 7917.9 7941.4 5374.5 5387.6 5398.9 5451.2 5611.1 8893.5 9226.2 9353.9 9471.5 9549.8 9079.8 9284.7 9398.0 9434.6 9539.7 7124.5 7412.8 7569.2 7574.4 7580.7 7930.7 8106.4 8174.5 8182.7 8183.0 7022.5 7112.5 7179.7 7187.6 7226.2 7046.9 7087.3 7090.8 7147.9 7171.6 6473.9 6579.2 6617.9 6625.1 6625.1 4501.0 4505.9 4532.3 4560.0 4685.6 4708.2 4813.5 4815.2 4853.4 4919.8 15:20:46 INFO - PROCESS | 24930 | 15:20:46 INFO - PROCESS | 24930 | [#4] prototype.html Cycles:180 Average:4568.38 Median:5211.86 stddev:1308.48 (25.1%) stddev-sans-first:1272.76 15:20:46 INFO - PROCESS | 24930 | Values: 323.0 344.2 345.6 349.6 350.8 5184.4 5248.2 5254.9 5261.6 5302.7 5143.7 5158.8 5209.5 5214.2 5262.7 4182.2 4193.5 4200.4 4205.3 4210.8 3922.0 3929.7 4173.5 4190.6 4192.9 4127.8 4135.6 4155.9 4156.8 4163.8 4132.4 4132.8 4151.4 4153.6 4154.4 3695.2 3707.9 3710.7 3713.1 3717.6 5035.8 5096.7 5106.4 5127.7 5146.5 4675.7 4719.7 4732.2 4746.9 4752.6 5353.6 5395.9 5433.3 5434.3 5436.7 4029.0 4043.1 4053.3 4055.8 4067.3 5577.5 5593.8 5630.9 5638.1 5650.4 4099.6 4117.8 4128.5 4136.0 4141.4 3889.5 4088.4 4142.2 4169.7 4184.9 4674.6 4678.5 4684.6 4689.2 4697.3 5491.5 5513.6 5514.9 5550.6 5553.5 1337.9 1350.4 1378.6 1380.8 1386.5 944.0 957.9 962.9 964.1 968.9 5046.2 5050.9 5064.7 5106.5 5121.7 5344.7 5355.2 5361.5 5399.8 5407.8 4835.8 4993.8 5026.9 5041.2 5048.0 2857.4 2860.9 2862.2 2867.6 2868.8 5552.4 5554.6 5557.8 5566.4 5571.9 5253.9 5420.4 5450.9 5456.3 5515.1 5482.9 5525.2 5535.9 5540.6 5544.8 5350.7 5376.9 5395.9 5400.8 5406.6 5173.4 5302.3 5311.2 5321.7 5340.2 5486.4 5487.2 5520.4 5560.1 5568.8 3785.9 3953.7 3954.0 3955.8 3957.1 5154.6 5576.6 5576.7 5600.5 5600.7 5487.7 5493.3 5494.8 5503.7 5504.6 5218.0 5394.0 5452.1 5478.5 5499.2 5421.0 5444.0 5447.6 5455.5 5456.2 5430.1 5505.8 5549.0 5568.6 5572.1 5308.4 5433.2 5435.3 5447.6 5463.1 15:20:46 INFO - PROCESS | 24930 | 15:20:46 INFO - PROCESS | 24930 | [#5] yui.html Cycles:180 Average:17563.10 Median:44879.16 stddev:23208.39 (51.7%) stddev-sans-first:23239.09 15:20:46 INFO - PROCESS | 24930 | Values: 733.7 740.0 745.1 784.1 809.4 15850.8 16816.8 16822.8 16880.2 16887.2 14851.1 14877.7 14966.6 14975.3 14999.4 652.9 672.6 765.8 767.4 789.9 788.2 798.6 799.2 799.6 799.8 848.8 849.8 850.2 850.4 850.5 690.2 708.3 798.3 841.8 841.9 603.7 604.7 604.9 605.1 605.3 13761.3 13917.0 13918.1 13971.4 14001.4 14385.2 14409.2 14425.4 14463.1 14540.3 12560.4 12600.1 12637.3 12806.6 13037.4 4156.8 4200.3 4210.2 4317.5 4364.8 82346.0 83321.0 84361.6 84479.6 84584.6 10807.6 11172.5 11177.8 11194.2 11194.4 21324.9 21409.6 21410.7 21506.7 21586.5 7989.4 8026.8 8036.0 8173.4 8457.2 4205.6 4340.2 4344.5 4355.1 4385.8 3446.5 3543.9 3577.1 3583.5 3586.3 595.7 613.1 621.8 622.0 639.0 566.4 602.8 626.5 645.4 649.8 8494.6 8971.7 8986.5 9065.5 9152.9 604.6 623.1 640.3 644.0 702.4 4266.9 4339.8 4412.3 4453.1 4576.5 61498.4 74658.6 76332.6 83086.0 87166.1 54477.2 68167.8 71110.0 73071.3 73566.9 64695.0 66045.7 66750.7 67393.3 67695.0 8293.0 8455.2 8525.7 8805.3 8842.1 36970.4 42301.2 43213.5 44635.6 45122.8 58060.4 59983.7 60520.7 60832.0 61497.0 10824.3 10960.6 11154.7 11315.7 11799.9 11451.7 11502.7 11543.4 11810.6 12051.3 11501.4 11863.4 12026.2 12192.6 12244.2 12272.6 12555.0 12904.6 13009.9 13137.1 11635.9 12039.4 12057.0 12293.8 12683.2 9792.9 9974.2 10122.7 10215.0 10305.5 10241.3 10359.6 10992.0 11575.2 11917.8 15:20:46 INFO - PROCESS | 24930 | -------- Summary: end -------- 15:20:46 INFO - PROCESS | 24930 | 15:20:47 INFO - TEST-INFO | 24930: exit 0 15:20:47 INFO - TEST-OK | dromaeo_css | took 1119090ms 15:20:47 INFO - TEST-START | kraken 15:20:47 INFO - operating with platform_type : linux_ 15:20:47 INFO - Initialising browser for kraken test... 15:20:47 INFO - TEST-INFO | started process 25238 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbpoY6x/profile http://localhost:55931/getInfo.html) 15:20:51 INFO - PROCESS | 25238 | __metrics Screen width/height:1600/1200 15:20:51 INFO - PROCESS | 25238 | colorDepth:24 15:20:51 INFO - PROCESS | 25238 | Browser inner width/height: 1024/697 15:20:51 INFO - PROCESS | 25238 | __metrics 15:20:52 INFO - PROCESS | 25238 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:20:52 INFO - PROCESS | 25238 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:20:53 INFO - PROCESS | 25238 | console.error: PushService: 15:20:53 INFO - PROCESS | 25238 | stateChangeProcessEnqueue: Error transitioning state 15:20:53 INFO - PROCESS | 25238 | UnknownError 15:20:54 INFO - TEST-INFO | 25238: exit 0 15:20:54 INFO - Browser initialized. 15:20:54 INFO - Running cycle 1/1 for kraken test... 15:20:54 INFO - TEST-INFO | started process 25321 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbpoY6x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:21:06 INFO - PROCESS | 25321 | RSS: Main: 173608960 15:21:06 INFO - PROCESS | 25321 | 15:21:08 INFO - PROCESS | 25321 | Cycle 1(1): loaded http://localhost:55931/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55931/tests/kraken/driver.html?testName=audio-beat-detection) 15:21:09 INFO - PROCESS | 25321 | RSS: Main: 239296512 15:21:09 INFO - PROCESS | 25321 | 15:21:12 INFO - PROCESS | 25321 | Cycle 1(1): loaded http://localhost:55931/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55931/tests/kraken/driver.html?testName=audio-dft) 15:21:12 INFO - PROCESS | 25321 | RSS: Main: 217477120 15:21:12 INFO - PROCESS | 25321 | 15:21:15 INFO - PROCESS | 25321 | Cycle 1(1): loaded http://localhost:55931/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55931/tests/kraken/driver.html?testName=audio-fft) 15:21:16 INFO - PROCESS | 25321 | RSS: Main: 299044864 15:21:16 INFO - PROCESS | 25321 | 15:21:18 INFO - PROCESS | 25321 | Cycle 1(1): loaded http://localhost:55931/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55931/tests/kraken/driver.html?testName=audio-oscillator) 15:21:19 INFO - PROCESS | 25321 | RSS: Main: 210784256 15:21:19 INFO - PROCESS | 25321 | 15:21:21 INFO - PROCESS | 25321 | Cycle 1(1): loaded http://localhost:55931/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55931/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:21:21 INFO - PROCESS | 25321 | RSS: Main: 213630976 15:21:21 INFO - PROCESS | 25321 | 15:21:24 INFO - PROCESS | 25321 | Cycle 1(1): loaded http://localhost:55931/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55931/tests/kraken/driver.html?testName=imaging-darkroom) 15:21:25 INFO - PROCESS | 25321 | RSS: Main: 252825600 15:21:25 INFO - PROCESS | 25321 | 15:21:28 INFO - PROCESS | 25321 | Cycle 1(1): loaded http://localhost:55931/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55931/tests/kraken/driver.html?testName=imaging-desaturate) 15:21:29 INFO - PROCESS | 25321 | RSS: Main: 253030400 15:21:29 INFO - PROCESS | 25321 | 15:21:32 INFO - PROCESS | 25321 | Cycle 1(1): loaded http://localhost:55931/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55931/tests/kraken/driver.html?testName=json-parse-financial) 15:21:32 INFO - PROCESS | 25321 | RSS: Main: 251936768 15:21:32 INFO - PROCESS | 25321 | 15:21:34 INFO - PROCESS | 25321 | Cycle 1(1): loaded http://localhost:55931/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55931/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:21:35 INFO - PROCESS | 25321 | RSS: Main: 213737472 15:21:35 INFO - PROCESS | 25321 | 15:21:36 INFO - PROCESS | 25321 | Cycle 1(1): loaded http://localhost:55931/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55931/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:21:37 INFO - PROCESS | 25321 | RSS: Main: 221462528 15:21:37 INFO - PROCESS | 25321 | 15:21:39 INFO - PROCESS | 25321 | Cycle 1(1): loaded http://localhost:55931/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55931/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:21:40 INFO - PROCESS | 25321 | RSS: Main: 230363136 15:21:40 INFO - PROCESS | 25321 | 15:21:42 INFO - PROCESS | 25321 | Cycle 1(1): loaded http://localhost:55931/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55931/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:21:43 INFO - PROCESS | 25321 | RSS: Main: 239136768 15:21:43 INFO - PROCESS | 25321 | 15:21:46 INFO - PROCESS | 25321 | Cycle 1(1): loaded http://localhost:55931/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55931/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:21:46 INFO - PROCESS | 25321 | RSS: Main: 235864064 15:21:46 INFO - PROCESS | 25321 | 15:21:48 INFO - PROCESS | 25321 | Cycle 1(1): loaded http://localhost:55931/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55931/tests/kraken/driver.html?testName=ai-astar) 15:21:48 INFO - PROCESS | 25321 | RSS: Main: 286179328 15:21:48 INFO - PROCESS | 25321 | 15:21:48 INFO - PROCESS | 25321 | __start_tp_report 15:21:48 INFO - PROCESS | 25321 | _x_x_mozilla_page_load 15:21:48 INFO - PROCESS | 25321 | _x_x_mozilla_page_load_details 15:21:48 INFO - PROCESS | 25321 | |i|pagename|runs| 15:21:48 INFO - PROCESS | 25321 | |0;ai-astar;111;113;112;112;113;111;111;110;111;111 15:21:48 INFO - PROCESS | 25321 | |1;audio-beat-detection;149;123;132;168;126;124;124;123;144;123 15:21:48 INFO - PROCESS | 25321 | |2;audio-dft;160;160;161;162;160;161;161;161;161;161 15:21:48 INFO - PROCESS | 25321 | |3;audio-fft;73;76;76;99;76;76;75;75;92;76 15:21:48 INFO - PROCESS | 25321 | |4;audio-oscillator;89;81;106;81;81;81;98;82;82;109 15:21:48 INFO - PROCESS | 25321 | |5;imaging-gaussian-blur;117;117;117;117;117;118;117;116;117;116 15:21:48 INFO - PROCESS | 25321 | |6;imaging-darkroom;146;145;145;146;146;145;146;147;146;146 15:21:48 INFO - PROCESS | 25321 | |7;imaging-desaturate;95;95;96;96;95;95;95;96;96;95 15:21:48 INFO - PROCESS | 25321 | |8;json-parse-financial;52;52;52;51;54;56;53;52;53;52 15:21:48 INFO - PROCESS | 25321 | |9;json-stringify-tinderbox;63;64;62;62;63;63;63;62;63;63 15:21:48 INFO - PROCESS | 25321 | |10;stanford-crypto-aes;85;87;81;81;85;87;85;81;80;81 15:21:48 INFO - PROCESS | 25321 | |11;stanford-crypto-ccm;135;132;138;134;130;131;143;143;187;134 15:21:48 INFO - PROCESS | 25321 | |12;stanford-crypto-pbkdf2;170;178;173;170;177;169;171;169;171;170 15:21:48 INFO - PROCESS | 25321 | |13;stanford-crypto-sha256-iterative;69;67;67;77;67;69;66;67;66;65 15:21:48 INFO - PROCESS | 25321 | __end_tp_report 15:21:48 INFO - PROCESS | 25321 | __start_cc_report 15:21:48 INFO - PROCESS | 25321 | _x_x_mozilla_cycle_collect,1702 15:21:48 INFO - PROCESS | 25321 | __end_cc_report 15:21:48 INFO - PROCESS | 25321 | __startTimestamp1480461708916__endTimestamp 15:21:48 INFO - PROCESS | 25321 | 15:21:48 INFO - PROCESS | 25321 | ------- Summary: start ------- 15:21:48 INFO - PROCESS | 25321 | Number of tests: 14 15:21:48 INFO - PROCESS | 25321 | 15:21:48 INFO - PROCESS | 25321 | [#0] ai-astar Cycles:10 Average:111.50 Median:111.50 stddev:0.97 (0.9%) stddev-sans-first:1.01 15:21:48 INFO - PROCESS | 25321 | Values: 111.0 113.0 112.0 112.0 113.0 111.0 111.0 110.0 111.0 111.0 15:21:48 INFO - PROCESS | 25321 | 15:21:48 INFO - PROCESS | 25321 | [#1] audio-beat-detection Cycles:10 Average:133.60 Median:129.00 stddev:15.31 (11.9%) stddev-sans-first:15.19 15:21:48 INFO - PROCESS | 25321 | Values: 149.0 123.0 132.0 168.0 126.0 124.0 124.0 123.0 144.0 123.0 15:21:48 INFO - PROCESS | 25321 | 15:21:48 INFO - PROCESS | 25321 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 15:21:48 INFO - PROCESS | 25321 | Values: 160.0 160.0 161.0 162.0 160.0 161.0 161.0 161.0 161.0 161.0 15:21:48 INFO - PROCESS | 25321 | 15:21:48 INFO - PROCESS | 25321 | [#3] audio-fft Cycles:10 Average:79.40 Median:76.00 stddev:8.69 (11.4%) stddev-sans-first:8.91 15:21:48 INFO - PROCESS | 25321 | Values: 73.0 76.0 76.0 99.0 76.0 76.0 75.0 75.0 92.0 76.0 15:21:48 INFO - PROCESS | 25321 | 15:21:48 INFO - PROCESS | 25321 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:81.50 stddev:11.18 (13.7%) stddev-sans-first:11.85 15:21:48 INFO - PROCESS | 25321 | Values: 89.0 81.0 106.0 81.0 81.0 81.0 98.0 82.0 82.0 109.0 15:21:48 INFO - PROCESS | 25321 | 15:21:48 INFO - PROCESS | 25321 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 15:21:48 INFO - PROCESS | 25321 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 117.0 116.0 117.0 116.0 15:21:48 INFO - PROCESS | 25321 | 15:21:48 INFO - PROCESS | 25321 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 15:21:48 INFO - PROCESS | 25321 | Values: 146.0 145.0 145.0 146.0 146.0 145.0 146.0 147.0 146.0 146.0 15:21:48 INFO - PROCESS | 25321 | 15:21:48 INFO - PROCESS | 25321 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 15:21:48 INFO - PROCESS | 25321 | Values: 95.0 95.0 96.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 15:21:48 INFO - PROCESS | 25321 | 15:21:48 INFO - PROCESS | 25321 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:52.50 stddev:1.42 (2.7%) stddev-sans-first:1.48 15:21:48 INFO - PROCESS | 25321 | Values: 52.0 52.0 52.0 51.0 54.0 56.0 53.0 52.0 53.0 52.0 15:21:48 INFO - PROCESS | 25321 | 15:21:48 INFO - PROCESS | 25321 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 15:21:48 INFO - PROCESS | 25321 | Values: 63.0 64.0 62.0 62.0 63.0 63.0 63.0 62.0 63.0 63.0 15:21:48 INFO - PROCESS | 25321 | 15:21:48 INFO - PROCESS | 25321 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:85.00 stddev:2.75 (3.2%) stddev-sans-first:2.85 15:21:48 INFO - PROCESS | 25321 | Values: 85.0 87.0 81.0 81.0 85.0 87.0 85.0 81.0 80.0 81.0 15:21:48 INFO - PROCESS | 25321 | 15:21:48 INFO - PROCESS | 25321 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:136.50 stddev:16.89 (12.4%) stddev-sans-first:17.79 15:21:48 INFO - PROCESS | 25321 | Values: 135.0 132.0 138.0 134.0 130.0 131.0 143.0 143.0 187.0 134.0 15:21:48 INFO - PROCESS | 25321 | 15:21:48 INFO - PROCESS | 25321 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.80 Median:171.00 stddev:3.22 (1.9%) stddev-sans-first:3.35 15:21:48 INFO - PROCESS | 25321 | Values: 170.0 178.0 173.0 170.0 177.0 169.0 171.0 169.0 171.0 170.0 15:21:48 INFO - PROCESS | 25321 | 15:21:48 INFO - PROCESS | 25321 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:67.00 stddev:3.40 (5.1%) stddev-sans-first:3.59 15:21:48 INFO - PROCESS | 25321 | Values: 69.0 67.0 67.0 77.0 67.0 69.0 66.0 67.0 66.0 65.0 15:21:48 INFO - PROCESS | 25321 | -------- Summary: end -------- 15:21:48 INFO - PROCESS | 25321 | 15:21:50 INFO - TEST-INFO | 25321: exit 0 15:21:50 INFO - TEST-OK | kraken | took 62646ms 15:21:50 INFO - SUITE-END | took 1181s 15:21:50 INFO - Completed test suite (00:19:42) 15:21:50 INFO - javascript benchmark 15:21:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3114.657387687355, 3136.6392864820546, 3137.8901738439145, 3162.4623813951625, 3183.347413780174, 5313.442088580701, 5411.864703382413, 5423.105187644044, 5429.321334833146, 5491.643043202189, 5411.756470958807, 5426.348838139419, 5428.67427954323, 5436.075867102592, 5436.510714035736, 4899.975500122503, 4915.5821755150855, 4931.630127740415, 4935.901281974358, 4973.278874563204, 4969.8012079516775, 5031.748412579356, 5033.597312215014, 5035.169197082477, 5042.092423363793, 4934.432540257881, 4962.503749625027, 4986.0, 4987.576056035223, 5023.899522009558, 5006.899862002758, 5024.924626130611, 5034.84895453137, 5036.219385995177, 5082.593392528589, 4821.807127714887, 4843.636727245471, 4874.0, 4944.258361245806, 4945.109880221558, 5321.600879934021, 5323.441038690959, 5351.57187425005, 5380.058489764276, 5411.053065713524, 5742.0, 5774.769009239625, 5778.162166485878, 5789.0, 5789.507891829199, 5688.544916406678, 5758.683272420015, 5759.68321742304, 5841.561882858802, 5843.357230704619, 5386.3536375634785, 5420.728963551806, 5422.945770542244, 5457.918131228074, 5466.9179962300595, 5915.467607915309, 5928.67392293428, 5931.0, 5932.228810254639, 5936.614120082181, 5564.443555644403, 5605.887882242332, 5703.800366987219, 5709.8287051388525, 5710.828675139753, 5708.686022268732, 5761.0, 5780.248567686258, 5795.217645617788, 5857.355690874, 5743.655380677173, 5748.6838223898085, 5795.971020144957, 5796.362400135981, 5811.912821307684, 5620.353659329147, 5811.88376232473, 5812.505936995318, 5820.185174075633, 5857.4435428634215, 4389.1660584488845, 4431.446069241345, 4434.401355816924, 4460.286354183315, 4460.955390446119, 4009.398590211433, 4010.8997275068355, 4034.91930161401, 4040.6363427291685, 4057.7159598827798, 5485.835424937259, 5503.229547863302, 5503.422140675251, 5507.862303442446, 5510.448955104538, 5668.26312579362, 5702.486776190163, 5738.512226460714, 5834.862201870595, 5850.063989761617, 5403.378611459654, 5460.481254280837, 5472.781088756485, 5485.341758988867, 5501.889962200734, 5001.524855138756, 5007.0, 5026.52248036436, 5037.974810125926, 5045.747712614355, 6009.248843894513, 6016.608920420159, 6019.428154325332, 6021.608595441195, 6057.333693293646, 5583.330000399978, 5677.489025987681, 5687.77248910039, 5753.0, 5815.156802263564, 5916.881662366814, 5918.201042859159, 5919.644821310735, 5922.052471604695, 5923.111533270044, 5636.88726225465, 5639.605227634026, 5639.746211420414, 5641.548676105819, 5642.85892852682, 5707.743151558273, 5742.19609254713, 5744.281964754406, 5744.913826292693, 5757.683327417032, 5588.664680119044, 5590.5248053915875, 5597.160425936142, 5600.915986260128, 5631.774729010957, 5543.473370029841, 5560.332760068818, 5562.749676264659, 5564.91652625219, 5566.443355664401, 5545.805896793593, 5552.056150454513, 5601.747921343468, 5605.299337582802, 5608.971955140199, 5709.600327977002, 5714.485696287354, 5729.312482502127, 5733.369329373682, 5735.0, 5485.588580856532, 5534.280543529316, 5585.720713964367, 5596.580256480862, 5602.159676048625], "value": 5336.912933571989, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.026026145944, 595.7736060297086, 607.6870411737953, 621.6891554222891, 622.3061286665367, 40085.398719019235, 40857.0, 41272.79363603181, 41344.58655413441, 43862.56137438625, 42268.36597451041, 42922.570774292246, 42931.14137717244, 42938.0, 43000.784996075054, 7795.649195786204, 7991.081025682034, 8607.440516366432, 8761.56192190391, 8766.211041006309, 9836.360636558637, 10109.292349535535, 10109.494525273743, 10350.0, 10364.740881477948, 10386.688399347993, 10451.163906887468, 10462.633807816728, 10464.790704185913, 10466.895331046668, 10312.071913527781, 10395.84406233907, 10401.635942742043, 10401.687949361494, 10407.635732749393, 10275.075243228146, 10331.586736530606, 10400.739981500446, 10400.739981500446, 10403.635872744419, 39989.60010399888, 40305.395419068445, 40313.79843100795, 40336.39495407571, 40346.79826600877, 3620.6560376764164, 3758.537057151773, 3903.512060992376, 4038.2125485530332, 4045.9797701011603, 29962.850185748932, 30072.84963575168, 30278.24304392386, 30310.393792124036, 30326.090217293517, 4166.958330416717, 4179.665626749853, 4204.474440694913, 4261.339492378686, 4367.956320436819, 306475.0, 321287.0, 324919.0, 328433.0, 456855.0, 53168.0, 53813.192802108, 54247.0, 54274.728626357406, 54350.45649543454, 57848.42151578431, 57978.71010645004, 58069.41930580725, 58397.416025840044, 58411.707941460874, 15653.765193522106, 15769.526914192364, 15800.130992795506, 15817.367305307658, 15830.44593439224, 10460.058594726359, 10494.842577361345, 10501.21240906935, 10614.89385106139, 12690.0, 19202.90398548026, 19511.272205847104, 20074.39776806698, 20323.79676203219, 20361.0, 7219.783406497813, 7272.818179545554, 7279.781606551812, 7440.702371905063, 7500.849983000309, 922.3405265235389, 1011.367895065584, 1040.2302296300834, 1147.0536807134147, 1150.269578817457, 31026.534601980988, 31133.844330778655, 31497.52753708696, 31616.525752113736, 31828.0, 1086.1039642295138, 1090.2150451674781, 1106.7952428800697, 1154.2901115813881, 1162.6802629277017, 15745.0, 16443.424480143138, 16541.66916661684, 16620.168991550618, 16913.492595222164, 491077.0, 491775.0, 499123.0, 502633.0, 779198.0, 53373.0, 53782.19326710102, 53825.730871346175, 54349.1847622286, 54377.72811135919, 1305.5430599290362, 1311.1346511302495, 1357.0907491980595, 1360.8911287097008, 1373.9038267321191, 29236.26909327284, 30456.543151852296, 30584.235394114436, 30701.0, 31116.688833112286, 45371.31943020923, 46014.0, 46054.30918536158, 46130.0, 46131.0, 356447.0, 357483.0, 358606.0, 358951.0, 360505.0, 24062.0, 24571.50856982886, 26301.34246643849, 26306.4738705221, 26687.33281667974, 38134.2373152541, 43820.34269485896, 44024.0, 44273.33589996088, 44426.0, 36785.63214367929, 36903.0, 37001.814990924875, 37655.43516847304, 37667.0, 36306.22419451939, 37670.8116459416, 37766.622333777406, 38657.806710966266, 38951.80524097475, 33708.146051966396, 33868.49197261994, 33924.3215135691, 34173.48739768856, 34728.958131256106, 31248.375032498767, 33269.334613308085, 33496.33007339888, 33818.66181338155, 33959.83020084884, 26038.218853434428, 26116.73883261219, 26291.21126366212, 26421.73578264193, 26685.455979913742], "value": 19578.33357406169, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.46965086921654, 377.1909254648777, 391.45392177911816, 393.13314142316216, 400.6454287955159, 14300.0, 15720.921395393021, 18152.727709084375, 18862.0, 18883.527911802194, 18399.172037258322, 18467.538311542183, 18545.35091271806, 18677.0, 18679.0, 4132.607402296777, 5404.216388623657, 5628.690422026787, 5629.183768353586, 5631.324241091075, 4178.080822219122, 5879.176915231871, 6126.479249263818, 6168.352323006065, 6260.841744277301, 6027.849303767419, 6177.536684748639, 6187.783427580036, 6198.256209254896, 6206.875862482771, 6217.658028808413, 6239.906401403982, 6246.812595622138, 6249.96875015622, 6250.874982500347, 5357.1696387060065, 5512.173174023928, 5547.25112109864, 5552.972235138839, 5562.415946325658, 17500.912495437442, 17614.735778963197, 19609.705854412194, 22142.22502212415, 22377.664335034988, 2224.9777502224933, 2272.704548408713, 2297.9195728149602, 2574.382148284398, 2751.55975043994, 13191.340432978408, 13766.587002389944, 14076.0, 14452.421903123863, 14586.34361453737, 1793.1213705284317, 1808.9005104719236, 1817.3003393693523, 1826.4246762269975, 1907.6184763047445, 68334.0, 75078.0, 75761.0, 77545.0, 90727.0, 10761.677149685365, 10899.182561307935, 11169.609063682732, 11290.943545282385, 11443.313401195956, 15496.0, 15500.379984800707, 15516.0, 15522.301496432689, 15529.767053494206, 7877.527348359117, 8224.0, 8272.0, 8323.791905202419, 8436.957815210884, 7902.723404680809, 7915.960420197862, 7950.522968621901, 8168.959155204186, 8205.056418511947, 4685.0, 4706.694064885772, 4746.377168526945, 4805.951940480621, 4837.105135549935, 1922.7596550431197, 1964.3714011516463, 1981.6631172700675, 2014.3956812956055, 2060.3509894383224, 719.442432115115, 803.6642314712095, 814.7352110564091, 958.8322043642474, 1007.7178390050798, 18352.63294734098, 19377.903110484356, 19441.12514936803, 19592.689608286153, 19667.0, 945.5697657565792, 976.7362812040709, 981.2689546288061, 1010.2978429991233, 1013.807376598444, 7951.960240198878, 10770.838437423445, 10784.460776961121, 10839.891601084046, 10846.349219046882, 431897.0, 434765.0, 435517.0, 435914.0, 435952.0, 91309.0, 93309.53345233231, 93664.53167734118, 94021.0, 94604.52697736467, 975.707287813653, 989.8218320702342, 1009.742515658517, 1017.1151098544166, 1020.4744556553381, 16245.918770406071, 16566.66866662636, 17032.74450883213, 17107.65784684324, 17115.486535403958, 32817.0, 42244.1551168981, 43586.56413435952, 44196.337054944845, 44333.77833110814, 57993.71003145126, 58265.417345826, 58309.708451457474, 59342.0, 61648.383516164264, 8102.189781021851, 8413.411061225655, 8507.191816777397, 8629.525376104375, 8801.735947921572, 9523.428594284365, 12795.232286062866, 13211.273379964194, 13285.335733213495, 13493.527726529524, 11310.83033754478, 11469.827952580885, 11631.76736465283, 11725.41372931367, 11736.647900562997, 11014.339139651647, 11021.228514003942, 11031.889681103086, 11112.888871111509, 11434.249093348104, 11374.715632109264, 11388.430578471209, 11566.132540059361, 11660.941695291469, 11697.122715796178, 8391.790205244917, 8417.957910210409, 8505.914940850513, 8600.13998600135, 8714.869276960977, 9324.393914395543, 11482.13883958723, 11675.591354302898, 11769.823452648046, 11951.521939122338], "value": 9108.705197985175, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1433.2547075520733, 1461.9122852628843, 1564.7496400575903, 1688.6707092117042, 1747.6679430908127, 7359.0, 7624.390048796097, 7909.367250619951, 8332.541710205936, 8399.87400188997, 7958.283754462097, 8205.0, 8205.261526462617, 8402.621882015308, 8410.705625303115, 2248.955020899581, 2282.669012993115, 2291.6218823894037, 2292.747797742247, 2294.0250393582746, 2051.4871282179456, 2270.6821045053707, 2290.3815969688176, 2315.8031567316716, 2323.5236776460783, 2027.0, 2166.750823655284, 2212.557488502306, 2221.4335344487213, 2233.486298151426, 2171.4788450771857, 2175.2930297653324, 2175.673648952654, 2181.3564998325533, 2227.610168220555, 2240.2271216430304, 2255.492514184312, 2258.8080013198896, 2260.5930932432157, 2261.2198791416936, 8298.460600060977, 8346.207110324509, 8346.248837604644, 8362.16378362165, 8369.121242269595, 4975.925361119586, 5141.997310524449, 5147.150720131174, 5149.665271757362, 5152.433232344477, 3002.6396832380256, 3058.189579761365, 3299.6535363786697, 3302.488114342281, 3309.3712194682935, 1016.5767924905192, 1032.6643840751785, 1041.3075304922218, 1043.7234132954773, 1070.0904231403322, 11424.314541127476, 11539.942300288445, 11586.131040171937, 11609.0, 11621.186516943817, 4426.977865110718, 4524.547545245449, 4635.23518619424, 4651.232546629836, 4662.067586482717, 9672.0, 9683.0, 9687.079727425884, 9689.806203875884, 9692.51537423126, 5141.460146684619, 5144.6398752087, 5148.433672296044, 5148.536631703165, 5149.201873709581, 4612.815487380534, 4648.465426475998, 4672.6261899047995, 4739.5307454689155, 4742.264948932921, 3715.0, 3745.138618117848, 3821.9617803821607, 3854.7494412863075, 3871.4192871069563, 1131.8189089745601, 1281.1736430002595, 1284.4733659199683, 1286.8327117474855, 1293.1012946002627, 794.5987276425484, 849.2738708404349, 877.0, 879.134052957836, 920.0615372320196, 5448.91826622601, 5456.727163641882, 5556.0, 5561.944380556142, 5660.5471562274915, 886.1404437695425, 890.8218356328761, 894.2845723421237, 916.8441364967971, 924.5977999570208, 3537.8231088445473, 3586.5158203642695, 3591.838367273479, 3790.9431358529646, 3823.617638236154, 9684.128428441474, 10215.131713804261, 10267.640632577824, 10276.691699249035, 10281.845772313422, 9982.850257246002, 10200.591976320864, 10209.591616335263, 10219.437930913722, 10294.536745846455, 7749.496282741717, 7905.762827115196, 7911.248431399008, 7917.920820791718, 7941.404394670423, 5374.48942350476, 5387.649802762808, 5398.892022159614, 5451.236826844324, 5611.130274807411, 8893.4663920165, 9226.169644732006, 9353.859692104488, 9471.526423678652, 9549.809003820024, 9079.773005674911, 9284.675036373694, 9398.01320861327, 9434.575444105169, 9539.666111686058, 7124.536905101152, 7412.777616671508, 7569.243075692387, 7574.431917606092, 7580.658870350958, 7930.682772689028, 8106.39202059836, 8174.509529428254, 8182.672693092448, 8182.959085204536, 7022.543534670434, 7112.466565007749, 7179.748708795167, 7187.640617969185, 7226.168990565942, 7046.929530704628, 7087.255838136922, 7090.751823686146, 7147.892781608384, 7171.605561694157, 6473.8705225896165, 6579.243387010555, 6617.933820661732, 6625.138731964814, 6625.138731964814, 4500.977495112504, 4505.887352816206, 4532.342810292555, 4559.977200113978, 4685.5782979532005, 4708.223143181337, 4813.470518242921, 4815.22956326986, 4853.369062021915, 4919.827806026772], "value": 4384.926356145545, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.9504597897408, 344.2220581485842, 345.6129135368388, 349.5997083339575, 350.76323481649894, 5184.418752280553, 5248.160294352909, 5254.92117618236, 5261.605379596526, 5302.674331417145, 5143.717095559743, 5158.767855446505, 5209.479052094798, 5214.243934629477, 5262.710550919698, 4182.247195504808, 4193.5387107418155, 4200.390943313218, 4205.264078786216, 4210.789460526977, 3921.960780392188, 3929.7052721045893, 4173.499180098393, 4190.559991200926, 4192.895177620553, 4127.772972486512, 4135.648469880064, 4155.896102597429, 4156.812943417538, 4163.791810409482, 4132.442120313749, 4132.834686612532, 4151.377293405983, 4153.626173644371, 4154.397612346208, 3695.2424752925585, 3707.888763337104, 3710.7402481826284, 3713.1274150574595, 3717.553893532793, 5035.84892453227, 5096.694198348111, 5106.361704786902, 5127.743612819344, 5146.511081447256, 4675.696079754839, 4719.716816990992, 4732.219183834698, 4746.928796068028, 4752.643551733634, 5353.57171426285, 5395.919061214085, 5433.293671822637, 5434.3207099112615, 5436.695193153654, 4029.005642207097, 4043.0903046814524, 4053.250148722496, 4055.762992287351, 4067.2678917794783, 5577.494076599295, 5593.8321850344555, 5630.943690563083, 5638.126090455986, 5650.434956504358, 4099.61053699904, 4117.773522456294, 4128.545859955402, 4135.97932010338, 4141.378793180987, 3889.4749208857006, 4088.407180958804, 4142.233686767958, 4169.749815011109, 4184.853530126431, 4674.579287864109, 4678.508756580578, 4684.625229981593, 4689.20283551797, 4697.271922851964, 5491.505764481216, 5513.61404701667, 5514.889702205934, 5550.639208451437, 5553.4724201200825, 1337.8996575256895, 1350.4328182163515, 1378.6415531961761, 1380.751464736357, 1386.5355106039387, 943.9575219115156, 957.913787759105, 962.8651988721584, 964.0985678390728, 968.9418634881789, 5046.1926091825135, 5050.873728156826, 5064.696118232918, 5106.540411362921, 5121.743912804345, 5344.706041167696, 5355.196720491879, 5361.463853614685, 5399.811006614828, 5407.810726624549, 4835.782389792468, 4993.775280112403, 5026.89946201074, 5041.218611115283, 5047.97476012625, 2857.3713782967716, 2860.9427811443657, 2862.2128914548666, 2867.5842002909462, 2868.770498360126, 5552.361478430033, 5554.638948468418, 5557.833265002057, 5566.443355664401, 5571.888562228733, 5253.870417860178, 5420.376656684453, 5450.91823622646, 5456.345238571317, 5515.117581187071, 5482.862928426821, 5525.198846167364, 5535.889282214333, 5540.612157148961, 5544.807866308683, 5350.713231677324, 5376.865578360573, 5395.946040539701, 5400.7569659364635, 5406.648567843077, 5173.3533308336455, 5302.257683924331, 5311.203319502106, 5321.7073060980465, 5340.2256672783005, 5486.396496385315, 5487.2317875496665, 5520.447955204608, 5560.13735398646, 5568.832935011957, 3785.9399368176955, 3953.723239373216, 3954.0, 3955.8417663293144, 3957.149212919121, 5154.57734864613, 5576.581756368208, 5576.665400076008, 5600.4959553640365, 5600.691961942132, 5487.670739755627, 5493.340799103973, 5494.835154945358, 5503.697296648723, 5504.587155963239, 5217.961063844531, 5393.9730301348245, 5452.146270268128, 5478.479544443271, 5499.230107784993, 5420.972895135499, 5444.0, 5447.618666693452, 5455.454454554513, 5456.217329162077, 5430.076886929152, 5505.834824955257, 5548.9722551386985, 5568.582356323373, 5572.108462645957, 5308.416074231909, 5433.212184233343, 5435.266239057677, 5447.55639755473, 5463.07127788269], "value": 4155.435605547662, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.7065173930428, 740.0490369874713, 745.0537816972445, 784.0982869699844, 809.4091313341264, 15850.76223856643, 16816.83183168168, 16822.83177168228, 16880.155992200373, 16887.240074196674, 14851.108933464, 14877.702445951074, 14966.625834354147, 14975.326110325035, 14999.400023999027, 652.9151210342649, 672.6166085331363, 765.7587859824165, 767.4244316762442, 789.940754443419, 788.1566723605744, 798.6126728536655, 799.160881074872, 799.5842162075717, 799.7800604833689, 848.8132610825609, 849.8215374771274, 850.1880703927765, 850.4174640371334, 850.5024560632038, 690.1511141296234, 708.2563308526027, 798.253632853284, 841.8484672758901, 841.8568843296624, 603.704184949376, 604.6644112517552, 604.8518113062283, 605.1104875832563, 605.267626172332, 13761.31193440324, 13917.0, 13918.09532380392, 13971.371288292052, 14001.439942402292, 14385.208813515252, 14409.207493587848, 14425.422983080663, 14463.13221206731, 14540.345684444226, 12560.434780434902, 12600.117991740583, 12637.304948227844, 12806.61580152597, 13037.413316400785, 4156.792160391999, 4200.285951388271, 4210.200061988243, 4317.4819021717285, 4364.803583838703, 82346.0, 83320.99999999939, 84361.57819210926, 84479.57760211221, 84584.57707711423, 10807.567697292177, 11172.497237624326, 11177.83233251502, 11194.216404851744, 11194.44027798623, 21324.89337553302, 21409.571808564055, 21410.678839817414, 21506.677399839016, 21586.46033849135, 7989.440739148204, 8026.799330016796, 8036.0, 8173.427860049858, 8457.238848503664, 4205.5794420557695, 4340.197063543254, 4344.500382456058, 4355.128974205171, 4385.824567017347, 3446.483027545838, 3543.8582456701442, 3577.123604716861, 3583.498310236569, 3586.278586278601, 595.7348979703991, 613.098744845077, 621.8476473263988, 621.9813405597839, 638.996805015972, 566.4165909113619, 602.810114813841, 626.5113211694885, 645.3836586060302, 649.8245473722163, 8494.575271236414, 8971.685990990283, 8986.505742184112, 9065.501397423204, 9152.90847091534, 604.5556515960766, 623.1120653069358, 640.2764875690533, 643.9774607888795, 702.4240123099112, 4266.914661706811, 4339.7830108494445, 4412.33814927757, 4453.131639330364, 4576.542345765463, 61498.38501614927, 74658.6267068672, 76332.61833690797, 83086.0, 87166.12833871707, 54477.182842257396, 68167.81986161692, 71110.0, 73071.26928730645, 73566.89649655152, 64695.0, 66045.66977165084, 66750.66624666845, 67393.32606673871, 67695.0, 8293.0, 8455.196756308142, 8525.658973640984, 8805.295576353748, 8842.119990206698, 36970.44544331783, 42301.153976919675, 43213.48752793637, 44635.553644463136, 45122.77438612786, 58060.419395805504, 59983.70008150106, 60520.69739651273, 60832.0, 61497.0, 10824.296420732628, 10960.56157753681, 11154.665360039211, 11315.660530184108, 11799.941000295286, 11451.656450306504, 11502.654920352403, 11543.36511491876, 11810.645680629596, 12051.276923384625, 11501.424928753362, 11863.406829658656, 12026.15816892809, 12192.634220973385, 12244.204126731735, 12272.631821045383, 12555.0, 12904.612861614167, 13009.869901301245, 13137.146085504412, 11635.941820290844, 12039.398030098635, 12057.0, 12293.75412491763, 12683.175593586388, 9792.902070979198, 9974.202063834731, 10122.746931326776, 10215.0, 10305.53625086888, 10241.283110182216, 10359.63741269052, 10992.010719035325, 11575.189736718348, 11917.82123268169], "value": 6980.001980558686, "unit": "score"}], "name": "dromaeo_css", "value": 7033.4310615245895, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 112.0, 112.0, 113.0, 111.0, 111.0, 110.0, 111.0, 111.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 132.0, 168.0, 126.0, 124.0, 124.0, 123.0, 144.0, 123.0], "value": 133.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 162.0, 160.0, 161.0, 161.0, 161.0, 161.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 76.0, 99.0, 76.0, 76.0, 75.0, 75.0, 92.0, 76.0], "value": 79.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 81.0, 106.0, 81.0, 81.0, 81.0, 98.0, 82.0, 82.0, 109.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 116.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 51.0, 54.0, 56.0, 53.0, 52.0, 53.0, 52.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 62.0, 63.0, 63.0, 63.0, 62.0, 63.0, 63.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 81.0, 81.0, 85.0, 87.0, 85.0, 81.0, 80.0, 81.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 132.0, 138.0, 134.0, 130.0, 131.0, 143.0, 143.0, 187.0, 134.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 178.0, 173.0, 170.0, 177.0, 169.0, 171.0, 169.0, 171.0, 170.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 77.0, 67.0, 69.0, 66.0, 67.0, 66.0, 65.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1511.7, "alertThreshold": 2.0}]} 15:21:50 INFO - Return code: 0 15:21:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:21:50 INFO - # TBPL SUCCESS # 15:21:50 INFO - Running post-action listener: _resource_record_post_action 15:21:50 INFO - [mozharness: 2016-11-29 23:21:50.751791Z] Finished run-tests step (success) 15:21:50 INFO - Running post-run listener: _resource_record_post_run 15:21:50 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392568832; Read time: 12; Write time: 462740 15:21:50 INFO - TinderboxPrint: CPU usage
13.1% 15:21:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:21:50 INFO - TinderboxPrint: I/O write bytes / time
392,568,832 / 462,740 15:21:50 INFO - TinderboxPrint: CPU idle
8,307.9 (86.8%) 15:21:50 INFO - TinderboxPrint: CPU user
1,205.3 (12.6%) 15:21:50 INFO - TinderboxPrint: Swap in / out
0 / 0 15:21:50 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103788544; Read time: 0; Write time: 129032 15:21:50 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 288780288; Read time: 0; Write time: 333708 15:21:51 INFO - Running post-run listener: _upload_blobber_files 15:21:51 INFO - Blob upload gear active. 15:21:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:21:51 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 15:21:51 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'] 15:21:51 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 15:21:51 INFO - (blobuploader) - INFO - Open directory for files ... 15:21:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:21:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:21:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:21:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:21:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:21:52 INFO - (blobuploader) - INFO - Done attempting. 15:21:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:21:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:21:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:21:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:21:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:21:53 INFO - (blobuploader) - INFO - Done attempting. 15:21:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:21:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:21:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:21:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:21:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:21:57 INFO - (blobuploader) - INFO - Done attempting. 15:21:57 INFO - (blobuploader) - INFO - Iteration through files over. 15:21:57 INFO - Return code: 0 15:21:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:21:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:21:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a4fc1c8a757d68db1cfaed4d787e6d7affd6f6188b55c7dac35d79ec5ff3610dc2f4542e28986f1fe525f49e04e5ec754ca65769bef84485aaf09def65f54021", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/81159a30841dd1e15572c2a09537e9357be871533158bfb5265231f9e8ca08418db74aa3642aa05514b2b88b7a9e34b8dd5a0ac01f61ae74fb0b7539a3407a56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/88a6e11979ec5ac5641c89729a5f0187704e21e582b7c9f791e09925f8ad26aa56cb54dca82c9cc73fca812db2d0854767c6ff5fd6f4564f0e439318586aec1a"} 15:21:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:21:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:21:57 INFO - Contents: 15:21:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a4fc1c8a757d68db1cfaed4d787e6d7affd6f6188b55c7dac35d79ec5ff3610dc2f4542e28986f1fe525f49e04e5ec754ca65769bef84485aaf09def65f54021", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/81159a30841dd1e15572c2a09537e9357be871533158bfb5265231f9e8ca08418db74aa3642aa05514b2b88b7a9e34b8dd5a0ac01f61ae74fb0b7539a3407a56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/88a6e11979ec5ac5641c89729a5f0187704e21e582b7c9f791e09925f8ad26aa56cb54dca82c9cc73fca812db2d0854767c6ff5fd6f4564f0e439318586aec1a"} 15:21:57 INFO - Running post-run listener: copy_logs_to_upload_dir 15:21:57 INFO - Copying logs to upload dir... 15:21:57 INFO - mkdir: /builds/slave/test/build/upload/logs 15:21:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.694303 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-11-29 15:21:56.909576) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 15:21:56.912716) ========= 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=5cf47e208febbcd81da23b2e0000026f-1480452856.452689-1637564807 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/a4fc1c8a757d68db1cfaed4d787e6d7affd6f6188b55c7dac35d79ec5ff3610dc2f4542e28986f1fe525f49e04e5ec754ca65769bef84485aaf09def65f54021", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/81159a30841dd1e15572c2a09537e9357be871533158bfb5265231f9e8ca08418db74aa3642aa05514b2b88b7a9e34b8dd5a0ac01f61ae74fb0b7539a3407a56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/88a6e11979ec5ac5641c89729a5f0187704e21e582b7c9f791e09925f8ad26aa56cb54dca82c9cc73fca812db2d0854767c6ff5fd6f4564f0e439318586aec1a"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011773 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a4fc1c8a757d68db1cfaed4d787e6d7affd6f6188b55c7dac35d79ec5ff3610dc2f4542e28986f1fe525f49e04e5ec754ca65769bef84485aaf09def65f54021", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/81159a30841dd1e15572c2a09537e9357be871533158bfb5265231f9e8ca08418db74aa3642aa05514b2b88b7a9e34b8dd5a0ac01f61ae74fb0b7539a3407a56", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/88a6e11979ec5ac5641c89729a5f0187704e21e582b7c9f791e09925f8ad26aa56cb54dca82c9cc73fca812db2d0854767c6ff5fd6f4564f0e439318586aec1a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 15:21:56.940384) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 15:21:56.940956) ========= 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=5cf47e208febbcd81da23b2e0000026f-1480452856.452689-1637564807 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004569 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 15:21:57.025839) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 15:21:57.026288) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 15:21:57.026570) ========= ========= Total master_lag: 0.17 =========