builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1479502440.55 results: success (0) buildid: 20161118124043 builduid: a9b6e6f4e60c4e66bc1442bca2e0e95e revision: a40cac8610de8543bf21eecaa91dacf3ed1b73e7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 12:54:00.545643) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 12:54:00.546080) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 12:54:00.546356) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 12:54:00.560949) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 12:54:00.561279) ========= 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=00204705a9daa57ed339a427000001b9-1479502439.783156-585782061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-18 12:54:00-- 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% 21.4M=0.001s 2016-11-18 12:54:00 (21.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114333 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 12:54:00.690833) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 12:54:00.691206) ========= 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=00204705a9daa57ed339a427000001b9-1479502439.783156-585782061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016846 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 12:54:00.741546) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-18 12:54:00.741915) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev a40cac8610de8543bf21eecaa91dacf3ed1b73e7 --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 a40cac8610de8543bf21eecaa91dacf3ed1b73e7 --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=00204705a9daa57ed339a427000001b9-1479502439.783156-585782061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-18 12:54:00,778 truncating revision to first 12 chars 2016-11-18 12:54:00,778 Setting DEBUG logging. 2016-11-18 12:54:00,778 attempt 1/10 2016-11-18 12:54:00,778 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/a40cac8610de?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-18 12:54:01,990 unpacking tar archive at: mozilla-inbound-a40cac8610de/testing/mozharness/ program finished with exit code 0 elapsedTime=1.537760 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-18 12:54:02.293027) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 12:54:02.293342) ========= script_repo_revision: a40cac8610de8543bf21eecaa91dacf3ed1b73e7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 12:54:02.293733) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 12:54:02.293997) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 12:54:02.302249) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-11-18 12:54:02.302522) ========= /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=00204705a9daa57ed339a427000001b9-1479502439.783156-585782061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:54:02 INFO - MultiFileLogger online at 20161118 12:54:02 in /builds/slave/test 12:54:02 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 12:54:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:54:02 INFO - {'append_to_log': False, 12:54:02 INFO - 'base_work_dir': '/builds/slave/test', 12:54:02 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 12:54:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:54:02 INFO - 'branch': 'Mozilla-Inbound', 12:54:02 INFO - 'buildbot_json_path': 'buildprops.json', 12:54:02 INFO - 'config_files': ('talos/linux_config.py',), 12:54:02 INFO - 'default_actions': ('clobber', 12:54:02 INFO - 'read-buildbot-config', 12:54:02 INFO - 'download-and-extract', 12:54:02 INFO - 'populate-webroot', 12:54:02 INFO - 'create-virtualenv', 12:54:02 INFO - 'install', 12:54:02 INFO - 'run-tests'), 12:54:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:54:02 INFO - 'download_minidump_stackwalk': True, 12:54:02 INFO - 'download_symbols': 'ondemand', 12:54:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:54:02 INFO - 'tooltool.py': '/tools/tooltool.py', 12:54:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:54:02 INFO - '/tools/misc-python/virtualenv.py')}, 12:54:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:54:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:54:02 INFO - 'installer_path': 'installer.exe', 12:54:02 INFO - 'log_level': 'info', 12:54:02 INFO - 'log_name': 'talos', 12:54:02 INFO - 'log_to_console': True, 12:54:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:54:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:54:02 INFO - 'opt_config_files': (), 12:54:02 INFO - 'pip_index': False, 12:54:02 INFO - 'sps_profile': False, 12:54:02 INFO - 'sps_profile_interval': 0, 12:54:02 INFO - 'suite': 'dromaeojs', 12:54:02 INFO - 'system_bits': '32', 12:54:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:54:02 INFO - 'title': 'talos-linux64-ix-016', 12:54:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:54:02 INFO - 'use_talos_json': True, 12:54:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:54:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:54:02 INFO - 'work_dir': 'build'} 12:54:02 INFO - [mozharness: 2016-11-18 20:54:02.437866Z] Running clobber step. 12:54:02 INFO - Running pre-action listener: _resource_record_pre_action 12:54:02 INFO - Running main action method: clobber 12:54:02 INFO - rmtree: /builds/slave/test/build 12:54:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:54:03 INFO - Running post-action listener: _resource_record_post_action 12:54:03 INFO - [mozharness: 2016-11-18 20:54:03.423583Z] Finished clobber step (success) 12:54:03 INFO - [mozharness: 2016-11-18 20:54:03.423682Z] Running read-buildbot-config step. 12:54:03 INFO - Running pre-action listener: _resource_record_pre_action 12:54:03 INFO - Running main action method: read_buildbot_config 12:54:03 INFO - Using buildbot properties: 12:54:03 INFO - { 12:54:03 INFO - "project": "", 12:54:03 INFO - "product": "firefox", 12:54:03 INFO - "script_repo_revision": "production", 12:54:03 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 12:54:03 INFO - "repository": "", 12:54:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 12:54:03 INFO - "buildid": "20161118124043", 12:54:03 INFO - "stage_platform": "linux64-pgo", 12:54:03 INFO - "basedir": "/builds/slave/test", 12:54:03 INFO - "buildnumber": 2888, 12:54:03 INFO - "platform": "ubuntu64_hw", 12:54:03 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:54:03 INFO - "slavebuilddir": "test", 12:54:03 INFO - "branch": "mozilla-inbound", 12:54:03 INFO - "revision": "a40cac8610de8543bf21eecaa91dacf3ed1b73e7", 12:54:03 INFO - "slavename": "talos-linux64-ix-016", 12:54:03 INFO - "builduid": "a9b6e6f4e60c4e66bc1442bca2e0e95e", 12:54:03 INFO - "repo_path": "integration/mozilla-inbound" 12:54:03 INFO - } 12:54:03 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479490650/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 12:54:03 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479490650/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 12:54:03 INFO - Running post-action listener: _resource_record_post_action 12:54:03 INFO - [mozharness: 2016-11-18 20:54:03.426036Z] Finished read-buildbot-config step (success) 12:54:03 INFO - [mozharness: 2016-11-18 20:54:03.426125Z] Running download-and-extract step. 12:54:03 INFO - Running pre-action listener: _resource_record_pre_action 12:54:03 INFO - Running main action method: download_and_extract 12:54:03 INFO - mkdir: /builds/slave/test/build/tests 12:54:03 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')]} 12:54:03 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479490650/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 12:54:03 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479490650/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 12:54:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479490650/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 12:54:03 INFO - Downloaded 1361 bytes. 12:54:03 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 12:54:03 INFO - Using the following test package requirements: 12:54:03 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 12:54:03 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:54:03 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:54:03 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:03 INFO - u'jsshell-linux-x86_64.zip'], 12:54:03 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:54:03 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 12:54:03 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:54:03 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:54:03 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:54:03 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:03 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:54:03 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:54:03 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/1479490650/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 12:54:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479490650/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:54:03 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479490650/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:54:03 INFO - Http code: 200 12:54:03 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 12:54:03 INFO - x-amz-cf-id: -35GA41sreKphWlCP-EQW9Zj7SvGdGnnfGhA_yXbWRx_PPeEfWYHuQ== 12:54:03 INFO - x-amz-replication-status: COMPLETED 12:54:03 INFO - x-amz-version-id: WzTChbo8WWkE7fvm5Lub07QRogyNs44E 12:54:03 INFO - Expected file size: 21955559 12:54:03 INFO - Obtained file size: 21955559 12:54:07 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 12:54:07 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/1479490650/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 12:54:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479490650/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:54:07 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479490650/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:54:07 INFO - Http code: 200 12:54:07 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 12:54:07 INFO - x-amz-cf-id: 7637JHQ_ctybSHRCFt5WufJcdta_fp0f-Y3VFTODayaSYgdvPu5hvw== 12:54:07 INFO - x-amz-replication-status: COMPLETED 12:54:07 INFO - x-amz-version-id: WzTChbo8WWkE7fvm5Lub07QRogyNs44E 12:54:08 INFO - Expected file size: 21955559 12:54:08 INFO - Obtained file size: 21955559 12:54:12 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/1479490650/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 12:54:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479490650/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:54:12 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479490650/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:54:12 INFO - Http code: 200 12:54:12 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 12:54:12 INFO - x-amz-cf-id: tWyuoCkEXjStwVoRnLu7Q5OE08vD1x7RyYA4UO3DYKzrSzGFftljeA== 12:54:12 INFO - x-amz-replication-status: COMPLETED 12:54:12 INFO - x-amz-version-id: flp7UXl6c0XfKDhenME2NUEosQWad_Bv 12:54:13 INFO - Expected file size: 14409392 12:54:13 INFO - Obtained file size: 14409392 12:54: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')]} 12:54:13 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479490650/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:54:13 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479490650/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 12:54:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479490650/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 12:54:13 INFO - Downloaded 59599566 bytes. 12:54:13 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479490650/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:54:13 INFO - mkdir: /builds/slave/test/properties 12:54:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:54:13 INFO - Writing to file /builds/slave/test/properties/build_url 12:54:13 INFO - Contents: 12:54:13 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479490650/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:54:14 INFO - Running post-action listener: _resource_record_post_action 12:54:14 INFO - Running post-action listener: set_extra_try_arguments 12:54:14 INFO - [mozharness: 2016-11-18 20:54:14.051790Z] Finished download-and-extract step (success) 12:54:14 INFO - [mozharness: 2016-11-18 20:54:14.052016Z] Running populate-webroot step. 12:54:14 INFO - Running pre-action listener: _resource_record_pre_action 12:54:14 INFO - Running main action method: populate_webroot 12:54:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:54:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:54:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:54:14 INFO - '--tppagecycles', 12:54:14 INFO - '7'], 12:54:14 INFO - 'tests': ['tsvgm']}}, 12:54:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:54:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:54:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:54:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:54:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:54:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:54:14 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:54:14 INFO - 'talos_options': ['--disable-e10s'], 12:54:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:54:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:54:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:54:14 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:54:14 INFO - 'talos_options': ['--disable-e10s'], 12:54:14 INFO - 'tests': ['damp', 'tps']}, 12:54:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:54:14 INFO - 'tests': ['damp', 'tps']}, 12:54:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:54:14 INFO - 'tests': ['dromaeo_dom']}, 12:54:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:54:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:54:14 INFO - 'tests': ['basic_compositor_video']}, 12:54:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:54:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:54:14 INFO - 'tests': ['a11yr', 12:54:14 INFO - 'ts_paint', 12:54:14 INFO - 'tpaint', 12:54:14 INFO - 'sessionrestore', 12:54:14 INFO - 'sessionrestore_no_auto_restore', 12:54:14 INFO - 'tabpaint']}, 12:54:14 INFO - 'other-e10s': {'tests': ['a11yr', 12:54:14 INFO - 'ts_paint', 12:54:14 INFO - 'tpaint', 12:54:14 INFO - 'sessionrestore', 12:54:14 INFO - 'sessionrestore_no_auto_restore', 12:54:14 INFO - 'tabpaint']}, 12:54:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:54:14 INFO - 'ts_paint', 12:54:14 INFO - 'tpaint', 12:54:14 INFO - 'sessionrestore', 12:54:14 INFO - 'sessionrestore_no_auto_restore', 12:54:14 INFO - 'tabpaint']}, 12:54:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:54:14 INFO - 'ts_paint', 12:54:14 INFO - 'tpaint', 12:54:14 INFO - 'sessionrestore', 12:54:14 INFO - 'sessionrestore_no_auto_restore', 12:54:14 INFO - 'tabpaint']}, 12:54:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:54:14 INFO - 'tests': ['a11yr', 12:54:14 INFO - 'ts_paint', 12:54:14 INFO - 'tpaint', 12:54:14 INFO - 'sessionrestore', 12:54:14 INFO - 'sessionrestore_no_auto_restore', 12:54:14 INFO - 'tabpaint']}, 12:54:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:54:14 INFO - 'tests': ['a11yr', 12:54:14 INFO - 'ts_paint', 12:54:14 INFO - 'tpaint', 12:54:14 INFO - 'sessionrestore', 12:54:14 INFO - 'sessionrestore_no_auto_restore', 12:54:14 INFO - 'tabpaint']}, 12:54:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:54:14 INFO - 'tests': ['tsvgx', 12:54:14 INFO - 'tsvgr_opacity', 12:54:14 INFO - 'tart', 12:54:14 INFO - 'tscrollx', 12:54:14 INFO - 'cart']}, 12:54:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:54:14 INFO - 'tsvgr_opacity', 12:54:14 INFO - 'tart', 12:54:14 INFO - 'tscrollx', 12:54:14 INFO - 'cart']}, 12:54:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:54:14 INFO - 'talos_options': ['--disable-e10s'], 12:54:14 INFO - 'tests': ['tp5o']}, 12:54:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:54:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:54:14 INFO - 'talos_options': ['--disable-e10s', 12:54:14 INFO - '--xperf_path', 12:54:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:54:14 INFO - 'tests': ['tp5n']}, 12:54:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:54:14 INFO - 'talos_options': ['--xperf_path', 12:54:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:54:14 INFO - 'tests': ['tp5n']}}, 12:54:14 INFO - 'talos.zip': {'path': '', 12:54:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:54:14 INFO - Running post-action listener: _resource_record_post_action 12:54:14 INFO - [mozharness: 2016-11-18 20:54:14.070906Z] Finished populate-webroot step (success) 12:54:14 INFO - [mozharness: 2016-11-18 20:54:14.071000Z] Running create-virtualenv step. 12:54:14 INFO - Running pre-action listener: _resource_record_pre_action 12:54:14 INFO - Running main action method: create_virtualenv 12:54:14 INFO - Creating virtualenv /builds/slave/test/build/venv 12:54:14 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 12:54:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:54:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:54:14 INFO - Using real prefix '/usr' 12:54:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:54:14 INFO - Installing distribute.............................................................................................................................................................................................done. 12:54:16 INFO - Installing pip.................done. 12:54:16 INFO - Return code: 0 12:54:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:54:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:54:16 INFO - Reading from file tmpfile_stdout 12:54:16 INFO - Output received: 12:54:16 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) 12:54:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa99bb5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acdb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c69130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7fc0>, '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 0x1cf8ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9350>, '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': '00204705a9daa57ed339a427000001b9-1479502439.783156-585782061', '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 12:54:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:54:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:54:16 INFO - Using env: {'DISPLAY': ':0', 12:54:16 INFO - 'HOME': '/home/cltbld', 12:54:16 INFO - 'LANG': 'en_US.UTF-8', 12:54:16 INFO - 'LANGUAGE': 'en_US:en', 12:54:16 INFO - 'LOGNAME': 'cltbld', 12:54:16 INFO - 'MAIL': '/var/mail/cltbld', 12:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:16 INFO - 'MOZ_NO_REMOTE': '1', 12:54:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:16 INFO - 'NO_EM_RESTART': '1', 12:54:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:16 INFO - 'PWD': '/builds/slave/test', 12:54:16 INFO - 'SHELL': '/bin/bash', 12:54:16 INFO - 'SHLVL': '1', 12:54:16 INFO - 'TERM': 'linux', 12:54:16 INFO - 'TMOUT': '86400', 12:54:16 INFO - 'USER': 'cltbld', 12:54:16 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1479502439.783156-585782061', 12:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:16 INFO - '_': '/tools/buildbot/bin/python'} 12:54:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:17 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 12:54:17 INFO - Cleaning up... 12:54:17 INFO - Return code: 0 12:54:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:54:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:17 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 0x7faa99bb5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acdb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c69130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7fc0>, '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 0x1cf8ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9350>, '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': '00204705a9daa57ed339a427000001b9-1479502439.783156-585782061', '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 12:54:17 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 12:54:17 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 12:54:17 INFO - Using env: {'DISPLAY': ':0', 12:54:17 INFO - 'HOME': '/home/cltbld', 12:54:17 INFO - 'LANG': 'en_US.UTF-8', 12:54:17 INFO - 'LANGUAGE': 'en_US:en', 12:54:17 INFO - 'LOGNAME': 'cltbld', 12:54:17 INFO - 'MAIL': '/var/mail/cltbld', 12:54:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:17 INFO - 'MOZ_NO_REMOTE': '1', 12:54:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:17 INFO - 'NO_EM_RESTART': '1', 12:54:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:17 INFO - 'PWD': '/builds/slave/test', 12:54:17 INFO - 'SHELL': '/bin/bash', 12:54:17 INFO - 'SHLVL': '1', 12:54:17 INFO - 'TERM': 'linux', 12:54:17 INFO - 'TMOUT': '86400', 12:54:17 INFO - 'USER': 'cltbld', 12:54:17 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1479502439.783156-585782061', 12:54:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:17 INFO - '_': '/tools/buildbot/bin/python'} 12:54:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:17 INFO - Downloading/unpacking psutil>=3.1.1 12:54:17 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 12:54:17 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 12:54:17 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 12:54:17 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 12:54:17 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 12:54:17 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 12:54:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:54:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:54:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:54:19 INFO - Installing collected packages: psutil 12:54:19 INFO - Running setup.py install for psutil 12:54:19 INFO - building 'psutil._psutil_linux' extension 12:54:19 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 12:54:19 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 12:54:19 INFO - building 'psutil._psutil_posix' extension 12:54:19 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 12:54:19 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 12:54:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:54:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:54:19 INFO - Successfully installed psutil 12:54:19 INFO - Cleaning up... 12:54:19 INFO - Return code: 0 12:54:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa99bb5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acdb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c69130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7fc0>, '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 0x1cf8ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9350>, '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': '00204705a9daa57ed339a427000001b9-1479502439.783156-585782061', '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 12:54:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:54:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:54:19 INFO - Using env: {'DISPLAY': ':0', 12:54:19 INFO - 'HOME': '/home/cltbld', 12:54:19 INFO - 'LANG': 'en_US.UTF-8', 12:54:19 INFO - 'LANGUAGE': 'en_US:en', 12:54:19 INFO - 'LOGNAME': 'cltbld', 12:54:19 INFO - 'MAIL': '/var/mail/cltbld', 12:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:19 INFO - 'MOZ_NO_REMOTE': '1', 12:54:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:19 INFO - 'NO_EM_RESTART': '1', 12:54:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:19 INFO - 'PWD': '/builds/slave/test', 12:54:19 INFO - 'SHELL': '/bin/bash', 12:54:19 INFO - 'SHLVL': '1', 12:54:19 INFO - 'TERM': 'linux', 12:54:19 INFO - 'TMOUT': '86400', 12:54:19 INFO - 'USER': 'cltbld', 12:54:19 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1479502439.783156-585782061', 12:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:19 INFO - '_': '/tools/buildbot/bin/python'} 12:54:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:54:20 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 12:54:20 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 12:54:20 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 12:54:20 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 12:54:20 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 12:54:20 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 12:54:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:54:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:54:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:54:22 INFO - Installing collected packages: mozsystemmonitor 12:54:22 INFO - Running setup.py install for mozsystemmonitor 12:54:22 INFO - Successfully installed mozsystemmonitor 12:54:22 INFO - Cleaning up... 12:54:22 INFO - Return code: 0 12:54:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:54:22 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')]} 12:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:22 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')]} 12:54:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:22 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 0x7faa99bb5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acdb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c69130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7fc0>, '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 0x1cf8ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9350>, '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': '00204705a9daa57ed339a427000001b9-1479502439.783156-585782061', '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 12:54:22 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 12:54:22 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 12:54:22 INFO - Using env: {'DISPLAY': ':0', 12:54:22 INFO - 'HOME': '/home/cltbld', 12:54:22 INFO - 'LANG': 'en_US.UTF-8', 12:54:22 INFO - 'LANGUAGE': 'en_US:en', 12:54:22 INFO - 'LOGNAME': 'cltbld', 12:54:22 INFO - 'MAIL': '/var/mail/cltbld', 12:54:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:22 INFO - 'MOZ_NO_REMOTE': '1', 12:54:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:22 INFO - 'NO_EM_RESTART': '1', 12:54:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:22 INFO - 'PWD': '/builds/slave/test', 12:54:22 INFO - 'SHELL': '/bin/bash', 12:54:22 INFO - 'SHLVL': '1', 12:54:22 INFO - 'TERM': 'linux', 12:54:22 INFO - 'TMOUT': '86400', 12:54:22 INFO - 'USER': 'cltbld', 12:54:22 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1479502439.783156-585782061', 12:54:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:22 INFO - '_': '/tools/buildbot/bin/python'} 12:54:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:22 INFO - Downloading/unpacking jsonschema==2.5.1 12:54:22 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 12:54:22 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 12:54:22 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 12:54:22 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 12:54:22 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 12:54:22 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 12:54:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:54:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:24 INFO - Downloading functools32-3.2.3-2.tar.gz 12:54:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:54:24 INFO - warning: no files found matching '*.txt' 12:54:24 INFO - no previously-included directories found matching 'build' 12:54:24 INFO - no previously-included directories found matching 'dist' 12:54:24 INFO - no previously-included directories found matching '.git*' 12:54:24 INFO - Installing collected packages: jsonschema, functools32 12:54:24 INFO - Running setup.py install for functools32 12:54:24 INFO - warning: no files found matching '*.txt' 12:54:24 INFO - no previously-included directories found matching 'build' 12:54:24 INFO - no previously-included directories found matching 'dist' 12:54:24 INFO - no previously-included directories found matching '.git*' 12:54:24 INFO - Successfully installed jsonschema functools32 12:54:24 INFO - Cleaning up... 12:54:24 INFO - Return code: 0 12:54:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7faa99bb5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acdb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c69130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7fc0>, '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 0x1cf8ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9350>, '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': '00204705a9daa57ed339a427000001b9-1479502439.783156-585782061', '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 12:54:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:54:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:54:24 INFO - Using env: {'DISPLAY': ':0', 12:54:24 INFO - 'HOME': '/home/cltbld', 12:54:24 INFO - 'LANG': 'en_US.UTF-8', 12:54:24 INFO - 'LANGUAGE': 'en_US:en', 12:54:24 INFO - 'LOGNAME': 'cltbld', 12:54:24 INFO - 'MAIL': '/var/mail/cltbld', 12:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:24 INFO - 'MOZ_NO_REMOTE': '1', 12:54:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:24 INFO - 'NO_EM_RESTART': '1', 12:54:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:24 INFO - 'PWD': '/builds/slave/test', 12:54:24 INFO - 'SHELL': '/bin/bash', 12:54:24 INFO - 'SHLVL': '1', 12:54:24 INFO - 'TERM': 'linux', 12:54:24 INFO - 'TMOUT': '86400', 12:54:24 INFO - 'USER': 'cltbld', 12:54:24 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1479502439.783156-585782061', 12:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:24 INFO - '_': '/tools/buildbot/bin/python'} 12:54:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:54:25 INFO - Cleaning up... 12:54:25 INFO - Return code: 0 12:54:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:54:25 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')]} 12:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:25 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')]} 12:54:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:25 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 0x7faa99bb5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acdb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c69130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7fc0>, '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 0x1cf8ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9350>, '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': '00204705a9daa57ed339a427000001b9-1479502439.783156-585782061', '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 12:54:25 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 12:54:25 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 12:54:25 INFO - Using env: {'DISPLAY': ':0', 12:54:25 INFO - 'HOME': '/home/cltbld', 12:54:25 INFO - 'LANG': 'en_US.UTF-8', 12:54:25 INFO - 'LANGUAGE': 'en_US:en', 12:54:25 INFO - 'LOGNAME': 'cltbld', 12:54:25 INFO - 'MAIL': '/var/mail/cltbld', 12:54:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:25 INFO - 'MOZ_NO_REMOTE': '1', 12:54:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:25 INFO - 'NO_EM_RESTART': '1', 12:54:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:25 INFO - 'PWD': '/builds/slave/test', 12:54:25 INFO - 'SHELL': '/bin/bash', 12:54:25 INFO - 'SHLVL': '1', 12:54:25 INFO - 'TERM': 'linux', 12:54:25 INFO - 'TMOUT': '86400', 12:54:25 INFO - 'USER': 'cltbld', 12:54:25 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1479502439.783156-585782061', 12:54:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:25 INFO - '_': '/tools/buildbot/bin/python'} 12:54:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:25 INFO - Downloading/unpacking blobuploader==1.2.4 12:54:25 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 12:54:25 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 12:54:25 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 12:54:25 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 12:54:25 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 12:54:25 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 12:54:27 INFO - Downloading blobuploader-1.2.4.tar.gz 12:54:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:54:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:54:27 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 12:54:27 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 12:54:27 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 12:54:27 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 12:54:27 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 12:54:27 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 12:54:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:54:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:54:27 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 12:54:27 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 12:54:27 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 12:54:27 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 12:54:27 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 12:54:27 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 12:54:28 INFO - Downloading docopt-0.6.1.tar.gz 12:54:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:54:28 INFO - Installing collected packages: blobuploader, requests, docopt 12:54:28 INFO - Running setup.py install for blobuploader 12:54:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:54:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:54:28 INFO - Running setup.py install for requests 12:54:28 INFO - Running setup.py install for docopt 12:54:28 INFO - Successfully installed blobuploader requests docopt 12:54:28 INFO - Cleaning up... 12:54:28 INFO - Return code: 0 12:54:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:28 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 0x7faa99bb5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acdb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c69130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7fc0>, '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 0x1cf8ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9350>, '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': '00204705a9daa57ed339a427000001b9-1479502439.783156-585782061', '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 12:54:28 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 12:54:28 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 12:54:28 INFO - Using env: {'DISPLAY': ':0', 12:54:28 INFO - 'HOME': '/home/cltbld', 12:54:28 INFO - 'LANG': 'en_US.UTF-8', 12:54:28 INFO - 'LANGUAGE': 'en_US:en', 12:54:28 INFO - 'LOGNAME': 'cltbld', 12:54:28 INFO - 'MAIL': '/var/mail/cltbld', 12:54:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:28 INFO - 'MOZ_NO_REMOTE': '1', 12:54:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:28 INFO - 'NO_EM_RESTART': '1', 12:54:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:28 INFO - 'PWD': '/builds/slave/test', 12:54:28 INFO - 'SHELL': '/bin/bash', 12:54:28 INFO - 'SHLVL': '1', 12:54:28 INFO - 'TERM': 'linux', 12:54:28 INFO - 'TMOUT': '86400', 12:54:28 INFO - 'USER': 'cltbld', 12:54:28 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1479502439.783156-585782061', 12:54:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:28 INFO - '_': '/tools/buildbot/bin/python'} 12:54:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:54:28 INFO - Running setup.py (path:/tmp/pip-ohZEZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:54:29 INFO - Running setup.py (path:/tmp/pip-Xb9j0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:54:29 INFO - Running setup.py (path:/tmp/pip-QwLJu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:54:29 INFO - Running setup.py (path:/tmp/pip-iEZY9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:54:29 INFO - Running setup.py (path:/tmp/pip-7dedUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:54:29 INFO - Running setup.py (path:/tmp/pip-Cse31b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:54:29 INFO - Running setup.py (path:/tmp/pip-A9w0Lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:54:29 INFO - Running setup.py (path:/tmp/pip-YEzVv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:54:29 INFO - Running setup.py (path:/tmp/pip-TNxfqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:54:29 INFO - Running setup.py (path:/tmp/pip-pugBKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:54:29 INFO - Running setup.py (path:/tmp/pip-IAnot5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:54:29 INFO - Running setup.py (path:/tmp/pip-MX1XUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:54:29 INFO - Running setup.py (path:/tmp/pip-Rmlry9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:54:29 INFO - Running setup.py (path:/tmp/pip-BlUvvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:29 INFO - Running setup.py (path:/tmp/pip-N4Zqe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:54:30 INFO - Running setup.py (path:/tmp/pip-BDIG_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:54:30 INFO - Running setup.py (path:/tmp/pip-mhdR8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:54:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:54:30 INFO - Running setup.py install for manifestparser 12:54:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:54:30 INFO - Running setup.py install for mozcrash 12:54:30 INFO - Running setup.py install for mozdebug 12:54:30 INFO - Running setup.py install for mozdevice 12:54:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:54:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:54:30 INFO - Running setup.py install for mozfile 12:54:30 INFO - Running setup.py install for mozhttpd 12:54:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:54:30 INFO - Running setup.py install for mozinfo 12:54:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:54:30 INFO - Running setup.py install for mozInstall 12:54:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:54:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:54:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:54:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:54:30 INFO - Running setup.py install for mozleak 12:54:31 INFO - Running setup.py install for mozlog 12:54:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:54:31 INFO - Running setup.py install for moznetwork 12:54:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:54:31 INFO - Running setup.py install for mozprocess 12:54:31 INFO - Running setup.py install for mozprofile 12:54:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:54:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:54:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:54:31 INFO - Running setup.py install for mozrunner 12:54:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:54:31 INFO - Running setup.py install for mozscreenshot 12:54:31 INFO - Running setup.py install for moztest 12:54:31 INFO - Running setup.py install for mozversion 12:54:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:54:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:54:31 INFO - Cleaning up... 12:54:31 INFO - Return code: 0 12:54:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54: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')]} 12:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54: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')]} 12:54:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:32 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 0x7faa99bb5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acdb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c69130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7fc0>, '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 0x1cf8ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9350>, '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': '00204705a9daa57ed339a427000001b9-1479502439.783156-585782061', '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 12:54:32 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 12:54:32 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 12:54:32 INFO - Using env: {'DISPLAY': ':0', 12:54:32 INFO - 'HOME': '/home/cltbld', 12:54:32 INFO - 'LANG': 'en_US.UTF-8', 12:54:32 INFO - 'LANGUAGE': 'en_US:en', 12:54:32 INFO - 'LOGNAME': 'cltbld', 12:54:32 INFO - 'MAIL': '/var/mail/cltbld', 12:54:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:32 INFO - 'MOZ_NO_REMOTE': '1', 12:54:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:32 INFO - 'NO_EM_RESTART': '1', 12:54:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:32 INFO - 'PWD': '/builds/slave/test', 12:54:32 INFO - 'SHELL': '/bin/bash', 12:54:32 INFO - 'SHLVL': '1', 12:54:32 INFO - 'TERM': 'linux', 12:54:32 INFO - 'TMOUT': '86400', 12:54:32 INFO - 'USER': 'cltbld', 12:54:32 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1479502439.783156-585782061', 12:54:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:32 INFO - '_': '/tools/buildbot/bin/python'} 12:54:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:54:32 INFO - Running setup.py (path:/tmp/pip-1QJjCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:54:32 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)) 12:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:54:32 INFO - Running setup.py (path:/tmp/pip-_6CBKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:54:32 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)) 12:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:54:32 INFO - Running setup.py (path:/tmp/pip-RjpMau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:54:32 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)) 12:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:54:32 INFO - Running setup.py (path:/tmp/pip-Jrvzd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:54:32 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)) 12:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:54:32 INFO - Running setup.py (path:/tmp/pip-_CcnZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:54:32 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)) 12:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:54:32 INFO - Running setup.py (path:/tmp/pip-TQqa7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:54:32 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)) 12:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:54:32 INFO - Running setup.py (path:/tmp/pip-FtcPWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:54:32 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)) 12:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:54:32 INFO - Running setup.py (path:/tmp/pip-phZig8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:54:32 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)) 12:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:54:32 INFO - Running setup.py (path:/tmp/pip-kga486-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:54:32 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)) 12:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:54:32 INFO - Running setup.py (path:/tmp/pip-QsXZSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:54:32 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)) 12:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:54:32 INFO - Running setup.py (path:/tmp/pip-4EVSvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:54:33 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)) 12:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:54:33 INFO - Running setup.py (path:/tmp/pip-mXSRXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:54:33 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)) 12:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:54:33 INFO - Running setup.py (path:/tmp/pip-eHwzFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:54:33 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)) 12:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:54:33 INFO - Running setup.py (path:/tmp/pip-8RKPU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:54:33 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)) 12:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:33 INFO - Running setup.py (path:/tmp/pip-8AS0JI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:33 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)) 12:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:54:33 INFO - Running setup.py (path:/tmp/pip-KiioA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:54:33 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)) 12:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:54:33 INFO - Running setup.py (path:/tmp/pip-rOE5eh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:54:33 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)) 12:54:33 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)) 12:54:33 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)) 12:54:33 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)) 12:54:33 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)) 12:54:33 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)) 12:54:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:54:33 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 12:54:33 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 12:54:33 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 12:54:33 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 12:54:33 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 12:54:33 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 12:54:35 INFO - Downloading blessings-1.6.tar.gz 12:54:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:54:35 INFO - Installing collected packages: blessings 12:54:35 INFO - Running setup.py install for blessings 12:54:35 INFO - Successfully installed blessings 12:54:35 INFO - Cleaning up... 12:54:35 INFO - Return code: 0 12:54:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:54:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:54:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:54:35 INFO - Reading from file tmpfile_stdout 12:54:35 INFO - Current package versions: 12:54:35 INFO - argparse == 1.2.1 12:54:35 INFO - blessings == 1.6 12:54:35 INFO - blobuploader == 1.2.4 12:54:35 INFO - docopt == 0.6.1 12:54:35 INFO - functools32 == 3.2.3-2 12:54:35 INFO - jsonschema == 2.5.1 12:54:35 INFO - manifestparser == 1.1 12:54:35 INFO - mozInstall == 1.12 12:54:35 INFO - mozcrash == 1.0 12:54:35 INFO - mozdebug == 0.1 12:54:35 INFO - mozdevice == 0.49 12:54:35 INFO - mozfile == 1.2 12:54:35 INFO - mozhttpd == 0.7 12:54:35 INFO - mozinfo == 0.9 12:54:35 INFO - mozleak == 0.1 12:54:35 INFO - mozlog == 3.4 12:54:35 INFO - moznetwork == 0.27 12:54:35 INFO - mozprocess == 0.23 12:54:35 INFO - mozprofile == 0.28 12:54:35 INFO - mozrunner == 6.13 12:54:35 INFO - mozscreenshot == 0.1 12:54:35 INFO - mozsystemmonitor == 0.3 12:54:35 INFO - moztest == 0.7 12:54:35 INFO - mozversion == 1.4 12:54:35 INFO - psutil == 3.1.1 12:54:35 INFO - requests == 1.2.3 12:54:35 INFO - wsgiref == 0.1.2 12:54:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:35 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 0x7faa99bb5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acdb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c69130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7fc0>, '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 0x1cf8ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9350>, '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': '00204705a9daa57ed339a427000001b9-1479502439.783156-585782061', '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 12:54:35 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 12:54:35 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 12:54:35 INFO - Using env: {'DISPLAY': ':0', 12:54:35 INFO - 'HOME': '/home/cltbld', 12:54:35 INFO - 'LANG': 'en_US.UTF-8', 12:54:35 INFO - 'LANGUAGE': 'en_US:en', 12:54:35 INFO - 'LOGNAME': 'cltbld', 12:54:35 INFO - 'MAIL': '/var/mail/cltbld', 12:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:35 INFO - 'MOZ_NO_REMOTE': '1', 12:54:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:35 INFO - 'NO_EM_RESTART': '1', 12:54:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:35 INFO - 'PWD': '/builds/slave/test', 12:54:35 INFO - 'SHELL': '/bin/bash', 12:54:35 INFO - 'SHLVL': '1', 12:54:35 INFO - 'TERM': 'linux', 12:54:35 INFO - 'TMOUT': '86400', 12:54:35 INFO - 'USER': 'cltbld', 12:54:35 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1479502439.783156-585782061', 12:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:35 INFO - '_': '/tools/buildbot/bin/python'} 12:54:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:36 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)) 12:54:36 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)) 12:54:36 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)) 12:54:36 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)) 12:54:36 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)) 12:54:36 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)) 12:54:36 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)) 12:54:36 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)) 12:54:36 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)) 12:54:36 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)) 12:54:36 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)) 12:54:36 INFO - Cleaning up... 12:54:36 INFO - Return code: 0 12:54:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:54: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')]} 12:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54: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')]} 12:54:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa99bb5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acdb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c69130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cf7fc0>, '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 0x1cf8ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9350>, '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': '00204705a9daa57ed339a427000001b9-1479502439.783156-585782061', '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 12:54:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:54:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:54:36 INFO - Using env: {'DISPLAY': ':0', 12:54:36 INFO - 'HOME': '/home/cltbld', 12:54:36 INFO - 'LANG': 'en_US.UTF-8', 12:54:36 INFO - 'LANGUAGE': 'en_US:en', 12:54:36 INFO - 'LOGNAME': 'cltbld', 12:54:36 INFO - 'MAIL': '/var/mail/cltbld', 12:54:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:36 INFO - 'MOZ_NO_REMOTE': '1', 12:54:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:36 INFO - 'NO_EM_RESTART': '1', 12:54:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:36 INFO - 'PWD': '/builds/slave/test', 12:54:36 INFO - 'SHELL': '/bin/bash', 12:54:36 INFO - 'SHLVL': '1', 12:54:36 INFO - 'TERM': 'linux', 12:54:36 INFO - 'TMOUT': '86400', 12:54:36 INFO - 'USER': 'cltbld', 12:54:36 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1479502439.783156-585782061', 12:54:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:36 INFO - '_': '/tools/buildbot/bin/python'} 12:54:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:54:36 INFO - Cleaning up... 12:54:36 INFO - Return code: 0 12:54:36 INFO - Running post-action listener: _resource_record_post_action 12:54:36 INFO - Running post-action listener: _start_resource_monitoring 12:54:36 INFO - Starting resource monitoring. 12:54:36 INFO - [mozharness: 2016-11-18 20:54:36.397111Z] Finished create-virtualenv step (success) 12:54:36 INFO - [mozharness: 2016-11-18 20:54:36.397678Z] Running install step. 12:54:36 INFO - Running pre-action listener: _resource_record_pre_action 12:54:36 INFO - Running main action method: install 12:54:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:54:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:54:36 INFO - Reading from file tmpfile_stdout 12:54:36 INFO - Detecting whether we're running mozinstall >=1.0... 12:54:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:54:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:54:36 INFO - Reading from file tmpfile_stdout 12:54:36 INFO - Output received: 12:54:36 INFO - Usage: mozinstall [options] installer 12:54:36 INFO - Options: 12:54:36 INFO - -h, --help show this help message and exit 12:54:36 INFO - -d DEST, --destination=DEST 12:54:36 INFO - Directory to install application into. [default: 12:54:36 INFO - "/builds/slave/test"] 12:54:36 INFO - --app=APP Application being installed. [default: firefox] 12:54:36 INFO - mkdir: /builds/slave/test/build/application 12:54:36 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'] 12:54:36 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 12:54:53 INFO - Reading from file tmpfile_stdout 12:54:53 INFO - Output received: 12:54:53 INFO - /builds/slave/test/build/application/firefox/firefox 12:54:53 INFO - Running post-action listener: _resource_record_post_action 12:54:53 INFO - [mozharness: 2016-11-18 20:54:53.605231Z] Finished install step (success) 12:54:53 INFO - [mozharness: 2016-11-18 20:54:53.605568Z] Running run-tests step. 12:54:53 INFO - Running pre-action listener: _resource_record_pre_action 12:54:53 INFO - Running main action method: run_tests 12:54:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:54:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:54:53 INFO - Python 2.7.3 12:54:53 INFO - Return code: 0 12:54:53 INFO - grabbing minidump binary from tooltool 12:54:53 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')]} 12:54:53 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 0x1cf7fc0>, '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 0x1cf8ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cf9350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:54:53 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 12:54:53 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 12:54:53 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 12:54:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:54:53 INFO - Return code: 0 12:54:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:54:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:54:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:54:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:54:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:54:53 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/1479490650/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 12:54:53 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/1479490650/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 12:54:53 INFO - Using env: {'DISPLAY': ':0', 12:54:53 INFO - 'HOME': '/home/cltbld', 12:54:53 INFO - 'LANG': 'en_US.UTF-8', 12:54:53 INFO - 'LANGUAGE': 'en_US:en', 12:54:53 INFO - 'LOGNAME': 'cltbld', 12:54:53 INFO - 'MAIL': '/var/mail/cltbld', 12:54:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:54:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:53 INFO - 'MOZ_NO_REMOTE': '1', 12:54:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:54:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:53 INFO - 'NO_EM_RESTART': '1', 12:54:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:53 INFO - 'PWD': '/builds/slave/test', 12:54:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:54:53 INFO - 'SHELL': '/bin/bash', 12:54:53 INFO - 'SHLVL': '1', 12:54:53 INFO - 'TERM': 'linux', 12:54:53 INFO - 'TMOUT': '86400', 12:54:53 INFO - 'USER': 'cltbld', 12:54:53 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1479502439.783156-585782061', 12:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:53 INFO - '_': '/tools/buildbot/bin/python'} 12:54:53 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/1479490650/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 12:54:53 INFO - mozversion application_buildid: 20161118093730 12:54:53 INFO - mozversion application_changeset: a40cac8610de8543bf21eecaa91dacf3ed1b73e7 12:54:53 INFO - mozversion application_display_name: Nightly 12:54:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:54:53 INFO - mozversion application_name: Firefox 12:54:53 INFO - mozversion application_remotingname: firefox 12:54:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:54:53 INFO - mozversion application_vendor: Mozilla 12:54:53 INFO - mozversion application_version: 53.0a1 12:54:53 INFO - mozversion platform_buildid: 20161118093730 12:54:53 INFO - mozversion platform_changeset: a40cac8610de8543bf21eecaa91dacf3ed1b73e7 12:54:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:54:53 INFO - mozversion platform_version: 53.0a1 12:54:53 INFO - using testdate: 1479502493 12:54:53 INFO - actual date: 1479502493 12:54:53 INFO - starting webserver on 'localhost:56822' 12:54:53 INFO - SUITE-START | Running 2 tests 12:54:53 INFO - TEST-START | dromaeo_css 12:54:53 INFO - operating with platform_type : linux_ 12:54:53 INFO - Initialising browser for dromaeo_css test... 12:54:53 INFO - TEST-INFO | started process 22119 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD8t7xg/profile http://localhost:56822/getInfo.html) 12:54:57 INFO - PROCESS | 22119 | __metrics Screen width/height:1600/1200 12:54:57 INFO - PROCESS | 22119 | colorDepth:24 12:54:57 INFO - PROCESS | 22119 | Browser inner width/height: 1024/697 12:54:57 INFO - PROCESS | 22119 | __metrics 12:54:58 INFO - PROCESS | 22119 | 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" 12:54:58 INFO - PROCESS | 22119 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:54:59 INFO - PROCESS | 22119 | console.error: PushService: 12:54:59 INFO - PROCESS | 22119 | stateChangeProcessEnqueue: Error transitioning state 12:54:59 INFO - PROCESS | 22119 | UnknownError 12:54:59 INFO - TEST-INFO | 22119: exit 0 12:54:59 INFO - Browser initialized. 12:54:59 INFO - Running cycle 1/1 for dromaeo_css test... 12:54:59 INFO - TEST-INFO | started process 22200 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD8t7xg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:55:12 INFO - PROCESS | 22200 | RSS: Main: 173998080 12:55:12 INFO - PROCESS | 22200 | 12:56:03 INFO - PROCESS | 22200 | 1479502562996 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] 12:58:14 INFO - PROCESS | 22200 | Cycle 1(1): loaded http://localhost:56822/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56822/tests/dromaeo/cssquery-ext.html) 12:58:15 INFO - PROCESS | 22200 | RSS: Main: 322314240 12:58:15 INFO - PROCESS | 22200 | 13:01:18 INFO - PROCESS | 22200 | Cycle 1(1): loaded http://localhost:56822/tests/dromaeo/cssquery-ext.html (next: http://localhost:56822/tests/dromaeo/cssquery-jquery.html) 13:01:18 INFO - PROCESS | 22200 | RSS: Main: 280621056 13:01:18 INFO - PROCESS | 22200 | 13:04:21 INFO - PROCESS | 22200 | Cycle 1(1): loaded http://localhost:56822/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56822/tests/dromaeo/cssquery-mootools.html) 13:04:21 INFO - PROCESS | 22200 | RSS: Main: 262422528 13:04:21 INFO - PROCESS | 22200 | 13:07:23 INFO - PROCESS | 22200 | Cycle 1(1): loaded http://localhost:56822/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56822/tests/dromaeo/cssquery-prototype.html) 13:07:24 INFO - PROCESS | 22200 | RSS: Main: 218046464 13:07:24 INFO - PROCESS | 22200 | 13:10:27 INFO - PROCESS | 22200 | Cycle 1(1): loaded http://localhost:56822/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56822/tests/dromaeo/cssquery-yui.html) 13:10:27 INFO - PROCESS | 22200 | RSS: Main: 218206208 13:10:27 INFO - PROCESS | 22200 | 13:13:30 INFO - PROCESS | 22200 | Cycle 1(1): loaded http://localhost:56822/tests/dromaeo/cssquery-yui.html (next: http://localhost:56822/tests/dromaeo/cssquery-dojo.html) 13:13:31 INFO - PROCESS | 22200 | RSS: Main: 311062528 13:13:31 INFO - PROCESS | 22200 | 13:13:31 INFO - PROCESS | 22200 | __start_tp_report 13:13:31 INFO - PROCESS | 22200 | _x_x_mozilla_page_load 13:13:31 INFO - PROCESS | 22200 | _x_x_mozilla_page_load_details 13:13:31 INFO - PROCESS | 22200 | |i|pagename|runs| 13:13:31 INFO - PROCESS | 22200 | |0;dojo.html;3011.0665693634974;3016.913910992044;3053.084074777566;3060.7857449978496;3065.049834551289;5163.690178589287;5235.293235413218;5325.760340784665;5354.946450535489;5394.379646340672;5249.973750131244;5251.317328747257;5268.0780863348955;5268.1834315681035;5270.9736451317785;4744.0511897620445;4771.928421073687;4783.7129772213775;4808.158572249859;4812.831550895719;4847.418309802829;4880.438749543795;4889.3888263967;4891.16850135476;4892.510748925115;4811.470738218811;4863.927041094386;4869.220924652056;4888.9511104889025;4895.828645997391;4914.606831453493;4915.729634870081;4934.580560652349;4939.950600493985;4984.526469985346;4761.6904901181315;4784.42586889572;4798.280257961299;4854.2718592211095;4895.2167653175675;5329.573634109301;5349.759260833272;5351.090314646481;5354.464553544653;5414.7834086636485;5675.233843431167;5727.484526392603;5744.482996530291;5749.942500574983;5750.108733146369;5571.693556854371;5644.096944488862;5685.971570142165;5713.057345537981;5756.8848623027725;5313.787448502056;5340.572754179656;5341.252224688546;5386;5387.8383648491;5830.5044071254415;5831.271091113611;5833.854153646193;5846.298444186725;5848.619839710405;5434.429384914527;5473.507384335349;5597.692126933058;5606.579506537026;5615.775368985195;5623.0721930880945;5660.490555849911;5671.234383358276;5696.857578560569;5749.108888122348;5611.607187496836;5657.8019769307875;5662.37713851476;5663.801766938137;5669.177969194444;5528.778848846001;5622.803201887914;5676.4323567642905;5683.9715801420725;5712.428757124254;4132.91734165315;4159.83360665576;4171.186618609403;4206.369044643328;4207.600277973587;3762.097096696828;3768.3217020936495;3784.962150378516;3800.733948623625;3803.581606023335;5478.123500240023;5481.342238931274;5486.396496385394;5489.313835770528;5517.889642207133;5607.607467477237;5623.072193088176;5649.350324712711;5670.659760414388;5778.422157784272;5359.839204823861;5395.7841686332895;5401.891962160735;5403.13549832025;5405.432429594836;4724.809990225211;4759.0719809637485;4765.380500534909;4766.76166191689;4811.061842940593;5711.828645140652;5820.534357251325;5827.3007239131575;5837.941620583825;5867.295924488918;5665.405132461032;5729.455701708331;5734.283214598176;5735.3977832327;5741.91387129185;5878.706064696834;5884.382139875423;5884.617499862496;5890.028145355968;5914.585978981602;5688.317401911797;5692.51613612831;5702.5437964961875;5725.6850873202375;5740.741666624928;5720.570957178145;5768.451997060272;5778;5779.797707080232;5786.6528008317955;5475.479829416199;5493.862653433696;5539.224508568723;5631.831045068655;5639.436056394327;5502.532284755681;5524.226608274765;5535.916961245665;5542.667439953616;5571.582131340247;5438.374586922555;5445.156000819879;5473.589480788877;5477.3427188737605;5478.945210548003;5531.115021596525;5552.972235138798;5571.359293681278;5579.358373787067;5630.211770352072;5496.725163741877;5501.834944951658;5511.5315198207;5512.4211957745465;5513.228148059355 13:13:31 INFO - PROCESS | 22200 | |1;ext.html;554.2874180666416;589.4900910712233;601.4196300569946;608.7625825927887;627.6767464755654;32190.517142242858;32577.348453030954;35000.474992875126;39366;41241.79379103108;43223.567764322346;43507.56492435075;43563.346549801776;43596.564034359726;43601;8545.102764209762;8727.519986400745;8730.519821409851;8730.781730456725;8738.475691458501;7876.763697089068;8112.391570632226;8115.918840811575;8304.128066553016;8584.184502472255;10111.848322275171;10433.269671123024;10436.582536698561;10820.350778953249;10829.133669306477;10489.73775655611;10539.736506587396;10549.41978191199;10553.73615659607;10561.155107591412;10451.163906887507;10499;10506.422146781924;10508.842367364496;10513.158947284199;40106;40348.596514034776;40352.59647403518;40379.1924161518;40395.39406908899;3032.848357582112;3083.1058992892035;3293.8517766700315;3341.5488908997218;3414.829258537063;30181.547276790865;30189.245268868235;30322.241943951358;30452.238694032825;32231;4134.131832315217;4178.603032711888;4351.0645211279725;4464.709793863389;4470.977645111753;343951;344897;345025;345886;347457;59469.70265148646;59648;59677.70161149166;60034.69982650059;60053.39946600478;61087;61371;61541.38458615446;61832;61884.690576546825;13849.653758656113;14554.854451455562;14575.271236438135;14582.052166609348;14594.635134121732;10499.160067194605;11018.228723989405;11019.338839669645;11025.83461248082;11033.007029367396;16592.585185370222;16941.491755247363;17833.375831845824;17990.339005178765;18496.35262765797;6683.866322673519;6821.69302381394;6867.141607299088;6959.930400696029;7063.85658382015;854.8931383577053;978.8091322192247;1010.368519675203;1019.6482213636284;1040.7294103532984;30369.69630303713;30925.226869328446;30949.535756963665;31235.219119522193;31356.529652055237;1022.6522982186092;1083.095615161349;1118.2172479264548;1126.4367816091954;1191.0531127753457;15992.92003539975;16553.83446165547;16564.83435165657;16699.9145055571;16787.664246714998;149776;149907;150108.24945875202;150561.24719376554;151248;50100.74949625228;50850.74574627103;54344.184837227476;55002.724986375615;55138;1275.515304184404;1303.3352989974992;1314.0276195615368;1319.8878095362002;1334.3395019465427;30149.246268842577;31242;31924.201894952814;32323.35353292968;33617.32765344728;54450.45549544454;55204;55325.72337138288;55332.44667553273;55453;451606;455448;456625;457213;458066;27557.724422755517;28174;29804.552931706476;29854.10437686786;42347.57652423436;43197.78401107974;44254.77872610616;45036.32445513254;46131.3080303789;46148;37883;37953.35816232204;38584.71846925434;38970.4154437678;40287.3956890641;37371.43942840914;37415.25169496649;37911.62088379191;38479.61520384761;39460.802695986335;38604.42093368658;38609.42085868658;38666;38872.61127388803;39944.4008339881;32487.512687309238;35407;35695.28609427745;36029.0992725184;36182.09544761297;26453;26862.865685671448;27145.412980816858;27271.31821704394;27358.759392294225 13:13:31 INFO - PROCESS | 22200 | |2;jquery.html;364.1333625970191;368.98893033209015;386.71769608186025;391.9000654833018;412.3608406969197;14645.853541464596;18194.81805181948;18890.62218755626;18963.620727585476;19645.50886227845;17733.379331723394;17746.46760597184;17908.55228619285;17916.731249031276;17975.370862019798;5291.074062039137;5559.527440167571;5610.214569960209;5617.269754931874;5638.746256418471;4139.668826493888;4295.063156973524;4368.344748287766;5542.1132618781;5648.378678345399;4309.418228539138;6290.339514350996;6303.212098487689;6305.716242769086;6338;5982.880342393171;6146.784862529835;6206.782762603287;6216.658083805389;6223.222097237845;5482.369527504348;5482.698451585161;5485.61600687952;5487.75305111271;5488.69812160335;22118.668219976713;22630.88684556583;22642.773572264232;22820;22864.771352286596;2168.92408765694;2245.2141750387395;2395.988020059906;2725.2641786717672;2842.6588809342807;13740.725185496334;14385.064970776866;14561.927190364086;15024.924875375553;15195.696086078327;1713.288985071194;1730.3424698614447;1739.20866005967;1742.9825701742948;1767.6994910865185;78175.60912195459;79246.60376698137;80203;81171.18828811696;81205.59397202976;10082.69751907444;10168.542415591317;10353.171746260281;10741.78516429667;10854.620088296871;14869.107853528823;14882.841987911908;14917.403303867724;14938.178400188093;15011.699766004618;7364.77905662831;7552.131504876899;7605;7769.650365733555;7896.565688887166;6910.619915904674;7037.753678621224;7234;7260.092488438945;7452.292032256927;6432.774852880127;6538.607683539003;6559.6064236145985;6571.868562628721;6599.274079851212;1886.0758228468226;1941.8834869907569;1944.5235917200093;1944.805519448044;1972.0928372948317;849.367221420046;1022.8516865054526;1049.732318258839;1066.594694016269;1073.9194560408;18816.455158843048;19565.217391304188;19688.803111968697;19762.505937351394;19820.60358792816;969.5733877094056;1013.2350075692805;1014.573878970834;1017.4149863828328;1066.2589500297374;10750.193735469871;11253.268537545033;11317.886821131848;11319.490622921989;11384.089272858151;367738;369735;370342;373066;497805;87730.56134719285;91675.99888013481;95377.52311238399;97067;97498;469.7017393954795;472.3623108803088;491.42748697767416;491.9409670839522;494.16486138425944;10515.894841051491;10899.455027248765;10953.83569246478;10954.452277386259;11561.30632162073;38904.60812445626;40041.59958400379;40849.795751021054;40971;42536.78731606322;54309.72845135749;54404.72797635986;55394;55436.16845747398;55987;7799.376049916106;8033.35733141359;8174.346052315919;8379.958100209704;8401.495910245405;9261.583228754587;12483.31341776211;12686.429110690226;12824.358782061046;13101.344932753515;10702.625408110678;10830.783384332111;10992.340459572451;11176.708774701005;11784.175107742376;10244.436555989194;10397.636082737068;10466.267361284637;10999.23005389615;11140.888591113986;10880.945595271973;11102.666919992413;11419.657410277705;11466.082713382742;11886.108541859223;8240.258376746122;8501.234888860032;8503.362247831561;8625.137486251324;8700.695475658322;9648.372855764354;11361.204715669825;11433;11450.885491144982;11577.031904576073 13:13:31 INFO - PROCESS | 22200 | |3;mootools.html;1324.516551458718;1430.1276221504884;1463.6487243061665;1558.7272227360215;1694.7118989771745;6976.895346569806;7878.842423151534;8198.303144232746;8200.425970182083;8357.665693372257;8207.58962051898;8263.628136733847;8267.503949763004;8268.255856972872;8282.213189746979;2250.313654335423;2279.247848210095;2280.692106565609;2281.7376001759762;2285.8057065149483;2220.245116660335;2286.531261091472;2289.759575244592;2291.656251562271;2291.8166546676307;2190.58378908007;2204;2209.657503087024;2215.4461384653837;2265.63749800032;2169.1215057901577;2173.695682604429;2180.618391781432;2213.302809614966;2215.3464727905307;2210.4142402263415;2220.822334213259;2228.4874478869788;2231.8884055797307;2238.731352237726;8054.677812887478;8237.629306681214;8310.459820111673;8312.459690120122;8323.583820808935;4809.5430934061205;5021.497850214986;5032.421271553745;5035.471275516092;5037.49625037497;3289.259916518788;3315.651856555075;3365.7812242204177;3432.626949220307;3457.7060949819297;1090.6891535912307;1091.1761619976867;1107.3245320354577;1109.2235435195396;1168.6902970712767;11130.16523760713;11174.050205732441;11228.270162439416;11249.381284029376;11249.493772780244;3881.3013657541915;4172.958270417257;4178.101708132766;4221.915561688749;4292.5063617683745;8949.865752013726;9017.053209413049;9036.954815226014;9052.27581793455;9056.683016094405;4870.805167793249;4877.6829506081995;4878.414590249193;4879.1461494238365;4879.512048795092;3905.5703872573995;4010.6189911958318;4468.32975053738;4549.067441174551;4574.565416285448;3594.335048016073;3594.856205751793;3597.2625611749527;3681.7975011374633;3693.0951916780023;1041.1098510773331;1043.446973104256;1050.2595670052594;1050.8896565860628;1064.7178497698117;873.6374404622138;874.5190145420121;881.9250363719156;901.9052999434965;906.1844340093836;5285.286486324297;5375.5162035417;5468.671879687232;5480.424555421703;5508.44915508446;873.7771868173575;914.4878867834034;927.452802846324;939.0703203828161;949.1457688080644;3505.4216054351255;3539.50446937429;3574.4459608760685;3620.402633565432;3652.845224754078;10036.548355324028;10402.531886065146;10413.47932603382;10416.114630256361;10417;10185.796284074277;10293.588256469808;10293.588256469808;10298.639547615798;10321.793564128675;7763.718986367299;7901.565413902291;7926.48477848938;7929.960350198212;7935.841283174304;4991.8752031198055;5089.236614507853;5152.149895267389;5224.947750522446;5345.625806193529;8936.329775267011;9061.275097992013;9238.722838314861;9318.068193180628;9395.248380129437;9330.813383732424;9337.906620933976;9391.577379018097;9426.717198484057;9452.574634141343;6169.691515424301;6354.078658594571;6354.618722876642;7043.612601306977;7227.7831665050135;7202.639868006474;7271.781846544613;7622.352100071556;7779.338756205786;7788.805279868048;7090.716371345295;7116.359527642537;7270.563766174047;7313.890291645524;7478.2521747824785;6880.208775990625;6900.872678451396;6961.547499412522;7011.789646310619;7240.601766902871;6198.566100372931;6201.286852012076;6249.406306400884;6255.530835187288;6257.749690012349;4514.390557274726;4616.953830461653;4678.321643361762;4694.225452800386;4769.66612337133;4580.839670611513;4581.496035436166;4719.622430205644;4725.50382209863;4816.638752093537 13:13:31 INFO - PROCESS | 22200 | |4;prototype.html;317.8744395963594;322.3150804540352;326.3082265596934;327.3763480569516;333.99165020874466;5087.186050231963;5090.363704536933;5102.668326558771;5134.127198376275;5149.922751158736;5050.661574682712;5056;5067.771950262238;5085.974570127153;5094;3872.7869967151796;3965.266425711253;3980.7412518186225;4030.858919937803;4054.945714114322;4068.1863627274665;4071.984367737959;4076.2866498362814;4084.346504559271;4092.7544347339253;4032.0565986829633;4043.6562892154056;4050.6961977851633;4052.5744796796353;4062.8577999770014;3828.272628200633;3833.5399752029657;3946.447497350359;4040.252553277653;4055.2903241932545;3593.2633810068874;3597.3165098631175;3602.7658202217035;3610.584782749991;3622.130688634735;4981.178105612569;4983.426905905831;4995;5002.274670172805;5002.799888004475;4491.136178485925;4577.756899119441;4606.769661516944;4624.583787459112;4628.861134165981;5275.815346462894;5293.602979776494;5309.761060752276;5324.254604355393;5341.385740639837;3914.745541539791;3928.332183528807;3930.8404020813928;3934.350832112698;3959;5283.63014588979;5521.365043020024;5554.555635549146;5561.277033985596;5570.663040870202;3951.7156923999814;3965.4844870166694;3970.1067259866877;3974.841006359771;3983.820728067244;4013.8996525087105;4014.458048163519;4016.5581786003518;4023.6177563131455;4033.1127152026506;4482.798274077674;4550.431196100488;4638.79125439356;4645.46577143626;4647.604953578983;5360.812371566976;5363.919541206885;5370.248165256867;5384.811531596453;5411.242426060355;1337.625464869838;1342.9597112086653;1349.1837438349853;1351.2433037498836;1351.3783659516732;878.7715194049593;939.5067589515559;947.0955237747934;949.4445749236636;950.3205208276116;5055.266986286968;5108.671745346237;5173.430922598511;5241.344831896013;5244.318238628954;5510.669359838423;5521.806736764194;5522.66863988162;5543.6396634218645;5558.916616250759;5124.820631277962;5269.420363759983;5280.20796880471;5280.339957505312;5288.391834938954;2804.709833476583;2834.4552219040675;2851.54375299951;2857.357094653728;2857.7428031477266;5400.785677872053;5544.3346798383645;5548.250986116904;5552.7778888844805;5554.944450555443;5109.554687421893;5297.258383826267;5340.092184328673;5356.3572371315695;5382.381026182039;5418.485243901823;5433.293671822637;5437.809676661377;5451;5451.64564303319;5314.707691076873;5315.900219413233;5318.680879147263;5323.574114070942;5334.813281535127;5050.570701490415;5267.420583735862;5270.4202537721585;5275.498827611371;5292.136740179613;5461.706083444883;5470.893705923168;5480.698561579152;5488.341399032141;5496.680796608865;3813.904652383713;3815.9618403815607;3819.789911554891;3827.1197624547067;3837.2901013312626;5203.5576975957465;5536.972315138399;5537.089704052096;5550.666959982414;5557.666540007613;5396.677813935611;5398.2982212312145;5403.648762830403;5417.702026388586;5433.728313584226;5186.299849520266;5377.435369286169;5389.299391079135;5411.350637923474;5435.10320797064;5298.15229563268;5314.840554783363;5319.46805319465;5330.920036199383;5336.412994570672;5158.3552055993005;5284.524392804666;5308.150695888639;5409.350877894678;5490.231367608618;5347.171188465794;5347.2728908256295;5362.865928351823;5364.678119312854;5377.139657654757 13:13:31 INFO - PROCESS | 22200 | |5;yui.html;751.5528260684894;751.9097708275007;779.8167430653796;782.8042989252687;810.3193317613204;12845.421956011978;13040.673983150426;13206.669833254173;13394.665133371658;13485.39315730792;13259;13485;13501.59495215145;13506.932465337659;13512.527061552848;657.3393739292005;674.6862708840388;746.5147654024887;749.6851322444586;772.5712229712507;770.7379490973068;782.37800948246;782.4366456151562;782.5617654113686;782.7064850680995;826.9090400055989;826.9214424629681;827.4414770030236;827.735124760077;829.1252728371566;691.0463560286772;700.7162099349772;804.6137853830194;822.4695071678764;822.7696245051366;592.076360877029;593.4214141212327;593.664579512574;593.8337265565606;593.9495142912857;12770.48918043277;12978.740425191538;13010.284434356106;13032.543860964915;13084;12932.224066556037;13373.264470454122;13682.110662806886;13727;13906.930465347608;11771.529138834436;12297.75404491914;12385.380730963416;12616.747665046647;12628.747425051448;4284.186004659136;4349.782510874444;4354.477462704464;4367.631430581417;4411.2941929291155;63650.36349636537;64878;64896;64910.350896490905;64992.35007649958;9775;9947.10476057144;10041.899581004243;10127.64553240633;10463.476826158661;17552.56118597045;17725.822741772674;17750.733738993924;17798.91100544515;18032;7305.780826575211;7438.7024519019715;7616.581088040211;7621.428392870557;7881.014873140857;4165.291900376943;4179.665626749853;4190.643795277436;4216.873493795191;4285.46431696038;3099.1632259289863;3194.9041528754174;3196.216926852936;3198.392305461955;3200.3279311344413;543.9265699130646;552.6739223857943;560.1821340842416;563.8759472915951;573.1488739222251;605.9454649081604;639.6066419152188;654.201873714068;655.849154694423;676.1581830620909;8198.754037378889;8488.74533763988;8515.144249979952;8623.655053797904;8640.783980400414;576.0207647000117;584.7397907931015;629.5058379172327;633.2084893882646;639.1658885154825;3872.6514613684903;3948.466956960831;4044.1176470588516;4083.6733061355612;4146.212219678251;82505;85258.57370713231;85675.57162214149;87635.12364876397;88995;46380.5361946383;47706.5229347709;60735.39264607386;65801.35496612528;73200.2679973204;50339.49660503421;61704.69147654233;62005;63069.36930630635;63596;8940.195382415613;9291.535423228946;9436.95281523588;9440.961494235491;9642.95178524131;42750.78624606857;43055.569444305154;43341.783291084605;43981.78009109934;44387.55612443964;54045.45954540404;56182.71908640431;59628.80742385215;60002.69998650153;60546.394536054075;11870.519657695646;12146.210496317712;12206.877931220573;12331.815022774845;12773.23360598367;13574.723338546388;13676.794848077487;13754.862451375358;13977.58067257984;14083.084599501;11314.434278285888;11402.958939000528;11451.004587566971;11510.36692981894;11874.881251187722;10700.464976750976;10986.176036797113;11379.601713940303;11405.087592992706;12415.751684966432;11072.723181920517;11295.096392288433;12853.550125745927;12980.415881285553;13234.669133271746;10835.187360947803;10943.343399396063;11323.773524529628;11430.485628146587;11875.76248475043;10413.739656508647;11004.724881878017;11017.151974471608;11231.21381503287;11268.605598804003 13:13:31 INFO - PROCESS | 22200 | __end_tp_report 13:13:31 INFO - PROCESS | 22200 | __start_cc_report 13:13:31 INFO - PROCESS | 22200 | _x_x_mozilla_cycle_collect,1395 13:13:31 INFO - PROCESS | 22200 | __end_cc_report 13:13:31 INFO - PROCESS | 22200 | __startTimestamp1479503611010__endTimestamp 13:13:31 INFO - PROCESS | 22200 | 13:13:31 INFO - PROCESS | 22200 | ------- Summary: start ------- 13:13:31 INFO - PROCESS | 22200 | Number of tests: 6 13:13:31 INFO - PROCESS | 22200 | 13:13:31 INFO - PROCESS | 22200 | [#0] dojo.html Cycles:165 Average:5278.01 Median:5493.86 stddev:621.40 (11.3%) stddev-sans-first:597.31 13:13:31 INFO - PROCESS | 22200 | Values: 3011.1 3016.9 3053.1 3060.8 3065.0 5163.7 5235.3 5325.8 5354.9 5394.4 5250.0 5251.3 5268.1 5268.2 5271.0 4744.1 4771.9 4783.7 4808.2 4812.8 4847.4 4880.4 4889.4 4891.2 4892.5 4811.5 4863.9 4869.2 4889.0 4895.8 4914.6 4915.7 4934.6 4940.0 4984.5 4761.7 4784.4 4798.3 4854.3 4895.2 5329.6 5349.8 5351.1 5354.5 5414.8 5675.2 5727.5 5744.5 5749.9 5750.1 5571.7 5644.1 5686.0 5713.1 5756.9 5313.8 5340.6 5341.3 5386.0 5387.8 5830.5 5831.3 5833.9 5846.3 5848.6 5434.4 5473.5 5597.7 5606.6 5615.8 5623.1 5660.5 5671.2 5696.9 5749.1 5611.6 5657.8 5662.4 5663.8 5669.2 5528.8 5622.8 5676.4 5684.0 5712.4 4132.9 4159.8 4171.2 4206.4 4207.6 3762.1 3768.3 3785.0 3800.7 3803.6 5478.1 5481.3 5486.4 5489.3 5517.9 5607.6 5623.1 5649.4 5670.7 5778.4 5359.8 5395.8 5401.9 5403.1 5405.4 4724.8 4759.1 4765.4 4766.8 4811.1 5711.8 5820.5 5827.3 5837.9 5867.3 5665.4 5729.5 5734.3 5735.4 5741.9 5878.7 5884.4 5884.6 5890.0 5914.6 5688.3 5692.5 5702.5 5725.7 5740.7 5720.6 5768.5 5778.0 5779.8 5786.7 5475.5 5493.9 5539.2 5631.8 5639.4 5502.5 5524.2 5535.9 5542.7 5571.6 5438.4 5445.2 5473.6 5477.3 5478.9 5531.1 5553.0 5571.4 5579.4 5630.2 5496.7 5501.8 5511.5 5512.4 5513.2 13:13:31 INFO - PROCESS | 22200 | 13:13:31 INFO - PROCESS | 22200 | [#1] ext.html Cycles:180 Average:49314.00 Median:35203.74 stddev:90630.98 (257.4%) stddev-sans-first:90811.29 13:13:31 INFO - PROCESS | 22200 | Values: 554.3 589.5 601.4 608.8 627.7 32190.5 32577.3 35000.5 39366.0 41241.8 43223.6 43507.6 43563.3 43596.6 43601.0 8545.1 8727.5 8730.5 8730.8 8738.5 7876.8 8112.4 8115.9 8304.1 8584.2 10111.8 10433.3 10436.6 10820.4 10829.1 10489.7 10539.7 10549.4 10553.7 10561.2 10451.2 10499.0 10506.4 10508.8 10513.2 40106.0 40348.6 40352.6 40379.2 40395.4 3032.8 3083.1 3293.9 3341.5 3414.8 30181.5 30189.2 30322.2 30452.2 32231.0 4134.1 4178.6 4351.1 4464.7 4471.0 343951.0 344897.0 345025.0 345886.0 347457.0 59469.7 59648.0 59677.7 60034.7 60053.4 61087.0 61371.0 61541.4 61832.0 61884.7 13849.7 14554.9 14575.3 14582.1 14594.6 10499.2 11018.2 11019.3 11025.8 11033.0 16592.6 16941.5 17833.4 17990.3 18496.4 6683.9 6821.7 6867.1 6959.9 7063.9 854.9 978.8 1010.4 1019.6 1040.7 30369.7 30925.2 30949.5 31235.2 31356.5 1022.7 1083.1 1118.2 1126.4 1191.1 15992.9 16553.8 16564.8 16699.9 16787.7 149776.0 149907.0 150108.2 150561.2 151248.0 50100.7 50850.7 54344.2 55002.7 55138.0 1275.5 1303.3 1314.0 1319.9 1334.3 30149.2 31242.0 31924.2 32323.4 33617.3 54450.5 55204.0 55325.7 55332.4 55453.0 451606.0 455448.0 456625.0 457213.0 458066.0 27557.7 28174.0 29804.6 29854.1 42347.6 43197.8 44254.8 45036.3 46131.3 46148.0 37883.0 37953.4 38584.7 38970.4 40287.4 37371.4 37415.3 37911.6 38479.6 39460.8 38604.4 38609.4 38666.0 38872.6 39944.4 32487.5 35407.0 35695.3 36029.1 36182.1 26453.0 26862.9 27145.4 27271.3 27358.8 13:13:31 INFO - PROCESS | 22200 | 13:13:31 INFO - PROCESS | 22200 | [#2] jquery.html Cycles:180 Average:26022.41 Median:1603.40 stddev:66473.50 (4145.8%) stddev-sans-first:66632.06 13:13:31 INFO - PROCESS | 22200 | Values: 364.1 369.0 386.7 391.9 412.4 14645.9 18194.8 18890.6 18963.6 19645.5 17733.4 17746.5 17908.6 17916.7 17975.4 5291.1 5559.5 5610.2 5617.3 5638.7 4139.7 4295.1 4368.3 5542.1 5648.4 4309.4 6290.3 6303.2 6305.7 6338.0 5982.9 6146.8 6206.8 6216.7 6223.2 5482.4 5482.7 5485.6 5487.8 5488.7 22118.7 22630.9 22642.8 22820.0 22864.8 2168.9 2245.2 2396.0 2725.3 2842.7 13740.7 14385.1 14561.9 15024.9 15195.7 1713.3 1730.3 1739.2 1743.0 1767.7 78175.6 79246.6 80203.0 81171.2 81205.6 10082.7 10168.5 10353.2 10741.8 10854.6 14869.1 14882.8 14917.4 14938.2 15011.7 7364.8 7552.1 7605.0 7769.7 7896.6 6910.6 7037.8 7234.0 7260.1 7452.3 6432.8 6538.6 6559.6 6571.9 6599.3 1886.1 1941.9 1944.5 1944.8 1972.1 849.4 1022.9 1049.7 1066.6 1073.9 18816.5 19565.2 19688.8 19762.5 19820.6 969.6 1013.2 1014.6 1017.4 1066.3 10750.2 11253.3 11317.9 11319.5 11384.1 367738.0 369735.0 370342.0 373066.0 497805.0 87730.6 91676.0 95377.5 97067.0 97498.0 469.7 472.4 491.4 491.9 494.2 10515.9 10899.5 10953.8 10954.5 11561.3 38904.6 40041.6 40849.8 40971.0 42536.8 54309.7 54404.7 55394.0 55436.2 55987.0 7799.4 8033.4 8174.3 8380.0 8401.5 9261.6 12483.3 12686.4 12824.4 13101.3 10702.6 10830.8 10992.3 11176.7 11784.2 10244.4 10397.6 10466.3 10999.2 11140.9 10880.9 11102.7 11419.7 11466.1 11886.1 8240.3 8501.2 8503.4 8625.1 8700.7 9648.4 11361.2 11433.0 11450.9 11577.0 13:13:31 INFO - PROCESS | 22200 | 13:13:31 INFO - PROCESS | 22200 | [#3] mootools.html Cycles:180 Average:5329.56 Median:4843.72 stddev:3014.72 (62.2%) stddev-sans-first:3008.15 13:13:31 INFO - PROCESS | 22200 | Values: 1324.5 1430.1 1463.6 1558.7 1694.7 6976.9 7878.8 8198.3 8200.4 8357.7 8207.6 8263.6 8267.5 8268.3 8282.2 2250.3 2279.2 2280.7 2281.7 2285.8 2220.2 2286.5 2289.8 2291.7 2291.8 2190.6 2204.0 2209.7 2215.4 2265.6 2169.1 2173.7 2180.6 2213.3 2215.3 2210.4 2220.8 2228.5 2231.9 2238.7 8054.7 8237.6 8310.5 8312.5 8323.6 4809.5 5021.5 5032.4 5035.5 5037.5 3289.3 3315.7 3365.8 3432.6 3457.7 1090.7 1091.2 1107.3 1109.2 1168.7 11130.2 11174.1 11228.3 11249.4 11249.5 3881.3 4173.0 4178.1 4221.9 4292.5 8949.9 9017.1 9037.0 9052.3 9056.7 4870.8 4877.7 4878.4 4879.1 4879.5 3905.6 4010.6 4468.3 4549.1 4574.6 3594.3 3594.9 3597.3 3681.8 3693.1 1041.1 1043.4 1050.3 1050.9 1064.7 873.6 874.5 881.9 901.9 906.2 5285.3 5375.5 5468.7 5480.4 5508.4 873.8 914.5 927.5 939.1 949.1 3505.4 3539.5 3574.4 3620.4 3652.8 10036.5 10402.5 10413.5 10416.1 10417.0 10185.8 10293.6 10293.6 10298.6 10321.8 7763.7 7901.6 7926.5 7930.0 7935.8 4991.9 5089.2 5152.1 5224.9 5345.6 8936.3 9061.3 9238.7 9318.1 9395.2 9330.8 9337.9 9391.6 9426.7 9452.6 6169.7 6354.1 6354.6 7043.6 7227.8 7202.6 7271.8 7622.4 7779.3 7788.8 7090.7 7116.4 7270.6 7313.9 7478.3 6880.2 6900.9 6961.5 7011.8 7240.6 6198.6 6201.3 6249.4 6255.5 6257.7 4514.4 4617.0 4678.3 4694.2 4769.7 4580.8 4581.5 4719.6 4725.5 4816.6 13:13:31 INFO - PROCESS | 22200 | 13:13:31 INFO - PROCESS | 22200 | [#4] prototype.html Cycles:180 Average:4496.58 Median:5165.89 stddev:1303.27 (25.2%) stddev-sans-first:1268.62 13:13:31 INFO - PROCESS | 22200 | Values: 317.9 322.3 326.3 327.4 334.0 5087.2 5090.4 5102.7 5134.1 5149.9 5050.7 5056.0 5067.8 5086.0 5094.0 3872.8 3965.3 3980.7 4030.9 4054.9 4068.2 4072.0 4076.3 4084.3 4092.8 4032.1 4043.7 4050.7 4052.6 4062.9 3828.3 3833.5 3946.4 4040.3 4055.3 3593.3 3597.3 3602.8 3610.6 3622.1 4981.2 4983.4 4995.0 5002.3 5002.8 4491.1 4577.8 4606.8 4624.6 4628.9 5275.8 5293.6 5309.8 5324.3 5341.4 3914.7 3928.3 3930.8 3934.4 3959.0 5283.6 5521.4 5554.6 5561.3 5570.7 3951.7 3965.5 3970.1 3974.8 3983.8 4013.9 4014.5 4016.6 4023.6 4033.1 4482.8 4550.4 4638.8 4645.5 4647.6 5360.8 5363.9 5370.2 5384.8 5411.2 1337.6 1343.0 1349.2 1351.2 1351.4 878.8 939.5 947.1 949.4 950.3 5055.3 5108.7 5173.4 5241.3 5244.3 5510.7 5521.8 5522.7 5543.6 5558.9 5124.8 5269.4 5280.2 5280.3 5288.4 2804.7 2834.5 2851.5 2857.4 2857.7 5400.8 5544.3 5548.3 5552.8 5554.9 5109.6 5297.3 5340.1 5356.4 5382.4 5418.5 5433.3 5437.8 5451.0 5451.6 5314.7 5315.9 5318.7 5323.6 5334.8 5050.6 5267.4 5270.4 5275.5 5292.1 5461.7 5470.9 5480.7 5488.3 5496.7 3813.9 3816.0 3819.8 3827.1 3837.3 5203.6 5537.0 5537.1 5550.7 5557.7 5396.7 5398.3 5403.6 5417.7 5433.7 5186.3 5377.4 5389.3 5411.4 5435.1 5298.2 5314.8 5319.5 5330.9 5336.4 5158.4 5284.5 5308.2 5409.4 5490.2 5347.2 5347.3 5362.9 5364.7 5377.1 13:13:31 INFO - PROCESS | 22200 | 13:13:31 INFO - PROCESS | 22200 | [#5] yui.html Cycles:180 Average:16541.18 Median:24196.54 stddev:21646.48 (89.5%) stddev-sans-first:21674.73 13:13:31 INFO - PROCESS | 22200 | Values: 751.6 751.9 779.8 782.8 810.3 12845.4 13040.7 13206.7 13394.7 13485.4 13259.0 13485.0 13501.6 13506.9 13512.5 657.3 674.7 746.5 749.7 772.6 770.7 782.4 782.4 782.6 782.7 826.9 826.9 827.4 827.7 829.1 691.0 700.7 804.6 822.5 822.8 592.1 593.4 593.7 593.8 593.9 12770.5 12978.7 13010.3 13032.5 13084.0 12932.2 13373.3 13682.1 13727.0 13906.9 11771.5 12297.8 12385.4 12616.7 12628.7 4284.2 4349.8 4354.5 4367.6 4411.3 63650.4 64878.0 64896.0 64910.4 64992.4 9775.0 9947.1 10041.9 10127.6 10463.5 17552.6 17725.8 17750.7 17798.9 18032.0 7305.8 7438.7 7616.6 7621.4 7881.0 4165.3 4179.7 4190.6 4216.9 4285.5 3099.2 3194.9 3196.2 3198.4 3200.3 543.9 552.7 560.2 563.9 573.1 605.9 639.6 654.2 655.8 676.2 8198.8 8488.7 8515.1 8623.7 8640.8 576.0 584.7 629.5 633.2 639.2 3872.7 3948.5 4044.1 4083.7 4146.2 82505.0 85258.6 85675.6 87635.1 88995.0 46380.5 47706.5 60735.4 65801.4 73200.3 50339.5 61704.7 62005.0 63069.4 63596.0 8940.2 9291.5 9437.0 9441.0 9643.0 42750.8 43055.6 43341.8 43981.8 44387.6 54045.5 56182.7 59628.8 60002.7 60546.4 11870.5 12146.2 12206.9 12331.8 12773.2 13574.7 13676.8 13754.9 13977.6 14083.1 11314.4 11403.0 11451.0 11510.4 11874.9 10700.5 10986.2 11379.6 11405.1 12415.8 11072.7 11295.1 12853.6 12980.4 13234.7 10835.2 10943.3 11323.8 11430.5 11875.8 10413.7 11004.7 11017.2 11231.2 11268.6 13:13:31 INFO - PROCESS | 22200 | -------- Summary: end -------- 13:13:31 INFO - PROCESS | 22200 | 13:13:31 INFO - TEST-INFO | 22200: exit 0 13:13:31 INFO - TEST-OK | dromaeo_css | took 1118092ms 13:13:31 INFO - TEST-START | kraken 13:13:31 INFO - operating with platform_type : linux_ 13:13:31 INFO - Initialising browser for kraken test... 13:13:31 INFO - TEST-INFO | started process 22499 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdm_SMN/profile http://localhost:56822/getInfo.html) 13:13:36 INFO - PROCESS | 22499 | __metrics Screen width/height:1600/1200 13:13:36 INFO - PROCESS | 22499 | colorDepth:24 13:13:36 INFO - PROCESS | 22499 | Browser inner width/height: 1024/697 13:13:36 INFO - PROCESS | 22499 | __metrics 13:13:36 INFO - PROCESS | 22499 | 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" 13:13:36 INFO - PROCESS | 22499 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:13:37 INFO - PROCESS | 22499 | console.error: PushService: 13:13:37 INFO - PROCESS | 22499 | stateChangeProcessEnqueue: Error transitioning state 13:13:37 INFO - PROCESS | 22499 | UnknownError 13:13:37 INFO - TEST-INFO | 22499: exit 0 13:13:37 INFO - Browser initialized. 13:13:37 INFO - Running cycle 1/1 for kraken test... 13:13:37 INFO - TEST-INFO | started process 22581 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdm_SMN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:13:50 INFO - PROCESS | 22581 | RSS: Main: 173727744 13:13:50 INFO - PROCESS | 22581 | 13:13:52 INFO - PROCESS | 22581 | Cycle 1(1): loaded http://localhost:56822/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56822/tests/kraken/driver.html?testName=audio-beat-detection) 13:13:53 INFO - PROCESS | 22581 | RSS: Main: 230436864 13:13:53 INFO - PROCESS | 22581 | 13:13:56 INFO - PROCESS | 22581 | Cycle 1(1): loaded http://localhost:56822/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56822/tests/kraken/driver.html?testName=audio-dft) 13:13:56 INFO - PROCESS | 22581 | RSS: Main: 216944640 13:13:56 INFO - PROCESS | 22581 | 13:13:59 INFO - PROCESS | 22581 | Cycle 1(1): loaded http://localhost:56822/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56822/tests/kraken/driver.html?testName=audio-fft) 13:14:00 INFO - PROCESS | 22581 | RSS: Main: 299139072 13:14:00 INFO - PROCESS | 22581 | 13:14:02 INFO - PROCESS | 22581 | Cycle 1(1): loaded http://localhost:56822/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56822/tests/kraken/driver.html?testName=audio-oscillator) 13:14:03 INFO - PROCESS | 22581 | RSS: Main: 207998976 13:14:03 INFO - PROCESS | 22581 | 13:14:05 INFO - PROCESS | 22581 | Cycle 1(1): loaded http://localhost:56822/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56822/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:14:05 INFO - PROCESS | 22581 | RSS: Main: 213823488 13:14:05 INFO - PROCESS | 22581 | 13:14:08 INFO - PROCESS | 22581 | Cycle 1(1): loaded http://localhost:56822/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56822/tests/kraken/driver.html?testName=imaging-darkroom) 13:14:09 INFO - PROCESS | 22581 | RSS: Main: 253972480 13:14:09 INFO - PROCESS | 22581 | 13:14:12 INFO - PROCESS | 22581 | Cycle 1(1): loaded http://localhost:56822/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56822/tests/kraken/driver.html?testName=imaging-desaturate) 13:14:13 INFO - PROCESS | 22581 | RSS: Main: 252866560 13:14:13 INFO - PROCESS | 22581 | 13:14:16 INFO - PROCESS | 22581 | Cycle 1(1): loaded http://localhost:56822/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56822/tests/kraken/driver.html?testName=json-parse-financial) 13:14:16 INFO - PROCESS | 22581 | RSS: Main: 251621376 13:14:16 INFO - PROCESS | 22581 | 13:14:18 INFO - PROCESS | 22581 | Cycle 1(1): loaded http://localhost:56822/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56822/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:14:18 INFO - PROCESS | 22581 | RSS: Main: 213803008 13:14:18 INFO - PROCESS | 22581 | 13:14:20 INFO - PROCESS | 22581 | Cycle 1(1): loaded http://localhost:56822/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56822/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:14:21 INFO - PROCESS | 22581 | RSS: Main: 220401664 13:14:21 INFO - PROCESS | 22581 | 13:14:23 INFO - PROCESS | 22581 | Cycle 1(1): loaded http://localhost:56822/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56822/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:14:23 INFO - PROCESS | 22581 | RSS: Main: 230031360 13:14:23 INFO - PROCESS | 22581 | 13:14:26 INFO - PROCESS | 22581 | Cycle 1(1): loaded http://localhost:56822/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56822/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:14:27 INFO - PROCESS | 22581 | RSS: Main: 240566272 13:14:27 INFO - PROCESS | 22581 | 13:14:30 INFO - PROCESS | 22581 | Cycle 1(1): loaded http://localhost:56822/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56822/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:14:30 INFO - PROCESS | 22581 | RSS: Main: 235618304 13:14:30 INFO - PROCESS | 22581 | 13:14:32 INFO - PROCESS | 22581 | Cycle 1(1): loaded http://localhost:56822/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56822/tests/kraken/driver.html?testName=ai-astar) 13:14:32 INFO - PROCESS | 22581 | RSS: Main: 287203328 13:14:32 INFO - PROCESS | 22581 | 13:14:32 INFO - PROCESS | 22581 | __start_tp_report 13:14:32 INFO - PROCESS | 22581 | _x_x_mozilla_page_load 13:14:32 INFO - PROCESS | 22581 | _x_x_mozilla_page_load_details 13:14:32 INFO - PROCESS | 22581 | |i|pagename|runs| 13:14:32 INFO - PROCESS | 22581 | |0;ai-astar;106;113;112;112;113;112;113;112;112;111 13:14:32 INFO - PROCESS | 22581 | |1;audio-beat-detection;149;123;127;170;124;127;123;123;158;126 13:14:32 INFO - PROCESS | 22581 | |2;audio-dft;161;163;161;161;163;161;163;161;164;161 13:14:32 INFO - PROCESS | 22581 | |3;audio-fft;76;74;76;110;75;77;75;74;101;75 13:14:32 INFO - PROCESS | 22581 | |4;audio-oscillator;83;83;122;82;83;82;100;81;81;115 13:14:32 INFO - PROCESS | 22581 | |5;imaging-gaussian-blur;117;116;116;117;116;117;117;117;117;117 13:14:32 INFO - PROCESS | 22581 | |6;imaging-darkroom;148;148;147;147;147;147;146;147;147;147 13:14:32 INFO - PROCESS | 22581 | |7;imaging-desaturate;96;95;96;95;96;96;95;96;96;95 13:14:32 INFO - PROCESS | 22581 | |8;json-parse-financial;53;52;50;50;52;51;51;51;52;52 13:14:32 INFO - PROCESS | 22581 | |9;json-stringify-tinderbox;64;62;62;62;62;62;62;62;63;62 13:14:32 INFO - PROCESS | 22581 | |10;stanford-crypto-aes;80;80;87;81;80;80;80;83;80;86 13:14:32 INFO - PROCESS | 22581 | |11;stanford-crypto-ccm;133;138;131;130;139;136;147;143;189;135 13:14:32 INFO - PROCESS | 22581 | |12;stanford-crypto-pbkdf2;167;162;168;167;162;164;163;161;163;164 13:14:32 INFO - PROCESS | 22581 | |13;stanford-crypto-sha256-iterative;67;68;67;63;74;64;68;66;63;62 13:14:32 INFO - PROCESS | 22581 | __end_tp_report 13:14:32 INFO - PROCESS | 22581 | __start_cc_report 13:14:32 INFO - PROCESS | 22581 | _x_x_mozilla_cycle_collect,1639 13:14:32 INFO - PROCESS | 22581 | __end_cc_report 13:14:32 INFO - PROCESS | 22581 | __startTimestamp1479503672698__endTimestamp 13:14:32 INFO - PROCESS | 22581 | 13:14:32 INFO - PROCESS | 22581 | ------- Summary: start ------- 13:14:32 INFO - PROCESS | 22581 | Number of tests: 14 13:14:32 INFO - PROCESS | 22581 | 13:14:32 INFO - PROCESS | 22581 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:2.07 (1.8%) stddev-sans-first:0.67 13:14:32 INFO - PROCESS | 22581 | Values: 106.0 113.0 112.0 112.0 113.0 112.0 113.0 112.0 112.0 111.0 13:14:32 INFO - PROCESS | 22581 | 13:14:32 INFO - PROCESS | 22581 | [#1] audio-beat-detection Cycles:10 Average:135.00 Median:127.00 stddev:17.36 (13.7%) stddev-sans-first:17.66 13:14:32 INFO - PROCESS | 22581 | Values: 149.0 123.0 127.0 170.0 124.0 127.0 123.0 123.0 158.0 126.0 13:14:32 INFO - PROCESS | 22581 | 13:14:32 INFO - PROCESS | 22581 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.20 (0.7%) stddev-sans-first:1.22 13:14:32 INFO - PROCESS | 22581 | Values: 161.0 163.0 161.0 161.0 163.0 161.0 163.0 161.0 164.0 161.0 13:14:32 INFO - PROCESS | 22581 | 13:14:32 INFO - PROCESS | 22581 | [#3] audio-fft Cycles:10 Average:81.30 Median:75.00 stddev:12.96 (17.3%) stddev-sans-first:13.61 13:14:32 INFO - PROCESS | 22581 | Values: 76.0 74.0 76.0 110.0 75.0 77.0 75.0 74.0 101.0 75.0 13:14:32 INFO - PROCESS | 22581 | 13:14:32 INFO - PROCESS | 22581 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:82.00 stddev:15.53 (18.9%) stddev-sans-first:16.19 13:14:32 INFO - PROCESS | 22581 | Values: 83.0 83.0 122.0 82.0 83.0 82.0 100.0 81.0 81.0 115.0 13:14:32 INFO - PROCESS | 22581 | 13:14:32 INFO - PROCESS | 22581 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 13:14:32 INFO - PROCESS | 22581 | Values: 117.0 116.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 13:14:32 INFO - PROCESS | 22581 | 13:14:32 INFO - PROCESS | 22581 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 13:14:32 INFO - PROCESS | 22581 | Values: 148.0 148.0 147.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 13:14:32 INFO - PROCESS | 22581 | 13:14:32 INFO - PROCESS | 22581 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 13:14:32 INFO - PROCESS | 22581 | Values: 96.0 95.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 95.0 13:14:32 INFO - PROCESS | 22581 | 13:14:32 INFO - PROCESS | 22581 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:52.00 stddev:0.97 (1.9%) stddev-sans-first:0.83 13:14:32 INFO - PROCESS | 22581 | Values: 53.0 52.0 50.0 50.0 52.0 51.0 51.0 51.0 52.0 52.0 13:14:32 INFO - PROCESS | 22581 | 13:14:32 INFO - PROCESS | 22581 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.33 13:14:32 INFO - PROCESS | 22581 | Values: 64.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 63.0 62.0 13:14:32 INFO - PROCESS | 22581 | 13:14:32 INFO - PROCESS | 22581 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:80.50 stddev:2.71 (3.4%) stddev-sans-first:2.80 13:14:32 INFO - PROCESS | 22581 | Values: 80.0 80.0 87.0 81.0 80.0 80.0 80.0 83.0 80.0 86.0 13:14:32 INFO - PROCESS | 22581 | 13:14:32 INFO - PROCESS | 22581 | [#11] stanford-crypto-ccm Cycles:10 Average:142.10 Median:138.50 stddev:17.29 (12.5%) stddev-sans-first:18.02 13:14:32 INFO - PROCESS | 22581 | Values: 133.0 138.0 131.0 130.0 139.0 136.0 147.0 143.0 189.0 135.0 13:14:32 INFO - PROCESS | 22581 | 13:14:32 INFO - PROCESS | 22581 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.10 Median:164.00 stddev:2.42 (1.5%) stddev-sans-first:2.33 13:14:32 INFO - PROCESS | 22581 | Values: 167.0 162.0 168.0 167.0 162.0 164.0 163.0 161.0 163.0 164.0 13:14:32 INFO - PROCESS | 22581 | 13:14:32 INFO - PROCESS | 22581 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:67.00 stddev:3.52 (5.3%) stddev-sans-first:3.72 13:14:32 INFO - PROCESS | 22581 | Values: 67.0 68.0 67.0 63.0 74.0 64.0 68.0 66.0 63.0 62.0 13:14:32 INFO - PROCESS | 22581 | -------- Summary: end -------- 13:14:32 INFO - PROCESS | 22581 | 13:14:33 INFO - TEST-INFO | 22581: exit 0 13:14:33 INFO - TEST-OK | kraken | took 61953ms 13:14:33 INFO - SUITE-END | took 1180s 13:14:34 INFO - Completed test suite (00:19:40) 13:14:34 INFO - javascript benchmark 13:14:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3011.0665693634974, 3016.913910992044, 3053.084074777566, 3060.7857449978496, 3065.049834551289, 5163.690178589287, 5235.293235413218, 5325.760340784665, 5354.946450535489, 5394.379646340672, 5249.973750131244, 5251.317328747257, 5268.0780863348955, 5268.1834315681035, 5270.9736451317785, 4744.0511897620445, 4771.928421073687, 4783.7129772213775, 4808.158572249859, 4812.831550895719, 4847.418309802829, 4880.438749543795, 4889.3888263967, 4891.16850135476, 4892.510748925115, 4811.470738218811, 4863.927041094386, 4869.220924652056, 4888.9511104889025, 4895.828645997391, 4914.606831453493, 4915.729634870081, 4934.580560652349, 4939.950600493985, 4984.526469985346, 4761.6904901181315, 4784.42586889572, 4798.280257961299, 4854.2718592211095, 4895.2167653175675, 5329.573634109301, 5349.759260833272, 5351.090314646481, 5354.464553544653, 5414.7834086636485, 5675.233843431167, 5727.484526392603, 5744.482996530291, 5749.942500574983, 5750.108733146369, 5571.693556854371, 5644.096944488862, 5685.971570142165, 5713.057345537981, 5756.8848623027725, 5313.787448502056, 5340.572754179656, 5341.252224688546, 5386.0, 5387.8383648491, 5830.5044071254415, 5831.271091113611, 5833.854153646193, 5846.298444186725, 5848.619839710405, 5434.429384914527, 5473.507384335349, 5597.692126933058, 5606.579506537026, 5615.775368985195, 5623.0721930880945, 5660.490555849911, 5671.234383358276, 5696.857578560569, 5749.108888122348, 5611.607187496836, 5657.8019769307875, 5662.37713851476, 5663.801766938137, 5669.177969194444, 5528.778848846001, 5622.803201887914, 5676.4323567642905, 5683.9715801420725, 5712.428757124254, 4132.91734165315, 4159.83360665576, 4171.186618609403, 4206.369044643328, 4207.600277973587, 3762.097096696828, 3768.3217020936495, 3784.962150378516, 3800.733948623625, 3803.581606023335, 5478.123500240023, 5481.342238931274, 5486.396496385394, 5489.313835770528, 5517.889642207133, 5607.607467477237, 5623.072193088176, 5649.350324712711, 5670.659760414388, 5778.422157784272, 5359.839204823861, 5395.7841686332895, 5401.891962160735, 5403.13549832025, 5405.432429594836, 4724.809990225211, 4759.0719809637485, 4765.380500534909, 4766.76166191689, 4811.061842940593, 5711.828645140652, 5820.534357251325, 5827.3007239131575, 5837.941620583825, 5867.295924488918, 5665.405132461032, 5729.455701708331, 5734.283214598176, 5735.3977832327, 5741.91387129185, 5878.706064696834, 5884.382139875423, 5884.617499862496, 5890.028145355968, 5914.585978981602, 5688.317401911797, 5692.51613612831, 5702.5437964961875, 5725.6850873202375, 5740.741666624928, 5720.570957178145, 5768.451997060272, 5778.0, 5779.797707080232, 5786.6528008317955, 5475.479829416199, 5493.862653433696, 5539.224508568723, 5631.831045068655, 5639.436056394327, 5502.532284755681, 5524.226608274765, 5535.916961245665, 5542.667439953616, 5571.582131340247, 5438.374586922555, 5445.156000819879, 5473.589480788877, 5477.3427188737605, 5478.945210548003, 5531.115021596525, 5552.972235138798, 5571.359293681278, 5579.358373787067, 5630.211770352072, 5496.725163741877, 5501.834944951658, 5511.5315198207, 5512.4211957745465, 5513.228148059355], "value": 5234.08619912778, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.2874180666416, 589.4900910712233, 601.4196300569946, 608.7625825927887, 627.6767464755654, 32190.517142242858, 32577.348453030954, 35000.474992875126, 39366.0, 41241.79379103108, 43223.567764322346, 43507.56492435075, 43563.346549801776, 43596.564034359726, 43601.0, 8545.102764209762, 8727.519986400745, 8730.519821409851, 8730.781730456725, 8738.475691458501, 7876.763697089068, 8112.391570632226, 8115.918840811575, 8304.128066553016, 8584.184502472255, 10111.848322275171, 10433.269671123024, 10436.582536698561, 10820.350778953249, 10829.133669306477, 10489.73775655611, 10539.736506587396, 10549.41978191199, 10553.73615659607, 10561.155107591412, 10451.163906887507, 10499.0, 10506.422146781924, 10508.842367364496, 10513.158947284199, 40106.0, 40348.596514034776, 40352.59647403518, 40379.1924161518, 40395.39406908899, 3032.848357582112, 3083.1058992892035, 3293.8517766700315, 3341.5488908997218, 3414.829258537063, 30181.547276790865, 30189.245268868235, 30322.241943951358, 30452.238694032825, 32231.0, 4134.131832315217, 4178.603032711888, 4351.0645211279725, 4464.709793863389, 4470.977645111753, 343951.0, 344897.0, 345025.0, 345886.0, 347457.0, 59469.70265148646, 59648.0, 59677.70161149166, 60034.69982650059, 60053.39946600478, 61087.0, 61371.0, 61541.38458615446, 61832.0, 61884.690576546825, 13849.653758656113, 14554.854451455562, 14575.271236438135, 14582.052166609348, 14594.635134121732, 10499.160067194605, 11018.228723989405, 11019.338839669645, 11025.83461248082, 11033.007029367396, 16592.585185370222, 16941.491755247363, 17833.375831845824, 17990.339005178765, 18496.35262765797, 6683.866322673519, 6821.69302381394, 6867.141607299088, 6959.930400696029, 7063.85658382015, 854.8931383577053, 978.8091322192247, 1010.368519675203, 1019.6482213636284, 1040.7294103532984, 30369.69630303713, 30925.226869328446, 30949.535756963665, 31235.219119522193, 31356.529652055237, 1022.6522982186092, 1083.095615161349, 1118.2172479264548, 1126.4367816091954, 1191.0531127753457, 15992.92003539975, 16553.83446165547, 16564.83435165657, 16699.9145055571, 16787.664246714998, 149776.0, 149907.0, 150108.24945875202, 150561.24719376554, 151248.0, 50100.74949625228, 50850.74574627103, 54344.184837227476, 55002.724986375615, 55138.0, 1275.515304184404, 1303.3352989974992, 1314.0276195615368, 1319.8878095362002, 1334.3395019465427, 30149.246268842577, 31242.0, 31924.201894952814, 32323.35353292968, 33617.32765344728, 54450.45549544454, 55204.0, 55325.72337138288, 55332.44667553273, 55453.0, 451606.0, 455448.0, 456625.0, 457213.0, 458066.0, 27557.724422755517, 28174.0, 29804.552931706476, 29854.10437686786, 42347.57652423436, 43197.78401107974, 44254.77872610616, 45036.32445513254, 46131.3080303789, 46148.0, 37883.0, 37953.35816232204, 38584.71846925434, 38970.4154437678, 40287.3956890641, 37371.43942840914, 37415.25169496649, 37911.62088379191, 38479.61520384761, 39460.802695986335, 38604.42093368658, 38609.42085868658, 38666.0, 38872.61127388803, 39944.4008339881, 32487.512687309238, 35407.0, 35695.28609427745, 36029.0992725184, 36182.09544761297, 26453.0, 26862.865685671448, 27145.412980816858, 27271.31821704394, 27358.759392294225], "value": 19042.85596899245, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.1333625970191, 368.98893033209015, 386.71769608186025, 391.9000654833018, 412.3608406969197, 14645.853541464596, 18194.81805181948, 18890.62218755626, 18963.620727585476, 19645.50886227845, 17733.379331723394, 17746.46760597184, 17908.55228619285, 17916.731249031276, 17975.370862019798, 5291.074062039137, 5559.527440167571, 5610.214569960209, 5617.269754931874, 5638.746256418471, 4139.668826493888, 4295.063156973524, 4368.344748287766, 5542.1132618781, 5648.378678345399, 4309.418228539138, 6290.339514350996, 6303.212098487689, 6305.716242769086, 6338.0, 5982.880342393171, 6146.784862529835, 6206.782762603287, 6216.658083805389, 6223.222097237845, 5482.369527504348, 5482.698451585161, 5485.61600687952, 5487.75305111271, 5488.69812160335, 22118.668219976713, 22630.88684556583, 22642.773572264232, 22820.0, 22864.771352286596, 2168.92408765694, 2245.2141750387395, 2395.988020059906, 2725.2641786717672, 2842.6588809342807, 13740.725185496334, 14385.064970776866, 14561.927190364086, 15024.924875375553, 15195.696086078327, 1713.288985071194, 1730.3424698614447, 1739.20866005967, 1742.9825701742948, 1767.6994910865185, 78175.60912195459, 79246.60376698137, 80203.0, 81171.18828811696, 81205.59397202976, 10082.69751907444, 10168.542415591317, 10353.171746260281, 10741.78516429667, 10854.620088296871, 14869.107853528823, 14882.841987911908, 14917.403303867724, 14938.178400188093, 15011.699766004618, 7364.77905662831, 7552.131504876899, 7605.0, 7769.650365733555, 7896.565688887166, 6910.619915904674, 7037.753678621224, 7234.0, 7260.092488438945, 7452.292032256927, 6432.774852880127, 6538.607683539003, 6559.6064236145985, 6571.868562628721, 6599.274079851212, 1886.0758228468226, 1941.8834869907569, 1944.5235917200093, 1944.805519448044, 1972.0928372948317, 849.367221420046, 1022.8516865054526, 1049.732318258839, 1066.594694016269, 1073.9194560408, 18816.455158843048, 19565.217391304188, 19688.803111968697, 19762.505937351394, 19820.60358792816, 969.5733877094056, 1013.2350075692805, 1014.573878970834, 1017.4149863828328, 1066.2589500297374, 10750.193735469871, 11253.268537545033, 11317.886821131848, 11319.490622921989, 11384.089272858151, 367738.0, 369735.0, 370342.0, 373066.0, 497805.0, 87730.56134719285, 91675.99888013481, 95377.52311238399, 97067.0, 97498.0, 469.7017393954795, 472.3623108803088, 491.42748697767416, 491.9409670839522, 494.16486138425944, 10515.894841051491, 10899.455027248765, 10953.83569246478, 10954.452277386259, 11561.30632162073, 38904.60812445626, 40041.59958400379, 40849.795751021054, 40971.0, 42536.78731606322, 54309.72845135749, 54404.72797635986, 55394.0, 55436.16845747398, 55987.0, 7799.376049916106, 8033.35733141359, 8174.346052315919, 8379.958100209704, 8401.495910245405, 9261.583228754587, 12483.31341776211, 12686.429110690226, 12824.358782061046, 13101.344932753515, 10702.625408110678, 10830.783384332111, 10992.340459572451, 11176.708774701005, 11784.175107742376, 10244.436555989194, 10397.636082737068, 10466.267361284637, 10999.23005389615, 11140.888591113986, 10880.945595271973, 11102.666919992413, 11419.657410277705, 11466.082713382742, 11886.108541859223, 8240.258376746122, 8501.234888860032, 8503.362247831561, 8625.137486251324, 8700.695475658322, 9648.372855764354, 11361.204715669825, 11433.0, 11450.885491144982, 11577.031904576073], "value": 8802.462208221657, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1324.516551458718, 1430.1276221504884, 1463.6487243061665, 1558.7272227360215, 1694.7118989771745, 6976.895346569806, 7878.842423151534, 8198.303144232746, 8200.425970182083, 8357.665693372257, 8207.58962051898, 8263.628136733847, 8267.503949763004, 8268.255856972872, 8282.213189746979, 2250.313654335423, 2279.247848210095, 2280.692106565609, 2281.7376001759762, 2285.8057065149483, 2220.245116660335, 2286.531261091472, 2289.759575244592, 2291.656251562271, 2291.8166546676307, 2190.58378908007, 2204.0, 2209.657503087024, 2215.4461384653837, 2265.63749800032, 2169.1215057901577, 2173.695682604429, 2180.618391781432, 2213.302809614966, 2215.3464727905307, 2210.4142402263415, 2220.822334213259, 2228.4874478869788, 2231.8884055797307, 2238.731352237726, 8054.677812887478, 8237.629306681214, 8310.459820111673, 8312.459690120122, 8323.583820808935, 4809.5430934061205, 5021.497850214986, 5032.421271553745, 5035.471275516092, 5037.49625037497, 3289.259916518788, 3315.651856555075, 3365.7812242204177, 3432.626949220307, 3457.7060949819297, 1090.6891535912307, 1091.1761619976867, 1107.3245320354577, 1109.2235435195396, 1168.6902970712767, 11130.16523760713, 11174.050205732441, 11228.270162439416, 11249.381284029376, 11249.493772780244, 3881.3013657541915, 4172.958270417257, 4178.101708132766, 4221.915561688749, 4292.5063617683745, 8949.865752013726, 9017.053209413049, 9036.954815226014, 9052.27581793455, 9056.683016094405, 4870.805167793249, 4877.6829506081995, 4878.414590249193, 4879.1461494238365, 4879.512048795092, 3905.5703872573995, 4010.6189911958318, 4468.32975053738, 4549.067441174551, 4574.565416285448, 3594.335048016073, 3594.856205751793, 3597.2625611749527, 3681.7975011374633, 3693.0951916780023, 1041.1098510773331, 1043.446973104256, 1050.2595670052594, 1050.8896565860628, 1064.7178497698117, 873.6374404622138, 874.5190145420121, 881.9250363719156, 901.9052999434965, 906.1844340093836, 5285.286486324297, 5375.5162035417, 5468.671879687232, 5480.424555421703, 5508.44915508446, 873.7771868173575, 914.4878867834034, 927.452802846324, 939.0703203828161, 949.1457688080644, 3505.4216054351255, 3539.50446937429, 3574.4459608760685, 3620.402633565432, 3652.845224754078, 10036.548355324028, 10402.531886065146, 10413.47932603382, 10416.114630256361, 10417.0, 10185.796284074277, 10293.588256469808, 10293.588256469808, 10298.639547615798, 10321.793564128675, 7763.718986367299, 7901.565413902291, 7926.48477848938, 7929.960350198212, 7935.841283174304, 4991.8752031198055, 5089.236614507853, 5152.149895267389, 5224.947750522446, 5345.625806193529, 8936.329775267011, 9061.275097992013, 9238.722838314861, 9318.068193180628, 9395.248380129437, 9330.813383732424, 9337.906620933976, 9391.577379018097, 9426.717198484057, 9452.574634141343, 6169.691515424301, 6354.078658594571, 6354.618722876642, 7043.612601306977, 7227.7831665050135, 7202.639868006474, 7271.781846544613, 7622.352100071556, 7779.338756205786, 7788.805279868048, 7090.716371345295, 7116.359527642537, 7270.563766174047, 7313.890291645524, 7478.2521747824785, 6880.208775990625, 6900.872678451396, 6961.547499412522, 7011.789646310619, 7240.601766902871, 6198.566100372931, 6201.286852012076, 6249.406306400884, 6255.530835187288, 6257.749690012349, 4514.390557274726, 4616.953830461653, 4678.321643361762, 4694.225452800386, 4769.66612337133, 4580.839670611513, 4581.496035436166, 4719.622430205644, 4725.50382209863, 4816.638752093537], "value": 4288.809071187619, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.8744395963594, 322.3150804540352, 326.3082265596934, 327.3763480569516, 333.99165020874466, 5087.186050231963, 5090.363704536933, 5102.668326558771, 5134.127198376275, 5149.922751158736, 5050.661574682712, 5056.0, 5067.771950262238, 5085.974570127153, 5094.0, 3872.7869967151796, 3965.266425711253, 3980.7412518186225, 4030.858919937803, 4054.945714114322, 4068.1863627274665, 4071.984367737959, 4076.2866498362814, 4084.346504559271, 4092.7544347339253, 4032.0565986829633, 4043.6562892154056, 4050.6961977851633, 4052.5744796796353, 4062.8577999770014, 3828.272628200633, 3833.5399752029657, 3946.447497350359, 4040.252553277653, 4055.2903241932545, 3593.2633810068874, 3597.3165098631175, 3602.7658202217035, 3610.584782749991, 3622.130688634735, 4981.178105612569, 4983.426905905831, 4995.0, 5002.274670172805, 5002.799888004475, 4491.136178485925, 4577.756899119441, 4606.769661516944, 4624.583787459112, 4628.861134165981, 5275.815346462894, 5293.602979776494, 5309.761060752276, 5324.254604355393, 5341.385740639837, 3914.745541539791, 3928.332183528807, 3930.8404020813928, 3934.350832112698, 3959.0, 5283.63014588979, 5521.365043020024, 5554.555635549146, 5561.277033985596, 5570.663040870202, 3951.7156923999814, 3965.4844870166694, 3970.1067259866877, 3974.841006359771, 3983.820728067244, 4013.8996525087105, 4014.458048163519, 4016.5581786003518, 4023.6177563131455, 4033.1127152026506, 4482.798274077674, 4550.431196100488, 4638.79125439356, 4645.46577143626, 4647.604953578983, 5360.812371566976, 5363.919541206885, 5370.248165256867, 5384.811531596453, 5411.242426060355, 1337.625464869838, 1342.9597112086653, 1349.1837438349853, 1351.2433037498836, 1351.3783659516732, 878.7715194049593, 939.5067589515559, 947.0955237747934, 949.4445749236636, 950.3205208276116, 5055.266986286968, 5108.671745346237, 5173.430922598511, 5241.344831896013, 5244.318238628954, 5510.669359838423, 5521.806736764194, 5522.66863988162, 5543.6396634218645, 5558.916616250759, 5124.820631277962, 5269.420363759983, 5280.20796880471, 5280.339957505312, 5288.391834938954, 2804.709833476583, 2834.4552219040675, 2851.54375299951, 2857.357094653728, 2857.7428031477266, 5400.785677872053, 5544.3346798383645, 5548.250986116904, 5552.7778888844805, 5554.944450555443, 5109.554687421893, 5297.258383826267, 5340.092184328673, 5356.3572371315695, 5382.381026182039, 5418.485243901823, 5433.293671822637, 5437.809676661377, 5451.0, 5451.64564303319, 5314.707691076873, 5315.900219413233, 5318.680879147263, 5323.574114070942, 5334.813281535127, 5050.570701490415, 5267.420583735862, 5270.4202537721585, 5275.498827611371, 5292.136740179613, 5461.706083444883, 5470.893705923168, 5480.698561579152, 5488.341399032141, 5496.680796608865, 3813.904652383713, 3815.9618403815607, 3819.789911554891, 3827.1197624547067, 3837.2901013312626, 5203.5576975957465, 5536.972315138399, 5537.089704052096, 5550.666959982414, 5557.666540007613, 5396.677813935611, 5398.2982212312145, 5403.648762830403, 5417.702026388586, 5433.728313584226, 5186.299849520266, 5377.435369286169, 5389.299391079135, 5411.350637923474, 5435.10320797064, 5298.15229563268, 5314.840554783363, 5319.46805319465, 5330.920036199383, 5336.412994570672, 5158.3552055993005, 5284.524392804666, 5308.150695888639, 5409.350877894678, 5490.231367608618, 5347.171188465794, 5347.2728908256295, 5362.865928351823, 5364.678119312854, 5377.139657654757], "value": 4082.147766875943, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.5528260684894, 751.9097708275007, 779.8167430653796, 782.8042989252687, 810.3193317613204, 12845.421956011978, 13040.673983150426, 13206.669833254173, 13394.665133371658, 13485.39315730792, 13259.0, 13485.0, 13501.59495215145, 13506.932465337659, 13512.527061552848, 657.3393739292005, 674.6862708840388, 746.5147654024887, 749.6851322444586, 772.5712229712507, 770.7379490973068, 782.37800948246, 782.4366456151562, 782.5617654113686, 782.7064850680995, 826.9090400055989, 826.9214424629681, 827.4414770030236, 827.735124760077, 829.1252728371566, 691.0463560286772, 700.7162099349772, 804.6137853830194, 822.4695071678764, 822.7696245051366, 592.076360877029, 593.4214141212327, 593.664579512574, 593.8337265565606, 593.9495142912857, 12770.48918043277, 12978.740425191538, 13010.284434356106, 13032.543860964915, 13084.0, 12932.224066556037, 13373.264470454122, 13682.110662806886, 13727.0, 13906.930465347608, 11771.529138834436, 12297.75404491914, 12385.380730963416, 12616.747665046647, 12628.747425051448, 4284.186004659136, 4349.782510874444, 4354.477462704464, 4367.631430581417, 4411.2941929291155, 63650.36349636537, 64878.0, 64896.0, 64910.350896490905, 64992.35007649958, 9775.0, 9947.10476057144, 10041.899581004243, 10127.64553240633, 10463.476826158661, 17552.56118597045, 17725.822741772674, 17750.733738993924, 17798.91100544515, 18032.0, 7305.780826575211, 7438.7024519019715, 7616.581088040211, 7621.428392870557, 7881.014873140857, 4165.291900376943, 4179.665626749853, 4190.643795277436, 4216.873493795191, 4285.46431696038, 3099.1632259289863, 3194.9041528754174, 3196.216926852936, 3198.392305461955, 3200.3279311344413, 543.9265699130646, 552.6739223857943, 560.1821340842416, 563.8759472915951, 573.1488739222251, 605.9454649081604, 639.6066419152188, 654.201873714068, 655.849154694423, 676.1581830620909, 8198.754037378889, 8488.74533763988, 8515.144249979952, 8623.655053797904, 8640.783980400414, 576.0207647000117, 584.7397907931015, 629.5058379172327, 633.2084893882646, 639.1658885154825, 3872.6514613684903, 3948.466956960831, 4044.1176470588516, 4083.6733061355612, 4146.212219678251, 82505.0, 85258.57370713231, 85675.57162214149, 87635.12364876397, 88995.0, 46380.5361946383, 47706.5229347709, 60735.39264607386, 65801.35496612528, 73200.2679973204, 50339.49660503421, 61704.69147654233, 62005.0, 63069.36930630635, 63596.0, 8940.195382415613, 9291.535423228946, 9436.95281523588, 9440.961494235491, 9642.95178524131, 42750.78624606857, 43055.569444305154, 43341.783291084605, 43981.78009109934, 44387.55612443964, 54045.45954540404, 56182.71908640431, 59628.80742385215, 60002.69998650153, 60546.394536054075, 11870.519657695646, 12146.210496317712, 12206.877931220573, 12331.815022774845, 12773.23360598367, 13574.723338546388, 13676.794848077487, 13754.862451375358, 13977.58067257984, 14083.084599501, 11314.434278285888, 11402.958939000528, 11451.004587566971, 11510.36692981894, 11874.881251187722, 10700.464976750976, 10986.176036797113, 11379.601713940303, 11405.087592992706, 12415.751684966432, 11072.723181920517, 11295.096392288433, 12853.550125745927, 12980.415881285553, 13234.669133271746, 10835.187360947803, 10943.343399396063, 11323.773524529628, 11430.485628146587, 11875.76248475043, 10413.739656508647, 11004.724881878017, 11017.151974471608, 11231.21381503287, 11268.605598804003], "value": 6715.976327795771, "unit": "score"}], "name": "dromaeo_css", "value": 6848.4629039584825, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 112.0, 112.0, 113.0, 112.0, 113.0, 112.0, 112.0, 111.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 127.0, 170.0, 124.0, 127.0, 123.0, 123.0, 158.0, 126.0], "value": 135.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 161.0, 161.0, 163.0, 161.0, 163.0, 161.0, 164.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 110.0, 75.0, 77.0, 75.0, 74.0, 101.0, 75.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 122.0, 82.0, 83.0, 82.0, 100.0, 81.0, 81.0, 115.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 50.0, 50.0, 52.0, 51.0, 51.0, 51.0, 52.0, 52.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 87.0, 81.0, 80.0, 80.0, 80.0, 83.0, 80.0, 86.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 138.0, 131.0, 130.0, 139.0, 136.0, 147.0, 143.0, 189.0, 135.0], "value": 142.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 162.0, 168.0, 167.0, 162.0, 164.0, 163.0, 161.0, 163.0, 164.0], "value": 164.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 63.0, 74.0, 64.0, 68.0, 66.0, 63.0, 62.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1508.2, "alertThreshold": 2.0}]} 13:14:34 INFO - Return code: 0 13:14:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:14:34 INFO - # TBPL SUCCESS # 13:14:34 INFO - Running post-action listener: _resource_record_post_action 13:14:34 INFO - [mozharness: 2016-11-18 21:14:34.503914Z] Finished run-tests step (success) 13:14:34 INFO - Running post-run listener: _resource_record_post_run 13:14:34 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 8192; Write bytes: 392814592; Read time: 216; Write time: 329036 13:14:34 INFO - TinderboxPrint: CPU usage
13.1% 13:14:34 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 216 13:14:34 INFO - TinderboxPrint: I/O write bytes / time
392,814,592 / 329,036 13:14:34 INFO - TinderboxPrint: CPU idle
8,304.0 (86.9%) 13:14:34 INFO - TinderboxPrint: CPU user
1,203.1 (12.6%) 13:14:34 INFO - TinderboxPrint: Swap in / out
0 / 0 13:14:34 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 105762816; Read time: 0; Write time: 95780 13:14:34 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287047680; Read time: 208; Write time: 233256 13:14:35 INFO - Running post-run listener: _upload_blobber_files 13:14:35 INFO - Blob upload gear active. 13:14:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:14:35 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 13:14:35 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'] 13:14:35 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 13:14:35 INFO - (blobuploader) - INFO - Open directory for files ... 13:14:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:14:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:14:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:36 INFO - (blobuploader) - INFO - Done attempting. 13:14:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:14:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:14:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:39 INFO - (blobuploader) - INFO - Done attempting. 13:14:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:14:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:14:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:40 INFO - (blobuploader) - INFO - Done attempting. 13:14:40 INFO - (blobuploader) - INFO - Iteration through files over. 13:14:40 INFO - Return code: 0 13:14:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:14:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:14:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/77c79647e4aee66f1a1fe662ad131d048f937eab7928ec6a8b6b9e94bab47c22771a12006aafd509a035fc3acb9ccc1f4a59cf6a817d947898ca9cabbb22ad20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/04a95ffd736ca3e81e335324efd2a4e0e7092ce29cff71618ad83d9740112e450252d35c05c34fc06abda6a989e984090f0420d5464e51240d2a23f2aa4e0f63", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/38b606094e27eceb8892d98337f0a0200915b0de0b74222f71e7b081b1d37051ce2cd0e0ebad79edbe1da354291ecb3e01882f96721f757e678b253097a84156"} 13:14:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:14:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:14:40 INFO - Contents: 13:14:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/77c79647e4aee66f1a1fe662ad131d048f937eab7928ec6a8b6b9e94bab47c22771a12006aafd509a035fc3acb9ccc1f4a59cf6a817d947898ca9cabbb22ad20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/04a95ffd736ca3e81e335324efd2a4e0e7092ce29cff71618ad83d9740112e450252d35c05c34fc06abda6a989e984090f0420d5464e51240d2a23f2aa4e0f63", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/38b606094e27eceb8892d98337f0a0200915b0de0b74222f71e7b081b1d37051ce2cd0e0ebad79edbe1da354291ecb3e01882f96721f757e678b253097a84156"} 13:14:40 INFO - Running post-run listener: copy_logs_to_upload_dir 13:14:40 INFO - Copying logs to upload dir... 13:14:40 INFO - mkdir: /builds/slave/test/build/upload/logs 13:14:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.440439 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-11-18 13:14:40.763840) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 13:14:40.766974) ========= 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=00204705a9daa57ed339a427000001b9-1479502439.783156-585782061 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/77c79647e4aee66f1a1fe662ad131d048f937eab7928ec6a8b6b9e94bab47c22771a12006aafd509a035fc3acb9ccc1f4a59cf6a817d947898ca9cabbb22ad20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/04a95ffd736ca3e81e335324efd2a4e0e7092ce29cff71618ad83d9740112e450252d35c05c34fc06abda6a989e984090f0420d5464e51240d2a23f2aa4e0f63", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/38b606094e27eceb8892d98337f0a0200915b0de0b74222f71e7b081b1d37051ce2cd0e0ebad79edbe1da354291ecb3e01882f96721f757e678b253097a84156"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479490650/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011809 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479490650/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/77c79647e4aee66f1a1fe662ad131d048f937eab7928ec6a8b6b9e94bab47c22771a12006aafd509a035fc3acb9ccc1f4a59cf6a817d947898ca9cabbb22ad20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/04a95ffd736ca3e81e335324efd2a4e0e7092ce29cff71618ad83d9740112e450252d35c05c34fc06abda6a989e984090f0420d5464e51240d2a23f2aa4e0f63", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/38b606094e27eceb8892d98337f0a0200915b0de0b74222f71e7b081b1d37051ce2cd0e0ebad79edbe1da354291ecb3e01882f96721f757e678b253097a84156"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 13:14:40.792456) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 13:14:40.792777) ========= 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=00204705a9daa57ed339a427000001b9-1479502439.783156-585782061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 13:14:40.875353) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 13:14:40.875680) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 13:14:40.875969) ========= ========= Total master_lag: 0.17 =========