builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1480460481.01 results: success (0) buildid: 20161129150058 builduid: e04922775fb943cf83b386d0fbf686a3 revision: d254eb61360d3c20172eb7aba1154e2779850263 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 15:01:21.007694) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 15:01:21.008263) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 15:01:21.008628) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 15:01:21.029779) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 15:01:21.030149) ========= 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=62c568580acbfdaac3eec7be000001dc-1480460480.225962-1051720692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-29 15:01:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.6M=0s 2016-11-29 15:01:21 (37.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.101933 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 15:01:21.146942) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 15:01:21.147328) ========= 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=62c568580acbfdaac3eec7be000001dc-1480460480.225962-1051720692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017780 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 15:01:21.201529) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 15:01:21.205003) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d254eb61360d3c20172eb7aba1154e2779850263 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d254eb61360d3c20172eb7aba1154e2779850263 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1480460480.225962-1051720692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-29 15:01:21,510 truncating revision to first 12 chars 2016-11-29 15:01:21,510 Setting DEBUG logging. 2016-11-29 15:01:21,510 attempt 1/10 2016-11-29 15:01:21,510 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d254eb61360d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-29 15:01:22,096 unpacking tar archive at: mozilla-inbound-d254eb61360d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.945886 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 15:01:22.165136) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 15:01:22.165523) ========= script_repo_revision: d254eb61360d3c20172eb7aba1154e2779850263 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 15:01:22.166052) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 15:01:22.166412) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 15:01:22.176600) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-11-29 15:01:22.176959) ========= /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=62c568580acbfdaac3eec7be000001dc-1480460480.225962-1051720692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:01:22 INFO - MultiFileLogger online at 20161129 15:01:22 in /builds/slave/test 15:01:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 15:01:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:01:22 INFO - {'append_to_log': False, 15:01:22 INFO - 'base_work_dir': '/builds/slave/test', 15:01:22 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:01:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:01:22 INFO - 'branch': 'Mozilla-Inbound', 15:01:22 INFO - 'buildbot_json_path': 'buildprops.json', 15:01:22 INFO - 'config_files': ('talos/linux_config.py',), 15:01:22 INFO - 'default_actions': ('clobber', 15:01:22 INFO - 'read-buildbot-config', 15:01:22 INFO - 'download-and-extract', 15:01:22 INFO - 'populate-webroot', 15:01:22 INFO - 'create-virtualenv', 15:01:22 INFO - 'install', 15:01:22 INFO - 'run-tests'), 15:01:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:01:22 INFO - 'download_minidump_stackwalk': True, 15:01:22 INFO - 'download_symbols': 'ondemand', 15:01:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:01:22 INFO - 'tooltool.py': '/tools/tooltool.py', 15:01:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:01:22 INFO - '/tools/misc-python/virtualenv.py')}, 15:01:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:01:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:01:22 INFO - 'installer_path': 'installer.exe', 15:01:22 INFO - 'log_level': 'info', 15:01:22 INFO - 'log_name': 'talos', 15:01:22 INFO - 'log_to_console': True, 15:01:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:01:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:01:22 INFO - 'opt_config_files': (), 15:01:22 INFO - 'pip_index': False, 15:01:22 INFO - 'sps_profile': False, 15:01:22 INFO - 'sps_profile_interval': 0, 15:01:22 INFO - 'suite': 'dromaeojs', 15:01:22 INFO - 'system_bits': '32', 15:01:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:01:22 INFO - 'title': 'talos-linux64-ix-018', 15:01:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:01:22 INFO - 'use_talos_json': True, 15:01:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:01:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:01:22 INFO - 'work_dir': 'build'} 15:01:22 INFO - [mozharness: 2016-11-29 23:01:22.584475Z] Running clobber step. 15:01:22 INFO - Running pre-action listener: _resource_record_pre_action 15:01:22 INFO - Running main action method: clobber 15:01:22 INFO - rmtree: /builds/slave/test/build 15:01:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:01:23 INFO - Running post-action listener: _resource_record_post_action 15:01:23 INFO - [mozharness: 2016-11-29 23:01:23.041691Z] Finished clobber step (success) 15:01:23 INFO - [mozharness: 2016-11-29 23:01:23.041788Z] Running read-buildbot-config step. 15:01:23 INFO - Running pre-action listener: _resource_record_pre_action 15:01:23 INFO - Running main action method: read_buildbot_config 15:01:23 INFO - Using buildbot properties: 15:01:23 INFO - { 15:01:23 INFO - "project": "", 15:01:23 INFO - "product": "firefox", 15:01:23 INFO - "script_repo_revision": "production", 15:01:23 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 15:01:23 INFO - "repository": "", 15:01:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 15:01:23 INFO - "buildid": "20161129150058", 15:01:23 INFO - "stage_platform": "linux64-pgo", 15:01:23 INFO - "basedir": "/builds/slave/test", 15:01:23 INFO - "buildnumber": 2145, 15:01:23 INFO - "platform": "ubuntu64_hw", 15:01:23 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:01:23 INFO - "slavebuilddir": "test", 15:01:23 INFO - "branch": "mozilla-inbound", 15:01:23 INFO - "revision": "d254eb61360d3c20172eb7aba1154e2779850263", 15:01:23 INFO - "slavename": "talos-linux64-ix-018", 15:01:23 INFO - "builduid": "e04922775fb943cf83b386d0fbf686a3", 15:01:23 INFO - "repo_path": "integration/mozilla-inbound" 15:01:23 INFO - } 15:01:23 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 15:01:23 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 15:01:23 INFO - Running post-action listener: _resource_record_post_action 15:01:23 INFO - [mozharness: 2016-11-29 23:01:23.044125Z] Finished read-buildbot-config step (success) 15:01:23 INFO - [mozharness: 2016-11-29 23:01:23.044212Z] Running download-and-extract step. 15:01:23 INFO - Running pre-action listener: _resource_record_pre_action 15:01:23 INFO - Running main action method: download_and_extract 15:01:23 INFO - mkdir: /builds/slave/test/build/tests 15:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:23 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:01:23 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:01:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:01:23 INFO - Downloaded 1361 bytes. 15:01:23 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:01:23 INFO - Using the following test package requirements: 15:01:23 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 15:01:23 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:23 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:01:23 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:23 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:01:23 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:23 INFO - u'jsshell-linux-x86_64.zip'], 15:01:23 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:23 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:01:23 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 15:01:23 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:23 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:01:23 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:23 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:01:23 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:23 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:01:23 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:01:23 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:01:23 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:01:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 15:01:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:01:23 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:01:23 INFO - Http code: 200 15:01:23 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 15:01:23 INFO - x-amz-cf-id: cFk8WwjyfYX1DgIeGum832f2NZQCA2ll1fv87zC3fWis6GVaYWdg7A== 15:01:23 INFO - x-amz-replication-status: COMPLETED 15:01:23 INFO - x-amz-version-id: NgAiTSUg5NHjTlSrCie7lvcJ.WvdJU8t 15:01:23 INFO - Expected file size: 21781655 15:01:23 INFO - Obtained file size: 21781655 15:01:27 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:01: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/1480450312/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 15:01: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/1480450312/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:01:27 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:01:27 INFO - Http code: 200 15:01:27 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 15:01:27 INFO - x-amz-cf-id: HbSMfb5PSukWIT3u3Gi_4XPQqavdZ-GotN4BYMTCIGiJp1jDivS4vw== 15:01:27 INFO - x-amz-replication-status: COMPLETED 15:01:27 INFO - x-amz-version-id: NgAiTSUg5NHjTlSrCie7lvcJ.WvdJU8t 15:01:27 INFO - Expected file size: 21781655 15:01:27 INFO - Obtained file size: 21781655 15:01:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 15:01:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:01:32 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:01:32 INFO - Http code: 200 15:01:32 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 15:01:32 INFO - x-amz-cf-id: -Nb4T3VKUKJo-WRsPHg2u34HY-3SBr-fBKTGYyZqqNzSRUouVhDAUg== 15:01:32 INFO - x-amz-replication-status: COMPLETED 15:01:32 INFO - x-amz-version-id: RDqRDktZfsVtVrHlr1W8TlvdGi6tGcpa 15:01:32 INFO - Expected file size: 14409702 15:01:32 INFO - Obtained file size: 14409702 15:01:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:32 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:01:32 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:01:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:01:33 INFO - Downloaded 59787803 bytes. 15:01:33 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:01:33 INFO - mkdir: /builds/slave/test/properties 15:01:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:01:33 INFO - Writing to file /builds/slave/test/properties/build_url 15:01:33 INFO - Contents: 15:01:33 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:01:33 INFO - Running post-action listener: _resource_record_post_action 15:01:33 INFO - Running post-action listener: set_extra_try_arguments 15:01:33 INFO - [mozharness: 2016-11-29 23:01:33.697677Z] Finished download-and-extract step (success) 15:01:33 INFO - [mozharness: 2016-11-29 23:01:33.697976Z] Running populate-webroot step. 15:01:33 INFO - Running pre-action listener: _resource_record_pre_action 15:01:33 INFO - Running main action method: populate_webroot 15:01:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:01:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:01:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:01:33 INFO - '--tppagecycles', 15:01:33 INFO - '7'], 15:01:33 INFO - 'tests': ['tsvgm']}}, 15:01:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:01:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:01:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:01:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:01:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:01:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:01:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:01:33 INFO - 'talos_options': ['--disable-e10s'], 15:01:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:01:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:01:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:01:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:01:33 INFO - 'talos_options': ['--disable-e10s'], 15:01:33 INFO - 'tests': ['damp', 'tps']}, 15:01:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:01:33 INFO - 'tests': ['damp', 'tps']}, 15:01:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:01:33 INFO - 'tests': ['dromaeo_dom']}, 15:01:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:01:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:01:33 INFO - 'tests': ['basic_compositor_video']}, 15:01:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:01:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:01:33 INFO - 'tests': ['a11yr', 15:01:33 INFO - 'ts_paint', 15:01:33 INFO - 'tpaint', 15:01:33 INFO - 'sessionrestore', 15:01:33 INFO - 'sessionrestore_no_auto_restore', 15:01:33 INFO - 'tabpaint']}, 15:01:33 INFO - 'other-e10s': {'tests': ['a11yr', 15:01:33 INFO - 'ts_paint', 15:01:33 INFO - 'tpaint', 15:01:33 INFO - 'sessionrestore', 15:01:33 INFO - 'sessionrestore_no_auto_restore', 15:01:33 INFO - 'tabpaint']}, 15:01:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:01:33 INFO - 'ts_paint', 15:01:33 INFO - 'tpaint', 15:01:33 INFO - 'sessionrestore', 15:01:33 INFO - 'sessionrestore_no_auto_restore', 15:01:33 INFO - 'tabpaint']}, 15:01:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:01:33 INFO - 'ts_paint', 15:01:33 INFO - 'tpaint', 15:01:33 INFO - 'sessionrestore', 15:01:33 INFO - 'sessionrestore_no_auto_restore', 15:01:33 INFO - 'tabpaint']}, 15:01:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:01:33 INFO - 'tests': ['a11yr', 15:01:33 INFO - 'ts_paint', 15:01:33 INFO - 'tpaint', 15:01:33 INFO - 'sessionrestore', 15:01:33 INFO - 'sessionrestore_no_auto_restore', 15:01:33 INFO - 'tabpaint']}, 15:01:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:01:33 INFO - 'tests': ['a11yr', 15:01:33 INFO - 'ts_paint', 15:01:33 INFO - 'tpaint', 15:01:33 INFO - 'sessionrestore', 15:01:33 INFO - 'sessionrestore_no_auto_restore', 15:01:33 INFO - 'tabpaint']}, 15:01:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:01:33 INFO - 'tests': ['tsvgx', 15:01:33 INFO - 'tsvgr_opacity', 15:01:33 INFO - 'tart', 15:01:33 INFO - 'tscrollx', 15:01:33 INFO - 'cart', 15:01:33 INFO - 'tsvg_static']}, 15:01:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:01:33 INFO - 'tsvgr_opacity', 15:01:33 INFO - 'tart', 15:01:33 INFO - 'tscrollx', 15:01:33 INFO - 'cart', 15:01:33 INFO - 'tsvg_static']}, 15:01:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:01:33 INFO - 'talos_options': ['--disable-e10s'], 15:01:33 INFO - 'tests': ['tp5o']}, 15:01:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:01:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:01:33 INFO - 'talos_options': ['--disable-e10s', 15:01:33 INFO - '--xperf_path', 15:01:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:01:33 INFO - 'tests': ['tp5n']}, 15:01:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:01:33 INFO - 'talos_options': ['--xperf_path', 15:01:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:01:33 INFO - 'tests': ['tp5n']}}, 15:01:33 INFO - 'talos.zip': {'path': '', 15:01:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:01:33 INFO - Running post-action listener: _resource_record_post_action 15:01:33 INFO - [mozharness: 2016-11-29 23:01:33.718755Z] Finished populate-webroot step (success) 15:01:33 INFO - [mozharness: 2016-11-29 23:01:33.718847Z] Running create-virtualenv step. 15:01:33 INFO - Running pre-action listener: _resource_record_pre_action 15:01:33 INFO - Running main action method: create_virtualenv 15:01:33 INFO - Creating virtualenv /builds/slave/test/build/venv 15:01:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:01:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:01:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:01:33 INFO - Using real prefix '/usr' 15:01:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:01:34 INFO - Installing distribute.............................................................................................................................................................................................done. 15:01:36 INFO - Installing pip.................done. 15:01:36 INFO - Return code: 0 15:01:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:01:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:01:36 INFO - Reading from file tmpfile_stdout 15:01:36 INFO - Output received: 15:01:36 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:01:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7091e8ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c48b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e72fc0>, '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 0x1e73ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e74350>, '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': '62c568580acbfdaac3eec7be000001dc-1480460480.225962-1051720692', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:01:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:01:36 INFO - Using env: {'DISPLAY': ':0', 15:01:36 INFO - 'HOME': '/home/cltbld', 15:01:36 INFO - 'LANG': 'en_US.UTF-8', 15:01:36 INFO - 'LANGUAGE': 'en_US:en', 15:01:36 INFO - 'LOGNAME': 'cltbld', 15:01:36 INFO - 'MAIL': '/var/mail/cltbld', 15:01:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:36 INFO - 'MOZ_NO_REMOTE': '1', 15:01:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:36 INFO - 'NO_EM_RESTART': '1', 15:01:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:36 INFO - 'PWD': '/builds/slave/test', 15:01:36 INFO - 'SHELL': '/bin/bash', 15:01:36 INFO - 'SHLVL': '1', 15:01:36 INFO - 'TERM': 'linux', 15:01:36 INFO - 'TMOUT': '86400', 15:01:36 INFO - 'USER': 'cltbld', 15:01:36 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480460480.225962-1051720692', 15:01:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:36 INFO - '_': '/tools/buildbot/bin/python'} 15:01:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:01:36 INFO - Cleaning up... 15:01:36 INFO - Return code: 0 15:01:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7091e8ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c48b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e72fc0>, '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 0x1e73ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e74350>, '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': '62c568580acbfdaac3eec7be000001dc-1480460480.225962-1051720692', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:01:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:01:36 INFO - Using env: {'DISPLAY': ':0', 15:01:36 INFO - 'HOME': '/home/cltbld', 15:01:36 INFO - 'LANG': 'en_US.UTF-8', 15:01:36 INFO - 'LANGUAGE': 'en_US:en', 15:01:36 INFO - 'LOGNAME': 'cltbld', 15:01:36 INFO - 'MAIL': '/var/mail/cltbld', 15:01:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:36 INFO - 'MOZ_NO_REMOTE': '1', 15:01:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:36 INFO - 'NO_EM_RESTART': '1', 15:01:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:36 INFO - 'PWD': '/builds/slave/test', 15:01:36 INFO - 'SHELL': '/bin/bash', 15:01:36 INFO - 'SHLVL': '1', 15:01:36 INFO - 'TERM': 'linux', 15:01:36 INFO - 'TMOUT': '86400', 15:01:36 INFO - 'USER': 'cltbld', 15:01:36 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480460480.225962-1051720692', 15:01:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:36 INFO - '_': '/tools/buildbot/bin/python'} 15:01:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:36 INFO - Downloading/unpacking psutil>=3.1.1 15:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:01:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:01:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:01:39 INFO - Installing collected packages: psutil 15:01:39 INFO - Running setup.py install for psutil 15:01:39 INFO - building 'psutil._psutil_linux' extension 15:01:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:01:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:01:39 INFO - building 'psutil._psutil_posix' extension 15:01:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:01:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:01:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:01:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:01:39 INFO - Successfully installed psutil 15:01:39 INFO - Cleaning up... 15:01:39 INFO - Return code: 0 15:01:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7091e8ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c48b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e72fc0>, '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 0x1e73ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e74350>, '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': '62c568580acbfdaac3eec7be000001dc-1480460480.225962-1051720692', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:01:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:01:39 INFO - Using env: {'DISPLAY': ':0', 15:01:39 INFO - 'HOME': '/home/cltbld', 15:01:39 INFO - 'LANG': 'en_US.UTF-8', 15:01:39 INFO - 'LANGUAGE': 'en_US:en', 15:01:39 INFO - 'LOGNAME': 'cltbld', 15:01:39 INFO - 'MAIL': '/var/mail/cltbld', 15:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:39 INFO - 'MOZ_NO_REMOTE': '1', 15:01:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:39 INFO - 'NO_EM_RESTART': '1', 15:01:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:39 INFO - 'PWD': '/builds/slave/test', 15:01:39 INFO - 'SHELL': '/bin/bash', 15:01:39 INFO - 'SHLVL': '1', 15:01:39 INFO - 'TERM': 'linux', 15:01:39 INFO - 'TMOUT': '86400', 15:01:39 INFO - 'USER': 'cltbld', 15:01:39 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480460480.225962-1051720692', 15:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:39 INFO - '_': '/tools/buildbot/bin/python'} 15:01:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:01:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:01:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:01:41 INFO - Installing collected packages: mozsystemmonitor 15:01:41 INFO - Running setup.py install for mozsystemmonitor 15:01:41 INFO - Successfully installed mozsystemmonitor 15:01:41 INFO - Cleaning up... 15:01:42 INFO - Return code: 0 15:01:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:42 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 0x7f7091e8ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c48b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e72fc0>, '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 0x1e73ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e74350>, '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': '62c568580acbfdaac3eec7be000001dc-1480460480.225962-1051720692', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:01:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:01:42 INFO - Using env: {'DISPLAY': ':0', 15:01:42 INFO - 'HOME': '/home/cltbld', 15:01:42 INFO - 'LANG': 'en_US.UTF-8', 15:01:42 INFO - 'LANGUAGE': 'en_US:en', 15:01:42 INFO - 'LOGNAME': 'cltbld', 15:01:42 INFO - 'MAIL': '/var/mail/cltbld', 15:01:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:42 INFO - 'MOZ_NO_REMOTE': '1', 15:01:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:42 INFO - 'NO_EM_RESTART': '1', 15:01:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:42 INFO - 'PWD': '/builds/slave/test', 15:01:42 INFO - 'SHELL': '/bin/bash', 15:01:42 INFO - 'SHLVL': '1', 15:01:42 INFO - 'TERM': 'linux', 15:01:42 INFO - 'TMOUT': '86400', 15:01:42 INFO - 'USER': 'cltbld', 15:01:42 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480460480.225962-1051720692', 15:01:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:42 INFO - '_': '/tools/buildbot/bin/python'} 15:01:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:42 INFO - Downloading/unpacking jsonschema==2.5.1 15:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:01:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:44 INFO - Downloading functools32-3.2.3-2.tar.gz 15:01:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:01:44 INFO - warning: no files found matching '*.txt' 15:01:44 INFO - no previously-included directories found matching 'build' 15:01:44 INFO - no previously-included directories found matching 'dist' 15:01:44 INFO - no previously-included directories found matching '.git*' 15:01:44 INFO - Installing collected packages: jsonschema, functools32 15:01:44 INFO - Running setup.py install for functools32 15:01:44 INFO - warning: no files found matching '*.txt' 15:01:44 INFO - no previously-included directories found matching 'build' 15:01:44 INFO - no previously-included directories found matching 'dist' 15:01:44 INFO - no previously-included directories found matching '.git*' 15:01:44 INFO - Successfully installed jsonschema functools32 15:01:44 INFO - Cleaning up... 15:01:44 INFO - Return code: 0 15:01:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:44 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 0x7f7091e8ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c48b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e72fc0>, '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 0x1e73ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e74350>, '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': '62c568580acbfdaac3eec7be000001dc-1480460480.225962-1051720692', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:01:44 INFO - Using env: {'DISPLAY': ':0', 15:01:44 INFO - 'HOME': '/home/cltbld', 15:01:44 INFO - 'LANG': 'en_US.UTF-8', 15:01:44 INFO - 'LANGUAGE': 'en_US:en', 15:01:44 INFO - 'LOGNAME': 'cltbld', 15:01:44 INFO - 'MAIL': '/var/mail/cltbld', 15:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:44 INFO - 'MOZ_NO_REMOTE': '1', 15:01:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:44 INFO - 'NO_EM_RESTART': '1', 15:01:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:44 INFO - 'PWD': '/builds/slave/test', 15:01:44 INFO - 'SHELL': '/bin/bash', 15:01:44 INFO - 'SHLVL': '1', 15:01:44 INFO - 'TERM': 'linux', 15:01:44 INFO - 'TMOUT': '86400', 15:01:44 INFO - 'USER': 'cltbld', 15:01:44 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480460480.225962-1051720692', 15:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:44 INFO - '_': '/tools/buildbot/bin/python'} 15:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:01:44 INFO - Cleaning up... 15:01:44 INFO - Return code: 0 15:01:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:44 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 0x7f7091e8ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c48b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e72fc0>, '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 0x1e73ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e74350>, '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': '62c568580acbfdaac3eec7be000001dc-1480460480.225962-1051720692', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:01:44 INFO - Using env: {'DISPLAY': ':0', 15:01:44 INFO - 'HOME': '/home/cltbld', 15:01:44 INFO - 'LANG': 'en_US.UTF-8', 15:01:44 INFO - 'LANGUAGE': 'en_US:en', 15:01:44 INFO - 'LOGNAME': 'cltbld', 15:01:44 INFO - 'MAIL': '/var/mail/cltbld', 15:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:44 INFO - 'MOZ_NO_REMOTE': '1', 15:01:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:44 INFO - 'NO_EM_RESTART': '1', 15:01:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:44 INFO - 'PWD': '/builds/slave/test', 15:01:44 INFO - 'SHELL': '/bin/bash', 15:01:44 INFO - 'SHLVL': '1', 15:01:44 INFO - 'TERM': 'linux', 15:01:44 INFO - 'TMOUT': '86400', 15:01:44 INFO - 'USER': 'cltbld', 15:01:44 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480460480.225962-1051720692', 15:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:44 INFO - '_': '/tools/buildbot/bin/python'} 15:01:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:45 INFO - Downloading/unpacking blobuploader==1.2.4 15:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:47 INFO - Downloading blobuploader-1.2.4.tar.gz 15:01:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:01:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:01:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:47 INFO - Downloading docopt-0.6.1.tar.gz 15:01:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:01:47 INFO - Installing collected packages: blobuploader, requests, docopt 15:01:47 INFO - Running setup.py install for blobuploader 15:01:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:01:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:01:47 INFO - Running setup.py install for requests 15:01:48 INFO - Running setup.py install for docopt 15:01:48 INFO - Successfully installed blobuploader requests docopt 15:01:48 INFO - Cleaning up... 15:01:48 INFO - Return code: 0 15:01:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01: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')]} 15:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01: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')]} 15:01:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:48 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 0x7f7091e8ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c48b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e72fc0>, '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 0x1e73ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e74350>, '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': '62c568580acbfdaac3eec7be000001dc-1480460480.225962-1051720692', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:01:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:01:48 INFO - Using env: {'DISPLAY': ':0', 15:01:48 INFO - 'HOME': '/home/cltbld', 15:01:48 INFO - 'LANG': 'en_US.UTF-8', 15:01:48 INFO - 'LANGUAGE': 'en_US:en', 15:01:48 INFO - 'LOGNAME': 'cltbld', 15:01:48 INFO - 'MAIL': '/var/mail/cltbld', 15:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:48 INFO - 'MOZ_NO_REMOTE': '1', 15:01:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:48 INFO - 'NO_EM_RESTART': '1', 15:01:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:48 INFO - 'PWD': '/builds/slave/test', 15:01:48 INFO - 'SHELL': '/bin/bash', 15:01:48 INFO - 'SHLVL': '1', 15:01:48 INFO - 'TERM': 'linux', 15:01:48 INFO - 'TMOUT': '86400', 15:01:48 INFO - 'USER': 'cltbld', 15:01:48 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480460480.225962-1051720692', 15:01:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:48 INFO - '_': '/tools/buildbot/bin/python'} 15:01:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:01:48 INFO - Running setup.py (path:/tmp/pip-gwvG_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:01:48 INFO - Running setup.py (path:/tmp/pip-kZq5Pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:01:48 INFO - Running setup.py (path:/tmp/pip-tjSFVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:01:48 INFO - Running setup.py (path:/tmp/pip-cEV68d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:01:48 INFO - Running setup.py (path:/tmp/pip-sMnvug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:01:49 INFO - Running setup.py (path:/tmp/pip-l3AM1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:01:49 INFO - Running setup.py (path:/tmp/pip-kTrg1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:01:49 INFO - Running setup.py (path:/tmp/pip-XC5mP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:01:49 INFO - Running setup.py (path:/tmp/pip-Mfi4a_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:01:49 INFO - Running setup.py (path:/tmp/pip-3Gx4S4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:01:49 INFO - Running setup.py (path:/tmp/pip-R9AALS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:01:49 INFO - Running setup.py (path:/tmp/pip-ZhkrFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:01:49 INFO - Running setup.py (path:/tmp/pip-64M_ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:01:49 INFO - Running setup.py (path:/tmp/pip-wOhZA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:49 INFO - Running setup.py (path:/tmp/pip-50tU90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:01:49 INFO - Running setup.py (path:/tmp/pip-RDQ81m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:01:49 INFO - Running setup.py (path:/tmp/pip-q2LM9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:01:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:01:49 INFO - Running setup.py install for manifestparser 15:01:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:01:50 INFO - Running setup.py install for mozcrash 15:01:50 INFO - Running setup.py install for mozdebug 15:01:50 INFO - Running setup.py install for mozdevice 15:01:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:01:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:01:50 INFO - Running setup.py install for mozfile 15:01:50 INFO - Running setup.py install for mozhttpd 15:01:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:01:50 INFO - Running setup.py install for mozinfo 15:01:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:01:50 INFO - Running setup.py install for mozInstall 15:01:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:01:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:01:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:01:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:01:50 INFO - Running setup.py install for mozleak 15:01:50 INFO - Running setup.py install for mozlog 15:01:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:01:50 INFO - Running setup.py install for moznetwork 15:01:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:01:51 INFO - Running setup.py install for mozprocess 15:01:51 INFO - Running setup.py install for mozprofile 15:01:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:01:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:01:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:01:51 INFO - Running setup.py install for mozrunner 15:01:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:01:51 INFO - Running setup.py install for mozscreenshot 15:01:51 INFO - Running setup.py install for moztest 15:01:51 INFO - Running setup.py install for mozversion 15:01:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:01:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:01:51 INFO - Cleaning up... 15:01:51 INFO - Return code: 0 15:01:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:01:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:51 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 0x7f7091e8ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c48b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e72fc0>, '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 0x1e73ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e74350>, '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': '62c568580acbfdaac3eec7be000001dc-1480460480.225962-1051720692', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:01:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:01:51 INFO - Using env: {'DISPLAY': ':0', 15:01:51 INFO - 'HOME': '/home/cltbld', 15:01:51 INFO - 'LANG': 'en_US.UTF-8', 15:01:51 INFO - 'LANGUAGE': 'en_US:en', 15:01:51 INFO - 'LOGNAME': 'cltbld', 15:01:51 INFO - 'MAIL': '/var/mail/cltbld', 15:01:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:51 INFO - 'MOZ_NO_REMOTE': '1', 15:01:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:51 INFO - 'NO_EM_RESTART': '1', 15:01:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:51 INFO - 'PWD': '/builds/slave/test', 15:01:51 INFO - 'SHELL': '/bin/bash', 15:01:51 INFO - 'SHLVL': '1', 15:01:51 INFO - 'TERM': 'linux', 15:01:51 INFO - 'TMOUT': '86400', 15:01:51 INFO - 'USER': 'cltbld', 15:01:51 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480460480.225962-1051720692', 15:01:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:51 INFO - '_': '/tools/buildbot/bin/python'} 15:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:01:51 INFO - Running setup.py (path:/tmp/pip-tv30cI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:01:52 INFO - Running setup.py (path:/tmp/pip-loQ0lE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:01:52 INFO - Running setup.py (path:/tmp/pip-N_LYOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:01:52 INFO - Running setup.py (path:/tmp/pip-jAX9UE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:01:52 INFO - Running setup.py (path:/tmp/pip-ytBwpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:01:52 INFO - Running setup.py (path:/tmp/pip-_BenQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:01:52 INFO - Running setup.py (path:/tmp/pip-mfIKPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:01:52 INFO - Running setup.py (path:/tmp/pip-mB7R38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:01:52 INFO - Running setup.py (path:/tmp/pip-thraVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:01:52 INFO - Running setup.py (path:/tmp/pip-R0rmkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:01:52 INFO - Running setup.py (path:/tmp/pip-FQ7vK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:01:52 INFO - Running setup.py (path:/tmp/pip-iKvlOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:01:52 INFO - Running setup.py (path:/tmp/pip-EOgpsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:01:52 INFO - Running setup.py (path:/tmp/pip-TjDnKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:52 INFO - Running setup.py (path:/tmp/pip-c9XuMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:01:53 INFO - Running setup.py (path:/tmp/pip-futfP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:01:53 INFO - Running setup.py (path:/tmp/pip-FqMHLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:01:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:55 INFO - Downloading blessings-1.6.tar.gz 15:01:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:01:55 INFO - Installing collected packages: blessings 15:01:55 INFO - Running setup.py install for blessings 15:01:55 INFO - Successfully installed blessings 15:01:55 INFO - Cleaning up... 15:01:55 INFO - Return code: 0 15:01:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:01:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:01:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:01:55 INFO - Reading from file tmpfile_stdout 15:01:55 INFO - Current package versions: 15:01:55 INFO - argparse == 1.2.1 15:01:55 INFO - blessings == 1.6 15:01:55 INFO - blobuploader == 1.2.4 15:01:55 INFO - docopt == 0.6.1 15:01:55 INFO - functools32 == 3.2.3-2 15:01:55 INFO - jsonschema == 2.5.1 15:01:55 INFO - manifestparser == 1.1 15:01:55 INFO - mozInstall == 1.12 15:01:55 INFO - mozcrash == 1.0 15:01:55 INFO - mozdebug == 0.1 15:01:55 INFO - mozdevice == 0.49 15:01:55 INFO - mozfile == 1.2 15:01:55 INFO - mozhttpd == 0.7 15:01:55 INFO - mozinfo == 0.9 15:01:55 INFO - mozleak == 0.1 15:01:55 INFO - mozlog == 3.4 15:01:55 INFO - moznetwork == 0.27 15:01:55 INFO - mozprocess == 0.23 15:01:55 INFO - mozprofile == 0.28 15:01:55 INFO - mozrunner == 6.13 15:01:55 INFO - mozscreenshot == 0.1 15:01:55 INFO - mozsystemmonitor == 0.3 15:01:55 INFO - moztest == 0.7 15:01:55 INFO - mozversion == 1.4 15:01:55 INFO - psutil == 3.1.1 15:01:55 INFO - requests == 1.2.3 15:01:55 INFO - wsgiref == 0.1.2 15:01:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:01: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')]} 15:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01: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')]} 15:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:55 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 0x7f7091e8ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c48b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e72fc0>, '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 0x1e73ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e74350>, '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': '62c568580acbfdaac3eec7be000001dc-1480460480.225962-1051720692', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:01:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:01:55 INFO - Using env: {'DISPLAY': ':0', 15:01:55 INFO - 'HOME': '/home/cltbld', 15:01:55 INFO - 'LANG': 'en_US.UTF-8', 15:01:55 INFO - 'LANGUAGE': 'en_US:en', 15:01:55 INFO - 'LOGNAME': 'cltbld', 15:01:55 INFO - 'MAIL': '/var/mail/cltbld', 15:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:55 INFO - 'MOZ_NO_REMOTE': '1', 15:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:55 INFO - 'NO_EM_RESTART': '1', 15:01:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:55 INFO - 'PWD': '/builds/slave/test', 15:01:55 INFO - 'SHELL': '/bin/bash', 15:01:55 INFO - 'SHLVL': '1', 15:01:55 INFO - 'TERM': 'linux', 15:01:55 INFO - 'TMOUT': '86400', 15:01:55 INFO - 'USER': 'cltbld', 15:01:55 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480460480.225962-1051720692', 15:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:55 INFO - '_': '/tools/buildbot/bin/python'} 15:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:01:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:01:55 INFO - Cleaning up... 15:01:55 INFO - Return code: 0 15:01:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:01: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')]} 15:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01: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')]} 15:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:55 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 0x7f7091e8ce30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c48b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e72fc0>, '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 0x1e73ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e74350>, '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': '62c568580acbfdaac3eec7be000001dc-1480460480.225962-1051720692', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:01:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:01:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:01:55 INFO - Using env: {'DISPLAY': ':0', 15:01:55 INFO - 'HOME': '/home/cltbld', 15:01:55 INFO - 'LANG': 'en_US.UTF-8', 15:01:55 INFO - 'LANGUAGE': 'en_US:en', 15:01:55 INFO - 'LOGNAME': 'cltbld', 15:01:55 INFO - 'MAIL': '/var/mail/cltbld', 15:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:55 INFO - 'MOZ_NO_REMOTE': '1', 15:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:55 INFO - 'NO_EM_RESTART': '1', 15:01:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:01:55 INFO - 'PWD': '/builds/slave/test', 15:01:55 INFO - 'SHELL': '/bin/bash', 15:01:55 INFO - 'SHLVL': '1', 15:01:55 INFO - 'TERM': 'linux', 15:01:55 INFO - 'TMOUT': '86400', 15:01:55 INFO - 'USER': 'cltbld', 15:01:55 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480460480.225962-1051720692', 15:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:55 INFO - '_': '/tools/buildbot/bin/python'} 15:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:01:56 INFO - Cleaning up... 15:01:56 INFO - Return code: 0 15:01:56 INFO - Running post-action listener: _resource_record_post_action 15:01:56 INFO - Running post-action listener: _start_resource_monitoring 15:01:56 INFO - Starting resource monitoring. 15:01:56 INFO - [mozharness: 2016-11-29 23:01:56.102783Z] Finished create-virtualenv step (success) 15:01:56 INFO - [mozharness: 2016-11-29 23:01:56.103304Z] Running install step. 15:01:56 INFO - Running pre-action listener: _resource_record_pre_action 15:01:56 INFO - Running main action method: install 15:01:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:01:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:01:56 INFO - Reading from file tmpfile_stdout 15:01:56 INFO - Detecting whether we're running mozinstall >=1.0... 15:01:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:01:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:01:56 INFO - Reading from file tmpfile_stdout 15:01:56 INFO - Output received: 15:01:56 INFO - Usage: mozinstall [options] installer 15:01:56 INFO - Options: 15:01:56 INFO - -h, --help show this help message and exit 15:01:56 INFO - -d DEST, --destination=DEST 15:01:56 INFO - Directory to install application into. [default: 15:01:56 INFO - "/builds/slave/test"] 15:01:56 INFO - --app=APP Application being installed. [default: firefox] 15:01:56 INFO - mkdir: /builds/slave/test/build/application 15:01:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:01:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:02:13 INFO - Reading from file tmpfile_stdout 15:02:13 INFO - Output received: 15:02:13 INFO - /builds/slave/test/build/application/firefox/firefox 15:02:13 INFO - Running post-action listener: _resource_record_post_action 15:02:13 INFO - [mozharness: 2016-11-29 23:02:13.354992Z] Finished install step (success) 15:02:13 INFO - [mozharness: 2016-11-29 23:02:13.355258Z] Running run-tests step. 15:02:13 INFO - Running pre-action listener: _resource_record_pre_action 15:02:13 INFO - Running main action method: run_tests 15:02:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:02:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:02:13 INFO - Python 2.7.3 15:02:13 INFO - Return code: 0 15:02:13 INFO - grabbing minidump binary from tooltool 15:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:02:13 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 0x1e72fc0>, '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 0x1e73ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e74350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:02:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:02:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:02:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:02:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:02:13 INFO - Return code: 0 15:02:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:02:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:02:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:02:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:02:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:02:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:02:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:02:13 INFO - Using env: {'DISPLAY': ':0', 15:02:13 INFO - 'HOME': '/home/cltbld', 15:02:13 INFO - 'LANG': 'en_US.UTF-8', 15:02:13 INFO - 'LANGUAGE': 'en_US:en', 15:02:13 INFO - 'LOGNAME': 'cltbld', 15:02:13 INFO - 'MAIL': '/var/mail/cltbld', 15:02:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:02:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:13 INFO - 'MOZ_NO_REMOTE': '1', 15:02:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:02:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:13 INFO - 'NO_EM_RESTART': '1', 15:02:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:02:13 INFO - 'PWD': '/builds/slave/test', 15:02:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:02:13 INFO - 'SHELL': '/bin/bash', 15:02:13 INFO - 'SHLVL': '1', 15:02:13 INFO - 'TERM': 'linux', 15:02:13 INFO - 'TMOUT': '86400', 15:02:13 INFO - 'USER': 'cltbld', 15:02:13 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1480460480.225962-1051720692', 15:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:13 INFO - '_': '/tools/buildbot/bin/python'} 15:02:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:02:13 INFO - mozversion application_buildid: 20161129121152 15:02:13 INFO - mozversion application_changeset: d254eb61360d3c20172eb7aba1154e2779850263 15:02:13 INFO - mozversion application_display_name: Nightly 15:02:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:02:13 INFO - mozversion application_name: Firefox 15:02:13 INFO - mozversion application_remotingname: firefox 15:02:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:02:13 INFO - mozversion application_vendor: Mozilla 15:02:13 INFO - mozversion application_version: 53.0a1 15:02:13 INFO - mozversion platform_buildid: 20161129121152 15:02:13 INFO - mozversion platform_changeset: d254eb61360d3c20172eb7aba1154e2779850263 15:02:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:02:13 INFO - mozversion platform_version: 53.0a1 15:02:13 INFO - using testdate: 1480460533 15:02:13 INFO - actual date: 1480460533 15:02:13 INFO - starting webserver on 'localhost:43416' 15:02:13 INFO - SUITE-START | Running 2 tests 15:02:13 INFO - TEST-START | dromaeo_css 15:02:13 INFO - operating with platform_type : linux_ 15:02:13 INFO - Initialising browser for dromaeo_css test... 15:02:13 INFO - TEST-INFO | started process 27685 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3bpO5m/profile http://localhost:43416/getInfo.html) 15:02:17 INFO - PROCESS | 27685 | __metrics Screen width/height:1600/1200 15:02:17 INFO - PROCESS | 27685 | colorDepth:24 15:02:17 INFO - PROCESS | 27685 | Browser inner width/height: 1024/697 15:02:17 INFO - PROCESS | 27685 | __metrics 15:02:18 INFO - PROCESS | 27685 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:02:18 INFO - PROCESS | 27685 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:02:18 INFO - PROCESS | 27685 | console.error: PushService: 15:02:18 INFO - PROCESS | 27685 | stateChangeProcessEnqueue: Error transitioning state 15:02:18 INFO - PROCESS | 27685 | UnknownError 15:02:19 INFO - TEST-INFO | 27685: exit 0 15:02:19 INFO - Browser initialized. 15:02:19 INFO - Running cycle 1/1 for dromaeo_css test... 15:02:19 INFO - TEST-INFO | started process 27770 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3bpO5m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:02:31 INFO - PROCESS | 27770 | RSS: Main: 173998080 15:02:31 INFO - PROCESS | 27770 | 15:03:23 INFO - PROCESS | 27770 | 1480460603651 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:05:34 INFO - PROCESS | 27770 | Cycle 1(1): loaded http://localhost:43416/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43416/tests/dromaeo/cssquery-ext.html) 15:05:35 INFO - PROCESS | 27770 | RSS: Main: 341995520 15:05:35 INFO - PROCESS | 27770 | 15:08:38 INFO - PROCESS | 27770 | Cycle 1(1): loaded http://localhost:43416/tests/dromaeo/cssquery-ext.html (next: http://localhost:43416/tests/dromaeo/cssquery-jquery.html) 15:08:39 INFO - PROCESS | 27770 | RSS: Main: 290291712 15:08:39 INFO - PROCESS | 27770 | 15:11:41 INFO - PROCESS | 27770 | Cycle 1(1): loaded http://localhost:43416/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43416/tests/dromaeo/cssquery-mootools.html) 15:11:41 INFO - PROCESS | 27770 | RSS: Main: 262299648 15:11:41 INFO - PROCESS | 27770 | 15:14:43 INFO - PROCESS | 27770 | Cycle 1(1): loaded http://localhost:43416/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43416/tests/dromaeo/cssquery-prototype.html) 15:14:44 INFO - PROCESS | 27770 | RSS: Main: 243412992 15:14:44 INFO - PROCESS | 27770 | 15:17:47 INFO - PROCESS | 27770 | Cycle 1(1): loaded http://localhost:43416/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43416/tests/dromaeo/cssquery-yui.html) 15:17:47 INFO - PROCESS | 27770 | RSS: Main: 221831168 15:17:47 INFO - PROCESS | 27770 | 15:20:50 INFO - PROCESS | 27770 | Cycle 1(1): loaded http://localhost:43416/tests/dromaeo/cssquery-yui.html (next: http://localhost:43416/tests/dromaeo/cssquery-dojo.html) 15:20:51 INFO - PROCESS | 27770 | RSS: Main: 315056128 15:20:51 INFO - PROCESS | 27770 | 15:20:51 INFO - PROCESS | 27770 | __start_tp_report 15:20:51 INFO - PROCESS | 27770 | _x_x_mozilla_page_load 15:20:51 INFO - PROCESS | 27770 | _x_x_mozilla_page_load_details 15:20:51 INFO - PROCESS | 27770 | |i|pagename|runs| 15:20:51 INFO - PROCESS | 27770 | |0;dojo.html;3119.189010857177;3148.2601588626667;3153.3535625196837;3169.0809665197066;3202.775805693601;5317.2821669074665;5403.540699040582;5412.512873841353;5439.292891924049;5484.780608775649;5367.892642147155;5434.592405569579;5443.891122177564;5445.128779395298;5535.640183388077;4892.975535122319;4908.067467181224;4950.851474455772;4961.5286547777905;5003.674761140514;4951.356323677935;5061.215511595708;5082.491750824925;5087.56755675768;5131.666441681297;4898.510148985109;4930.4330002049865;5000.124978128849;5041.092603331399;5054.064997975386;4916;4993.051320249141;4993.925091123636;4997.425296090923;5053.898922021575;4942.332785074005;4949.133901567211;4950.331705219785;4957.405111386656;4970.403551573834;5440.782368705247;5458.444343362123;5459.727013649302;5467;5471.480209380103;5743.712814359307;5768.307803063617;5781.364049954502;5817.127430885359;5824.737886795105;5883.911741323841;5892.793752218652;5915;5920.259967504062;5968.373320801296;5488.9725551371985;5493.725313734298;5494.780208791603;5495.780168793283;5497.065498865162;5841.824745257649;5850.64896106235;5901.822945311647;5988.640681559121;5991.400859914061;5632.690202038845;5668.716564171775;5673.461021202979;5701.0308247598;5703.17303990919;5771.624844385102;5772.191893134965;5773.047447171254;5774.971125144348;5775.797847075332;5642.7178641067785;5774.595778295563;5775.27809023872;5783.652980821164;5784.566157538202;5753.510951569164;5781.6241944274325;5843;5848.444397782204;5922.200502932049;4506.076254367912;4508.301213311942;4538.659600529973;4545.022820093695;4554.795034223468;4032.2540330039037;4045.2516284487465;4046.919061618751;4047.9392809107885;4080.0411903202726;5356;5369.5167434931045;5413.215083812904;5512.3385193777;5533.170024496358;5797.333306669702;5811.79658711943;5816.243888294494;5820.796272130455;5820.88358232833;5381.13901775714;5410.864728381744;5436.728163591804;5437.564994800407;5441.5102640762525;5007.324011258506;5019.447860735316;5020.196768517019;5020.548150666385;5020.673656212334;6001.279846418458;6001.399860013964;6005.309389420097;6007.969960150172;6011.969940150271;5821.970890145522;5847.298324201123;5851.502622276984;5854.560907931837;5856.0630299151935;6028.487578555696;6031.185789918481;6034.306054803754;6036.758529658764;6036.909446358396;5801.448862358069;5802.158686990447;5802.767889284381;5805.883882322414;5808.593398462236;5673.177389278449;5923.170756094237;5929.673867937305;5929.792457263975;5939.346671866005;5596.552275817843;5679.9432005681065;5683.5737319700365;5686.800961966312;5686.943130568807;5520.365158006881;5647.943520564741;5655.858603534944;5657.575681823797;5657.943420565742;5575.888482230252;5592.720363981866;5623.100303951348;5630.465105814941;5709.115087161496;5687.488126068508;5691.544676425959;5697.259356283656;5699.316082070012;5726.112452569859;5577.470140336662;5592.944070559242;5596.048671725735;5601.6358936668985;5602.85992850182 15:20:51 INFO - PROCESS | 27770 | |1;ext.html;564.5681053993695;592.869568694887;594.2898236607255;605.1709158452917;616.5375968023982;31763.205919851986;34129.31741365174;34228.14429639257;40702;42239.788801055955;42018.57981420185;42485;42504.14991700164;42544.361834572504;42574.57425425745;8500.10748871369;8630.741077767645;8630.827383452328;8654.134586541359;8657.26413254874;7809.453338266324;7978.042634883822;8535.658573657078;9974.152197063258;10245.743856403575;10242.539085741122;10343.172546196287;10343.896561034406;10351.068403843652;10352;10004.399736015826;10007.099361057468;10012.94993525035;10018.549165287506;10053.296269261118;10133.797324053477;10205.948970255175;10210.540525676288;10211.897881021168;10212.897871021269;39984;40264.194716105805;40266.59733402687;40267;40277;3328.8994504974594;3425.811580363079;3453.5165076889257;3717.7211709121925;3850.961490385116;30489.69510304913;31113.688863111307;31160.688393116005;31332.06003819889;31946.201344966328;4063.2686116499017;4156.750594964312;4234.5765423457715;4256.680748943811;4267.445232119836;322697;324647;325182;325739;326443;55661.443385565624;55673.72163139239;56137.98275215598;56164.43835561674;56226.43773562212;60071.69964150151;60195;60229.39770602326;60288.397116029155;60302;15961.760573591406;16195.595110122105;16395.508134755975;16400.425985090464;16415.179241037902;11979.580714674945;12370.257784532776;12431.813522797165;12453.564125255754;12459.127861049821;14800.777988330183;16617.252223649724;16893.493195204162;16894.493165204818;17379.4786156413;5569.387367389584;5623.718814059281;5652.943470565242;5699.886002279931;5726.484616384545;951.6383774165772;1018.4144117132678;1062.9165198664202;1078.0085263393987;1096.1833434091493;29795.40409191804;30114.481598861756;30187.396252075276;30223.69776302209;30486.237844053634;1041.2763129624989;1052.1898138433364;1091.3942761767296;1121.0863146535548;1181.9067362689477;15413.768793468107;16317.755233671505;16359.591010224602;16401.902911653993;16489.422870199487;154092;154356;155002;155087;155433.2228338851;54815.45184548183;54844;54877.72561137249;54879;54944.45055549393;1238.962831115068;1270.1236147058685;1276.0620943606257;1333.646583655332;1359.4766015084265;28480.287992800346;31839.204019899687;31848.203794905312;32347.67652323541;32753.672463276016;47323.05353892834;47885.28172077491;47932.5206747942;48016.75991620019;48064;332115;334476;334643;335392;335593;26739.86630066837;27456.45087098207;27560.310992225353;29036.7096329034;38781.98879173733;44351;45086.32370514379;45092.77453612711;46204.53795462002;46340;37854.242915142095;38518.80740596391;38785.418218726176;38805.2238955225;39538.40692389674;38161.6183838158;38475.807620961714;38695.22609547737;39165.608343916196;40212.798936005136;39234;39360.40959385554;39550.20899581935;40604.59395406126;40740;32147;34302.656973430945;34407.655923441445;34473.23039305852;35130.12174695653;24947.251582452554;25341.61987570151;25431.36421589401;27207.183784486497;27933.580996284665 15:20:51 INFO - PROCESS | 27770 | |2;jquery.html;372.9571099323577;375.41810194198985;405.4931335830212;408.4506338974079;416.7707760731597;13156.736865262688;15282.923585382072;16716.498505044838;19144.808551914477;19210;18372.26510939564;18735.3442629508;19223.61552768944;19249.807501924977;19258.22967081315;5497.670139791615;5507.752151153188;5728.713564321788;5729.05470597353;5732.7133643317875;5188.6367954243215;5638.464345887134;5642.943570564283;5658.8019419320335;5659.943400566003;5428.5385742211765;5617.466340697627;5623.353314368838;5624.887502249952;5625.324961004685;5558.471945165203;5584.748686309105;5622.8313150605545;5626.409227031144;5628.015097357967;4828.372311599504;4910.312556242129;5051.722155281458;5051.898962020739;5060.822871199527;22669.659955100688;22798.202062927718;22809.543809123723;22977;23047.23433188028;2265.2184996176293;2407.7110746710505;2429.757024297574;2484.9378765530823;2988.4770165221;13845;14004.789928151085;14149.787753183711;14262.64343391413;14451.349689263903;1880.9435716928515;1909.255390397746;1912.80871912809;1939.5151212196952;2015.6472617291915;82738.58630706868;85184;85664.57167714121;85953.57023214844;87129;10831.783364332827;11056.447177641086;11141.331520108657;11374.772504550028;11658.825117623242;15573.299201535958;15581.298841552158;15597.688046239238;15600.843991560167;15610.9219453902;8006.1993800619475;8180.100188979208;8395.412321137585;8503.574821258911;8532.189442003;7885.29032387088;8053.959730201312;8065.435419520694;8146.837063258702;8156.898818659405;4685.648576356787;4751.714897106115;4795.95204047955;4911.484294149134;4920.384951881015;1942.2522328903192;1994.5312851479891;2043.8058384453452;2049.7540295164376;2062.9484262893548;709.824238609407;831.1148626712531;859.7979474823411;902.3412908576776;984.2667212926273;17517.7372339415;19012.714809277873;19179.520511987033;19298.22807087729;19355.612887742165;962.9133377996014;976.8827740671023;985.0887928665956;995.318207028188;1017.2097109088058;10079;10689.144868410509;10720.249582529148;10723.678289651323;10736.570537178426;411070;417394;419884;421489;426524;88425;90137.09862901419;91930.54034729784;94015.52992234995;95853;993.279872092727;1023.1507848485887;1053.5153829238636;1056.2817284246632;1061.7186445591924;16449.753253700965;16467.876865057355;17019;17263.22315495831;17453.912730436776;41281.380779287734;41754;43020;43070.56929430665;43403.78298108489;54485;57416.71291643515;58266.7086664564;60059.39940600538;60690;8184.8772268417215;8285.54429506383;8308;8494.193051660082;8725.171108744658;10668.35989840581;11839.572887557857;12758.61724148277;13015.284159371326;13320.333983300603;11283.887161128283;11364.431778411212;11374.772504550028;11572.727000029821;11888.643340699793;10740.73148171302;10841.295315804447;10937;10985.121190304597;11029.889701102886;10920.18098642589;10990.065844403316;11445.599404020819;11456.713582160513;11772.529098836294;8351;8390.874136887829;8637.654493820428;8689.391742578211;8752.91247087521;10563.471826408495;11000.119990400908;11158.218924675519;11238.831417528907;11613.3612651305 15:20:51 INFO - PROCESS | 27770 | |3;mootools.html;1432.7421064208438;1467;1585.952421427357;1709.5555155659524;1736.2707662781622;7062.823429414268;7281.1262648482125;7742.187070357616;8076.1923807619205;8076.3538916886655;7633.0458692663415;7878.40911931606;7886.960565197181;8020.197980201977;8026.197380261986;2222.355516900101;2263.513344630904;2271.0461606125386;2272.6363781794917;2276.681264622954;2015.4659015360942;2077.6883467479925;2269.1377276634857;2305.596520608895;2307.1348244408346;2187.562487502498;2270.795628393444;2272.4091736148557;2281.2471884278148;2291.541691661666;2231.553689262154;2233.7877901599322;2238.46276893546;2283.3264187064774;2301.0680674326923;2270.126001489422;2274.9203777867697;2297.8965946532444;2303.585354636165;2313.016967788683;7853.646585903648;7913.050433947906;7930.960345198295;7936.325412339958;7969.760907172737;5090.160123579605;5207.583393328525;5224.8693782655355;5228.686278823245;5240.135377662681;3090.752739780812;3171.0645359618966;3182.745380369565;3235.773495855291;3240.0603824890754;1028.9073983341534;1046.26238501856;1051.8692405663942;1069.9893001070045;1090.0353187429102;11011.28426652273;11061.446927653586;11079.72300692489;11084.889151108466;11087.944560277147;4294.3558466230315;4592.7933243004145;4603.263477843529;4649.674522783373;4656.674032817738;9116.726498205064;9140.131687489678;9204.309676774135;9215.308851836138;9216.677416290531;5097.46476619957;5100;5102.2346648003095;5106.234064890222;5114.897702045938;4598.057398233354;4659.836905708352;4682.063587282489;4725.220338644154;4734.218853889139;3596.964030359663;3699.445083237482;3776.169242766587;3872.302985462644;3916.941245881314;1175.61204802415;1198.1193822540426;1213.1386715431966;1244.9190802597802;1255.4727014653868;838.1576515601903;927.6011315134422;950.12588418655;952.2953014769021;953.9523023848918;5545.114661015194;5794.826155215266;5834.8541286467325;5848.56083842031;6084.756609735649;905.1401168889581;905.8686490458847;949.2453499467939;967.811276801017;997.9002099789963;3655.9817200913826;3873.1479074603544;3887.2419878123496;3939.350007248772;4056.290149223874;10231.897681023094;10411.219158563137;10479.68560943173;10511.421871797125;10544.209184311054;9609.37539059973;9968.651097211563;9975.501224938724;10281.485925703684;10406.5837366506;7417.8145546361775;7586.544807311579;7591.4685971981435;7602.46782725204;7621.771346859603;5452.263944367618;5519.586031047607;5595.160725891149;5626.606137570331;5764.423557644202;9468.526573671426;9486.098820612031;9500.572474238537;9530.904690953003;9615.086566776145;9363.204127649225;9376.203022743142;9390.24878009744;9410.294227932796;9823.557939892866;7261.709531618676;7406.962965185139;7414.962925185339;7418.18399976013;7432.405407567489;7785.727499537489;7807.531548107132;7840.215978402114;7900.68397264103;7909.841803164019;7009.684564194521;7101.751438699621;7142.142942846684;7143.4999550031;7181.964090179516;6930.792076237721;6963.303669633199;6998.16022077354;7061.329173728487;7077.929220707727;6534.542582019403;6685.76599819004;6690.698918548775;6692.464602831665;6723.562968407038;4689.296605509201;4737.526247375235;4841.927371089507;4965.851024469272;4967.105920934122;4804.6876952997945;4836.685615434985;4854.611631069577;4956.752162391938;5033.043721692867 15:20:51 INFO - PROCESS | 27770 | |4;prototype.html;323.5546850622386;338.09390832568715;345.78906866811246;347.1650680114324;349.6870301080535;5219.269302297681;5332.946670533293;5349;5364.900195459931;5417.864553386167;5180.740962951856;5232.110541207994;5278.577713782898;5279.102552566063;5323.281357016802;4176.832926682944;4181.665466762667;4226.640735537483;4235.957640423602;4253.595908388698;3977.9801100994455;4038.5961403859674;4181.142865712522;4230.455883602478;4249.851255206068;4061.451704019949;4128.153728485669;4161.687873409492;4166.604172603597;4175.102352994121;4153.646940010072;4164.4586203793315;4167.312393455076;4171.395147703581;4181.268278051344;3695.133957351547;3700.870469533553;3716.312482190803;3723.2739615774935;3724.832382542792;4963;5039.974800126012;5051.419086805027;5069.417017043051;5085.593152547787;4741.905161896777;4774.8540350316025;4791.329213910055;4809.302651115569;4832.806687732486;5377.166539186433;5530.695811730353;5553.916691249635;5557.861053473655;5571.554275657938;3968.6626636735914;4038.6365227129404;4045.4740883685226;4058.8782336529953;4069.857554985591;5643.266375371217;5656.971715141439;5662.471132794122;5671.120976248647;5708.543316534668;4153.0447996960265;4158.606866699629;4165.16696660663;4218.325067989107;4226.852060177879;3922.7057970652313;4092.1815636872743;4098.401623366889;4123.36087906375;4274.893127671833;4633.606143477842;4636.165490211794;4688.718676879398;4690.288044863601;4706.3411122442885;5503.862403439946;5522.22688823565;5528.75120619573;5537.501624853782;5542.445755424506;1358.4634069542476;1385.3627331427454;1389.7915312702974;1391.7703578909366;1392.644875556747;949.3259785552335;965.8406362950175;973.9026097390346;974.2949837783879;975.5463709375175;5186.688798672017;5237.528622424;5253.632245742838;5264.92102618461;5265.446693225507;5527.429745168516;5536.511997441586;5553;5561.860953476114;5574.777008919679;5051.933193779043;5126.282320475062;5161.535461808456;5177.689338639619;5179.663321884065;2886;2905.7965942384253;2909.723576260252;2912.9854350728533;2914.184028472031;5646.661200327993;5676.631018983753;5685.005124103348;5687.43125687428;5714.7999820006935;5405;5409.053415652245;5518;5554.333479982428;5579.525740312038;5646.887062258732;5657.264555607745;5662.85842853932;5673.347565030074;5684.811347631109;5435.396558015474;5492.917606235989;5539.58453116026;5563.078029988929;5597.888042239214;5615.466530679579;5625.943740562542;5634.7464364104535;5662.85842853932;5706.457886500776;5834.095715164156;5864.794732184353;5884.411558844253;5968.373320801427;6005.459508644243;3883.2815929053218;3890.8443662253194;4062.1469491407133;4086.40747091676;4107.671386289149;5491.917621235764;5629.211910332475;5756.683382414008;5757.955925646503;5761.329214527907;5648.350439699487;5656.264685590847;5680.375158732453;5685.403032681675;5687.715614219355;5392.272043274108;5571.804986825442;5590.2453168821685;5654.491095801398;5655.660660360391;5545.445455454423;5550.8057217997175;5559.305086864142;5586.988684073649;5592.636478628876;5584.190292407659;5674.638086859041;5680.403557626555;5690.687012214203;5726.885462290647;5247.9766445542755;5405.864853378697;5507.586930980113;5509.47659972302;5513.476219759116 15:20:51 INFO - PROCESS | 27770 | |5;yui.html;711.477064357697;732.476279460186;748.6481353763733;789.6999140326675;826.8635675113607;15383.692326153485;16142.192890355494;16172.514824555268;16212.675746485063;16259.83740162598;14852.18312992785;14923.328450219738;15015.324310406031;15035.624109397271;15061.774073388908;660.1978596005852;675.4427597232303;771.9922800771976;776.735909790671;795.2683531151325;801.5591424716412;808.107041718901;813.515958004986;815.2581151152452;815.8572249856281;860.0496451421184;861.2421069458899;861.9827603447927;862.0948004595182;862.1723145780028;701.554512884317;859.4671303791627;860.371928492198;860.5568132411813;860.995695021524;528.7699850564978;593.2643522032648;610.7221214347461;611.541343992006;612.3814946903615;15012.549623511311;15049.398024079024;15054.698906021928;15057.096574205583;15065.246737663074;13812;14156;14215.573532794033;14322.641933951734;14402.207878566674;12072.637820865388;12178.78927980195;12293.754124917541;12498.25010499373;12653;4177.49870015597;4221.493420789525;4287.592678695519;4293.162833247518;4425.7565833879125;77963.99999999943;79957.20042799614;80938.59530702367;81223.59388203021;81596.18403815945;10078.377408160859;10444.27897741375;11025.117990560735;11080.778384432266;11232.606858759904;21138.89430552868;21241.575168496543;21248.150073997178;21343.8932805335;21495.78504214969;8244.093149753522;8321.833563328699;8381.916180838114;8409.453385529921;8533.615987280587;4449.688521803443;4564.908701826012;4565.703229290086;4590.655700822452;4752.904941901212;3579.6241394653707;3703.166787472797;3704.129529560551;3714.684251838624;3739.775613463201;613.9539534534928;614.388683260159;636.5194278319839;651.4592887903029;652.1163823019834;643.8615697624939;648.4585371214994;676.2155899156954;705.7812078255655;715.7673756029311;9707.46608936501;9780.853287200698;9993.900060999442;10110.162049972025;10282.434466104436;654.326044174501;660.4716227018462;672.4217173231017;710.3855165282097;723.960182189974;4549.203889319356;4666.346711460398;4809.031231350665;4882.804687812519;4883.609311255091;81561.59219203866;81707.59146204231;82255.58872205601;84543;85292.57353713315;69957.65021174963;70704.2929570708;71560;72601.2739872605;74823.62588187132;66140.66929665417;67608.3239167602;68614;68916.6554167226;69424;8585.399022068395;8593.355498337774;8637.956810215908;8659.826803464022;8825.955870220609;43323.56676433321;44254;44798.552014480745;45005.774971124934;46165;58882.22355528997;59577;61144;63387.366126338144;65112.069956853;11985.28088314704;12047.638570842888;12190.57332993341;12613.49546018149;12914.354282286036;14434.783478248044;14500.419983200554;15130.243487825785;15816.920915395349;15940.211766579021;13607.115537490032;13766;13825.446982120602;13926.373313201133;14134;12332.876671233173;12738.554150604685;12822.551210707581;13446.126001809851;13711.382987765375;12527.37363131858;12929.224246545238;13139.73720525565;13442.93278533601;13527.323633818072;10813.351198928089;11172.49723762449;11328;11332.490037948477;12157.878421215675;9491.288153388661;10771.569137234736;11617.186796924472;11633.6509904703;11775.23460975034 15:20:51 INFO - PROCESS | 27770 | __end_tp_report 15:20:51 INFO - PROCESS | 27770 | __start_cc_report 15:20:51 INFO - PROCESS | 27770 | _x_x_mozilla_cycle_collect,1621 15:20:51 INFO - PROCESS | 27770 | __end_cc_report 15:20:51 INFO - PROCESS | 27770 | __startTimestamp1480461651150__endTimestamp 15:20:51 INFO - PROCESS | 27770 | 15:20:51 INFO - PROCESS | 27770 | ------- Summary: start ------- 15:20:51 INFO - PROCESS | 27770 | Number of tests: 6 15:20:51 INFO - PROCESS | 27770 | 15:20:51 INFO - PROCESS | 27770 | [#0] dojo.html Cycles:165 Average:5412.39 Median:5601.64 stddev:597.58 (10.7%) stddev-sans-first:571.70 15:20:51 INFO - PROCESS | 27770 | Values: 3119.2 3148.3 3153.4 3169.1 3202.8 5317.3 5403.5 5412.5 5439.3 5484.8 5367.9 5434.6 5443.9 5445.1 5535.6 4893.0 4908.1 4950.9 4961.5 5003.7 4951.4 5061.2 5082.5 5087.6 5131.7 4898.5 4930.4 5000.1 5041.1 5054.1 4916.0 4993.1 4993.9 4997.4 5053.9 4942.3 4949.1 4950.3 4957.4 4970.4 5440.8 5458.4 5459.7 5467.0 5471.5 5743.7 5768.3 5781.4 5817.1 5824.7 5883.9 5892.8 5915.0 5920.3 5968.4 5489.0 5493.7 5494.8 5495.8 5497.1 5841.8 5850.6 5901.8 5988.6 5991.4 5632.7 5668.7 5673.5 5701.0 5703.2 5771.6 5772.2 5773.0 5775.0 5775.8 5642.7 5774.6 5775.3 5783.7 5784.6 5753.5 5781.6 5843.0 5848.4 5922.2 4506.1 4508.3 4538.7 4545.0 4554.8 4032.3 4045.3 4046.9 4047.9 4080.0 5356.0 5369.5 5413.2 5512.3 5533.2 5797.3 5811.8 5816.2 5820.8 5820.9 5381.1 5410.9 5436.7 5437.6 5441.5 5007.3 5019.4 5020.2 5020.5 5020.7 6001.3 6001.4 6005.3 6008.0 6012.0 5822.0 5847.3 5851.5 5854.6 5856.1 6028.5 6031.2 6034.3 6036.8 6036.9 5801.4 5802.2 5802.8 5805.9 5808.6 5673.2 5923.2 5929.7 5929.8 5939.3 5596.6 5679.9 5683.6 5686.8 5686.9 5520.4 5647.9 5655.9 5657.6 5657.9 5575.9 5592.7 5623.1 5630.5 5709.1 5687.5 5691.5 5697.3 5699.3 5726.1 5577.5 5592.9 5596.0 5601.6 5602.9 15:20:51 INFO - PROCESS | 27770 | 15:20:51 INFO - PROCESS | 27770 | [#1] ext.html Cycles:180 Average:45142.20 Median:335492.50 stddev:74495.03 (22.2%) stddev-sans-first:74628.81 15:20:51 INFO - PROCESS | 27770 | Values: 564.6 592.9 594.3 605.2 616.5 31763.2 34129.3 34228.1 40702.0 42239.8 42018.6 42485.0 42504.1 42544.4 42574.6 8500.1 8630.7 8630.8 8654.1 8657.3 7809.5 7978.0 8535.7 9974.2 10245.7 10242.5 10343.2 10343.9 10351.1 10352.0 10004.4 10007.1 10012.9 10018.5 10053.3 10133.8 10205.9 10210.5 10211.9 10212.9 39984.0 40264.2 40266.6 40267.0 40277.0 3328.9 3425.8 3453.5 3717.7 3851.0 30489.7 31113.7 31160.7 31332.1 31946.2 4063.3 4156.8 4234.6 4256.7 4267.4 322697.0 324647.0 325182.0 325739.0 326443.0 55661.4 55673.7 56138.0 56164.4 56226.4 60071.7 60195.0 60229.4 60288.4 60302.0 15961.8 16195.6 16395.5 16400.4 16415.2 11979.6 12370.3 12431.8 12453.6 12459.1 14800.8 16617.3 16893.5 16894.5 17379.5 5569.4 5623.7 5652.9 5699.9 5726.5 951.6 1018.4 1062.9 1078.0 1096.2 29795.4 30114.5 30187.4 30223.7 30486.2 1041.3 1052.2 1091.4 1121.1 1181.9 15413.8 16317.8 16359.6 16401.9 16489.4 154092.0 154356.0 155002.0 155087.0 155433.2 54815.5 54844.0 54877.7 54879.0 54944.5 1239.0 1270.1 1276.1 1333.6 1359.5 28480.3 31839.2 31848.2 32347.7 32753.7 47323.1 47885.3 47932.5 48016.8 48064.0 332115.0 334476.0 334643.0 335392.0 335593.0 26739.9 27456.5 27560.3 29036.7 38782.0 44351.0 45086.3 45092.8 46204.5 46340.0 37854.2 38518.8 38785.4 38805.2 39538.4 38161.6 38475.8 38695.2 39165.6 40212.8 39234.0 39360.4 39550.2 40604.6 40740.0 32147.0 34302.7 34407.7 34473.2 35130.1 24947.3 25341.6 25431.4 27207.2 27933.6 15:20:51 INFO - PROCESS | 27770 | 15:20:51 INFO - PROCESS | 27770 | [#2] jquery.html Cycles:180 Average:27101.87 Median:374.19 stddev:69706.97 (18628.9%) stddev-sans-first:69873.63 15:20:51 INFO - PROCESS | 27770 | Values: 373.0 375.4 405.5 408.5 416.8 13156.7 15282.9 16716.5 19144.8 19210.0 18372.3 18735.3 19223.6 19249.8 19258.2 5497.7 5507.8 5728.7 5729.1 5732.7 5188.6 5638.5 5642.9 5658.8 5659.9 5428.5 5617.5 5623.4 5624.9 5625.3 5558.5 5584.7 5622.8 5626.4 5628.0 4828.4 4910.3 5051.7 5051.9 5060.8 22669.7 22798.2 22809.5 22977.0 23047.2 2265.2 2407.7 2429.8 2484.9 2988.5 13845.0 14004.8 14149.8 14262.6 14451.3 1880.9 1909.3 1912.8 1939.5 2015.6 82738.6 85184.0 85664.6 85953.6 87129.0 10831.8 11056.4 11141.3 11374.8 11658.8 15573.3 15581.3 15597.7 15600.8 15610.9 8006.2 8180.1 8395.4 8503.6 8532.2 7885.3 8054.0 8065.4 8146.8 8156.9 4685.6 4751.7 4796.0 4911.5 4920.4 1942.3 1994.5 2043.8 2049.8 2062.9 709.8 831.1 859.8 902.3 984.3 17517.7 19012.7 19179.5 19298.2 19355.6 962.9 976.9 985.1 995.3 1017.2 10079.0 10689.1 10720.2 10723.7 10736.6 411070.0 417394.0 419884.0 421489.0 426524.0 88425.0 90137.1 91930.5 94015.5 95853.0 993.3 1023.2 1053.5 1056.3 1061.7 16449.8 16467.9 17019.0 17263.2 17453.9 41281.4 41754.0 43020.0 43070.6 43403.8 54485.0 57416.7 58266.7 60059.4 60690.0 8184.9 8285.5 8308.0 8494.2 8725.2 10668.4 11839.6 12758.6 13015.3 13320.3 11283.9 11364.4 11374.8 11572.7 11888.6 10740.7 10841.3 10937.0 10985.1 11029.9 10920.2 10990.1 11445.6 11456.7 11772.5 8351.0 8390.9 8637.7 8689.4 8752.9 10563.5 11000.1 11158.2 11238.8 11613.4 15:20:51 INFO - PROCESS | 27770 | 15:20:51 INFO - PROCESS | 27770 | [#3] mootools.html Cycles:180 Average:5424.83 Median:5104.23 stddev:2985.11 (58.5%) stddev-sans-first:2978.41 15:20:51 INFO - PROCESS | 27770 | Values: 1432.7 1467.0 1586.0 1709.6 1736.3 7062.8 7281.1 7742.2 8076.2 8076.4 7633.0 7878.4 7887.0 8020.2 8026.2 2222.4 2263.5 2271.0 2272.6 2276.7 2015.5 2077.7 2269.1 2305.6 2307.1 2187.6 2270.8 2272.4 2281.2 2291.5 2231.6 2233.8 2238.5 2283.3 2301.1 2270.1 2274.9 2297.9 2303.6 2313.0 7853.6 7913.1 7931.0 7936.3 7969.8 5090.2 5207.6 5224.9 5228.7 5240.1 3090.8 3171.1 3182.7 3235.8 3240.1 1028.9 1046.3 1051.9 1070.0 1090.0 11011.3 11061.4 11079.7 11084.9 11087.9 4294.4 4592.8 4603.3 4649.7 4656.7 9116.7 9140.1 9204.3 9215.3 9216.7 5097.5 5100.0 5102.2 5106.2 5114.9 4598.1 4659.8 4682.1 4725.2 4734.2 3597.0 3699.4 3776.2 3872.3 3916.9 1175.6 1198.1 1213.1 1244.9 1255.5 838.2 927.6 950.1 952.3 954.0 5545.1 5794.8 5834.9 5848.6 6084.8 905.1 905.9 949.2 967.8 997.9 3656.0 3873.1 3887.2 3939.4 4056.3 10231.9 10411.2 10479.7 10511.4 10544.2 9609.4 9968.7 9975.5 10281.5 10406.6 7417.8 7586.5 7591.5 7602.5 7621.8 5452.3 5519.6 5595.2 5626.6 5764.4 9468.5 9486.1 9500.6 9530.9 9615.1 9363.2 9376.2 9390.2 9410.3 9823.6 7261.7 7407.0 7415.0 7418.2 7432.4 7785.7 7807.5 7840.2 7900.7 7909.8 7009.7 7101.8 7142.1 7143.5 7182.0 6930.8 6963.3 6998.2 7061.3 7077.9 6534.5 6685.8 6690.7 6692.5 6723.6 4689.3 4737.5 4841.9 4965.9 4967.1 4804.7 4836.7 4854.6 4956.8 5033.0 15:20:51 INFO - PROCESS | 27770 | 15:20:51 INFO - PROCESS | 27770 | [#4] prototype.html Cycles:180 Average:4654.60 Median:5301.19 stddev:1354.49 (25.6%) stddev-sans-first:1318.70 15:20:51 INFO - PROCESS | 27770 | Values: 323.6 338.1 345.8 347.2 349.7 5219.3 5332.9 5349.0 5364.9 5417.9 5180.7 5232.1 5278.6 5279.1 5323.3 4176.8 4181.7 4226.6 4236.0 4253.6 3978.0 4038.6 4181.1 4230.5 4249.9 4061.5 4128.2 4161.7 4166.6 4175.1 4153.6 4164.5 4167.3 4171.4 4181.3 3695.1 3700.9 3716.3 3723.3 3724.8 4963.0 5040.0 5051.4 5069.4 5085.6 4741.9 4774.9 4791.3 4809.3 4832.8 5377.2 5530.7 5553.9 5557.9 5571.6 3968.7 4038.6 4045.5 4058.9 4069.9 5643.3 5657.0 5662.5 5671.1 5708.5 4153.0 4158.6 4165.2 4218.3 4226.9 3922.7 4092.2 4098.4 4123.4 4274.9 4633.6 4636.2 4688.7 4690.3 4706.3 5503.9 5522.2 5528.8 5537.5 5542.4 1358.5 1385.4 1389.8 1391.8 1392.6 949.3 965.8 973.9 974.3 975.5 5186.7 5237.5 5253.6 5264.9 5265.4 5527.4 5536.5 5553.0 5561.9 5574.8 5051.9 5126.3 5161.5 5177.7 5179.7 2886.0 2905.8 2909.7 2913.0 2914.2 5646.7 5676.6 5685.0 5687.4 5714.8 5405.0 5409.1 5518.0 5554.3 5579.5 5646.9 5657.3 5662.9 5673.3 5684.8 5435.4 5492.9 5539.6 5563.1 5597.9 5615.5 5625.9 5634.7 5662.9 5706.5 5834.1 5864.8 5884.4 5968.4 6005.5 3883.3 3890.8 4062.1 4086.4 4107.7 5491.9 5629.2 5756.7 5758.0 5761.3 5648.4 5656.3 5680.4 5685.4 5687.7 5392.3 5571.8 5590.2 5654.5 5655.7 5545.4 5550.8 5559.3 5587.0 5592.6 5584.2 5674.6 5680.4 5690.7 5726.9 5248.0 5405.9 5507.6 5509.5 5513.5 15:20:51 INFO - PROCESS | 27770 | 15:20:51 INFO - PROCESS | 27770 | [#5] yui.html Cycles:180 Average:18202.09 Median:25415.67 stddev:23742.26 (93.4%) stddev-sans-first:23772.53 15:20:51 INFO - PROCESS | 27770 | Values: 711.5 732.5 748.6 789.7 826.9 15383.7 16142.2 16172.5 16212.7 16259.8 14852.2 14923.3 15015.3 15035.6 15061.8 660.2 675.4 772.0 776.7 795.3 801.6 808.1 813.5 815.3 815.9 860.0 861.2 862.0 862.1 862.2 701.6 859.5 860.4 860.6 861.0 528.8 593.3 610.7 611.5 612.4 15012.5 15049.4 15054.7 15057.1 15065.2 13812.0 14156.0 14215.6 14322.6 14402.2 12072.6 12178.8 12293.8 12498.3 12653.0 4177.5 4221.5 4287.6 4293.2 4425.8 77964.0 79957.2 80938.6 81223.6 81596.2 10078.4 10444.3 11025.1 11080.8 11232.6 21138.9 21241.6 21248.2 21343.9 21495.8 8244.1 8321.8 8381.9 8409.5 8533.6 4449.7 4564.9 4565.7 4590.7 4752.9 3579.6 3703.2 3704.1 3714.7 3739.8 614.0 614.4 636.5 651.5 652.1 643.9 648.5 676.2 705.8 715.8 9707.5 9780.9 9993.9 10110.2 10282.4 654.3 660.5 672.4 710.4 724.0 4549.2 4666.3 4809.0 4882.8 4883.6 81561.6 81707.6 82255.6 84543.0 85292.6 69957.7 70704.3 71560.0 72601.3 74823.6 66140.7 67608.3 68614.0 68916.7 69424.0 8585.4 8593.4 8638.0 8659.8 8826.0 43323.6 44254.0 44798.6 45005.8 46165.0 58882.2 59577.0 61144.0 63387.4 65112.1 11985.3 12047.6 12190.6 12613.5 12914.4 14434.8 14500.4 15130.2 15816.9 15940.2 13607.1 13766.0 13825.4 13926.4 14134.0 12332.9 12738.6 12822.6 13446.1 13711.4 12527.4 12929.2 13139.7 13442.9 13527.3 10813.4 11172.5 11328.0 11332.5 12157.9 9491.3 10771.6 11617.2 11633.7 11775.2 15:20:51 INFO - PROCESS | 27770 | -------- Summary: end -------- 15:20:51 INFO - PROCESS | 27770 | 15:20:52 INFO - TEST-INFO | 27770: exit 0 15:20:52 INFO - TEST-OK | dromaeo_css | took 1118416ms 15:20:52 INFO - TEST-START | kraken 15:20:52 INFO - operating with platform_type : linux_ 15:20:52 INFO - Initialising browser for kraken test... 15:20:52 INFO - TEST-INFO | started process 28083 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4TSTsS/profile http://localhost:43416/getInfo.html) 15:20:55 INFO - PROCESS | 28083 | __metrics Screen width/height:1600/1200 15:20:55 INFO - PROCESS | 28083 | colorDepth:24 15:20:55 INFO - PROCESS | 28083 | Browser inner width/height: 1024/697 15:20:55 INFO - PROCESS | 28083 | __metrics 15:20:56 INFO - PROCESS | 28083 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:20:56 INFO - PROCESS | 28083 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:20:56 INFO - PROCESS | 28083 | console.error: PushService: 15:20:56 INFO - PROCESS | 28083 | stateChangeProcessEnqueue: Error transitioning state 15:20:56 INFO - PROCESS | 28083 | UnknownError 15:20:57 INFO - TEST-INFO | 28083: exit 0 15:20:57 INFO - Browser initialized. 15:20:57 INFO - Running cycle 1/1 for kraken test... 15:20:57 INFO - TEST-INFO | started process 28167 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4TSTsS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:21:09 INFO - PROCESS | 28167 | RSS: Main: 173449216 15:21:09 INFO - PROCESS | 28167 | 15:21:12 INFO - PROCESS | 28167 | Cycle 1(1): loaded http://localhost:43416/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43416/tests/kraken/driver.html?testName=audio-beat-detection) 15:21:13 INFO - PROCESS | 28167 | RSS: Main: 234840064 15:21:13 INFO - PROCESS | 28167 | 15:21:15 INFO - PROCESS | 28167 | Cycle 1(1): loaded http://localhost:43416/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43416/tests/kraken/driver.html?testName=audio-dft) 15:21:16 INFO - PROCESS | 28167 | RSS: Main: 217083904 15:21:16 INFO - PROCESS | 28167 | 15:21:19 INFO - PROCESS | 28167 | Cycle 1(1): loaded http://localhost:43416/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43416/tests/kraken/driver.html?testName=audio-fft) 15:21:20 INFO - PROCESS | 28167 | RSS: Main: 298156032 15:21:20 INFO - PROCESS | 28167 | 15:21:22 INFO - PROCESS | 28167 | Cycle 1(1): loaded http://localhost:43416/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43416/tests/kraken/driver.html?testName=audio-oscillator) 15:21:22 INFO - PROCESS | 28167 | RSS: Main: 209973248 15:21:22 INFO - PROCESS | 28167 | 15:21:24 INFO - PROCESS | 28167 | Cycle 1(1): loaded http://localhost:43416/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43416/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:21:25 INFO - PROCESS | 28167 | RSS: Main: 213897216 15:21:25 INFO - PROCESS | 28167 | 15:21:28 INFO - PROCESS | 28167 | Cycle 1(1): loaded http://localhost:43416/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43416/tests/kraken/driver.html?testName=imaging-darkroom) 15:21:29 INFO - PROCESS | 28167 | RSS: Main: 253091840 15:21:29 INFO - PROCESS | 28167 | 15:21:32 INFO - PROCESS | 28167 | Cycle 1(1): loaded http://localhost:43416/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43416/tests/kraken/driver.html?testName=imaging-desaturate) 15:21:33 INFO - PROCESS | 28167 | RSS: Main: 252547072 15:21:33 INFO - PROCESS | 28167 | 15:21:35 INFO - PROCESS | 28167 | Cycle 1(1): loaded http://localhost:43416/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43416/tests/kraken/driver.html?testName=json-parse-financial) 15:21:36 INFO - PROCESS | 28167 | RSS: Main: 251813888 15:21:36 INFO - PROCESS | 28167 | 15:21:37 INFO - PROCESS | 28167 | Cycle 1(1): loaded http://localhost:43416/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43416/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:21:38 INFO - PROCESS | 28167 | RSS: Main: 214585344 15:21:38 INFO - PROCESS | 28167 | 15:21:40 INFO - PROCESS | 28167 | Cycle 1(1): loaded http://localhost:43416/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43416/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:21:40 INFO - PROCESS | 28167 | RSS: Main: 220844032 15:21:40 INFO - PROCESS | 28167 | 15:21:42 INFO - PROCESS | 28167 | Cycle 1(1): loaded http://localhost:43416/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43416/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:21:43 INFO - PROCESS | 28167 | RSS: Main: 230395904 15:21:43 INFO - PROCESS | 28167 | 15:21:46 INFO - PROCESS | 28167 | Cycle 1(1): loaded http://localhost:43416/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43416/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:21:46 INFO - PROCESS | 28167 | RSS: Main: 239783936 15:21:46 INFO - PROCESS | 28167 | 15:21:49 INFO - PROCESS | 28167 | Cycle 1(1): loaded http://localhost:43416/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43416/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:21:50 INFO - PROCESS | 28167 | RSS: Main: 235880448 15:21:50 INFO - PROCESS | 28167 | 15:21:52 INFO - PROCESS | 28167 | Cycle 1(1): loaded http://localhost:43416/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43416/tests/kraken/driver.html?testName=ai-astar) 15:21:52 INFO - PROCESS | 28167 | RSS: Main: 287264768 15:21:52 INFO - PROCESS | 28167 | 15:21:52 INFO - PROCESS | 28167 | __start_tp_report 15:21:52 INFO - PROCESS | 28167 | _x_x_mozilla_page_load 15:21:52 INFO - PROCESS | 28167 | _x_x_mozilla_page_load_details 15:21:52 INFO - PROCESS | 28167 | |i|pagename|runs| 15:21:52 INFO - PROCESS | 28167 | |0;ai-astar;109;112;113;110;110;114;110;113;112;112 15:21:52 INFO - PROCESS | 28167 | |1;audio-beat-detection;159;124;123;165;128;123;130;124;146;123 15:21:52 INFO - PROCESS | 28167 | |2;audio-dft;162;160;159;162;161;161;162;161;160;160 15:21:52 INFO - PROCESS | 28167 | |3;audio-fft;76;76;75;114;77;75;75;75;95;75 15:21:52 INFO - PROCESS | 28167 | |4;audio-oscillator;81;82;104;83;83;83;100;82;81;109 15:21:52 INFO - PROCESS | 28167 | |5;imaging-gaussian-blur;117;118;117;118;117;118;117;117;117;117 15:21:52 INFO - PROCESS | 28167 | |6;imaging-darkroom;147;147;147;146;147;146;147;146;147;146 15:21:52 INFO - PROCESS | 28167 | |7;imaging-desaturate;96;96;96;96;96;96;96;95;95;95 15:21:52 INFO - PROCESS | 28167 | |8;json-parse-financial;54;53;52;51;52;52;52;52;52;52 15:21:52 INFO - PROCESS | 28167 | |9;json-stringify-tinderbox;62;62;62;61;63;62;62;64;62;64 15:21:52 INFO - PROCESS | 28167 | |10;stanford-crypto-aes;80;81;80;81;81;85;90;80;80;92 15:21:52 INFO - PROCESS | 28167 | |11;stanford-crypto-ccm;134;135;135;133;144;132;137;144;172;130 15:21:52 INFO - PROCESS | 28167 | |12;stanford-crypto-pbkdf2;170;172;173;169;171;169;172;173;172;171 15:21:52 INFO - PROCESS | 28167 | |13;stanford-crypto-sha256-iterative;67;66;68;67;66;70;70;66;66;65 15:21:52 INFO - PROCESS | 28167 | __end_tp_report 15:21:52 INFO - PROCESS | 28167 | __start_cc_report 15:21:52 INFO - PROCESS | 28167 | _x_x_mozilla_cycle_collect,1715 15:21:52 INFO - PROCESS | 28167 | __end_cc_report 15:21:52 INFO - PROCESS | 28167 | __startTimestamp1480461712334__endTimestamp 15:21:52 INFO - PROCESS | 28167 | 15:21:52 INFO - PROCESS | 28167 | ------- Summary: start ------- 15:21:52 INFO - PROCESS | 28167 | Number of tests: 14 15:21:52 INFO - PROCESS | 28167 | 15:21:52 INFO - PROCESS | 28167 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:1.65 (1.5%) stddev-sans-first:1.48 15:21:52 INFO - PROCESS | 28167 | Values: 109.0 112.0 113.0 110.0 110.0 114.0 110.0 113.0 112.0 112.0 15:21:52 INFO - PROCESS | 28167 | 15:21:52 INFO - PROCESS | 28167 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:129.00 stddev:16.13 (12.5%) stddev-sans-first:14.47 15:21:52 INFO - PROCESS | 28167 | Values: 159.0 124.0 123.0 165.0 128.0 123.0 130.0 124.0 146.0 123.0 15:21:52 INFO - PROCESS | 28167 | 15:21:52 INFO - PROCESS | 28167 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:1.00 15:21:52 INFO - PROCESS | 28167 | Values: 162.0 160.0 159.0 162.0 161.0 161.0 162.0 161.0 160.0 160.0 15:21:52 INFO - PROCESS | 28167 | 15:21:52 INFO - PROCESS | 28167 | [#3] audio-fft Cycles:10 Average:81.30 Median:75.50 stddev:13.04 (17.3%) stddev-sans-first:13.69 15:21:52 INFO - PROCESS | 28167 | Values: 76.0 76.0 75.0 114.0 77.0 75.0 75.0 75.0 95.0 75.0 15:21:52 INFO - PROCESS | 28167 | 15:21:52 INFO - PROCESS | 28167 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:82.00 stddev:10.95 (13.4%) stddev-sans-first:11.25 15:21:52 INFO - PROCESS | 28167 | Values: 81.0 82.0 104.0 83.0 83.0 83.0 100.0 82.0 81.0 109.0 15:21:52 INFO - PROCESS | 28167 | 15:21:52 INFO - PROCESS | 28167 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 15:21:52 INFO - PROCESS | 28167 | Values: 117.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 15:21:52 INFO - PROCESS | 28167 | 15:21:52 INFO - PROCESS | 28167 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 15:21:52 INFO - PROCESS | 28167 | Values: 147.0 147.0 147.0 146.0 147.0 146.0 147.0 146.0 147.0 146.0 15:21:52 INFO - PROCESS | 28167 | 15:21:52 INFO - PROCESS | 28167 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 15:21:52 INFO - PROCESS | 28167 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 15:21:52 INFO - PROCESS | 28167 | 15:21:52 INFO - PROCESS | 28167 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.00 stddev:0.79 (1.5%) stddev-sans-first:0.50 15:21:52 INFO - PROCESS | 28167 | Values: 54.0 53.0 52.0 51.0 52.0 52.0 52.0 52.0 52.0 52.0 15:21:52 INFO - PROCESS | 28167 | 15:21:52 INFO - PROCESS | 28167 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.00 stddev:0.97 (1.6%) stddev-sans-first:1.01 15:21:52 INFO - PROCESS | 28167 | Values: 62.0 62.0 62.0 61.0 63.0 62.0 62.0 64.0 62.0 64.0 15:21:52 INFO - PROCESS | 28167 | 15:21:52 INFO - PROCESS | 28167 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:81.00 stddev:4.50 (5.6%) stddev-sans-first:4.64 15:21:52 INFO - PROCESS | 28167 | Values: 80.0 81.0 80.0 81.0 81.0 85.0 90.0 80.0 80.0 92.0 15:21:52 INFO - PROCESS | 28167 | 15:21:52 INFO - PROCESS | 28167 | [#11] stanford-crypto-ccm Cycles:10 Average:139.60 Median:136.00 stddev:12.30 (9.0%) stddev-sans-first:12.88 15:21:52 INFO - PROCESS | 28167 | Values: 134.0 135.0 135.0 133.0 144.0 132.0 137.0 144.0 172.0 130.0 15:21:52 INFO - PROCESS | 28167 | 15:21:52 INFO - PROCESS | 28167 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.20 Median:172.00 stddev:1.48 (0.9%) stddev-sans-first:1.50 15:21:52 INFO - PROCESS | 28167 | Values: 170.0 172.0 173.0 169.0 171.0 169.0 172.0 173.0 172.0 171.0 15:21:52 INFO - PROCESS | 28167 | 15:21:52 INFO - PROCESS | 28167 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.73 (2.6%) stddev-sans-first:1.83 15:21:52 INFO - PROCESS | 28167 | Values: 67.0 66.0 68.0 67.0 66.0 70.0 70.0 66.0 66.0 65.0 15:21:52 INFO - PROCESS | 28167 | -------- Summary: end -------- 15:21:52 INFO - PROCESS | 28167 | 15:21:53 INFO - TEST-INFO | 28167: exit 0 15:21:53 INFO - TEST-OK | kraken | took 61538ms 15:21:53 INFO - SUITE-END | took 1179s 15:21:53 INFO - Completed test suite (00:19:40) 15:21:53 INFO - javascript benchmark 15:21:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3119.189010857177, 3148.2601588626667, 3153.3535625196837, 3169.0809665197066, 3202.775805693601, 5317.2821669074665, 5403.540699040582, 5412.512873841353, 5439.292891924049, 5484.780608775649, 5367.892642147155, 5434.592405569579, 5443.891122177564, 5445.128779395298, 5535.640183388077, 4892.975535122319, 4908.067467181224, 4950.851474455772, 4961.5286547777905, 5003.674761140514, 4951.356323677935, 5061.215511595708, 5082.491750824925, 5087.56755675768, 5131.666441681297, 4898.510148985109, 4930.4330002049865, 5000.124978128849, 5041.092603331399, 5054.064997975386, 4916.0, 4993.051320249141, 4993.925091123636, 4997.425296090923, 5053.898922021575, 4942.332785074005, 4949.133901567211, 4950.331705219785, 4957.405111386656, 4970.403551573834, 5440.782368705247, 5458.444343362123, 5459.727013649302, 5467.0, 5471.480209380103, 5743.712814359307, 5768.307803063617, 5781.364049954502, 5817.127430885359, 5824.737886795105, 5883.911741323841, 5892.793752218652, 5915.0, 5920.259967504062, 5968.373320801296, 5488.9725551371985, 5493.725313734298, 5494.780208791603, 5495.780168793283, 5497.065498865162, 5841.824745257649, 5850.64896106235, 5901.822945311647, 5988.640681559121, 5991.400859914061, 5632.690202038845, 5668.716564171775, 5673.461021202979, 5701.0308247598, 5703.17303990919, 5771.624844385102, 5772.191893134965, 5773.047447171254, 5774.971125144348, 5775.797847075332, 5642.7178641067785, 5774.595778295563, 5775.27809023872, 5783.652980821164, 5784.566157538202, 5753.510951569164, 5781.6241944274325, 5843.0, 5848.444397782204, 5922.200502932049, 4506.076254367912, 4508.301213311942, 4538.659600529973, 4545.022820093695, 4554.795034223468, 4032.2540330039037, 4045.2516284487465, 4046.919061618751, 4047.9392809107885, 4080.0411903202726, 5356.0, 5369.5167434931045, 5413.215083812904, 5512.3385193777, 5533.170024496358, 5797.333306669702, 5811.79658711943, 5816.243888294494, 5820.796272130455, 5820.88358232833, 5381.13901775714, 5410.864728381744, 5436.728163591804, 5437.564994800407, 5441.5102640762525, 5007.324011258506, 5019.447860735316, 5020.196768517019, 5020.548150666385, 5020.673656212334, 6001.279846418458, 6001.399860013964, 6005.309389420097, 6007.969960150172, 6011.969940150271, 5821.970890145522, 5847.298324201123, 5851.502622276984, 5854.560907931837, 5856.0630299151935, 6028.487578555696, 6031.185789918481, 6034.306054803754, 6036.758529658764, 6036.909446358396, 5801.448862358069, 5802.158686990447, 5802.767889284381, 5805.883882322414, 5808.593398462236, 5673.177389278449, 5923.170756094237, 5929.673867937305, 5929.792457263975, 5939.346671866005, 5596.552275817843, 5679.9432005681065, 5683.5737319700365, 5686.800961966312, 5686.943130568807, 5520.365158006881, 5647.943520564741, 5655.858603534944, 5657.575681823797, 5657.943420565742, 5575.888482230252, 5592.720363981866, 5623.100303951348, 5630.465105814941, 5709.115087161496, 5687.488126068508, 5691.544676425959, 5697.259356283656, 5699.316082070012, 5726.112452569859, 5577.470140336662, 5592.944070559242, 5596.048671725735, 5601.6358936668985, 5602.85992850182], "value": 5372.996097532515, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.5681053993695, 592.869568694887, 594.2898236607255, 605.1709158452917, 616.5375968023982, 31763.205919851986, 34129.31741365174, 34228.14429639257, 40702.0, 42239.788801055955, 42018.57981420185, 42485.0, 42504.14991700164, 42544.361834572504, 42574.57425425745, 8500.10748871369, 8630.741077767645, 8630.827383452328, 8654.134586541359, 8657.26413254874, 7809.453338266324, 7978.042634883822, 8535.658573657078, 9974.152197063258, 10245.743856403575, 10242.539085741122, 10343.172546196287, 10343.896561034406, 10351.068403843652, 10352.0, 10004.399736015826, 10007.099361057468, 10012.94993525035, 10018.549165287506, 10053.296269261118, 10133.797324053477, 10205.948970255175, 10210.540525676288, 10211.897881021168, 10212.897871021269, 39984.0, 40264.194716105805, 40266.59733402687, 40267.0, 40277.0, 3328.8994504974594, 3425.811580363079, 3453.5165076889257, 3717.7211709121925, 3850.961490385116, 30489.69510304913, 31113.688863111307, 31160.688393116005, 31332.06003819889, 31946.201344966328, 4063.2686116499017, 4156.750594964312, 4234.5765423457715, 4256.680748943811, 4267.445232119836, 322697.0, 324647.0, 325182.0, 325739.0, 326443.0, 55661.443385565624, 55673.72163139239, 56137.98275215598, 56164.43835561674, 56226.43773562212, 60071.69964150151, 60195.0, 60229.39770602326, 60288.397116029155, 60302.0, 15961.760573591406, 16195.595110122105, 16395.508134755975, 16400.425985090464, 16415.179241037902, 11979.580714674945, 12370.257784532776, 12431.813522797165, 12453.564125255754, 12459.127861049821, 14800.777988330183, 16617.252223649724, 16893.493195204162, 16894.493165204818, 17379.4786156413, 5569.387367389584, 5623.718814059281, 5652.943470565242, 5699.886002279931, 5726.484616384545, 951.6383774165772, 1018.4144117132678, 1062.9165198664202, 1078.0085263393987, 1096.1833434091493, 29795.40409191804, 30114.481598861756, 30187.396252075276, 30223.69776302209, 30486.237844053634, 1041.2763129624989, 1052.1898138433364, 1091.3942761767296, 1121.0863146535548, 1181.9067362689477, 15413.768793468107, 16317.755233671505, 16359.591010224602, 16401.902911653993, 16489.422870199487, 154092.0, 154356.0, 155002.0, 155087.0, 155433.2228338851, 54815.45184548183, 54844.0, 54877.72561137249, 54879.0, 54944.45055549393, 1238.962831115068, 1270.1236147058685, 1276.0620943606257, 1333.646583655332, 1359.4766015084265, 28480.287992800346, 31839.204019899687, 31848.203794905312, 32347.67652323541, 32753.672463276016, 47323.05353892834, 47885.28172077491, 47932.5206747942, 48016.75991620019, 48064.0, 332115.0, 334476.0, 334643.0, 335392.0, 335593.0, 26739.86630066837, 27456.45087098207, 27560.310992225353, 29036.7096329034, 38781.98879173733, 44351.0, 45086.32370514379, 45092.77453612711, 46204.53795462002, 46340.0, 37854.242915142095, 38518.80740596391, 38785.418218726176, 38805.2238955225, 39538.40692389674, 38161.6183838158, 38475.807620961714, 38695.22609547737, 39165.608343916196, 40212.798936005136, 39234.0, 39360.40959385554, 39550.20899581935, 40604.59395406126, 40740.0, 32147.0, 34302.656973430945, 34407.655923441445, 34473.23039305852, 35130.12174695653, 24947.251582452554, 25341.61987570151, 25431.36421589401, 27207.183784486497, 27933.580996284665], "value": 18732.675462314408, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.9571099323577, 375.41810194198985, 405.4931335830212, 408.4506338974079, 416.7707760731597, 13156.736865262688, 15282.923585382072, 16716.498505044838, 19144.808551914477, 19210.0, 18372.26510939564, 18735.3442629508, 19223.61552768944, 19249.807501924977, 19258.22967081315, 5497.670139791615, 5507.752151153188, 5728.713564321788, 5729.05470597353, 5732.7133643317875, 5188.6367954243215, 5638.464345887134, 5642.943570564283, 5658.8019419320335, 5659.943400566003, 5428.5385742211765, 5617.466340697627, 5623.353314368838, 5624.887502249952, 5625.324961004685, 5558.471945165203, 5584.748686309105, 5622.8313150605545, 5626.409227031144, 5628.015097357967, 4828.372311599504, 4910.312556242129, 5051.722155281458, 5051.898962020739, 5060.822871199527, 22669.659955100688, 22798.202062927718, 22809.543809123723, 22977.0, 23047.23433188028, 2265.2184996176293, 2407.7110746710505, 2429.757024297574, 2484.9378765530823, 2988.4770165221, 13845.0, 14004.789928151085, 14149.787753183711, 14262.64343391413, 14451.349689263903, 1880.9435716928515, 1909.255390397746, 1912.80871912809, 1939.5151212196952, 2015.6472617291915, 82738.58630706868, 85184.0, 85664.57167714121, 85953.57023214844, 87129.0, 10831.783364332827, 11056.447177641086, 11141.331520108657, 11374.772504550028, 11658.825117623242, 15573.299201535958, 15581.298841552158, 15597.688046239238, 15600.843991560167, 15610.9219453902, 8006.1993800619475, 8180.100188979208, 8395.412321137585, 8503.574821258911, 8532.189442003, 7885.29032387088, 8053.959730201312, 8065.435419520694, 8146.837063258702, 8156.898818659405, 4685.648576356787, 4751.714897106115, 4795.95204047955, 4911.484294149134, 4920.384951881015, 1942.2522328903192, 1994.5312851479891, 2043.8058384453452, 2049.7540295164376, 2062.9484262893548, 709.824238609407, 831.1148626712531, 859.7979474823411, 902.3412908576776, 984.2667212926273, 17517.7372339415, 19012.714809277873, 19179.520511987033, 19298.22807087729, 19355.612887742165, 962.9133377996014, 976.8827740671023, 985.0887928665956, 995.318207028188, 1017.2097109088058, 10079.0, 10689.144868410509, 10720.249582529148, 10723.678289651323, 10736.570537178426, 411070.0, 417394.0, 419884.0, 421489.0, 426524.0, 88425.0, 90137.09862901419, 91930.54034729784, 94015.52992234995, 95853.0, 993.279872092727, 1023.1507848485887, 1053.5153829238636, 1056.2817284246632, 1061.7186445591924, 16449.753253700965, 16467.876865057355, 17019.0, 17263.22315495831, 17453.912730436776, 41281.380779287734, 41754.0, 43020.0, 43070.56929430665, 43403.78298108489, 54485.0, 57416.71291643515, 58266.7086664564, 60059.39940600538, 60690.0, 8184.8772268417215, 8285.54429506383, 8308.0, 8494.193051660082, 8725.171108744658, 10668.35989840581, 11839.572887557857, 12758.61724148277, 13015.284159371326, 13320.333983300603, 11283.887161128283, 11364.431778411212, 11374.772504550028, 11572.727000029821, 11888.643340699793, 10740.73148171302, 10841.295315804447, 10937.0, 10985.121190304597, 11029.889701102886, 10920.18098642589, 10990.065844403316, 11445.599404020819, 11456.713582160513, 11772.529098836294, 8351.0, 8390.874136887829, 8637.654493820428, 8689.391742578211, 8752.91247087521, 10563.471826408495, 11000.119990400908, 11158.218924675519, 11238.831417528907, 11613.3612651305], "value": 9127.273323732523, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1432.7421064208438, 1467.0, 1585.952421427357, 1709.5555155659524, 1736.2707662781622, 7062.823429414268, 7281.1262648482125, 7742.187070357616, 8076.1923807619205, 8076.3538916886655, 7633.0458692663415, 7878.40911931606, 7886.960565197181, 8020.197980201977, 8026.197380261986, 2222.355516900101, 2263.513344630904, 2271.0461606125386, 2272.6363781794917, 2276.681264622954, 2015.4659015360942, 2077.6883467479925, 2269.1377276634857, 2305.596520608895, 2307.1348244408346, 2187.562487502498, 2270.795628393444, 2272.4091736148557, 2281.2471884278148, 2291.541691661666, 2231.553689262154, 2233.7877901599322, 2238.46276893546, 2283.3264187064774, 2301.0680674326923, 2270.126001489422, 2274.9203777867697, 2297.8965946532444, 2303.585354636165, 2313.016967788683, 7853.646585903648, 7913.050433947906, 7930.960345198295, 7936.325412339958, 7969.760907172737, 5090.160123579605, 5207.583393328525, 5224.8693782655355, 5228.686278823245, 5240.135377662681, 3090.752739780812, 3171.0645359618966, 3182.745380369565, 3235.773495855291, 3240.0603824890754, 1028.9073983341534, 1046.26238501856, 1051.8692405663942, 1069.9893001070045, 1090.0353187429102, 11011.28426652273, 11061.446927653586, 11079.72300692489, 11084.889151108466, 11087.944560277147, 4294.3558466230315, 4592.7933243004145, 4603.263477843529, 4649.674522783373, 4656.674032817738, 9116.726498205064, 9140.131687489678, 9204.309676774135, 9215.308851836138, 9216.677416290531, 5097.46476619957, 5100.0, 5102.2346648003095, 5106.234064890222, 5114.897702045938, 4598.057398233354, 4659.836905708352, 4682.063587282489, 4725.220338644154, 4734.218853889139, 3596.964030359663, 3699.445083237482, 3776.169242766587, 3872.302985462644, 3916.941245881314, 1175.61204802415, 1198.1193822540426, 1213.1386715431966, 1244.9190802597802, 1255.4727014653868, 838.1576515601903, 927.6011315134422, 950.12588418655, 952.2953014769021, 953.9523023848918, 5545.114661015194, 5794.826155215266, 5834.8541286467325, 5848.56083842031, 6084.756609735649, 905.1401168889581, 905.8686490458847, 949.2453499467939, 967.811276801017, 997.9002099789963, 3655.9817200913826, 3873.1479074603544, 3887.2419878123496, 3939.350007248772, 4056.290149223874, 10231.897681023094, 10411.219158563137, 10479.68560943173, 10511.421871797125, 10544.209184311054, 9609.37539059973, 9968.651097211563, 9975.501224938724, 10281.485925703684, 10406.5837366506, 7417.8145546361775, 7586.544807311579, 7591.4685971981435, 7602.46782725204, 7621.771346859603, 5452.263944367618, 5519.586031047607, 5595.160725891149, 5626.606137570331, 5764.423557644202, 9468.526573671426, 9486.098820612031, 9500.572474238537, 9530.904690953003, 9615.086566776145, 9363.204127649225, 9376.203022743142, 9390.24878009744, 9410.294227932796, 9823.557939892866, 7261.709531618676, 7406.962965185139, 7414.962925185339, 7418.18399976013, 7432.405407567489, 7785.727499537489, 7807.531548107132, 7840.215978402114, 7900.68397264103, 7909.841803164019, 7009.684564194521, 7101.751438699621, 7142.142942846684, 7143.4999550031, 7181.964090179516, 6930.792076237721, 6963.303669633199, 6998.16022077354, 7061.329173728487, 7077.929220707727, 6534.542582019403, 6685.76599819004, 6690.698918548775, 6692.464602831665, 6723.562968407038, 4689.296605509201, 4737.526247375235, 4841.927371089507, 4965.851024469272, 4967.105920934122, 4804.6876952997945, 4836.685615434985, 4854.611631069577, 4956.752162391938, 5033.043721692867], "value": 4396.241712114723, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.5546850622386, 338.09390832568715, 345.78906866811246, 347.1650680114324, 349.6870301080535, 5219.269302297681, 5332.946670533293, 5349.0, 5364.900195459931, 5417.864553386167, 5180.740962951856, 5232.110541207994, 5278.577713782898, 5279.102552566063, 5323.281357016802, 4176.832926682944, 4181.665466762667, 4226.640735537483, 4235.957640423602, 4253.595908388698, 3977.9801100994455, 4038.5961403859674, 4181.142865712522, 4230.455883602478, 4249.851255206068, 4061.451704019949, 4128.153728485669, 4161.687873409492, 4166.604172603597, 4175.102352994121, 4153.646940010072, 4164.4586203793315, 4167.312393455076, 4171.395147703581, 4181.268278051344, 3695.133957351547, 3700.870469533553, 3716.312482190803, 3723.2739615774935, 3724.832382542792, 4963.0, 5039.974800126012, 5051.419086805027, 5069.417017043051, 5085.593152547787, 4741.905161896777, 4774.8540350316025, 4791.329213910055, 4809.302651115569, 4832.806687732486, 5377.166539186433, 5530.695811730353, 5553.916691249635, 5557.861053473655, 5571.554275657938, 3968.6626636735914, 4038.6365227129404, 4045.4740883685226, 4058.8782336529953, 4069.857554985591, 5643.266375371217, 5656.971715141439, 5662.471132794122, 5671.120976248647, 5708.543316534668, 4153.0447996960265, 4158.606866699629, 4165.16696660663, 4218.325067989107, 4226.852060177879, 3922.7057970652313, 4092.1815636872743, 4098.401623366889, 4123.36087906375, 4274.893127671833, 4633.606143477842, 4636.165490211794, 4688.718676879398, 4690.288044863601, 4706.3411122442885, 5503.862403439946, 5522.22688823565, 5528.75120619573, 5537.501624853782, 5542.445755424506, 1358.4634069542476, 1385.3627331427454, 1389.7915312702974, 1391.7703578909366, 1392.644875556747, 949.3259785552335, 965.8406362950175, 973.9026097390346, 974.2949837783879, 975.5463709375175, 5186.688798672017, 5237.528622424, 5253.632245742838, 5264.92102618461, 5265.446693225507, 5527.429745168516, 5536.511997441586, 5553.0, 5561.860953476114, 5574.777008919679, 5051.933193779043, 5126.282320475062, 5161.535461808456, 5177.689338639619, 5179.663321884065, 2886.0, 2905.7965942384253, 2909.723576260252, 2912.9854350728533, 2914.184028472031, 5646.661200327993, 5676.631018983753, 5685.005124103348, 5687.43125687428, 5714.7999820006935, 5405.0, 5409.053415652245, 5518.0, 5554.333479982428, 5579.525740312038, 5646.887062258732, 5657.264555607745, 5662.85842853932, 5673.347565030074, 5684.811347631109, 5435.396558015474, 5492.917606235989, 5539.58453116026, 5563.078029988929, 5597.888042239214, 5615.466530679579, 5625.943740562542, 5634.7464364104535, 5662.85842853932, 5706.457886500776, 5834.095715164156, 5864.794732184353, 5884.411558844253, 5968.373320801427, 6005.459508644243, 3883.2815929053218, 3890.8443662253194, 4062.1469491407133, 4086.40747091676, 4107.671386289149, 5491.917621235764, 5629.211910332475, 5756.683382414008, 5757.955925646503, 5761.329214527907, 5648.350439699487, 5656.264685590847, 5680.375158732453, 5685.403032681675, 5687.715614219355, 5392.272043274108, 5571.804986825442, 5590.2453168821685, 5654.491095801398, 5655.660660360391, 5545.445455454423, 5550.8057217997175, 5559.305086864142, 5586.988684073649, 5592.636478628876, 5584.190292407659, 5674.638086859041, 5680.403557626555, 5690.687012214203, 5726.885462290647, 5247.9766445542755, 5405.864853378697, 5507.586930980113, 5509.47659972302, 5513.476219759116], "value": 4225.145696825468, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.477064357697, 732.476279460186, 748.6481353763733, 789.6999140326675, 826.8635675113607, 15383.692326153485, 16142.192890355494, 16172.514824555268, 16212.675746485063, 16259.83740162598, 14852.18312992785, 14923.328450219738, 15015.324310406031, 15035.624109397271, 15061.774073388908, 660.1978596005852, 675.4427597232303, 771.9922800771976, 776.735909790671, 795.2683531151325, 801.5591424716412, 808.107041718901, 813.515958004986, 815.2581151152452, 815.8572249856281, 860.0496451421184, 861.2421069458899, 861.9827603447927, 862.0948004595182, 862.1723145780028, 701.554512884317, 859.4671303791627, 860.371928492198, 860.5568132411813, 860.995695021524, 528.7699850564978, 593.2643522032648, 610.7221214347461, 611.541343992006, 612.3814946903615, 15012.549623511311, 15049.398024079024, 15054.698906021928, 15057.096574205583, 15065.246737663074, 13812.0, 14156.0, 14215.573532794033, 14322.641933951734, 14402.207878566674, 12072.637820865388, 12178.78927980195, 12293.754124917541, 12498.25010499373, 12653.0, 4177.49870015597, 4221.493420789525, 4287.592678695519, 4293.162833247518, 4425.7565833879125, 77963.99999999943, 79957.20042799614, 80938.59530702367, 81223.59388203021, 81596.18403815945, 10078.377408160859, 10444.27897741375, 11025.117990560735, 11080.778384432266, 11232.606858759904, 21138.89430552868, 21241.575168496543, 21248.150073997178, 21343.8932805335, 21495.78504214969, 8244.093149753522, 8321.833563328699, 8381.916180838114, 8409.453385529921, 8533.615987280587, 4449.688521803443, 4564.908701826012, 4565.703229290086, 4590.655700822452, 4752.904941901212, 3579.6241394653707, 3703.166787472797, 3704.129529560551, 3714.684251838624, 3739.775613463201, 613.9539534534928, 614.388683260159, 636.5194278319839, 651.4592887903029, 652.1163823019834, 643.8615697624939, 648.4585371214994, 676.2155899156954, 705.7812078255655, 715.7673756029311, 9707.46608936501, 9780.853287200698, 9993.900060999442, 10110.162049972025, 10282.434466104436, 654.326044174501, 660.4716227018462, 672.4217173231017, 710.3855165282097, 723.960182189974, 4549.203889319356, 4666.346711460398, 4809.031231350665, 4882.804687812519, 4883.609311255091, 81561.59219203866, 81707.59146204231, 82255.58872205601, 84543.0, 85292.57353713315, 69957.65021174963, 70704.2929570708, 71560.0, 72601.2739872605, 74823.62588187132, 66140.66929665417, 67608.3239167602, 68614.0, 68916.6554167226, 69424.0, 8585.399022068395, 8593.355498337774, 8637.956810215908, 8659.826803464022, 8825.955870220609, 43323.56676433321, 44254.0, 44798.552014480745, 45005.774971124934, 46165.0, 58882.22355528997, 59577.0, 61144.0, 63387.366126338144, 65112.069956853, 11985.28088314704, 12047.638570842888, 12190.57332993341, 12613.49546018149, 12914.354282286036, 14434.783478248044, 14500.419983200554, 15130.243487825785, 15816.920915395349, 15940.211766579021, 13607.115537490032, 13766.0, 13825.446982120602, 13926.373313201133, 14134.0, 12332.876671233173, 12738.554150604685, 12822.551210707581, 13446.126001809851, 13711.382987765375, 12527.37363131858, 12929.224246545238, 13139.73720525565, 13442.93278533601, 13527.323633818072, 10813.351198928089, 11172.49723762449, 11328.0, 11332.490037948477, 12157.878421215675, 9491.288153388661, 10771.569137234736, 11617.186796924472, 11633.6509904703, 11775.23460975034], "value": 7269.387369862927, "unit": "score"}], "name": "dromaeo_css", "value": 7062.152041288274, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 113.0, 110.0, 110.0, 114.0, 110.0, 113.0, 112.0, 112.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 124.0, 123.0, 165.0, 128.0, 123.0, 130.0, 124.0, 146.0, 123.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 159.0, 162.0, 161.0, 161.0, 162.0, 161.0, 160.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 114.0, 77.0, 75.0, 75.0, 75.0, 95.0, 75.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 104.0, 83.0, 83.0, 83.0, 100.0, 82.0, 81.0, 109.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 51.0, 52.0, 52.0, 52.0, 52.0, 52.0, 52.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 63.0, 62.0, 62.0, 64.0, 62.0, 64.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 80.0, 81.0, 81.0, 85.0, 90.0, 80.0, 80.0, 92.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 135.0, 133.0, 144.0, 132.0, 137.0, 144.0, 172.0, 130.0], "value": 139.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 172.0, 173.0, 169.0, 171.0, 169.0, 172.0, 173.0, 172.0, 171.0], "value": 171.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 67.0, 66.0, 70.0, 70.0, 66.0, 66.0, 65.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1512.0, "alertThreshold": 2.0}]} 15:21:54 INFO - Return code: 0 15:21:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:21:54 INFO - # TBPL SUCCESS # 15:21:54 INFO - Running post-action listener: _resource_record_post_action 15:21:54 INFO - [mozharness: 2016-11-29 23:21:54.147572Z] Finished run-tests step (success) 15:21:54 INFO - Running post-run listener: _resource_record_post_run 15:21:54 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 394080256; Read time: 0; Write time: 315756 15:21:54 INFO - TinderboxPrint: CPU usage
13.1% 15:21:54 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 15:21:54 INFO - TinderboxPrint: I/O write bytes / time
394,080,256 / 315,756 15:21:54 INFO - TinderboxPrint: CPU idle
8,305.1 (86.9%) 15:21:54 INFO - TinderboxPrint: CPU user
1,204.6 (12.6%) 15:21:54 INFO - TinderboxPrint: Swap in / out
0 / 0 15:21:54 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103936000; Read time: 0; Write time: 96316 15:21:54 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 290144256; Read time: 0; Write time: 219440 15:21:54 INFO - Running post-run listener: _upload_blobber_files 15:21:54 INFO - Blob upload gear active. 15:21:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:21:54 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:21:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:21:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:21:55 INFO - (blobuploader) - INFO - Open directory for files ... 15:21:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:21:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:21:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:21:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:21:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:21:55 INFO - (blobuploader) - INFO - Done attempting. 15:21:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:21:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:21:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:21:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:21:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:21:56 INFO - (blobuploader) - INFO - Done attempting. 15:21:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:21:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:21:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:22:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:00 INFO - (blobuploader) - INFO - Done attempting. 15:22:00 INFO - (blobuploader) - INFO - Iteration through files over. 15:22:00 INFO - Return code: 0 15:22:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:22:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:22:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9697ee867e4b34522b7a12ee012eb2c86d24da18cbe5ebcfe926bdebb1f1cf1f2256fdd04acdf8f6f2e0bca4575faac34aeb77d5858986a6d24ce07396547edf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4bb67067357809fd2a101f03fadb93b405efcb5e07f2758d35eed7d03b17e052915c73ddf8f14952c7921812113fb5ed21e3882f9efeba1bbb7bc0add51899ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2f54841794708b98b27caf0b02c606075677d60be93fe7b3c1ba9fc85950d8fc38fe26de56d47beb4b4e7f2eb34e61473c183ee29996f67bba4b6eb05d6690a1"} 15:22:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:22:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:22:00 INFO - Contents: 15:22:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9697ee867e4b34522b7a12ee012eb2c86d24da18cbe5ebcfe926bdebb1f1cf1f2256fdd04acdf8f6f2e0bca4575faac34aeb77d5858986a6d24ce07396547edf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4bb67067357809fd2a101f03fadb93b405efcb5e07f2758d35eed7d03b17e052915c73ddf8f14952c7921812113fb5ed21e3882f9efeba1bbb7bc0add51899ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2f54841794708b98b27caf0b02c606075677d60be93fe7b3c1ba9fc85950d8fc38fe26de56d47beb4b4e7f2eb34e61473c183ee29996f67bba4b6eb05d6690a1"} 15:22:00 INFO - Running post-run listener: copy_logs_to_upload_dir 15:22:00 INFO - Copying logs to upload dir... 15:22:00 INFO - mkdir: /builds/slave/test/build/upload/logs 15:22:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.256843 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-11-29 15:22:00.455096) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 15:22:00.458479) ========= 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=62c568580acbfdaac3eec7be000001dc-1480460480.225962-1051720692 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/9697ee867e4b34522b7a12ee012eb2c86d24da18cbe5ebcfe926bdebb1f1cf1f2256fdd04acdf8f6f2e0bca4575faac34aeb77d5858986a6d24ce07396547edf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4bb67067357809fd2a101f03fadb93b405efcb5e07f2758d35eed7d03b17e052915c73ddf8f14952c7921812113fb5ed21e3882f9efeba1bbb7bc0add51899ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2f54841794708b98b27caf0b02c606075677d60be93fe7b3c1ba9fc85950d8fc38fe26de56d47beb4b4e7f2eb34e61473c183ee29996f67bba4b6eb05d6690a1"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011836 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480450312/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9697ee867e4b34522b7a12ee012eb2c86d24da18cbe5ebcfe926bdebb1f1cf1f2256fdd04acdf8f6f2e0bca4575faac34aeb77d5858986a6d24ce07396547edf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4bb67067357809fd2a101f03fadb93b405efcb5e07f2758d35eed7d03b17e052915c73ddf8f14952c7921812113fb5ed21e3882f9efeba1bbb7bc0add51899ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2f54841794708b98b27caf0b02c606075677d60be93fe7b3c1ba9fc85950d8fc38fe26de56d47beb4b4e7f2eb34e61473c183ee29996f67bba4b6eb05d6690a1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 15:22:00.485356) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 15:22:00.485749) ========= 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=62c568580acbfdaac3eec7be000001dc-1480460480.225962-1051720692 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004411 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 15:22:00.568202) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 15:22:00.568603) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 15:22:00.569009) ========= ========= Total master_lag: 0.18 =========