builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1477773805.51 results: success (0) buildid: 20161029131757 builduid: 5844e2c709944b50b1385cc9972c216c revision: 6f5c85e2f3f886f42a53fc926e265b476b642ea7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-29 13:43:25.506287) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-29 13:43:25.506736) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-29 13:43:25.507010) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-29 13:43:25.521562) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 13:43:25.521858) ========= 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=db0483c52d987ecb441a263b000001ad-1477773804.765618-544863779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-29 13:43:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-10-29 13:43:25 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.072082 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 13:43:25.608973) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 13:43:25.609444) ========= 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=db0483c52d987ecb441a263b000001ad-1477773804.765618-544863779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021238 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 13:43:25.659536) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-29 13:43:25.659907) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 6f5c85e2f3f886f42a53fc926e265b476b642ea7 --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 6f5c85e2f3f886f42a53fc926e265b476b642ea7 --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=db0483c52d987ecb441a263b000001ad-1477773804.765618-544863779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-29 13:43:25,707 truncating revision to first 12 chars 2016-10-29 13:43:25,707 Setting DEBUG logging. 2016-10-29 13:43:25,707 attempt 1/10 2016-10-29 13:43:25,707 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/6f5c85e2f3f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-29 13:43:26,400 unpacking tar archive at: mozilla-inbound-6f5c85e2f3f8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.045361 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-29 13:43:26.719233) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-29 13:43:26.719570) ========= script_repo_revision: 6f5c85e2f3f886f42a53fc926e265b476b642ea7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-29 13:43:26.719963) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-29 13:43:26.720235) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-29 13:43:26.730366) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-10-29 13:43:26.730758) ========= /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=db0483c52d987ecb441a263b000001ad-1477773804.765618-544863779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:43:26 INFO - MultiFileLogger online at 20161029 13:43:26 in /builds/slave/test 13:43:26 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 13:43:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:43:26 INFO - {'append_to_log': False, 13:43:26 INFO - 'base_work_dir': '/builds/slave/test', 13:43:26 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 13:43:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:43:26 INFO - 'branch': 'Mozilla-Inbound', 13:43:26 INFO - 'buildbot_json_path': 'buildprops.json', 13:43:26 INFO - 'config_files': ('talos/linux_config.py',), 13:43:26 INFO - 'default_actions': ('clobber', 13:43:26 INFO - 'read-buildbot-config', 13:43:26 INFO - 'download-and-extract', 13:43:26 INFO - 'populate-webroot', 13:43:26 INFO - 'create-virtualenv', 13:43:26 INFO - 'install', 13:43:26 INFO - 'run-tests'), 13:43:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:43:26 INFO - 'download_minidump_stackwalk': True, 13:43:26 INFO - 'download_symbols': 'ondemand', 13:43:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:43:26 INFO - 'tooltool.py': '/tools/tooltool.py', 13:43:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:43:26 INFO - '/tools/misc-python/virtualenv.py')}, 13:43:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:43:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:43:26 INFO - 'installer_path': 'installer.exe', 13:43:26 INFO - 'log_level': 'info', 13:43:26 INFO - 'log_name': 'talos', 13:43:26 INFO - 'log_to_console': True, 13:43:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:43:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:43:26 INFO - 'opt_config_files': (), 13:43:26 INFO - 'pip_index': False, 13:43:26 INFO - 'sps_profile': False, 13:43:26 INFO - 'sps_profile_interval': 0, 13:43:26 INFO - 'suite': 'dromaeojs', 13:43:26 INFO - 'system_bits': '32', 13:43:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:43:26 INFO - 'title': 'talos-linux64-ix-031', 13:43:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:43:26 INFO - 'use_talos_json': True, 13:43:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:43:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:43:26 INFO - 'work_dir': 'build'} 13:43:26 INFO - [mozharness: 2016-10-29 20:43:26.869202Z] Running clobber step. 13:43:26 INFO - Running pre-action listener: _resource_record_pre_action 13:43:26 INFO - Running main action method: clobber 13:43:26 INFO - rmtree: /builds/slave/test/build 13:43:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:43:27 INFO - Running post-action listener: _resource_record_post_action 13:43:27 INFO - [mozharness: 2016-10-29 20:43:27.326665Z] Finished clobber step (success) 13:43:27 INFO - [mozharness: 2016-10-29 20:43:27.326765Z] Running read-buildbot-config step. 13:43:27 INFO - Running pre-action listener: _resource_record_pre_action 13:43:27 INFO - Running main action method: read_buildbot_config 13:43:27 INFO - Using buildbot properties: 13:43:27 INFO - { 13:43:27 INFO - "project": "", 13:43:27 INFO - "product": "firefox", 13:43:27 INFO - "script_repo_revision": "production", 13:43:27 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 13:43:27 INFO - "repository": "", 13:43:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 13:43:27 INFO - "buildid": "20161029131757", 13:43:27 INFO - "stage_platform": "linux64-pgo", 13:43:27 INFO - "basedir": "/builds/slave/test", 13:43:27 INFO - "buildnumber": 1940, 13:43:27 INFO - "platform": "ubuntu64_hw", 13:43:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:43:27 INFO - "slavebuilddir": "test", 13:43:27 INFO - "branch": "mozilla-inbound", 13:43:27 INFO - "revision": "6f5c85e2f3f886f42a53fc926e265b476b642ea7", 13:43:27 INFO - "slavename": "talos-linux64-ix-031", 13:43:27 INFO - "builduid": "5844e2c709944b50b1385cc9972c216c", 13:43:27 INFO - "repo_path": "integration/mozilla-inbound" 13:43:27 INFO - } 13:43:27 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698456/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 13:43:27 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698456/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 13:43:27 INFO - Running post-action listener: _resource_record_post_action 13:43:27 INFO - [mozharness: 2016-10-29 20:43:27.329124Z] Finished read-buildbot-config step (success) 13:43:27 INFO - [mozharness: 2016-10-29 20:43:27.329212Z] Running download-and-extract step. 13:43:27 INFO - Running pre-action listener: _resource_record_pre_action 13:43:27 INFO - Running main action method: download_and_extract 13:43:27 INFO - mkdir: /builds/slave/test/build/tests 13:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:43:27 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698456/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:43:27 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698456/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:43:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698456/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:43:27 INFO - Downloaded 1361 bytes. 13:43:27 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:43:27 INFO - Using the following test package requirements: 13:43:27 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:43:27 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:43:27 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:43:27 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:27 INFO - u'jsshell-linux-x86_64.zip'], 13:43:27 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:43:27 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:43:27 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:43:27 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:43:27 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:43:27 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:43:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:43:27 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:43:27 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/1477698456/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:43:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698456/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:43:27 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698456/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:43:27 INFO - Http code: 200 13:43:27 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 13:43:27 INFO - x-amz-cf-id: mnFdqQeZs_FbZNEOPJk_2QpEpqrkzpn7r_rwaj_PKHJkxOyO8cTWNQ== 13:43:27 INFO - x-amz-replication-status: PENDING 13:43:27 INFO - x-amz-version-id: dBbwMsMQSbUsdb9MoLn2OpThRhJYykzt 13:43:27 INFO - Expected file size: 22005836 13:43:27 INFO - Obtained file size: 22005836 13:43:31 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:43:31 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/1477698456/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:43:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698456/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:43:31 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698456/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:43:31 INFO - Http code: 200 13:43:31 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 13:43:31 INFO - x-amz-cf-id: JyKC_qZEbDJgZ5zPIfqqMWPq2iynaiZ3crcG5XGoXgu0eDYAm_5uDg== 13:43:31 INFO - x-amz-replication-status: PENDING 13:43:31 INFO - x-amz-version-id: dBbwMsMQSbUsdb9MoLn2OpThRhJYykzt 13:43:31 INFO - Expected file size: 22005836 13:43:31 INFO - Obtained file size: 22005836 13:43:36 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/1477698456/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 13:43:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698456/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:43:36 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698456/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 13:43:36 INFO - Http code: 200 13:43:36 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 13:43:36 INFO - x-amz-cf-id: SJDLCMwGnErIc8hwDyBXIvVAtqvzLObInf57z0DSix-2Q28TaBWOog== 13:43:36 INFO - x-amz-replication-status: PENDING 13:43:36 INFO - x-amz-version-id: j9kntvpjNdzuWmDXncSFj4o2N6F8PMqu 13:43:36 INFO - Expected file size: 14409030 13:43:36 INFO - Obtained file size: 14409030 13:43: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')]} 13:43:36 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698456/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:43:36 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698456/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:43:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698456/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:43:37 INFO - Downloaded 59389582 bytes. 13:43:37 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698456/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:43:37 INFO - mkdir: /builds/slave/test/properties 13:43:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:43:37 INFO - Writing to file /builds/slave/test/properties/build_url 13:43:37 INFO - Contents: 13:43:37 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698456/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:43:37 INFO - Running post-action listener: _resource_record_post_action 13:43:37 INFO - Running post-action listener: set_extra_try_arguments 13:43:37 INFO - [mozharness: 2016-10-29 20:43:37.790686Z] Finished download-and-extract step (success) 13:43:37 INFO - [mozharness: 2016-10-29 20:43:37.790914Z] Running populate-webroot step. 13:43:37 INFO - Running pre-action listener: _resource_record_pre_action 13:43:37 INFO - Running main action method: populate_webroot 13:43:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:43:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:43:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:43:37 INFO - '--tppagecycles', 13:43:37 INFO - '7'], 13:43:37 INFO - 'tests': ['tsvgm']}}, 13:43:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:43:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:43:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:43:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:43:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:43:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:43:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:37 INFO - 'talos_options': ['--disable-e10s'], 13:43:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:43:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:43:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:37 INFO - 'talos_options': ['--disable-e10s'], 13:43:37 INFO - 'tests': ['damp', 'tps']}, 13:43:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:37 INFO - 'tests': ['damp', 'tps']}, 13:43:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:43:37 INFO - 'tests': ['dromaeo_dom']}, 13:43:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:43:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:43:37 INFO - 'tests': ['basic_compositor_video']}, 13:43:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:43:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:43:37 INFO - 'tests': ['a11yr', 13:43:37 INFO - 'ts_paint', 13:43:37 INFO - 'tpaint', 13:43:37 INFO - 'sessionrestore', 13:43:37 INFO - 'sessionrestore_no_auto_restore', 13:43:37 INFO - 'tabpaint']}, 13:43:37 INFO - 'other-e10s': {'tests': ['a11yr', 13:43:37 INFO - 'ts_paint', 13:43:37 INFO - 'tpaint', 13:43:37 INFO - 'sessionrestore', 13:43:37 INFO - 'sessionrestore_no_auto_restore', 13:43:37 INFO - 'tabpaint']}, 13:43:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:43:37 INFO - 'ts_paint', 13:43:37 INFO - 'tpaint', 13:43:37 INFO - 'sessionrestore', 13:43:37 INFO - 'sessionrestore_no_auto_restore', 13:43:37 INFO - 'tabpaint']}, 13:43:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:43:37 INFO - 'ts_paint', 13:43:37 INFO - 'tpaint', 13:43:37 INFO - 'sessionrestore', 13:43:37 INFO - 'sessionrestore_no_auto_restore', 13:43:37 INFO - 'tabpaint']}, 13:43:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:43:37 INFO - 'tests': ['a11yr', 13:43:37 INFO - 'ts_paint', 13:43:37 INFO - 'tpaint', 13:43:37 INFO - 'sessionrestore', 13:43:37 INFO - 'sessionrestore_no_auto_restore', 13:43:37 INFO - 'tabpaint']}, 13:43:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:43:37 INFO - 'tests': ['a11yr', 13:43:37 INFO - 'ts_paint', 13:43:37 INFO - 'tpaint', 13:43:37 INFO - 'sessionrestore', 13:43:37 INFO - 'sessionrestore_no_auto_restore', 13:43:37 INFO - 'tabpaint']}, 13:43:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:43:37 INFO - 'tests': ['tsvgx', 13:43:37 INFO - 'tsvgr_opacity', 13:43:37 INFO - 'tart', 13:43:37 INFO - 'tscrollx', 13:43:37 INFO - 'cart']}, 13:43:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:43:37 INFO - 'tsvgr_opacity', 13:43:37 INFO - 'tart', 13:43:37 INFO - 'tscrollx', 13:43:37 INFO - 'cart']}, 13:43:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:37 INFO - 'talos_options': ['--disable-e10s'], 13:43:37 INFO - 'tests': ['tp5o']}, 13:43:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:37 INFO - 'tests': ['tp5o']}, 13:43:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:37 INFO - 'talos_options': ['--disable-e10s', 13:43:37 INFO - '--xperf_path', 13:43:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:43:37 INFO - 'tests': ['tp5n']}, 13:43:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:43:37 INFO - 'talos_options': ['--xperf_path', 13:43:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:43:37 INFO - 'tests': ['tp5n']}}, 13:43:37 INFO - 'talos.zip': {'path': '', 13:43:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:43:37 INFO - Running post-action listener: _resource_record_post_action 13:43:37 INFO - [mozharness: 2016-10-29 20:43:37.808286Z] Finished populate-webroot step (success) 13:43:37 INFO - [mozharness: 2016-10-29 20:43:37.808373Z] Running create-virtualenv step. 13:43:37 INFO - Running pre-action listener: _resource_record_pre_action 13:43:37 INFO - Running main action method: create_virtualenv 13:43:37 INFO - Creating virtualenv /builds/slave/test/build/venv 13:43:37 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 13:43:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:43:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:43:37 INFO - Using real prefix '/usr' 13:43:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:43:38 INFO - Installing distribute.............................................................................................................................................................................................done. 13:43:40 INFO - Installing pip.................done. 13:43:40 INFO - Return code: 0 13:43:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:43:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:43:40 INFO - Reading from file tmpfile_stdout 13:43:40 INFO - Output received: 13:43:40 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) 13:43:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:43:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:43:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3eefa68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1698ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1695f60>, '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 0x1696d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16971d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477773804.765618-544863779', '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 13:43:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:43:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:43:40 INFO - Using env: {'DISPLAY': ':0', 13:43:40 INFO - 'HOME': '/home/cltbld', 13:43:40 INFO - 'LANG': 'en_US.UTF-8', 13:43:40 INFO - 'LANGUAGE': 'en_US:en', 13:43:40 INFO - 'LOGNAME': 'cltbld', 13:43:40 INFO - 'MAIL': '/var/mail/cltbld', 13:43:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:40 INFO - 'MOZ_NO_REMOTE': '1', 13:43:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:40 INFO - 'NO_EM_RESTART': '1', 13:43:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:40 INFO - 'PWD': '/builds/slave/test', 13:43:40 INFO - 'SHELL': '/bin/bash', 13:43:40 INFO - 'SHLVL': '1', 13:43:40 INFO - 'TERM': 'linux', 13:43:40 INFO - 'TMOUT': '86400', 13:43:40 INFO - 'USER': 'cltbld', 13:43:40 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477773804.765618-544863779', 13:43:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:40 INFO - '_': '/tools/buildbot/bin/python'} 13:43:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:43:40 INFO - Cleaning up... 13:43:40 INFO - Return code: 0 13:43:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:43:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:43:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3eefa68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1698ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1695f60>, '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 0x1696d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16971d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477773804.765618-544863779', '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 13:43:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:43:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:43:40 INFO - Using env: {'DISPLAY': ':0', 13:43:40 INFO - 'HOME': '/home/cltbld', 13:43:40 INFO - 'LANG': 'en_US.UTF-8', 13:43:40 INFO - 'LANGUAGE': 'en_US:en', 13:43:40 INFO - 'LOGNAME': 'cltbld', 13:43:40 INFO - 'MAIL': '/var/mail/cltbld', 13:43:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:40 INFO - 'MOZ_NO_REMOTE': '1', 13:43:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:40 INFO - 'NO_EM_RESTART': '1', 13:43:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:40 INFO - 'PWD': '/builds/slave/test', 13:43:40 INFO - 'SHELL': '/bin/bash', 13:43:40 INFO - 'SHLVL': '1', 13:43:40 INFO - 'TERM': 'linux', 13:43:40 INFO - 'TMOUT': '86400', 13:43:40 INFO - 'USER': 'cltbld', 13:43:40 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477773804.765618-544863779', 13:43:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:40 INFO - '_': '/tools/buildbot/bin/python'} 13:43:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:41 INFO - Downloading/unpacking psutil>=3.1.1 13:43: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 13:43: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 13:43: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 13:43: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 13:43: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 13:43: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 13:43:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:43:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:43:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:43:43 INFO - Installing collected packages: psutil 13:43:43 INFO - Running setup.py install for psutil 13:43:43 INFO - building 'psutil._psutil_linux' extension 13:43:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:43:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:43:43 INFO - building 'psutil._psutil_posix' extension 13:43:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:43:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:43:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:43:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:43:43 INFO - Successfully installed psutil 13:43:43 INFO - Cleaning up... 13:43:43 INFO - Return code: 0 13:43:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:43: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')]} 13:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43: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')]} 13:43:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3eefa68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1698ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1695f60>, '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 0x1696d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16971d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477773804.765618-544863779', '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 13:43:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:43:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:43:43 INFO - Using env: {'DISPLAY': ':0', 13:43:43 INFO - 'HOME': '/home/cltbld', 13:43:43 INFO - 'LANG': 'en_US.UTF-8', 13:43:43 INFO - 'LANGUAGE': 'en_US:en', 13:43:43 INFO - 'LOGNAME': 'cltbld', 13:43:43 INFO - 'MAIL': '/var/mail/cltbld', 13:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:43 INFO - 'MOZ_NO_REMOTE': '1', 13:43:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:43 INFO - 'NO_EM_RESTART': '1', 13:43:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:43 INFO - 'PWD': '/builds/slave/test', 13:43:43 INFO - 'SHELL': '/bin/bash', 13:43:43 INFO - 'SHLVL': '1', 13:43:43 INFO - 'TERM': 'linux', 13:43:43 INFO - 'TMOUT': '86400', 13:43:43 INFO - 'USER': 'cltbld', 13:43:43 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477773804.765618-544863779', 13:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:43 INFO - '_': '/tools/buildbot/bin/python'} 13:43:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:43:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:43:45 INFO - Installing collected packages: mozsystemmonitor 13:43:45 INFO - Running setup.py install for mozsystemmonitor 13:43:45 INFO - Successfully installed mozsystemmonitor 13:43:45 INFO - Cleaning up... 13:43:45 INFO - Return code: 0 13:43:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3eefa68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1698ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1695f60>, '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 0x1696d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16971d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477773804.765618-544863779', '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 13:43:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:43:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:43:45 INFO - Using env: {'DISPLAY': ':0', 13:43:45 INFO - 'HOME': '/home/cltbld', 13:43:45 INFO - 'LANG': 'en_US.UTF-8', 13:43:45 INFO - 'LANGUAGE': 'en_US:en', 13:43:45 INFO - 'LOGNAME': 'cltbld', 13:43:45 INFO - 'MAIL': '/var/mail/cltbld', 13:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:45 INFO - 'MOZ_NO_REMOTE': '1', 13:43:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:45 INFO - 'NO_EM_RESTART': '1', 13:43:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:45 INFO - 'PWD': '/builds/slave/test', 13:43:45 INFO - 'SHELL': '/bin/bash', 13:43:45 INFO - 'SHLVL': '1', 13:43:45 INFO - 'TERM': 'linux', 13:43:45 INFO - 'TMOUT': '86400', 13:43:45 INFO - 'USER': 'cltbld', 13:43:45 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477773804.765618-544863779', 13:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:45 INFO - '_': '/tools/buildbot/bin/python'} 13:43:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:46 INFO - Downloading/unpacking jsonschema==2.5.1 13:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:43:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:43: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 13:43: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 13:43: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 13:43: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 13:43: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 13:43: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 13:43:48 INFO - Downloading functools32-3.2.3-2.tar.gz 13:43:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:43:48 INFO - warning: no files found matching '*.txt' 13:43:48 INFO - no previously-included directories found matching 'build' 13:43:48 INFO - no previously-included directories found matching 'dist' 13:43:48 INFO - no previously-included directories found matching '.git*' 13:43:48 INFO - Installing collected packages: jsonschema, functools32 13:43:48 INFO - Running setup.py install for functools32 13:43:48 INFO - warning: no files found matching '*.txt' 13:43:48 INFO - no previously-included directories found matching 'build' 13:43:48 INFO - no previously-included directories found matching 'dist' 13:43:48 INFO - no previously-included directories found matching '.git*' 13:43:48 INFO - Successfully installed jsonschema functools32 13:43:48 INFO - Cleaning up... 13:43:48 INFO - Return code: 0 13:43:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:43:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3eefa68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1698ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1695f60>, '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 0x1696d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16971d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477773804.765618-544863779', '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 13:43:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:43:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:43:48 INFO - Using env: {'DISPLAY': ':0', 13:43:48 INFO - 'HOME': '/home/cltbld', 13:43:48 INFO - 'LANG': 'en_US.UTF-8', 13:43:48 INFO - 'LANGUAGE': 'en_US:en', 13:43:48 INFO - 'LOGNAME': 'cltbld', 13:43:48 INFO - 'MAIL': '/var/mail/cltbld', 13:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:48 INFO - 'MOZ_NO_REMOTE': '1', 13:43:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:48 INFO - 'NO_EM_RESTART': '1', 13:43:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:48 INFO - 'PWD': '/builds/slave/test', 13:43:48 INFO - 'SHELL': '/bin/bash', 13:43:48 INFO - 'SHLVL': '1', 13:43:48 INFO - 'TERM': 'linux', 13:43:48 INFO - 'TMOUT': '86400', 13:43:48 INFO - 'USER': 'cltbld', 13:43:48 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477773804.765618-544863779', 13:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:48 INFO - '_': '/tools/buildbot/bin/python'} 13:43:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:43:48 INFO - Cleaning up... 13:43:48 INFO - Return code: 0 13:43:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:43:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3eefa68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1698ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1695f60>, '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 0x1696d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16971d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477773804.765618-544863779', '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 13:43:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:43:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:43:48 INFO - Using env: {'DISPLAY': ':0', 13:43:48 INFO - 'HOME': '/home/cltbld', 13:43:48 INFO - 'LANG': 'en_US.UTF-8', 13:43:48 INFO - 'LANGUAGE': 'en_US:en', 13:43:48 INFO - 'LOGNAME': 'cltbld', 13:43:48 INFO - 'MAIL': '/var/mail/cltbld', 13:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:48 INFO - 'MOZ_NO_REMOTE': '1', 13:43:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:48 INFO - 'NO_EM_RESTART': '1', 13:43:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:48 INFO - 'PWD': '/builds/slave/test', 13:43:48 INFO - 'SHELL': '/bin/bash', 13:43:48 INFO - 'SHLVL': '1', 13:43:48 INFO - 'TERM': 'linux', 13:43:48 INFO - 'TMOUT': '86400', 13:43:48 INFO - 'USER': 'cltbld', 13:43:48 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477773804.765618-544863779', 13:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:48 INFO - '_': '/tools/buildbot/bin/python'} 13:43:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:49 INFO - Downloading/unpacking blobuploader==1.2.4 13:43:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:50 INFO - Downloading blobuploader-1.2.4.tar.gz 13:43:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:43:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:43:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:43:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:43:51 INFO - Downloading docopt-0.6.1.tar.gz 13:43:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:43:51 INFO - Installing collected packages: blobuploader, requests, docopt 13:43:51 INFO - Running setup.py install for blobuploader 13:43:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:43:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:43:51 INFO - Running setup.py install for requests 13:43:52 INFO - Running setup.py install for docopt 13:43:52 INFO - Successfully installed blobuploader requests docopt 13:43:52 INFO - Cleaning up... 13:43:52 INFO - Return code: 0 13:43:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:43:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:43:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3eefa68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1698ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1695f60>, '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 0x1696d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16971d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477773804.765618-544863779', '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 13:43:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:43:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:43:52 INFO - Using env: {'DISPLAY': ':0', 13:43:52 INFO - 'HOME': '/home/cltbld', 13:43:52 INFO - 'LANG': 'en_US.UTF-8', 13:43:52 INFO - 'LANGUAGE': 'en_US:en', 13:43:52 INFO - 'LOGNAME': 'cltbld', 13:43:52 INFO - 'MAIL': '/var/mail/cltbld', 13:43:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:52 INFO - 'MOZ_NO_REMOTE': '1', 13:43:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:52 INFO - 'NO_EM_RESTART': '1', 13:43:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:52 INFO - 'PWD': '/builds/slave/test', 13:43:52 INFO - 'SHELL': '/bin/bash', 13:43:52 INFO - 'SHLVL': '1', 13:43:52 INFO - 'TERM': 'linux', 13:43:52 INFO - 'TMOUT': '86400', 13:43:52 INFO - 'USER': 'cltbld', 13:43:52 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477773804.765618-544863779', 13:43:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:52 INFO - '_': '/tools/buildbot/bin/python'} 13:43:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:43:52 INFO - Running setup.py (path:/tmp/pip-mdKs8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:43:52 INFO - Running setup.py (path:/tmp/pip-gsH37p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:43:52 INFO - Running setup.py (path:/tmp/pip-_yyiOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:43:52 INFO - Running setup.py (path:/tmp/pip-IWh6jY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:43:52 INFO - Running setup.py (path:/tmp/pip-wsxbA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:43:52 INFO - Running setup.py (path:/tmp/pip-HjQANr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:43:52 INFO - Running setup.py (path:/tmp/pip-1wky1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:43:53 INFO - Running setup.py (path:/tmp/pip-Cq7EqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:43:53 INFO - Running setup.py (path:/tmp/pip-DshfzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:43:53 INFO - Running setup.py (path:/tmp/pip-wC_TwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:43:53 INFO - Running setup.py (path:/tmp/pip-I4__2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:43:53 INFO - Running setup.py (path:/tmp/pip-1fpdra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:43:53 INFO - Running setup.py (path:/tmp/pip-jAx2Ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:43:53 INFO - Running setup.py (path:/tmp/pip-FT2euy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:43:53 INFO - Running setup.py (path:/tmp/pip-BOTsUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:43:53 INFO - Running setup.py (path:/tmp/pip-QNwCTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:43:53 INFO - Running setup.py (path:/tmp/pip-wDTnoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:43:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:43:53 INFO - Running setup.py install for manifestparser 13:43:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:43:53 INFO - Running setup.py install for mozcrash 13:43:53 INFO - Running setup.py install for mozdebug 13:43:54 INFO - Running setup.py install for mozdevice 13:43:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:43:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:43:54 INFO - Running setup.py install for mozfile 13:43:54 INFO - Running setup.py install for mozhttpd 13:43:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:43:54 INFO - Running setup.py install for mozinfo 13:43:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:43:54 INFO - Running setup.py install for mozInstall 13:43:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:43:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:43:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:43:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:43:54 INFO - Running setup.py install for mozleak 13:43:54 INFO - Running setup.py install for mozlog 13:43:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:43:54 INFO - Running setup.py install for moznetwork 13:43:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:43:54 INFO - Running setup.py install for mozprocess 13:43:55 INFO - Running setup.py install for mozprofile 13:43:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:43:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:43:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:43:55 INFO - Running setup.py install for mozrunner 13:43:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:43:55 INFO - Running setup.py install for mozscreenshot 13:43:55 INFO - Running setup.py install for moztest 13:43:55 INFO - Running setup.py install for mozversion 13:43:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:43:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:43:55 INFO - Cleaning up... 13:43:55 INFO - Return code: 0 13:43:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3eefa68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1698ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1695f60>, '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 0x1696d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16971d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477773804.765618-544863779', '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 13:43:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:43:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:43:55 INFO - Using env: {'DISPLAY': ':0', 13:43:55 INFO - 'HOME': '/home/cltbld', 13:43:55 INFO - 'LANG': 'en_US.UTF-8', 13:43:55 INFO - 'LANGUAGE': 'en_US:en', 13:43:55 INFO - 'LOGNAME': 'cltbld', 13:43:55 INFO - 'MAIL': '/var/mail/cltbld', 13:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:55 INFO - 'MOZ_NO_REMOTE': '1', 13:43:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:55 INFO - 'NO_EM_RESTART': '1', 13:43:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:55 INFO - 'PWD': '/builds/slave/test', 13:43:55 INFO - 'SHELL': '/bin/bash', 13:43:55 INFO - 'SHLVL': '1', 13:43:55 INFO - 'TERM': 'linux', 13:43:55 INFO - 'TMOUT': '86400', 13:43:55 INFO - 'USER': 'cltbld', 13:43:55 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477773804.765618-544863779', 13:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:55 INFO - '_': '/tools/buildbot/bin/python'} 13:43:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:43:55 INFO - Running setup.py (path:/tmp/pip-nSd1YV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:43:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:43:55 INFO - Running setup.py (path:/tmp/pip-AOC03U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:43:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:43:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:43:55 INFO - Running setup.py (path:/tmp/pip-W3yH7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:43:56 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)) 13:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:43:56 INFO - Running setup.py (path:/tmp/pip-iwWb6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:43:56 INFO - Running setup.py (path:/tmp/pip-62lq3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:43:56 INFO - Running setup.py (path:/tmp/pip-sZAI1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:43:56 INFO - Running setup.py (path:/tmp/pip-EzCTW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:43:56 INFO - Running setup.py (path:/tmp/pip-ejW_VY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:43:56 INFO - Running setup.py (path:/tmp/pip-RPoJ5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:43:56 INFO - Running setup.py (path:/tmp/pip-6FBXCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:43:56 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)) 13:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:43:56 INFO - Running setup.py (path:/tmp/pip-yq6qEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:43:56 INFO - Running setup.py (path:/tmp/pip-ZHfGNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:43:56 INFO - Running setup.py (path:/tmp/pip-NHLDAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:43:56 INFO - Running setup.py (path:/tmp/pip-qOZ_vY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:43:56 INFO - Running setup.py (path:/tmp/pip-oxPbEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:43:56 INFO - Running setup.py (path:/tmp/pip-xDcPZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:43:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:43:56 INFO - Running setup.py (path:/tmp/pip-wVV5vT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:43:57 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)) 13:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:43:57 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)) 13:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:43:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:43:57 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 13:43:57 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 13:43:57 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 13:43:57 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 13:43:57 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 13:43:57 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 13:43:58 INFO - Downloading blessings-1.6.tar.gz 13:43:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:43:59 INFO - Installing collected packages: blessings 13:43:59 INFO - Running setup.py install for blessings 13:43:59 INFO - Successfully installed blessings 13:43:59 INFO - Cleaning up... 13:43:59 INFO - Return code: 0 13:43:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:43:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:43:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:43:59 INFO - Reading from file tmpfile_stdout 13:43:59 INFO - Current package versions: 13:43:59 INFO - argparse == 1.2.1 13:43:59 INFO - blessings == 1.6 13:43:59 INFO - blobuploader == 1.2.4 13:43:59 INFO - docopt == 0.6.1 13:43:59 INFO - functools32 == 3.2.3-2 13:43:59 INFO - jsonschema == 2.5.1 13:43:59 INFO - manifestparser == 1.1 13:43:59 INFO - mozInstall == 1.12 13:43:59 INFO - mozcrash == 0.17 13:43:59 INFO - mozdebug == 0.1 13:43:59 INFO - mozdevice == 0.48 13:43:59 INFO - mozfile == 1.2 13:43:59 INFO - mozhttpd == 0.7 13:43:59 INFO - mozinfo == 0.9 13:43:59 INFO - mozleak == 0.1 13:43:59 INFO - mozlog == 3.4 13:43:59 INFO - moznetwork == 0.27 13:43:59 INFO - mozprocess == 0.23 13:43:59 INFO - mozprofile == 0.28 13:43:59 INFO - mozrunner == 6.12 13:43:59 INFO - mozscreenshot == 0.1 13:43:59 INFO - mozsystemmonitor == 0.3 13:43:59 INFO - moztest == 0.7 13:43:59 INFO - mozversion == 1.4 13:43:59 INFO - psutil == 3.1.1 13:43:59 INFO - requests == 1.2.3 13:43:59 INFO - wsgiref == 0.1.2 13:43:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:43:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3eefa68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1698ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1695f60>, '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 0x1696d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16971d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477773804.765618-544863779', '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 13:43:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:43:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:43:59 INFO - Using env: {'DISPLAY': ':0', 13:43:59 INFO - 'HOME': '/home/cltbld', 13:43:59 INFO - 'LANG': 'en_US.UTF-8', 13:43:59 INFO - 'LANGUAGE': 'en_US:en', 13:43:59 INFO - 'LOGNAME': 'cltbld', 13:43:59 INFO - 'MAIL': '/var/mail/cltbld', 13:43:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:59 INFO - 'MOZ_NO_REMOTE': '1', 13:43:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:59 INFO - 'NO_EM_RESTART': '1', 13:43:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:59 INFO - 'PWD': '/builds/slave/test', 13:43:59 INFO - 'SHELL': '/bin/bash', 13:43:59 INFO - 'SHLVL': '1', 13:43:59 INFO - 'TERM': 'linux', 13:43:59 INFO - 'TMOUT': '86400', 13:43:59 INFO - 'USER': 'cltbld', 13:43:59 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477773804.765618-544863779', 13:43:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:59 INFO - '_': '/tools/buildbot/bin/python'} 13:43:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:43:59 INFO - Cleaning up... 13:43:59 INFO - Return code: 0 13:43:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:43:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:43:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:43:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:43:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3eefa68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1698ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1695f60>, '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 0x1696d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16971d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477773804.765618-544863779', '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 13:43:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:43:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:43:59 INFO - Using env: {'DISPLAY': ':0', 13:43:59 INFO - 'HOME': '/home/cltbld', 13:43:59 INFO - 'LANG': 'en_US.UTF-8', 13:43:59 INFO - 'LANGUAGE': 'en_US:en', 13:43:59 INFO - 'LOGNAME': 'cltbld', 13:43:59 INFO - 'MAIL': '/var/mail/cltbld', 13:43:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:43:59 INFO - 'MOZ_NO_REMOTE': '1', 13:43:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:43:59 INFO - 'NO_EM_RESTART': '1', 13:43:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:43:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:43:59 INFO - 'PWD': '/builds/slave/test', 13:43:59 INFO - 'SHELL': '/bin/bash', 13:43:59 INFO - 'SHLVL': '1', 13:43:59 INFO - 'TERM': 'linux', 13:43:59 INFO - 'TMOUT': '86400', 13:43:59 INFO - 'USER': 'cltbld', 13:43:59 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477773804.765618-544863779', 13:43:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:43:59 INFO - '_': '/tools/buildbot/bin/python'} 13:43:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:43:59 INFO - Cleaning up... 13:43:59 INFO - Return code: 0 13:43:59 INFO - Running post-action listener: _resource_record_post_action 13:43:59 INFO - Running post-action listener: _start_resource_monitoring 13:43:59 INFO - Starting resource monitoring. 13:43:59 INFO - [mozharness: 2016-10-29 20:43:59.928833Z] Finished create-virtualenv step (success) 13:43:59 INFO - [mozharness: 2016-10-29 20:43:59.929288Z] Running install step. 13:43:59 INFO - Running pre-action listener: _resource_record_pre_action 13:43:59 INFO - Running main action method: install 13:43:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:43:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:44:00 INFO - Reading from file tmpfile_stdout 13:44:00 INFO - Detecting whether we're running mozinstall >=1.0... 13:44:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:44:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:44:00 INFO - Reading from file tmpfile_stdout 13:44:00 INFO - Output received: 13:44:00 INFO - Usage: mozinstall [options] installer 13:44:00 INFO - Options: 13:44:00 INFO - -h, --help show this help message and exit 13:44:00 INFO - -d DEST, --destination=DEST 13:44:00 INFO - Directory to install application into. [default: 13:44:00 INFO - "/builds/slave/test"] 13:44:00 INFO - --app=APP Application being installed. [default: firefox] 13:44:00 INFO - mkdir: /builds/slave/test/build/application 13:44:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:44:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:44:17 INFO - Reading from file tmpfile_stdout 13:44:17 INFO - Output received: 13:44:17 INFO - /builds/slave/test/build/application/firefox/firefox 13:44:17 INFO - Running post-action listener: _resource_record_post_action 13:44:17 INFO - [mozharness: 2016-10-29 20:44:17.096004Z] Finished install step (success) 13:44:17 INFO - [mozharness: 2016-10-29 20:44:17.096280Z] Running run-tests step. 13:44:17 INFO - Running pre-action listener: _resource_record_pre_action 13:44:17 INFO - Running main action method: run_tests 13:44:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:44:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:44:17 INFO - Python 2.7.3 13:44:17 INFO - Return code: 0 13:44:17 INFO - grabbing minidump binary from tooltool 13:44:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:44:17 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1695f60>, '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 0x1696d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16971d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:44:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:44:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:44:17 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:44:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:44:17 INFO - Return code: 0 13:44:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:44:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:44:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:44:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:44:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:44:17 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/1477698456/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 13:44:17 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/1477698456/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 13:44:17 INFO - Using env: {'DISPLAY': ':0', 13:44:17 INFO - 'HOME': '/home/cltbld', 13:44:17 INFO - 'LANG': 'en_US.UTF-8', 13:44:17 INFO - 'LANGUAGE': 'en_US:en', 13:44:17 INFO - 'LOGNAME': 'cltbld', 13:44:17 INFO - 'MAIL': '/var/mail/cltbld', 13:44:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:44:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:44:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:44:17 INFO - 'MOZ_NO_REMOTE': '1', 13:44:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:44:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:44:17 INFO - 'NO_EM_RESTART': '1', 13:44:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:44:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:44:17 INFO - 'PWD': '/builds/slave/test', 13:44:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:44:17 INFO - 'SHELL': '/bin/bash', 13:44:17 INFO - 'SHLVL': '1', 13:44:17 INFO - 'TERM': 'linux', 13:44:17 INFO - 'TMOUT': '86400', 13:44:17 INFO - 'USER': 'cltbld', 13:44:17 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477773804.765618-544863779', 13:44:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:44:17 INFO - '_': '/tools/buildbot/bin/python'} 13:44:17 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/1477698456/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 13:44:17 INFO - mozversion application_buildid: 20161028164736 13:44:17 INFO - mozversion application_changeset: 6f5c85e2f3f886f42a53fc926e265b476b642ea7 13:44:17 INFO - mozversion application_display_name: Nightly 13:44:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:44:17 INFO - mozversion application_name: Firefox 13:44:17 INFO - mozversion application_remotingname: firefox 13:44:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:44:17 INFO - mozversion application_vendor: Mozilla 13:44:17 INFO - mozversion application_version: 52.0a1 13:44:17 INFO - mozversion platform_buildid: 20161028164736 13:44:17 INFO - mozversion platform_changeset: 6f5c85e2f3f886f42a53fc926e265b476b642ea7 13:44:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:44:17 INFO - mozversion platform_version: 52.0a1 13:44:17 INFO - using testdate: 1477773857 13:44:17 INFO - actual date: 1477773857 13:44:17 INFO - starting webserver on 'localhost:46662' 13:44:17 INFO - SUITE-START | Running 2 tests 13:44:17 INFO - TEST-START | dromaeo_css 13:44:17 INFO - operating with platform_type : linux_ 13:44:17 INFO - Initialising browser for dromaeo_css test... 13:44:17 INFO - TEST-INFO | started process 20095 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplx1UZI/profile http://localhost:46662/getInfo.html) 13:44:21 INFO - PROCESS | 20095 | __metrics Screen width/height:1600/1200 13:44:21 INFO - PROCESS | 20095 | colorDepth:24 13:44:21 INFO - PROCESS | 20095 | Browser inner width/height: 1024/697 13:44:21 INFO - PROCESS | 20095 | __metrics 13:44:22 INFO - PROCESS | 20095 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:44:22 INFO - PROCESS | 20095 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:44:22 INFO - PROCESS | 20095 | console.error: PushService: 13:44:22 INFO - PROCESS | 20095 | stateChangeProcessEnqueue: Error transitioning state 13:44:22 INFO - PROCESS | 20095 | UnknownError 13:44:23 INFO - TEST-INFO | 20095: exit 0 13:44:23 INFO - Browser initialized. 13:44:23 INFO - Running cycle 1/1 for dromaeo_css test... 13:44:23 INFO - TEST-INFO | started process 20178 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplx1UZI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:44:35 INFO - PROCESS | 20178 | RSS: Main: 172052480 13:44:35 INFO - PROCESS | 20178 | 13:45:26 INFO - PROCESS | 20178 | 1477773926657 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] 13:47:37 INFO - PROCESS | 20178 | Cycle 1(1): loaded http://localhost:46662/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46662/tests/dromaeo/cssquery-ext.html) 13:47:39 INFO - PROCESS | 20178 | RSS: Main: 275091456 13:47:39 INFO - PROCESS | 20178 | 13:50:41 INFO - PROCESS | 20178 | Cycle 1(1): loaded http://localhost:46662/tests/dromaeo/cssquery-ext.html (next: http://localhost:46662/tests/dromaeo/cssquery-jquery.html) 13:50:42 INFO - PROCESS | 20178 | RSS: Main: 274403328 13:50:42 INFO - PROCESS | 20178 | 13:53:43 INFO - PROCESS | 20178 | Cycle 1(1): loaded http://localhost:46662/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46662/tests/dromaeo/cssquery-mootools.html) 13:53:44 INFO - PROCESS | 20178 | RSS: Main: 260165632 13:53:44 INFO - PROCESS | 20178 | 13:56:46 INFO - PROCESS | 20178 | Cycle 1(1): loaded http://localhost:46662/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46662/tests/dromaeo/cssquery-prototype.html) 13:56:47 INFO - PROCESS | 20178 | RSS: Main: 225996800 13:56:47 INFO - PROCESS | 20178 | 13:59:49 INFO - PROCESS | 20178 | Cycle 1(1): loaded http://localhost:46662/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46662/tests/dromaeo/cssquery-yui.html) 13:59:50 INFO - PROCESS | 20178 | RSS: Main: 215810048 13:59:50 INFO - PROCESS | 20178 | 14:02:53 INFO - PROCESS | 20178 | Cycle 1(1): loaded http://localhost:46662/tests/dromaeo/cssquery-yui.html (next: http://localhost:46662/tests/dromaeo/cssquery-dojo.html) 14:02:53 INFO - PROCESS | 20178 | RSS: Main: 306757632 14:02:53 INFO - PROCESS | 20178 | 14:02:53 INFO - PROCESS | 20178 | __start_tp_report 14:02:53 INFO - PROCESS | 20178 | _x_x_mozilla_page_load 14:02:53 INFO - PROCESS | 20178 | _x_x_mozilla_page_load_details 14:02:53 INFO - PROCESS | 20178 | |i|pagename|runs| 14:02:53 INFO - PROCESS | 20178 | |0;dojo.html;2999.7750168737343;3028.227801910515;3057.37323848611;3065.080475857242;3073.9077827665164;5179.378474583055;5277.577793776498;5286.814961476349;5315.335583052119;5335.702981863206;5301.469853014697;5310.07073762091;5316.441773613773;5320.6275560710765;5323.920141197885;4804.822818409494;4819.903601927959;4825.782839772219;4886.144924638192;4936.506349365052;4850.733209673466;4900.362952816129;4908.75456227189;4920.926186107211;4946.629002824802;4861.392325959255;4871.7076975381415;4887.315775791392;4894.388201474816;4908.877278068059;4905.460399356068;4935.235038569028;4936.432310284327;4945.653804233705;4985.999999999982;4754.738489383082;4800.4719480857075;4806.519348065201;4855.322695879961;4907.141250281186;5245.1345527988215;5295.152775555893;5331.893362132774;5334.22653715213;5362.195670649434;5732.8853422931725;5735.827925162252;5736.655800651933;5744.6840423776675;5745.569082318801;5524.033294173503;5590.748416321235;5767.192593036978;5774.82675519735;5786.218860453827;5299.73501324936;5313.814016509404;5322.361316642027;5324.866878327995;5398.676079435247;5792.768289268466;5843.678597677169;5858.853528661817;5860.560457965669;5863.179154918314;5388.0570900092325;5602.635828671205;5603.411641777555;5603.551715862721;5607.467290607386;5495.780168793283;5550.7779688812;5563.916541251884;5564.777408903679;5614.073677843192;5579.804706835242;5613.410591887875;5618.97190514053;5671.602987790815;5690.544756419559;5627.465390787868;5629.043062679354;5629.859253518613;5631.211630371751;5637;4242.809073591696;4257.425247591597;4352.717073390219;4354.695171337976;4415.62467190286;3849.672777813917;3859.671927886105;3897.902552436212;3908.7459315144424;3935.8819235422984;5348.491893270133;5356.892862142813;5358.651687640291;5359;5366.946330536723;5688.374278829326;5693.601447898607;5695.145728140729;5696.259486266758;5698.800541981011;5205.27126202332;5331.786728530893;5354.892902142014;5373.838784836461;5424.810131645373;5010.749462526859;5011.423686276052;5032.899342013139;5055.620828437882;5072.289879416885;5957;5977.9402205977385;6009.879802404015;6011.879762404727;6014.578979471483;5553.222548843084;5602.691851948182;5687.77248910039;5772.105323674838;5793.710314484343;5902.793402230901;5959.612625179349;5961.165436838933;6020.608660437058;6031.396860313934;5597.384287728428;5606.747696353592;5633.549316054624;5639.943600564106;5644.8306550803545;5561.805336813192;5603.0194715923735;5677.574181936454;5728.369879313355;5735.713214339183;5498.147787093007;5531.806386776443;5575.637583557218;5582.246396736551;5634.549236061187;5634.352049514358;5639.351474580311;5641.746121424628;5645.463680950304;5650.802221922213;5424.105022671215;5603.915941260966;5623.100303951348;5629.859253518531;5632.267805185464;5524.475174858382;5608.298962629671;5625.296837895263;5667.688277144632;5745.626534275259;5517.972410138084;5540.695261760642;5559.4162612926675;5573.219749235192;5630.296212973379 14:02:53 INFO - PROCESS | 20178 | |1;ext.html;574.2219292858177;594.5006194796372;614.2138063279002;642.8200103970889;650.2359727320397;34304.313913721744;40871.38692919609;41602.7919860401;41965.58034419655;45335.54664453355;43861.78069109658;44269.33595996055;44294.7785261074;44326.55673443273;44354.33468497975;7994.440389172761;8921.286297096232;9068.501232432214;9078.591463384131;9080.182783549479;8013.198680131998;8273.255407013368;8305.626246818907;10518.263721539495;10782.137429005661;11037.558497660084;11090.2236843421;11097.1122310215;11097.83353249702;11101.111911047137;10839.620613278537;10907.181961352851;10912.23614346996;10918.617848375268;10928.672139835779;10861.34831910088;10916.399598022106;10930.508127134299;10936.45317734118;10936.890631093667;41091;41369.37945930813;41385;41385.58614413848;41441.1711765763;3549.8225088745457;3653.113562233881;3703.888883333477;3711.554613446404;3822.617738226183;30191.547126793117;31043.844780776177;31071.68928310733;31147;31209;4311.353297005443;4389.275769498061;4402.7798610069685;4425.402570652953;4468;322260;323361.6453285229;323804.3336966413;323849;324325;54601.71770798974;54850.17724734132;54872;54904;54906.45093549093;34182.31635367279;35053;51347.48652513502;51566.484335156165;58161.41838581645;14674.192919389536;15057.096574205583;15065.774013389808;15071.09573425598;15083.924580377248;10339.9483002586;11379.317240965569;11456.083513318914;11490.310581365145;11490.42547872603;16236.940764808798;17973.640527189382;18598.721019184723;18619.162137703835;19385.83684978906;7239.89140162898;7279.745208917662;7280.235575264627;7370.373518250902;7385.4460915431555;962.6438217859437;1014.6043043213152;1031.865857438528;1057.746140926172;1088.894771806617;31229.843850781053;31294.530582041287;31295.37409251802;31935.520967185512;31951.840240798647;1080.9513571889283;1106;1113.0705860606483;1134.6709454258173;1180.7933611618105;16413.67172656564;16622;16707.49877503677;16731.83268167327;16770.413035543697;456064;761046;771304;773158;775353;56825.715871420376;57601.42398576044;57626;57826.42173578295;57884.71057644769;1283.287775284726;1330.255057167989;1334.8932085433141;1361.3669643615567;1379.0760190672274;30269.69730302669;31882.20294492656;32601;32621.836890815393;32661.673383265865;48159.75920120377;48835.511644883096;48869.51130488792;48966.26550601672;49045.2643210345;448298;452727;453531;453577;454234;26783.732162678123;27284.863575681993;27800.72199278062;27806.77545796291;33844.83077584596;36068;42226;53752.46247537475;53901.46098538965;55305.1704224445;36784;39146.804265978484;39264.2147157061;42577.787111064245;44880.551194487634;41702;42216.155676885675;42843.57156428521;43479.56520434755;44695.10609787721;42206.366904495844;43122.568774311854;43285.56714432815;43492;43692.56307436885;35769.82115089408;37905;38101.61898380981;38347;38394.23211535809;28788.136355909355;28848.882050872115;29151.854240728662;29540.704592953796;29604 14:02:53 INFO - PROCESS | 20178 | |2;jquery.html;372.6255113610821;381.95225596800395;386.3682878493663;399.5305516018677;409.0836526181355;18070.186841592127;19174.233030678755;19522;19706.901465492654;19709;16724.66550668986;16958.3216671333;17227.82772172278;17376.913115434436;17414.21636026379;5538.667679939196;5564.276644036269;5806.680632565207;5809.564282678816;5811.302643682764;5661.575381846357;5709.714514274269;5747.2528571285675;5757.68332741699;5764.7982320618785;5677.829665110054;5720.79977200798;5739.311282646088;5766.279215098113;5772.393898640625;5857.238558987326;5955.851103722398;5963.2844058713235;5963.910541341883;5966.46301832835;5617.21359009739;5751.568632352591;5782;5786.826395208151;5808.564357673149;13364.866351336557;13494.730105397837;13544.119632223874;13600.795988060187;13623.25072121033;2254.763249858774;2270.2394697776263;2281.5436912617542;2370.0638247892157;2883.918530551043;9867.950660246725;9908.455034973074;10146.847797283046;10270.178385729123;10641.73395665107;1790.6955817511055;1872.7565416495768;1907.523119220195;1956.6010302633686;1966.0562929793637;71859;76121;76514.23485765127;83362;84071;10234;10452.947735261427;10475.84286235707;11081.944590277159;11092.168087393478;15016.699666006618;15090.622734431727;15095;15105.47130850437;15134.772978405334;7584.5070070445245;7622.885656715153;7642.5032372895585;7805.609719514116;7809.531428114331;6987.274962764526;7063.470239732041;7223.566586004857;7266.818329541804;7347.926520734831;4478.507364189936;4588.357629931812;4602.838900638529;4676.2985552166765;4697.10754956564;1898.4874083997242;1927.6915693489254;1929.536911141344;1953.8925359105385;1983.7502373504888;893.6274192020197;904.5929331800716;949.3876449689911;994.179801663616;1032.3341444768082;17544;19317.710234346498;19399.224031038884;19413;19658;940.2149205413556;968.6367612145445;971.155095067296;1002.6440613582073;1003.9096481316717;10109.191264698806;11020.283681560673;11031.393273369882;11049.016765473278;11049.502772375263;455999;457745;461541;462512;467175;52201.73899130556;52505.7374713124;71592.28407715961;87634.56182719045;90573.6598438103;966.1932286540676;990.9752256193509;1014.9391036537831;1017.4861694844057;1018.8522664213648;16482.587935301235;16982.40561580339;17349.479515614552;17383.652326953645;17475.737863932307;42245.788771057174;43298.13403731971;43803.56196437995;44198.0110895004;44306.3354049696;55909.44090559205;56769.14846277227;57674.711626441596;58063.70968145132;58835.411645882996;7137.82155446118;7437.330640242404;7668.5782281975025;7947.84104317922;8011.559364234789;13136.408861601441;13160.14459060158;13200.933995329962;13309.733805323645;13600.183988960694;11867.525298988288;11878.46546905374;11937.343446110548;12102.455389507317;12184.939075304566;11122.666320010412;11367.772644547229;11457.59898403552;11780.646580602595;12191.695207619881;11230.438478075901;11492.138089643144;11642.476088576204;11649.941750291533;12082.637520874388;7558.962205189159;7630.7710768677025;7643.503172293783;7648.120466146464;8068.394870384627;8541.103184165573;10662.200334975063;11472.82790758156;11492.597759078391;11985.700357491132 14:02:53 INFO - PROCESS | 20178 | |3;mootools.html;1306.2293246984277;1458.0668372241764;1479.652281713797;1605.6467577133026;1762.2334284586198;7150.74972375967;7743.535387876731;8052.63763130659;8053.073896501896;8244.58777061146;8063.95968020159;8127.55298458586;8138.837223255531;8139.389545784075;8143.144969778177;2186.2676003538795;2221.611218036845;2232.7655596162413;2233.1625640384855;2239.787220214077;2253.1663284584724;2258.627326491135;2272.8181745460406;2289.7595752446005;2293.472501324696;2210.5689390568764;2245.9101635934544;2263.388885001049;2264.060414927803;2264.7395549511853;2145.4636340914617;2202.570498752744;2221.522372689871;2224.2659922225707;2232.1964092926532;2185.8579192352445;2224.0547767198877;2226.398872304485;2239.3058151972778;2252.8760918149496;7916.208379162095;8041.8793718094275;8100.3519718422385;8107.554084525349;8113.716019939333;4637.675362724611;4773.856784296477;4774.355462012653;4776.737279449629;4783.4977327380475;2994.595729576501;3150.322680623677;3189.856456459465;3202.5356323332985;3209.6950789674943;1087.12486448409;1103.4648195625116;1121.159130652011;1134.7219931116929;1148.110214583696;11048.834267485994;11052;11124.833127503094;11167.329960202333;11186.105111591054;3892.2410130024373;4061.614146656063;4159.812808423628;4172.207280616673;4174;8855.247303979233;8866.556672166495;8872.600732967032;8875.511846848356;8877.866831997526;4729.314249433813;4741.454732705783;4747.026859493795;4750.762461876892;4757.666963312535;3763.8533463349154;3915.3735402335487;4029.174019326031;4432.15789000089;4437.267850804581;3338.1487720631085;3544.468329750558;3546.716262698978;3555.982220088935;3558.1104723819044;1068.5939343049592;1107.5126944144552;1112.9220954533266;1118.8321751737305;1125.5835340923747;755.527795128045;876.9345245526715;914.2629004890628;917.4816228830823;935.1583574782615;5342.8931421372135;5369.301990741179;5519.862003449865;5543.223948647193;5725.484706376446;416.82910006897026;427.31842710876106;437.13883649211004;442.4756663353936;443.2044480158124;3693.8337774800198;3696;3761.5486141663177;3803.448499967489;3935.4490371348033;9585.616575336908;9935.552900119512;10008.049235322633;10032.949835250776;10033.799324013626;9652.9034709652;9764.658236961672;9977.900220997843;9993.250506212064;9994.050565196294;7318.414526837841;7424.183339832614;7442.702291908371;7448.441366897613;7450.18048014718;5232.843014709565;5369.382521009978;5418.674879507243;5477.233187353694;5543.584231182596;9126.817463650557;9130.680426185318;9139.771505712144;9154.633814647339;9155.816883662423;9258.53707314645;9320.300977426585;9322.580483878106;9362.578683959375;9362.95318523403;6866.244713081457;6923.5499692519825;6940.41006514452;6944.4791640626145;6948.235694073547;7630.389568834591;7788.182240864628;7847.372210223054;7848.411369147451;7880;6983.336583024605;7140.500164988401;7148.249433809375;7299.8465452690525;7396.6671499783715;6974.337437943387;7055.470839686941;7085.787426377217;7111;7117.466190035664;6218.595791273553;6278.497720182466;6290.874182516232;6328.6519241442165;6406.263279722892;4696.178168820375;4804.183288840835;4805.3512775774825;4844.2007068833245;4888.95111048885;4773.427188737373;4800.831970881002;4842.443119041355;4936.185529387611;5028.547430731252 14:02:53 INFO - PROCESS | 20178 | |4;prototype.html;306.5677394873229;318.3251506805573;321.67671490152395;326.4401551339452;329.51067664518195;5068.226120857698;5198.532132108109;5206;5276.915618330757;5284.154535274357;4980.576650984671;5098.5921126309895;5149.845504634857;5152.278680984656;5169.819056333029;4092.4270602115726;4102.938455923164;4105.651019663333;4109.4246805447265;4120.196561670476;3967.226390853785;4053.3653125468536;4115.9373970016895;4123.257813593552;4135.73117747347;4027.7784721840285;4043.7573745575214;4048.534418541861;4049.9392509112386;4061.472008638873;4028.9194216115516;4031.8185681644395;4032.6572241359518;4034.1528279061286;4036.979815100935;3437.862485500577;3534.8586056557706;3536.5225694531423;3560.3769340365334;3574;5025.798968041274;5026.623003274733;5030.547250747451;5035.697858128524;5049.798008079672;4601.7929193186055;4638.791254393526;4639.744814035227;4647.651426143053;4647.86056418308;5324.387695415038;5336.93261347732;5374.919376209321;5414.91877621836;5475.152920481367;3856.7107466940092;3867.6269924177077;3868.593797651234;3870.9419358709642;3874.748141370802;5670.376258611549;5676.943230567683;5676.943230567724;5690.2887139107615;5706.657600543939;3861.8841434757;3989.34708418904;4018.095928416083;4021.1756589899;4035.21313343901;4022.3162062449455;4038.131801662598;4041.3937909313836;4052.8986775330263;4067;4511.954880451219;4523.5024147343765;4528.818847246139;4551.749653769009;4618.8452886778305;5290.232916227125;5356.598255130881;5365.283109404953;5408.540274076748;5426.728663566806;1340.825692659948;1350.4672197056411;1357.5384369314481;1362.9250391228577;1375.5941997110876;872.3849685971375;873.2839071961058;892.2511876721569;894.8702438146563;896.5830888636815;4592.7933243004145;4605.171069207508;4617.007343421114;4623.330436259335;4624.468186158635;4834.6068695995;4845.9757701211265;4853.490383509751;4871.29366241893;4901.264810278415;4506.59440650343;4653.302004699254;4655.416243984553;4657.6273898088075;4684.882877928079;2555.6038813983864;2575.9098431554808;2577.92477055968;2597.8960841566127;2598.8700564971678;4984.352034235526;5065.56942659878;5074.213496907985;5083.339165908408;5090.796368145307;4703.553162449562;4858.708477491291;4952.8761780955765;4966.428860680996;5025.748712564357;4976.9050808822;4993.725345105981;5013.674111182761;5038.143515602356;5098.490150984946;4877.853664390074;4887.291342755209;4909.926351104665;4934.333864928189;4959.82640607577;4679.438467383936;4835.008823191167;4875.78151940859;4879.487358918746;4891.95108048915;4993.001399720143;4999;5003.224500202475;5033.798648054037;5071.54356107952;3616.3852145134865;3754.7747135171976;3817.732758706864;3871.8965094947803;3915.9021024474614;5467.234587157722;5468.179773034077;5492.91760623583;5504.724763761876;5509.614326997072;5354.11657076578;5376.7580458878665;5384.326959130109;5390.164524498709;5397.27136836522;5155.355580552431;5317.946820531745;5332.893342133213;5349.2778474906945;5357.410684824744;5286.299590286738;5290.497402746733;5291.867703307448;5295.920561191662;5316.893662126813;5235.685858848481;5316.840494785162;5346.251524786455;5362.981033603603;5398.652835242175;5392.946070539245;5405.297311349499;5420.647657902224;5423.15612691671;5426.1512705829755 14:02:53 INFO - PROCESS | 20178 | |5;yui.html;692.9896051559226;751.6129193465365;752.337942610503;756.0926887734717;832.1553623072579;13958.092723972948;14134.575962721108;14391.352389142488;14501.129932204076;14512.056716313433;14089.084209526374;14204.928975355135;14231.359588818503;14232.430702771902;14255.144691318528;630.8738252349525;658.5752189837576;760.5892817878339;772.7797577690345;789.6130895861044;769.8806684963812;778.8208711996244;779.2285637219169;779.5790273252437;783.3967844759532;835.0146826744439;835.9749207523784;836.6527890925258;836.9121242269565;836.9874451883227;678.4538446550525;705.693023534764;833.3999520345342;834.862247729124;835.2023817254508;591.2136857978878;604.8850718363541;611.807280706576;611.8133969139411;612.0788213738296;13999.160050396908;14040.578782636538;14059.78910316346;14060.789088163685;14073;13293.601191964257;13323.333833308392;13367.465301387932;13429.597112086556;13560.321983900765;12082.939585302018;12302.507899684002;12308.70758570355;12483.375831208403;12517.812232816515;4275.315949448104;4303.160883627694;4316.395704601358;4345.217860785057;4359.629431498326;51799.74100129475;52323.215151772754;55111.72444137794;56772.432275677544;57910.71044644792;10877.238593298393;10918.1811364148;10944.507497162487;11021.283616564897;11246.887531124748;18910.338138165098;19089.331873384366;19641.214351425784;19757;19769;8045.9597702011115;8102.513849169069;8197.79505512367;8201.384896132695;8288.958555207186;4493.5281795411665;4614.607758340579;4620.722756634613;4661.347411362412;4829.420469543677;3432.090496018557;3521.5774107107313;3528.6118526962014;3540.5574303212097;3540.982295088508;574.5202755699038;577.8613132848086;586.5044037788062;588.2323567744135;589.8260013296087;648.0764910003227;654.7773756922574;683.729926678959;725.2892165677665;744.133084956031;8690.436321285237;9102.180803727697;9959.651412200537;10165.339252948535;10340;622.6202016769766;668.2415458454689;711.772232885482;768.0898135709202;770.4067867741808;4391.670624703096;4646.465656449484;4649.399369437688;4787.640926930494;4803.975980120077;71114;71422.64288678524;72355;73593;74321.25678743252;60434.39565604376;62421.37578624156;62958;63921;66064;56988;57625;59376.70311648414;60825.69587152036;61526.69236653788;8832.12479677638;9159.404638698463;9172.54137293146;9180.44917304964;9224.446533208029;39498.60501394949;39656.60343396529;39727.60272397239;40005;40828.387574185814;48914.51085489099;54178;55659.44340556543;56252.43747562472;57456.13815792683;10727.731806704895;10772;10858.45707714627;10957.287776294515;11359.432028398713;12366.258024518558;12704;12816.679583010125;13037.15258508194;13126.540571079966;12093.57672481494;12454.564090256797;12883.677908052374;13022;13087.345632718516;12029.218100823418;12065.638030859089;12107;12239;12518.436670349674;12240.265584064984;12326.95220906233;12332;12858.678533036375;13271;10025.598976040877;10746.946265268623;10938.617148399768;11697.590584329508;11716.70708232301;11248.83126753083;11707;11730.296182229093;11814.232074915102;11900.36026967895 14:02:53 INFO - PROCESS | 20178 | __end_tp_report 14:02:53 INFO - PROCESS | 20178 | __start_cc_report 14:02:53 INFO - PROCESS | 20178 | _x_x_mozilla_cycle_collect,1316 14:02:53 INFO - PROCESS | 20178 | __end_cc_report 14:02:53 INFO - PROCESS | 20178 | __startTimestamp1477774973371__endTimestamp 14:02:53 INFO - PROCESS | 20178 | 14:02:53 INFO - PROCESS | 20178 | ------- Summary: start ------- 14:02:53 INFO - PROCESS | 20178 | Number of tests: 6 14:02:53 INFO - PROCESS | 20178 | 14:02:53 INFO - PROCESS | 20178 | [#0] dojo.html Cycles:165 Average:5300.57 Median:5531.81 stddev:604.35 (10.9%) stddev-sans-first:578.63 14:02:53 INFO - PROCESS | 20178 | Values: 2999.8 3028.2 3057.4 3065.1 3073.9 5179.4 5277.6 5286.8 5315.3 5335.7 5301.5 5310.1 5316.4 5320.6 5323.9 4804.8 4819.9 4825.8 4886.1 4936.5 4850.7 4900.4 4908.8 4920.9 4946.6 4861.4 4871.7 4887.3 4894.4 4908.9 4905.5 4935.2 4936.4 4945.7 4986.0 4754.7 4800.5 4806.5 4855.3 4907.1 5245.1 5295.2 5331.9 5334.2 5362.2 5732.9 5735.8 5736.7 5744.7 5745.6 5524.0 5590.7 5767.2 5774.8 5786.2 5299.7 5313.8 5322.4 5324.9 5398.7 5792.8 5843.7 5858.9 5860.6 5863.2 5388.1 5602.6 5603.4 5603.6 5607.5 5495.8 5550.8 5563.9 5564.8 5614.1 5579.8 5613.4 5619.0 5671.6 5690.5 5627.5 5629.0 5629.9 5631.2 5637.0 4242.8 4257.4 4352.7 4354.7 4415.6 3849.7 3859.7 3897.9 3908.7 3935.9 5348.5 5356.9 5358.7 5359.0 5366.9 5688.4 5693.6 5695.1 5696.3 5698.8 5205.3 5331.8 5354.9 5373.8 5424.8 5010.7 5011.4 5032.9 5055.6 5072.3 5957.0 5977.9 6009.9 6011.9 6014.6 5553.2 5602.7 5687.8 5772.1 5793.7 5902.8 5959.6 5961.2 6020.6 6031.4 5597.4 5606.7 5633.5 5639.9 5644.8 5561.8 5603.0 5677.6 5728.4 5735.7 5498.1 5531.8 5575.6 5582.2 5634.5 5634.4 5639.4 5641.7 5645.5 5650.8 5424.1 5603.9 5623.1 5629.9 5632.3 5524.5 5608.3 5625.3 5667.7 5745.6 5518.0 5540.7 5559.4 5573.2 5630.3 14:02:53 INFO - PROCESS | 20178 | 14:02:53 INFO - PROCESS | 20178 | [#1] ext.html Cycles:180 Average:64261.68 Median:20808.28 stddev:140689.62 (676.1%) stddev-sans-first:141003.03 14:02:53 INFO - PROCESS | 20178 | Values: 574.2 594.5 614.2 642.8 650.2 34304.3 40871.4 41602.8 41965.6 45335.5 43861.8 44269.3 44294.8 44326.6 44354.3 7994.4 8921.3 9068.5 9078.6 9080.2 8013.2 8273.3 8305.6 10518.3 10782.1 11037.6 11090.2 11097.1 11097.8 11101.1 10839.6 10907.2 10912.2 10918.6 10928.7 10861.3 10916.4 10930.5 10936.5 10936.9 41091.0 41369.4 41385.0 41385.6 41441.2 3549.8 3653.1 3703.9 3711.6 3822.6 30191.5 31043.8 31071.7 31147.0 31209.0 4311.4 4389.3 4402.8 4425.4 4468.0 322260.0 323361.6 323804.3 323849.0 324325.0 54601.7 54850.2 54872.0 54904.0 54906.5 34182.3 35053.0 51347.5 51566.5 58161.4 14674.2 15057.1 15065.8 15071.1 15083.9 10339.9 11379.3 11456.1 11490.3 11490.4 16236.9 17973.6 18598.7 18619.2 19385.8 7239.9 7279.7 7280.2 7370.4 7385.4 962.6 1014.6 1031.9 1057.7 1088.9 31229.8 31294.5 31295.4 31935.5 31951.8 1081.0 1106.0 1113.1 1134.7 1180.8 16413.7 16622.0 16707.5 16731.8 16770.4 456064.0 761046.0 771304.0 773158.0 775353.0 56825.7 57601.4 57626.0 57826.4 57884.7 1283.3 1330.3 1334.9 1361.4 1379.1 30269.7 31882.2 32601.0 32621.8 32661.7 48159.8 48835.5 48869.5 48966.3 49045.3 448298.0 452727.0 453531.0 453577.0 454234.0 26783.7 27284.9 27800.7 27806.8 33844.8 36068.0 42226.0 53752.5 53901.5 55305.2 36784.0 39146.8 39264.2 42577.8 44880.6 41702.0 42216.2 42843.6 43479.6 44695.1 42206.4 43122.6 43285.6 43492.0 43692.6 35769.8 37905.0 38101.6 38347.0 38394.2 28788.1 28848.9 29151.9 29540.7 29604.0 14:02:53 INFO - PROCESS | 20178 | 14:02:53 INFO - PROCESS | 20178 | [#2] jquery.html Cycles:180 Average:27132.06 Median:392.95 stddev:75838.65 (19299.9%) stddev-sans-first:76024.78 14:02:53 INFO - PROCESS | 20178 | Values: 372.6 382.0 386.4 399.5 409.1 18070.2 19174.2 19522.0 19706.9 19709.0 16724.7 16958.3 17227.8 17376.9 17414.2 5538.7 5564.3 5806.7 5809.6 5811.3 5661.6 5709.7 5747.3 5757.7 5764.8 5677.8 5720.8 5739.3 5766.3 5772.4 5857.2 5955.9 5963.3 5963.9 5966.5 5617.2 5751.6 5782.0 5786.8 5808.6 13364.9 13494.7 13544.1 13600.8 13623.3 2254.8 2270.2 2281.5 2370.1 2883.9 9868.0 9908.5 10146.8 10270.2 10641.7 1790.7 1872.8 1907.5 1956.6 1966.1 71859.0 76121.0 76514.2 83362.0 84071.0 10234.0 10452.9 10475.8 11081.9 11092.2 15016.7 15090.6 15095.0 15105.5 15134.8 7584.5 7622.9 7642.5 7805.6 7809.5 6987.3 7063.5 7223.6 7266.8 7347.9 4478.5 4588.4 4602.8 4676.3 4697.1 1898.5 1927.7 1929.5 1953.9 1983.8 893.6 904.6 949.4 994.2 1032.3 17544.0 19317.7 19399.2 19413.0 19658.0 940.2 968.6 971.2 1002.6 1003.9 10109.2 11020.3 11031.4 11049.0 11049.5 455999.0 457745.0 461541.0 462512.0 467175.0 52201.7 52505.7 71592.3 87634.6 90573.7 966.2 991.0 1014.9 1017.5 1018.9 16482.6 16982.4 17349.5 17383.7 17475.7 42245.8 43298.1 43803.6 44198.0 44306.3 55909.4 56769.1 57674.7 58063.7 58835.4 7137.8 7437.3 7668.6 7947.8 8011.6 13136.4 13160.1 13200.9 13309.7 13600.2 11867.5 11878.5 11937.3 12102.5 12184.9 11122.7 11367.8 11457.6 11780.6 12191.7 11230.4 11492.1 11642.5 11649.9 12082.6 7559.0 7630.8 7643.5 7648.1 8068.4 8541.1 10662.2 11472.8 11492.6 11985.7 14:02:53 INFO - PROCESS | 20178 | 14:02:53 INFO - PROCESS | 20178 | [#3] mootools.html Cycles:180 Average:5276.44 Median:4802.51 stddev:2975.62 (62.0%) stddev-sans-first:2969.01 14:02:53 INFO - PROCESS | 20178 | Values: 1306.2 1458.1 1479.7 1605.6 1762.2 7150.7 7743.5 8052.6 8053.1 8244.6 8064.0 8127.6 8138.8 8139.4 8143.1 2186.3 2221.6 2232.8 2233.2 2239.8 2253.2 2258.6 2272.8 2289.8 2293.5 2210.6 2245.9 2263.4 2264.1 2264.7 2145.5 2202.6 2221.5 2224.3 2232.2 2185.9 2224.1 2226.4 2239.3 2252.9 7916.2 8041.9 8100.4 8107.6 8113.7 4637.7 4773.9 4774.4 4776.7 4783.5 2994.6 3150.3 3189.9 3202.5 3209.7 1087.1 1103.5 1121.2 1134.7 1148.1 11048.8 11052.0 11124.8 11167.3 11186.1 3892.2 4061.6 4159.8 4172.2 4174.0 8855.2 8866.6 8872.6 8875.5 8877.9 4729.3 4741.5 4747.0 4750.8 4757.7 3763.9 3915.4 4029.2 4432.2 4437.3 3338.1 3544.5 3546.7 3556.0 3558.1 1068.6 1107.5 1112.9 1118.8 1125.6 755.5 876.9 914.3 917.5 935.2 5342.9 5369.3 5519.9 5543.2 5725.5 416.8 427.3 437.1 442.5 443.2 3693.8 3696.0 3761.5 3803.4 3935.4 9585.6 9935.6 10008.0 10032.9 10033.8 9652.9 9764.7 9977.9 9993.3 9994.1 7318.4 7424.2 7442.7 7448.4 7450.2 5232.8 5369.4 5418.7 5477.2 5543.6 9126.8 9130.7 9139.8 9154.6 9155.8 9258.5 9320.3 9322.6 9362.6 9363.0 6866.2 6923.5 6940.4 6944.5 6948.2 7630.4 7788.2 7847.4 7848.4 7880.0 6983.3 7140.5 7148.2 7299.8 7396.7 6974.3 7055.5 7085.8 7111.0 7117.5 6218.6 6278.5 6290.9 6328.7 6406.3 4696.2 4804.2 4805.4 4844.2 4889.0 4773.4 4800.8 4842.4 4936.2 5028.5 14:02:53 INFO - PROCESS | 20178 | 14:02:53 INFO - PROCESS | 20178 | [#4] prototype.html Cycles:180 Average:4379.81 Median:4883.39 stddev:1260.19 (25.8%) stddev-sans-first:1226.08 14:02:53 INFO - PROCESS | 20178 | Values: 306.6 318.3 321.7 326.4 329.5 5068.2 5198.5 5206.0 5276.9 5284.2 4980.6 5098.6 5149.8 5152.3 5169.8 4092.4 4102.9 4105.7 4109.4 4120.2 3967.2 4053.4 4115.9 4123.3 4135.7 4027.8 4043.8 4048.5 4049.9 4061.5 4028.9 4031.8 4032.7 4034.2 4037.0 3437.9 3534.9 3536.5 3560.4 3574.0 5025.8 5026.6 5030.5 5035.7 5049.8 4601.8 4638.8 4639.7 4647.7 4647.9 5324.4 5336.9 5374.9 5414.9 5475.2 3856.7 3867.6 3868.6 3870.9 3874.7 5670.4 5676.9 5676.9 5690.3 5706.7 3861.9 3989.3 4018.1 4021.2 4035.2 4022.3 4038.1 4041.4 4052.9 4067.0 4512.0 4523.5 4528.8 4551.7 4618.8 5290.2 5356.6 5365.3 5408.5 5426.7 1340.8 1350.5 1357.5 1362.9 1375.6 872.4 873.3 892.3 894.9 896.6 4592.8 4605.2 4617.0 4623.3 4624.5 4834.6 4846.0 4853.5 4871.3 4901.3 4506.6 4653.3 4655.4 4657.6 4684.9 2555.6 2575.9 2577.9 2597.9 2598.9 4984.4 5065.6 5074.2 5083.3 5090.8 4703.6 4858.7 4952.9 4966.4 5025.7 4976.9 4993.7 5013.7 5038.1 5098.5 4877.9 4887.3 4909.9 4934.3 4959.8 4679.4 4835.0 4875.8 4879.5 4892.0 4993.0 4999.0 5003.2 5033.8 5071.5 3616.4 3754.8 3817.7 3871.9 3915.9 5467.2 5468.2 5492.9 5504.7 5509.6 5354.1 5376.8 5384.3 5390.2 5397.3 5155.4 5317.9 5332.9 5349.3 5357.4 5286.3 5290.5 5291.9 5295.9 5316.9 5235.7 5316.8 5346.3 5363.0 5398.7 5392.9 5405.3 5420.6 5423.2 5426.2 14:02:53 INFO - PROCESS | 20178 | 14:02:53 INFO - PROCESS | 20178 | [#5] yui.html Cycles:180 Average:16039.11 Median:4633.59 stddev:19678.24 (424.7%) stddev-sans-first:19699.70 14:02:53 INFO - PROCESS | 20178 | Values: 693.0 751.6 752.3 756.1 832.2 13958.1 14134.6 14391.4 14501.1 14512.1 14089.1 14204.9 14231.4 14232.4 14255.1 630.9 658.6 760.6 772.8 789.6 769.9 778.8 779.2 779.6 783.4 835.0 836.0 836.7 836.9 837.0 678.5 705.7 833.4 834.9 835.2 591.2 604.9 611.8 611.8 612.1 13999.2 14040.6 14059.8 14060.8 14073.0 13293.6 13323.3 13367.5 13429.6 13560.3 12082.9 12302.5 12308.7 12483.4 12517.8 4275.3 4303.2 4316.4 4345.2 4359.6 51799.7 52323.2 55111.7 56772.4 57910.7 10877.2 10918.2 10944.5 11021.3 11246.9 18910.3 19089.3 19641.2 19757.0 19769.0 8046.0 8102.5 8197.8 8201.4 8289.0 4493.5 4614.6 4620.7 4661.3 4829.4 3432.1 3521.6 3528.6 3540.6 3541.0 574.5 577.9 586.5 588.2 589.8 648.1 654.8 683.7 725.3 744.1 8690.4 9102.2 9959.7 10165.3 10340.0 622.6 668.2 711.8 768.1 770.4 4391.7 4646.5 4649.4 4787.6 4804.0 71114.0 71422.6 72355.0 73593.0 74321.3 60434.4 62421.4 62958.0 63921.0 66064.0 56988.0 57625.0 59376.7 60825.7 61526.7 8832.1 9159.4 9172.5 9180.4 9224.4 39498.6 39656.6 39727.6 40005.0 40828.4 48914.5 54178.0 55659.4 56252.4 57456.1 10727.7 10772.0 10858.5 10957.3 11359.4 12366.3 12704.0 12816.7 13037.2 13126.5 12093.6 12454.6 12883.7 13022.0 13087.3 12029.2 12065.6 12107.0 12239.0 12518.4 12240.3 12327.0 12332.0 12858.7 13271.0 10025.6 10746.9 10938.6 11697.6 11716.7 11248.8 11707.0 11730.3 11814.2 11900.4 14:02:53 INFO - PROCESS | 20178 | -------- Summary: end -------- 14:02:53 INFO - PROCESS | 20178 | 14:02:54 INFO - TEST-INFO | 20178: exit 0 14:02:54 INFO - TEST-OK | dromaeo_css | took 1116954ms 14:02:54 INFO - TEST-START | kraken 14:02:54 INFO - operating with platform_type : linux_ 14:02:54 INFO - Initialising browser for kraken test... 14:02:54 INFO - TEST-INFO | started process 20484 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8pRqTH/profile http://localhost:46662/getInfo.html) 14:02:58 INFO - PROCESS | 20484 | __metrics Screen width/height:1600/1200 14:02:58 INFO - PROCESS | 20484 | colorDepth:24 14:02:58 INFO - PROCESS | 20484 | Browser inner width/height: 1024/697 14:02:58 INFO - PROCESS | 20484 | __metrics 14:02:58 INFO - PROCESS | 20484 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:02:58 INFO - PROCESS | 20484 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:02:59 INFO - PROCESS | 20484 | console.error: PushService: 14:02:59 INFO - PROCESS | 20484 | stateChangeProcessEnqueue: Error transitioning state 14:02:59 INFO - PROCESS | 20484 | UnknownError 14:03:00 INFO - TEST-INFO | 20484: exit 0 14:03:00 INFO - Browser initialized. 14:03:00 INFO - Running cycle 1/1 for kraken test... 14:03:00 INFO - TEST-INFO | started process 20566 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8pRqTH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:03:12 INFO - PROCESS | 20566 | RSS: Main: 172412928 14:03:12 INFO - PROCESS | 20566 | 14:03:14 INFO - PROCESS | 20566 | Cycle 1(1): loaded http://localhost:46662/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46662/tests/kraken/driver.html?testName=audio-beat-detection) 14:03:15 INFO - PROCESS | 20566 | RSS: Main: 237518848 14:03:15 INFO - PROCESS | 20566 | 14:03:18 INFO - PROCESS | 20566 | Cycle 1(1): loaded http://localhost:46662/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46662/tests/kraken/driver.html?testName=audio-dft) 14:03:19 INFO - PROCESS | 20566 | RSS: Main: 215924736 14:03:19 INFO - PROCESS | 20566 | 14:03:22 INFO - PROCESS | 20566 | Cycle 1(1): loaded http://localhost:46662/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46662/tests/kraken/driver.html?testName=audio-fft) 14:03:22 INFO - PROCESS | 20566 | RSS: Main: 297381888 14:03:22 INFO - PROCESS | 20566 | 14:03:24 INFO - PROCESS | 20566 | Cycle 1(1): loaded http://localhost:46662/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46662/tests/kraken/driver.html?testName=audio-oscillator) 14:03:25 INFO - PROCESS | 20566 | RSS: Main: 206426112 14:03:25 INFO - PROCESS | 20566 | 14:03:27 INFO - PROCESS | 20566 | Cycle 1(1): loaded http://localhost:46662/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46662/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:03:28 INFO - PROCESS | 20566 | RSS: Main: 211668992 14:03:28 INFO - PROCESS | 20566 | 14:03:31 INFO - PROCESS | 20566 | Cycle 1(1): loaded http://localhost:46662/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46662/tests/kraken/driver.html?testName=imaging-darkroom) 14:03:31 INFO - PROCESS | 20566 | RSS: Main: 247406592 14:03:31 INFO - PROCESS | 20566 | 14:03:35 INFO - PROCESS | 20566 | Cycle 1(1): loaded http://localhost:46662/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46662/tests/kraken/driver.html?testName=imaging-desaturate) 14:03:35 INFO - PROCESS | 20566 | RSS: Main: 246571008 14:03:35 INFO - PROCESS | 20566 | 14:03:38 INFO - PROCESS | 20566 | Cycle 1(1): loaded http://localhost:46662/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46662/tests/kraken/driver.html?testName=json-parse-financial) 14:03:38 INFO - PROCESS | 20566 | RSS: Main: 246439936 14:03:38 INFO - PROCESS | 20566 | 14:03:40 INFO - PROCESS | 20566 | Cycle 1(1): loaded http://localhost:46662/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46662/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:03:41 INFO - PROCESS | 20566 | RSS: Main: 209354752 14:03:41 INFO - PROCESS | 20566 | 14:03:42 INFO - PROCESS | 20566 | Cycle 1(1): loaded http://localhost:46662/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46662/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:03:43 INFO - PROCESS | 20566 | RSS: Main: 216821760 14:03:43 INFO - PROCESS | 20566 | 14:03:45 INFO - PROCESS | 20566 | Cycle 1(1): loaded http://localhost:46662/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46662/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:03:46 INFO - PROCESS | 20566 | RSS: Main: 225366016 14:03:46 INFO - PROCESS | 20566 | 14:03:48 INFO - PROCESS | 20566 | Cycle 1(1): loaded http://localhost:46662/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46662/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:03:49 INFO - PROCESS | 20566 | RSS: Main: 233549824 14:03:49 INFO - PROCESS | 20566 | 14:03:52 INFO - PROCESS | 20566 | Cycle 1(1): loaded http://localhost:46662/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46662/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:03:52 INFO - PROCESS | 20566 | RSS: Main: 230928384 14:03:52 INFO - PROCESS | 20566 | 14:03:54 INFO - PROCESS | 20566 | Cycle 1(1): loaded http://localhost:46662/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46662/tests/kraken/driver.html?testName=ai-astar) 14:03:54 INFO - PROCESS | 20566 | RSS: Main: 282169344 14:03:54 INFO - PROCESS | 20566 | 14:03:54 INFO - PROCESS | 20566 | __start_tp_report 14:03:54 INFO - PROCESS | 20566 | _x_x_mozilla_page_load 14:03:54 INFO - PROCESS | 20566 | _x_x_mozilla_page_load_details 14:03:54 INFO - PROCESS | 20566 | |i|pagename|runs| 14:03:54 INFO - PROCESS | 20566 | |0;ai-astar;104;113;110;110;112;111;109;110;110;111 14:03:54 INFO - PROCESS | 20566 | |1;audio-beat-detection;148;122;123;174;124;125;123;123;161;122 14:03:54 INFO - PROCESS | 20566 | |2;audio-dft;160;160;160;161;159;159;161;160;161;163 14:03:54 INFO - PROCESS | 20566 | |3;audio-fft;75;76;75;113;76;77;75;76;97;74 14:03:54 INFO - PROCESS | 20566 | |4;audio-oscillator;81;82;108;83;82;83;106;81;82;115 14:03:54 INFO - PROCESS | 20566 | |5;imaging-gaussian-blur;117;117;116;116;116;117;116;117;116;117 14:03:54 INFO - PROCESS | 20566 | |6;imaging-darkroom;145;146;145;146;146;147;147;147;146;146 14:03:54 INFO - PROCESS | 20566 | |7;imaging-desaturate;84;85;84;84;85;84;84;84;85;85 14:03:54 INFO - PROCESS | 20566 | |8;json-parse-financial;52;51;51;51;52;53;53;53;54;53 14:03:54 INFO - PROCESS | 20566 | |9;json-stringify-tinderbox;60;62;61;61;61;60;61;61;61;61 14:03:54 INFO - PROCESS | 20566 | |10;stanford-crypto-aes;86;81;79;80;82;80;80;81;79;79 14:03:54 INFO - PROCESS | 20566 | |11;stanford-crypto-ccm;134;135;139;131;131;131;136;129;169;131 14:03:54 INFO - PROCESS | 20566 | |12;stanford-crypto-pbkdf2;165;164;163;162;162;163;162;164;162;163 14:03:54 INFO - PROCESS | 20566 | |13;stanford-crypto-sha256-iterative;63;64;64;62;65;63;63;63;62;62 14:03:54 INFO - PROCESS | 20566 | __end_tp_report 14:03:54 INFO - PROCESS | 20566 | __start_cc_report 14:03:54 INFO - PROCESS | 20566 | _x_x_mozilla_cycle_collect,1668 14:03:54 INFO - PROCESS | 20566 | __end_cc_report 14:03:54 INFO - PROCESS | 20566 | __startTimestamp1477775034616__endTimestamp 14:03:54 INFO - PROCESS | 20566 | 14:03:54 INFO - PROCESS | 20566 | ------- Summary: start ------- 14:03:54 INFO - PROCESS | 20566 | Number of tests: 14 14:03:54 INFO - PROCESS | 20566 | 14:03:54 INFO - PROCESS | 20566 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.50 stddev:2.40 (2.2%) stddev-sans-first:1.22 14:03:54 INFO - PROCESS | 20566 | Values: 104.0 113.0 110.0 110.0 112.0 111.0 109.0 110.0 110.0 111.0 14:03:54 INFO - PROCESS | 20566 | 14:03:54 INFO - PROCESS | 20566 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:124.50 stddev:19.31 (15.5%) stddev-sans-first:19.85 14:03:54 INFO - PROCESS | 20566 | Values: 148.0 122.0 123.0 174.0 124.0 125.0 123.0 123.0 161.0 122.0 14:03:54 INFO - PROCESS | 20566 | 14:03:54 INFO - PROCESS | 20566 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:1.17 (0.7%) stddev-sans-first:1.24 14:03:54 INFO - PROCESS | 20566 | Values: 160.0 160.0 160.0 161.0 159.0 159.0 161.0 160.0 161.0 163.0 14:03:54 INFO - PROCESS | 20566 | 14:03:54 INFO - PROCESS | 20566 | [#3] audio-fft Cycles:10 Average:81.40 Median:76.00 stddev:13.02 (17.1%) stddev-sans-first:13.61 14:03:54 INFO - PROCESS | 20566 | Values: 75.0 76.0 75.0 113.0 76.0 77.0 75.0 76.0 97.0 74.0 14:03:54 INFO - PROCESS | 20566 | 14:03:54 INFO - PROCESS | 20566 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:82.00 stddev:13.57 (16.5%) stddev-sans-first:13.96 14:03:54 INFO - PROCESS | 20566 | Values: 81.0 82.0 108.0 83.0 82.0 83.0 106.0 81.0 82.0 115.0 14:03:54 INFO - PROCESS | 20566 | 14:03:54 INFO - PROCESS | 20566 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 14:03:54 INFO - PROCESS | 20566 | Values: 117.0 117.0 116.0 116.0 116.0 117.0 116.0 117.0 116.0 117.0 14:03:54 INFO - PROCESS | 20566 | 14:03:54 INFO - PROCESS | 20566 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 14:03:54 INFO - PROCESS | 20566 | Values: 145.0 146.0 145.0 146.0 146.0 147.0 147.0 147.0 146.0 146.0 14:03:54 INFO - PROCESS | 20566 | 14:03:54 INFO - PROCESS | 20566 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 14:03:54 INFO - PROCESS | 20566 | Values: 84.0 85.0 84.0 84.0 85.0 84.0 84.0 84.0 85.0 85.0 14:03:54 INFO - PROCESS | 20566 | 14:03:54 INFO - PROCESS | 20566 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:53.00 stddev:1.06 (2.0%) stddev-sans-first:1.12 14:03:54 INFO - PROCESS | 20566 | Values: 52.0 51.0 51.0 51.0 52.0 53.0 53.0 53.0 54.0 53.0 14:03:54 INFO - PROCESS | 20566 | 14:03:54 INFO - PROCESS | 20566 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 14:03:54 INFO - PROCESS | 20566 | Values: 60.0 62.0 61.0 61.0 61.0 60.0 61.0 61.0 61.0 61.0 14:03:54 INFO - PROCESS | 20566 | 14:03:54 INFO - PROCESS | 20566 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.50 stddev:2.11 (2.6%) stddev-sans-first:1.05 14:03:54 INFO - PROCESS | 20566 | Values: 86.0 81.0 79.0 80.0 82.0 80.0 80.0 81.0 79.0 79.0 14:03:54 INFO - PROCESS | 20566 | 14:03:54 INFO - PROCESS | 20566 | [#11] stanford-crypto-ccm Cycles:10 Average:136.60 Median:134.50 stddev:11.78 (8.8%) stddev-sans-first:12.45 14:03:54 INFO - PROCESS | 20566 | Values: 134.0 135.0 139.0 131.0 131.0 131.0 136.0 129.0 169.0 131.0 14:03:54 INFO - PROCESS | 20566 | 14:03:54 INFO - PROCESS | 20566 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.00 Median:163.00 stddev:1.05 (0.6%) stddev-sans-first:0.83 14:03:54 INFO - PROCESS | 20566 | Values: 165.0 164.0 163.0 162.0 162.0 163.0 162.0 164.0 162.0 163.0 14:03:54 INFO - PROCESS | 20566 | 14:03:54 INFO - PROCESS | 20566 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.00 stddev:0.99 (1.6%) stddev-sans-first:1.05 14:03:54 INFO - PROCESS | 20566 | Values: 63.0 64.0 64.0 62.0 65.0 63.0 63.0 63.0 62.0 62.0 14:03:54 INFO - PROCESS | 20566 | -------- Summary: end -------- 14:03:54 INFO - PROCESS | 20566 | 14:03:55 INFO - TEST-INFO | 20566: exit 0 14:03:55 INFO - TEST-OK | kraken | took 61545ms 14:03:55 INFO - SUITE-END | took 1178s 14:03:56 INFO - Completed test suite (00:19:38) 14:03:56 INFO - javascript benchmark 14:03:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2999.7750168737343, 3028.227801910515, 3057.37323848611, 3065.080475857242, 3073.9077827665164, 5179.378474583055, 5277.577793776498, 5286.814961476349, 5315.335583052119, 5335.702981863206, 5301.469853014697, 5310.07073762091, 5316.441773613773, 5320.6275560710765, 5323.920141197885, 4804.822818409494, 4819.903601927959, 4825.782839772219, 4886.144924638192, 4936.506349365052, 4850.733209673466, 4900.362952816129, 4908.75456227189, 4920.926186107211, 4946.629002824802, 4861.392325959255, 4871.7076975381415, 4887.315775791392, 4894.388201474816, 4908.877278068059, 4905.460399356068, 4935.235038569028, 4936.432310284327, 4945.653804233705, 4985.999999999982, 4754.738489383082, 4800.4719480857075, 4806.519348065201, 4855.322695879961, 4907.141250281186, 5245.1345527988215, 5295.152775555893, 5331.893362132774, 5334.22653715213, 5362.195670649434, 5732.8853422931725, 5735.827925162252, 5736.655800651933, 5744.6840423776675, 5745.569082318801, 5524.033294173503, 5590.748416321235, 5767.192593036978, 5774.82675519735, 5786.218860453827, 5299.73501324936, 5313.814016509404, 5322.361316642027, 5324.866878327995, 5398.676079435247, 5792.768289268466, 5843.678597677169, 5858.853528661817, 5860.560457965669, 5863.179154918314, 5388.0570900092325, 5602.635828671205, 5603.411641777555, 5603.551715862721, 5607.467290607386, 5495.780168793283, 5550.7779688812, 5563.916541251884, 5564.777408903679, 5614.073677843192, 5579.804706835242, 5613.410591887875, 5618.97190514053, 5671.602987790815, 5690.544756419559, 5627.465390787868, 5629.043062679354, 5629.859253518613, 5631.211630371751, 5637.0, 4242.809073591696, 4257.425247591597, 4352.717073390219, 4354.695171337976, 4415.62467190286, 3849.672777813917, 3859.671927886105, 3897.902552436212, 3908.7459315144424, 3935.8819235422984, 5348.491893270133, 5356.892862142813, 5358.651687640291, 5359.0, 5366.946330536723, 5688.374278829326, 5693.601447898607, 5695.145728140729, 5696.259486266758, 5698.800541981011, 5205.27126202332, 5331.786728530893, 5354.892902142014, 5373.838784836461, 5424.810131645373, 5010.749462526859, 5011.423686276052, 5032.899342013139, 5055.620828437882, 5072.289879416885, 5957.0, 5977.9402205977385, 6009.879802404015, 6011.879762404727, 6014.578979471483, 5553.222548843084, 5602.691851948182, 5687.77248910039, 5772.105323674838, 5793.710314484343, 5902.793402230901, 5959.612625179349, 5961.165436838933, 6020.608660437058, 6031.396860313934, 5597.384287728428, 5606.747696353592, 5633.549316054624, 5639.943600564106, 5644.8306550803545, 5561.805336813192, 5603.0194715923735, 5677.574181936454, 5728.369879313355, 5735.713214339183, 5498.147787093007, 5531.806386776443, 5575.637583557218, 5582.246396736551, 5634.549236061187, 5634.352049514358, 5639.351474580311, 5641.746121424628, 5645.463680950304, 5650.802221922213, 5424.105022671215, 5603.915941260966, 5623.100303951348, 5629.859253518531, 5632.267805185464, 5524.475174858382, 5608.298962629671, 5625.296837895263, 5667.688277144632, 5745.626534275259, 5517.972410138084, 5540.695261760642, 5559.4162612926675, 5573.219749235192, 5630.296212973379], "value": 5259.245506067603, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.2219292858177, 594.5006194796372, 614.2138063279002, 642.8200103970889, 650.2359727320397, 34304.313913721744, 40871.38692919609, 41602.7919860401, 41965.58034419655, 45335.54664453355, 43861.78069109658, 44269.33595996055, 44294.7785261074, 44326.55673443273, 44354.33468497975, 7994.440389172761, 8921.286297096232, 9068.501232432214, 9078.591463384131, 9080.182783549479, 8013.198680131998, 8273.255407013368, 8305.626246818907, 10518.263721539495, 10782.137429005661, 11037.558497660084, 11090.2236843421, 11097.1122310215, 11097.83353249702, 11101.111911047137, 10839.620613278537, 10907.181961352851, 10912.23614346996, 10918.617848375268, 10928.672139835779, 10861.34831910088, 10916.399598022106, 10930.508127134299, 10936.45317734118, 10936.890631093667, 41091.0, 41369.37945930813, 41385.0, 41385.58614413848, 41441.1711765763, 3549.8225088745457, 3653.113562233881, 3703.888883333477, 3711.554613446404, 3822.617738226183, 30191.547126793117, 31043.844780776177, 31071.68928310733, 31147.0, 31209.0, 4311.353297005443, 4389.275769498061, 4402.7798610069685, 4425.402570652953, 4468.0, 322260.0, 323361.6453285229, 323804.3336966413, 323849.0, 324325.0, 54601.71770798974, 54850.17724734132, 54872.0, 54904.0, 54906.45093549093, 34182.31635367279, 35053.0, 51347.48652513502, 51566.484335156165, 58161.41838581645, 14674.192919389536, 15057.096574205583, 15065.774013389808, 15071.09573425598, 15083.924580377248, 10339.9483002586, 11379.317240965569, 11456.083513318914, 11490.310581365145, 11490.42547872603, 16236.940764808798, 17973.640527189382, 18598.721019184723, 18619.162137703835, 19385.83684978906, 7239.89140162898, 7279.745208917662, 7280.235575264627, 7370.373518250902, 7385.4460915431555, 962.6438217859437, 1014.6043043213152, 1031.865857438528, 1057.746140926172, 1088.894771806617, 31229.843850781053, 31294.530582041287, 31295.37409251802, 31935.520967185512, 31951.840240798647, 1080.9513571889283, 1106.0, 1113.0705860606483, 1134.6709454258173, 1180.7933611618105, 16413.67172656564, 16622.0, 16707.49877503677, 16731.83268167327, 16770.413035543697, 456064.0, 761046.0, 771304.0, 773158.0, 775353.0, 56825.715871420376, 57601.42398576044, 57626.0, 57826.42173578295, 57884.71057644769, 1283.287775284726, 1330.255057167989, 1334.8932085433141, 1361.3669643615567, 1379.0760190672274, 30269.69730302669, 31882.20294492656, 32601.0, 32621.836890815393, 32661.673383265865, 48159.75920120377, 48835.511644883096, 48869.51130488792, 48966.26550601672, 49045.2643210345, 448298.0, 452727.0, 453531.0, 453577.0, 454234.0, 26783.732162678123, 27284.863575681993, 27800.72199278062, 27806.77545796291, 33844.83077584596, 36068.0, 42226.0, 53752.46247537475, 53901.46098538965, 55305.1704224445, 36784.0, 39146.804265978484, 39264.2147157061, 42577.787111064245, 44880.551194487634, 41702.0, 42216.155676885675, 42843.57156428521, 43479.56520434755, 44695.10609787721, 42206.366904495844, 43122.568774311854, 43285.56714432815, 43492.0, 43692.56307436885, 35769.82115089408, 37905.0, 38101.61898380981, 38347.0, 38394.23211535809, 28788.136355909355, 28848.882050872115, 29151.854240728662, 29540.704592953796, 29604.0], "value": 20317.3911143837, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.6255113610821, 381.95225596800395, 386.3682878493663, 399.5305516018677, 409.0836526181355, 18070.186841592127, 19174.233030678755, 19522.0, 19706.901465492654, 19709.0, 16724.66550668986, 16958.3216671333, 17227.82772172278, 17376.913115434436, 17414.21636026379, 5538.667679939196, 5564.276644036269, 5806.680632565207, 5809.564282678816, 5811.302643682764, 5661.575381846357, 5709.714514274269, 5747.2528571285675, 5757.68332741699, 5764.7982320618785, 5677.829665110054, 5720.79977200798, 5739.311282646088, 5766.279215098113, 5772.393898640625, 5857.238558987326, 5955.851103722398, 5963.2844058713235, 5963.910541341883, 5966.46301832835, 5617.21359009739, 5751.568632352591, 5782.0, 5786.826395208151, 5808.564357673149, 13364.866351336557, 13494.730105397837, 13544.119632223874, 13600.795988060187, 13623.25072121033, 2254.763249858774, 2270.2394697776263, 2281.5436912617542, 2370.0638247892157, 2883.918530551043, 9867.950660246725, 9908.455034973074, 10146.847797283046, 10270.178385729123, 10641.73395665107, 1790.6955817511055, 1872.7565416495768, 1907.523119220195, 1956.6010302633686, 1966.0562929793637, 71859.0, 76121.0, 76514.23485765127, 83362.0, 84071.0, 10234.0, 10452.947735261427, 10475.84286235707, 11081.944590277159, 11092.168087393478, 15016.699666006618, 15090.622734431727, 15095.0, 15105.47130850437, 15134.772978405334, 7584.5070070445245, 7622.885656715153, 7642.5032372895585, 7805.609719514116, 7809.531428114331, 6987.274962764526, 7063.470239732041, 7223.566586004857, 7266.818329541804, 7347.926520734831, 4478.507364189936, 4588.357629931812, 4602.838900638529, 4676.2985552166765, 4697.10754956564, 1898.4874083997242, 1927.6915693489254, 1929.536911141344, 1953.8925359105385, 1983.7502373504888, 893.6274192020197, 904.5929331800716, 949.3876449689911, 994.179801663616, 1032.3341444768082, 17544.0, 19317.710234346498, 19399.224031038884, 19413.0, 19658.0, 940.2149205413556, 968.6367612145445, 971.155095067296, 1002.6440613582073, 1003.9096481316717, 10109.191264698806, 11020.283681560673, 11031.393273369882, 11049.016765473278, 11049.502772375263, 455999.0, 457745.0, 461541.0, 462512.0, 467175.0, 52201.73899130556, 52505.7374713124, 71592.28407715961, 87634.56182719045, 90573.6598438103, 966.1932286540676, 990.9752256193509, 1014.9391036537831, 1017.4861694844057, 1018.8522664213648, 16482.587935301235, 16982.40561580339, 17349.479515614552, 17383.652326953645, 17475.737863932307, 42245.788771057174, 43298.13403731971, 43803.56196437995, 44198.0110895004, 44306.3354049696, 55909.44090559205, 56769.14846277227, 57674.711626441596, 58063.70968145132, 58835.411645882996, 7137.82155446118, 7437.330640242404, 7668.5782281975025, 7947.84104317922, 8011.559364234789, 13136.408861601441, 13160.14459060158, 13200.933995329962, 13309.733805323645, 13600.183988960694, 11867.525298988288, 11878.46546905374, 11937.343446110548, 12102.455389507317, 12184.939075304566, 11122.666320010412, 11367.772644547229, 11457.59898403552, 11780.646580602595, 12191.695207619881, 11230.438478075901, 11492.138089643144, 11642.476088576204, 11649.941750291533, 12082.637520874388, 7558.962205189159, 7630.7710768677025, 7643.503172293783, 7648.120466146464, 8068.394870384627, 8541.103184165573, 10662.200334975063, 11472.82790758156, 11492.597759078391, 11985.700357491132], "value": 8844.72004834884, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1306.2293246984277, 1458.0668372241764, 1479.652281713797, 1605.6467577133026, 1762.2334284586198, 7150.74972375967, 7743.535387876731, 8052.63763130659, 8053.073896501896, 8244.58777061146, 8063.95968020159, 8127.55298458586, 8138.837223255531, 8139.389545784075, 8143.144969778177, 2186.2676003538795, 2221.611218036845, 2232.7655596162413, 2233.1625640384855, 2239.787220214077, 2253.1663284584724, 2258.627326491135, 2272.8181745460406, 2289.7595752446005, 2293.472501324696, 2210.5689390568764, 2245.9101635934544, 2263.388885001049, 2264.060414927803, 2264.7395549511853, 2145.4636340914617, 2202.570498752744, 2221.522372689871, 2224.2659922225707, 2232.1964092926532, 2185.8579192352445, 2224.0547767198877, 2226.398872304485, 2239.3058151972778, 2252.8760918149496, 7916.208379162095, 8041.8793718094275, 8100.3519718422385, 8107.554084525349, 8113.716019939333, 4637.675362724611, 4773.856784296477, 4774.355462012653, 4776.737279449629, 4783.4977327380475, 2994.595729576501, 3150.322680623677, 3189.856456459465, 3202.5356323332985, 3209.6950789674943, 1087.12486448409, 1103.4648195625116, 1121.159130652011, 1134.7219931116929, 1148.110214583696, 11048.834267485994, 11052.0, 11124.833127503094, 11167.329960202333, 11186.105111591054, 3892.2410130024373, 4061.614146656063, 4159.812808423628, 4172.207280616673, 4174.0, 8855.247303979233, 8866.556672166495, 8872.600732967032, 8875.511846848356, 8877.866831997526, 4729.314249433813, 4741.454732705783, 4747.026859493795, 4750.762461876892, 4757.666963312535, 3763.8533463349154, 3915.3735402335487, 4029.174019326031, 4432.15789000089, 4437.267850804581, 3338.1487720631085, 3544.468329750558, 3546.716262698978, 3555.982220088935, 3558.1104723819044, 1068.5939343049592, 1107.5126944144552, 1112.9220954533266, 1118.8321751737305, 1125.5835340923747, 755.527795128045, 876.9345245526715, 914.2629004890628, 917.4816228830823, 935.1583574782615, 5342.8931421372135, 5369.301990741179, 5519.862003449865, 5543.223948647193, 5725.484706376446, 416.82910006897026, 427.31842710876106, 437.13883649211004, 442.4756663353936, 443.2044480158124, 3693.8337774800198, 3696.0, 3761.5486141663177, 3803.448499967489, 3935.4490371348033, 9585.616575336908, 9935.552900119512, 10008.049235322633, 10032.949835250776, 10033.799324013626, 9652.9034709652, 9764.658236961672, 9977.900220997843, 9993.250506212064, 9994.050565196294, 7318.414526837841, 7424.183339832614, 7442.702291908371, 7448.441366897613, 7450.18048014718, 5232.843014709565, 5369.382521009978, 5418.674879507243, 5477.233187353694, 5543.584231182596, 9126.817463650557, 9130.680426185318, 9139.771505712144, 9154.633814647339, 9155.816883662423, 9258.53707314645, 9320.300977426585, 9322.580483878106, 9362.578683959375, 9362.95318523403, 6866.244713081457, 6923.5499692519825, 6940.41006514452, 6944.4791640626145, 6948.235694073547, 7630.389568834591, 7788.182240864628, 7847.372210223054, 7848.411369147451, 7880.0, 6983.336583024605, 7140.500164988401, 7148.249433809375, 7299.8465452690525, 7396.6671499783715, 6974.337437943387, 7055.470839686941, 7085.787426377217, 7111.0, 7117.466190035664, 6218.595791273553, 6278.497720182466, 6290.874182516232, 6328.6519241442165, 6406.263279722892, 4696.178168820375, 4804.183288840835, 4805.3512775774825, 4844.2007068833245, 4888.95111048885, 4773.427188737373, 4800.831970881002, 4842.443119041355, 4936.185529387611, 5028.547430731252], "value": 4185.572315372218, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.5677394873229, 318.3251506805573, 321.67671490152395, 326.4401551339452, 329.51067664518195, 5068.226120857698, 5198.532132108109, 5206.0, 5276.915618330757, 5284.154535274357, 4980.576650984671, 5098.5921126309895, 5149.845504634857, 5152.278680984656, 5169.819056333029, 4092.4270602115726, 4102.938455923164, 4105.651019663333, 4109.4246805447265, 4120.196561670476, 3967.226390853785, 4053.3653125468536, 4115.9373970016895, 4123.257813593552, 4135.73117747347, 4027.7784721840285, 4043.7573745575214, 4048.534418541861, 4049.9392509112386, 4061.472008638873, 4028.9194216115516, 4031.8185681644395, 4032.6572241359518, 4034.1528279061286, 4036.979815100935, 3437.862485500577, 3534.8586056557706, 3536.5225694531423, 3560.3769340365334, 3574.0, 5025.798968041274, 5026.623003274733, 5030.547250747451, 5035.697858128524, 5049.798008079672, 4601.7929193186055, 4638.791254393526, 4639.744814035227, 4647.651426143053, 4647.86056418308, 5324.387695415038, 5336.93261347732, 5374.919376209321, 5414.91877621836, 5475.152920481367, 3856.7107466940092, 3867.6269924177077, 3868.593797651234, 3870.9419358709642, 3874.748141370802, 5670.376258611549, 5676.943230567683, 5676.943230567724, 5690.2887139107615, 5706.657600543939, 3861.8841434757, 3989.34708418904, 4018.095928416083, 4021.1756589899, 4035.21313343901, 4022.3162062449455, 4038.131801662598, 4041.3937909313836, 4052.8986775330263, 4067.0, 4511.954880451219, 4523.5024147343765, 4528.818847246139, 4551.749653769009, 4618.8452886778305, 5290.232916227125, 5356.598255130881, 5365.283109404953, 5408.540274076748, 5426.728663566806, 1340.825692659948, 1350.4672197056411, 1357.5384369314481, 1362.9250391228577, 1375.5941997110876, 872.3849685971375, 873.2839071961058, 892.2511876721569, 894.8702438146563, 896.5830888636815, 4592.7933243004145, 4605.171069207508, 4617.007343421114, 4623.330436259335, 4624.468186158635, 4834.6068695995, 4845.9757701211265, 4853.490383509751, 4871.29366241893, 4901.264810278415, 4506.59440650343, 4653.302004699254, 4655.416243984553, 4657.6273898088075, 4684.882877928079, 2555.6038813983864, 2575.9098431554808, 2577.92477055968, 2597.8960841566127, 2598.8700564971678, 4984.352034235526, 5065.56942659878, 5074.213496907985, 5083.339165908408, 5090.796368145307, 4703.553162449562, 4858.708477491291, 4952.8761780955765, 4966.428860680996, 5025.748712564357, 4976.9050808822, 4993.725345105981, 5013.674111182761, 5038.143515602356, 5098.490150984946, 4877.853664390074, 4887.291342755209, 4909.926351104665, 4934.333864928189, 4959.82640607577, 4679.438467383936, 4835.008823191167, 4875.78151940859, 4879.487358918746, 4891.95108048915, 4993.001399720143, 4999.0, 5003.224500202475, 5033.798648054037, 5071.54356107952, 3616.3852145134865, 3754.7747135171976, 3817.732758706864, 3871.8965094947803, 3915.9021024474614, 5467.234587157722, 5468.179773034077, 5492.91760623583, 5504.724763761876, 5509.614326997072, 5354.11657076578, 5376.7580458878665, 5384.326959130109, 5390.164524498709, 5397.27136836522, 5155.355580552431, 5317.946820531745, 5332.893342133213, 5349.2778474906945, 5357.410684824744, 5286.299590286738, 5290.497402746733, 5291.867703307448, 5295.920561191662, 5316.893662126813, 5235.685858848481, 5316.840494785162, 5346.251524786455, 5362.981033603603, 5398.652835242175, 5392.946070539245, 5405.297311349499, 5420.647657902224, 5423.15612691671, 5426.1512705829755], "value": 3978.848852353142, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [692.9896051559226, 751.6129193465365, 752.337942610503, 756.0926887734717, 832.1553623072579, 13958.092723972948, 14134.575962721108, 14391.352389142488, 14501.129932204076, 14512.056716313433, 14089.084209526374, 14204.928975355135, 14231.359588818503, 14232.430702771902, 14255.144691318528, 630.8738252349525, 658.5752189837576, 760.5892817878339, 772.7797577690345, 789.6130895861044, 769.8806684963812, 778.8208711996244, 779.2285637219169, 779.5790273252437, 783.3967844759532, 835.0146826744439, 835.9749207523784, 836.6527890925258, 836.9121242269565, 836.9874451883227, 678.4538446550525, 705.693023534764, 833.3999520345342, 834.862247729124, 835.2023817254508, 591.2136857978878, 604.8850718363541, 611.807280706576, 611.8133969139411, 612.0788213738296, 13999.160050396908, 14040.578782636538, 14059.78910316346, 14060.789088163685, 14073.0, 13293.601191964257, 13323.333833308392, 13367.465301387932, 13429.597112086556, 13560.321983900765, 12082.939585302018, 12302.507899684002, 12308.70758570355, 12483.375831208403, 12517.812232816515, 4275.315949448104, 4303.160883627694, 4316.395704601358, 4345.217860785057, 4359.629431498326, 51799.74100129475, 52323.215151772754, 55111.72444137794, 56772.432275677544, 57910.71044644792, 10877.238593298393, 10918.1811364148, 10944.507497162487, 11021.283616564897, 11246.887531124748, 18910.338138165098, 19089.331873384366, 19641.214351425784, 19757.0, 19769.0, 8045.9597702011115, 8102.513849169069, 8197.79505512367, 8201.384896132695, 8288.958555207186, 4493.5281795411665, 4614.607758340579, 4620.722756634613, 4661.347411362412, 4829.420469543677, 3432.090496018557, 3521.5774107107313, 3528.6118526962014, 3540.5574303212097, 3540.982295088508, 574.5202755699038, 577.8613132848086, 586.5044037788062, 588.2323567744135, 589.8260013296087, 648.0764910003227, 654.7773756922574, 683.729926678959, 725.2892165677665, 744.133084956031, 8690.436321285237, 9102.180803727697, 9959.651412200537, 10165.339252948535, 10340.0, 622.6202016769766, 668.2415458454689, 711.772232885482, 768.0898135709202, 770.4067867741808, 4391.670624703096, 4646.465656449484, 4649.399369437688, 4787.640926930494, 4803.975980120077, 71114.0, 71422.64288678524, 72355.0, 73593.0, 74321.25678743252, 60434.39565604376, 62421.37578624156, 62958.0, 63921.0, 66064.0, 56988.0, 57625.0, 59376.70311648414, 60825.69587152036, 61526.69236653788, 8832.12479677638, 9159.404638698463, 9172.54137293146, 9180.44917304964, 9224.446533208029, 39498.60501394949, 39656.60343396529, 39727.60272397239, 40005.0, 40828.387574185814, 48914.51085489099, 54178.0, 55659.44340556543, 56252.43747562472, 57456.13815792683, 10727.731806704895, 10772.0, 10858.45707714627, 10957.287776294515, 11359.432028398713, 12366.258024518558, 12704.0, 12816.679583010125, 13037.15258508194, 13126.540571079966, 12093.57672481494, 12454.564090256797, 12883.677908052374, 13022.0, 13087.345632718516, 12029.218100823418, 12065.638030859089, 12107.0, 12239.0, 12518.436670349674, 12240.265584064984, 12326.95220906233, 12332.0, 12858.678533036375, 13271.0, 10025.598976040877, 10746.946265268623, 10938.617148399768, 11697.590584329508, 11716.70708232301, 11248.83126753083, 11707.0, 11730.296182229093, 11814.232074915102, 11900.36026967895], "value": 6864.567479867804, "unit": "score"}], "name": "dromaeo_css", "value": 6901.477867205994, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 110.0, 110.0, 112.0, 111.0, 109.0, 110.0, 110.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 122.0, 123.0, 174.0, 124.0, 125.0, 123.0, 123.0, 161.0, 122.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 161.0, 159.0, 159.0, 161.0, 160.0, 161.0, 163.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 113.0, 76.0, 77.0, 75.0, 76.0, 97.0, 74.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 108.0, 83.0, 82.0, 83.0, 106.0, 81.0, 82.0, 115.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 84.0, 85.0, 84.0, 84.0, 84.0, 85.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 51.0, 52.0, 53.0, 53.0, 53.0, 54.0, 53.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 81.0, 79.0, 80.0, 82.0, 80.0, 80.0, 81.0, 79.0, 79.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 139.0, 131.0, 131.0, 131.0, 136.0, 129.0, 169.0, 131.0], "value": 136.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 163.0, 162.0, 162.0, 163.0, 162.0, 164.0, 162.0, 163.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 62.0, 65.0, 63.0, 63.0, 63.0, 62.0, 62.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1480.1999999999998, "alertThreshold": 2.0}]} 14:03:56 INFO - Return code: 0 14:03:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:03:56 INFO - # TBPL SUCCESS # 14:03:56 INFO - Running post-action listener: _resource_record_post_action 14:03:56 INFO - [mozharness: 2016-10-29 21:03:56.425954Z] Finished run-tests step (success) 14:03:56 INFO - Running post-run listener: _resource_record_post_run 14:03:56 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 16384; Write bytes: 392372224; Read time: 324; Write time: 335740 14:03:56 INFO - TinderboxPrint: CPU usage
13.1% 14:03:56 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 324 14:03:56 INFO - TinderboxPrint: I/O write bytes / time
392,372,224 / 335,740 14:03:56 INFO - TinderboxPrint: CPU idle
8,293.1 (86.9%) 14:03:56 INFO - TinderboxPrint: CPU user
1,197.5 (12.5%) 14:03:56 INFO - TinderboxPrint: Swap in / out
0 / 0 14:03:56 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 103550976; Read time: 60; Write time: 104404 14:03:56 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288288768; Read time: 236; Write time: 231268 14:03:57 INFO - Running post-run listener: _upload_blobber_files 14:03:57 INFO - Blob upload gear active. 14:03:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:03:57 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 14:03:57 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'] 14:03:57 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 14:03:57 INFO - (blobuploader) - INFO - Open directory for files ... 14:03:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:03:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:03:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:04:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:04:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:04:00 INFO - (blobuploader) - INFO - Done attempting. 14:04:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:04:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:04:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:04:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:04:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:04:01 INFO - (blobuploader) - INFO - Done attempting. 14:04:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:04:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:04:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:04:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:04:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:04:02 INFO - (blobuploader) - INFO - Done attempting. 14:04:02 INFO - (blobuploader) - INFO - Iteration through files over. 14:04:02 INFO - Return code: 0 14:04:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:04:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:04:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a3c7b18994801a30498e17bd12e2d6b08a0df9addd61febda08075ab2b9abae896d62dafd374a344175b2a80c2a0955ca956fe195db41aaf6e1da160e551235f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/398eb64ed91039cc4662b16443698050d45f909f3ff686c909fd99125916418ce94348b52685d06b3ef56d8d449c0794d2aa88df99b1e4b7298d738021b54c6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/470ad5bd11d074ceccd3c1bb911e6129daf04f604a10587fcb70e920fcd2970f651c3d503d4173c3ff5aaa83299c6a0ef88ffcc481a207791f494a8880f16f9d"} 14:04:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:04:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:04:02 INFO - Contents: 14:04:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a3c7b18994801a30498e17bd12e2d6b08a0df9addd61febda08075ab2b9abae896d62dafd374a344175b2a80c2a0955ca956fe195db41aaf6e1da160e551235f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/398eb64ed91039cc4662b16443698050d45f909f3ff686c909fd99125916418ce94348b52685d06b3ef56d8d449c0794d2aa88df99b1e4b7298d738021b54c6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/470ad5bd11d074ceccd3c1bb911e6129daf04f604a10587fcb70e920fcd2970f651c3d503d4173c3ff5aaa83299c6a0ef88ffcc481a207791f494a8880f16f9d"} 14:04:02 INFO - Running post-run listener: copy_logs_to_upload_dir 14:04:02 INFO - Copying logs to upload dir... 14:04:02 INFO - mkdir: /builds/slave/test/build/upload/logs 14:04:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.406979 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-10-29 14:04:02.163884) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-29 14:04:02.168283) ========= 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=db0483c52d987ecb441a263b000001ad-1477773804.765618-544863779 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/a3c7b18994801a30498e17bd12e2d6b08a0df9addd61febda08075ab2b9abae896d62dafd374a344175b2a80c2a0955ca956fe195db41aaf6e1da160e551235f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/398eb64ed91039cc4662b16443698050d45f909f3ff686c909fd99125916418ce94348b52685d06b3ef56d8d449c0794d2aa88df99b1e4b7298d738021b54c6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/470ad5bd11d074ceccd3c1bb911e6129daf04f604a10587fcb70e920fcd2970f651c3d503d4173c3ff5aaa83299c6a0ef88ffcc481a207791f494a8880f16f9d"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698456/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011340 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477698456/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a3c7b18994801a30498e17bd12e2d6b08a0df9addd61febda08075ab2b9abae896d62dafd374a344175b2a80c2a0955ca956fe195db41aaf6e1da160e551235f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/398eb64ed91039cc4662b16443698050d45f909f3ff686c909fd99125916418ce94348b52685d06b3ef56d8d449c0794d2aa88df99b1e4b7298d738021b54c6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/470ad5bd11d074ceccd3c1bb911e6129daf04f604a10587fcb70e920fcd2970f651c3d503d4173c3ff5aaa83299c6a0ef88ffcc481a207791f494a8880f16f9d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-29 14:04:02.194768) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 14:04:02.195133) ========= 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=db0483c52d987ecb441a263b000001ad-1477773804.765618-544863779 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 14:04:02.279539) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-29 14:04:02.279890) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-29 14:04:02.280209) ========= ========= Total master_lag: 0.18 =========