builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1476971161.79 results: success (0) buildid: 20161020063311 builduid: 50a9f3a3fc88435486866e1371776b7e revision: 99a239e1866a57f987b08dad796528e4ea30e622 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 06:46:01.788096) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 06:46:01.788831) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 06:46:01.789207) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 06:46:01.804258) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 06:46:01.804687) ========= 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=337fe3f4b1febe37b85fccc40000019e-1476971161.480285-1013204608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-20 06:46:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 216M=0s 2016-10-20 06:46:02 (216 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124002 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 06:46:01.943474) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 06:46:01.943844) ========= 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=337fe3f4b1febe37b85fccc40000019e-1476971161.480285-1013204608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018152 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 06:46:01.994816) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-20 06:46:01.995251) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 99a239e1866a57f987b08dad796528e4ea30e622 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 99a239e1866a57f987b08dad796528e4ea30e622 --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=337fe3f4b1febe37b85fccc40000019e-1476971161.480285-1013204608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-20 06:46:02,522 truncating revision to first 12 chars 2016-10-20 06:46:02,522 Setting DEBUG logging. 2016-10-20 06:46:02,522 attempt 1/10 2016-10-20 06:46:02,522 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/99a239e1866a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 06:46:03,318 unpacking tar archive at: fx-team-99a239e1866a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.094424 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-20 06:46:03.107885) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 06:46:03.108275) ========= script_repo_revision: 99a239e1866a57f987b08dad796528e4ea30e622 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 06:46:03.108714) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 06:46:03.109022) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 06:46:03.118697) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-20 06:46:03.119048) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=337fe3f4b1febe37b85fccc40000019e-1476971161.480285-1013204608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:46:03 INFO - MultiFileLogger online at 20161020 06:46:03 in /builds/slave/test 06:46:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:46:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:46:03 INFO - {'append_to_log': False, 06:46:03 INFO - 'base_work_dir': '/builds/slave/test', 06:46:03 INFO - 'blob_upload_branch': 'Fx-Team', 06:46:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:46:03 INFO - 'branch': 'Fx-Team', 06:46:03 INFO - 'buildbot_json_path': 'buildprops.json', 06:46:03 INFO - 'config_files': ('talos/linux_config.py',), 06:46:03 INFO - 'default_actions': ('clobber', 06:46:03 INFO - 'read-buildbot-config', 06:46:03 INFO - 'download-and-extract', 06:46:03 INFO - 'populate-webroot', 06:46:03 INFO - 'create-virtualenv', 06:46:03 INFO - 'install', 06:46:03 INFO - 'run-tests'), 06:46:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:46:03 INFO - 'download_minidump_stackwalk': True, 06:46:03 INFO - 'download_symbols': 'ondemand', 06:46:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:46:03 INFO - 'tooltool.py': '/tools/tooltool.py', 06:46:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:46:03 INFO - '/tools/misc-python/virtualenv.py')}, 06:46:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:46:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:46:03 INFO - 'installer_path': 'installer.exe', 06:46:03 INFO - 'log_level': 'info', 06:46:03 INFO - 'log_name': 'talos', 06:46:03 INFO - 'log_to_console': True, 06:46:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:46:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:46:03 INFO - 'opt_config_files': (), 06:46:03 INFO - 'pip_index': False, 06:46:03 INFO - 'sps_profile': False, 06:46:03 INFO - 'sps_profile_interval': 0, 06:46:03 INFO - 'suite': 'dromaeojs', 06:46:03 INFO - 'system_bits': '32', 06:46:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:46:03 INFO - 'title': 'talos-linux64-ix-060', 06:46:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:46:03 INFO - 'use_talos_json': True, 06:46:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:46:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:46:03 INFO - 'work_dir': 'build'} 06:46:03 INFO - [mozharness: 2016-10-20 13:46:03.740910Z] Running clobber step. 06:46:03 INFO - Running pre-action listener: _resource_record_pre_action 06:46:03 INFO - Running main action method: clobber 06:46:03 INFO - rmtree: /builds/slave/test/build 06:46:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:46:04 INFO - Running post-action listener: _resource_record_post_action 06:46:04 INFO - [mozharness: 2016-10-20 13:46:04.203117Z] Finished clobber step (success) 06:46:04 INFO - [mozharness: 2016-10-20 13:46:04.203220Z] Running read-buildbot-config step. 06:46:04 INFO - Running pre-action listener: _resource_record_pre_action 06:46:04 INFO - Running main action method: read_buildbot_config 06:46:04 INFO - Using buildbot properties: 06:46:04 INFO - { 06:46:04 INFO - "project": "", 06:46:04 INFO - "product": "firefox", 06:46:04 INFO - "script_repo_revision": "production", 06:46:04 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:46:04 INFO - "repository": "", 06:46:04 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 06:46:04 INFO - "buildid": "20161020063311", 06:46:04 INFO - "stage_platform": "linux64-pgo", 06:46:04 INFO - "basedir": "/builds/slave/test", 06:46:04 INFO - "buildnumber": 549, 06:46:04 INFO - "platform": "ubuntu64_hw", 06:46:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:46:04 INFO - "slavebuilddir": "test", 06:46:04 INFO - "branch": "fx-team", 06:46:04 INFO - "revision": "99a239e1866a57f987b08dad796528e4ea30e622", 06:46:04 INFO - "slavename": "talos-linux64-ix-060", 06:46:04 INFO - "builduid": "50a9f3a3fc88435486866e1371776b7e", 06:46:04 INFO - "repo_path": "integration/fx-team" 06:46:04 INFO - } 06:46:04 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476959407/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:46:04 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476959407/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 06:46:04 INFO - Running post-action listener: _resource_record_post_action 06:46:04 INFO - [mozharness: 2016-10-20 13:46:04.205618Z] Finished read-buildbot-config step (success) 06:46:04 INFO - [mozharness: 2016-10-20 13:46:04.205705Z] Running download-and-extract step. 06:46:04 INFO - Running pre-action listener: _resource_record_pre_action 06:46:04 INFO - Running main action method: download_and_extract 06:46:04 INFO - mkdir: /builds/slave/test/build/tests 06:46:04 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')]} 06:46:04 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476959407/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:46:04 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476959407/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:46:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476959407/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:46:04 INFO - Downloaded 1361 bytes. 06:46:04 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:46:04 INFO - Using the following test package requirements: 06:46:04 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:46:04 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:46:04 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:46:04 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:46:04 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:46:04 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:46:04 INFO - u'jsshell-linux-x86_64.zip'], 06:46:04 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:46:04 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:46:04 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:46:04 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:46:04 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:46:04 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:46:04 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:46:04 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:46:04 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:46:04 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:46:04 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:46:04 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:46:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476959407/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:46:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476959407/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:46:04 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476959407/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:46:04 INFO - Http code: 200 06:46:04 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 06:46:04 INFO - x-amz-cf-id: AbSfK9DzByBWvxp-Dmq-Pz53-jalDqCqFYILUPILr6v0DFaXeD5MLw== 06:46:04 INFO - x-amz-replication-status: COMPLETED 06:46:04 INFO - x-amz-version-id: x4qKTFvpAiLSassJlLzjSEbOJfrl8pyX 06:46:04 INFO - Expected file size: 22116251 06:46:04 INFO - Obtained file size: 22116251 06:46:08 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:46:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476959407/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:46:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476959407/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:46:08 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476959407/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:46:08 INFO - Http code: 200 06:46:08 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 06:46:08 INFO - x-amz-cf-id: gOtdCGRh5UkWjN_3ClfOAfMfKVga93OPyFtdyc0gWsqQlobFxSRY7g== 06:46:08 INFO - x-amz-replication-status: COMPLETED 06:46:08 INFO - x-amz-version-id: x4qKTFvpAiLSassJlLzjSEbOJfrl8pyX 06:46:08 INFO - Expected file size: 22116251 06:46:08 INFO - Obtained file size: 22116251 06:46:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476959407/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:46:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476959407/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:46:13 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476959407/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:46:13 INFO - Http code: 200 06:46:13 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 06:46:13 INFO - x-amz-cf-id: gnEfSok9gVem2QQgelHQbO5Mu1Y8PIe2DxrKAT0Ut-Bh3iQlKmEmsA== 06:46:13 INFO - x-amz-replication-status: COMPLETED 06:46:13 INFO - x-amz-version-id: iw0UkJ4rCx6h2IXTENkX2x58UsMPFlaG 06:46:13 INFO - Expected file size: 14409028 06:46:13 INFO - Obtained file size: 14409028 06:46: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')]} 06:46:13 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476959407/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:46:13 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476959407/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:46:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476959407/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:46:14 INFO - Downloaded 59472912 bytes. 06:46:14 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476959407/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:46:14 INFO - mkdir: /builds/slave/test/properties 06:46:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:46:14 INFO - Writing to file /builds/slave/test/properties/build_url 06:46:14 INFO - Contents: 06:46:14 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476959407/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:46:14 INFO - Running post-action listener: _resource_record_post_action 06:46:14 INFO - Running post-action listener: set_extra_try_arguments 06:46:14 INFO - [mozharness: 2016-10-20 13:46:14.810821Z] Finished download-and-extract step (success) 06:46:14 INFO - [mozharness: 2016-10-20 13:46:14.811048Z] Running populate-webroot step. 06:46:14 INFO - Running pre-action listener: _resource_record_pre_action 06:46:14 INFO - Running main action method: populate_webroot 06:46:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:46:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:46:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:46:14 INFO - '--tppagecycles', 06:46:14 INFO - '7'], 06:46:14 INFO - 'tests': ['tsvgm']}}, 06:46:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:46:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:46:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:46:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:46:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:46:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:46:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:46:14 INFO - 'talos_options': ['--disable-e10s'], 06:46:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:46:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:46:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:46:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:46:14 INFO - 'talos_options': ['--disable-e10s'], 06:46:14 INFO - 'tests': ['damp', 'tps']}, 06:46:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:46:14 INFO - 'tests': ['damp', 'tps']}, 06:46:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:46:14 INFO - 'tests': ['dromaeo_dom']}, 06:46:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:46:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:46:14 INFO - 'tests': ['basic_compositor_video']}, 06:46:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:46:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:46:14 INFO - 'tests': ['a11yr', 06:46:14 INFO - 'ts_paint', 06:46:14 INFO - 'tpaint', 06:46:14 INFO - 'sessionrestore', 06:46:14 INFO - 'sessionrestore_no_auto_restore', 06:46:14 INFO - 'tabpaint']}, 06:46:14 INFO - 'other-e10s': {'tests': ['a11yr', 06:46:14 INFO - 'ts_paint', 06:46:14 INFO - 'tpaint', 06:46:14 INFO - 'sessionrestore', 06:46:14 INFO - 'sessionrestore_no_auto_restore', 06:46:14 INFO - 'tabpaint']}, 06:46:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:46:14 INFO - 'ts_paint', 06:46:14 INFO - 'tpaint', 06:46:14 INFO - 'sessionrestore', 06:46:14 INFO - 'sessionrestore_no_auto_restore', 06:46:14 INFO - 'tabpaint']}, 06:46:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:46:14 INFO - 'ts_paint', 06:46:14 INFO - 'tpaint', 06:46:14 INFO - 'sessionrestore', 06:46:14 INFO - 'sessionrestore_no_auto_restore', 06:46:14 INFO - 'tabpaint']}, 06:46:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:46:14 INFO - 'tests': ['a11yr', 06:46:14 INFO - 'ts_paint', 06:46:14 INFO - 'tpaint', 06:46:14 INFO - 'sessionrestore', 06:46:14 INFO - 'sessionrestore_no_auto_restore', 06:46:14 INFO - 'tabpaint']}, 06:46:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:46:14 INFO - 'tests': ['a11yr', 06:46:14 INFO - 'ts_paint', 06:46:14 INFO - 'tpaint', 06:46:14 INFO - 'sessionrestore', 06:46:14 INFO - 'sessionrestore_no_auto_restore', 06:46:14 INFO - 'tabpaint']}, 06:46:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:46:14 INFO - 'tests': ['tsvgx', 06:46:14 INFO - 'tsvgr_opacity', 06:46:14 INFO - 'tart', 06:46:14 INFO - 'tscrollx', 06:46:14 INFO - 'cart']}, 06:46:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:46:14 INFO - 'tsvgr_opacity', 06:46:14 INFO - 'tart', 06:46:14 INFO - 'tscrollx', 06:46:14 INFO - 'cart']}, 06:46:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:46:14 INFO - 'talos_options': ['--disable-e10s'], 06:46:14 INFO - 'tests': ['tp5o']}, 06:46:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:46:14 INFO - 'tests': ['tp5o']}, 06:46:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:46:14 INFO - 'talos_options': ['--disable-e10s', 06:46:14 INFO - '--xperf_path', 06:46:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:46:14 INFO - 'tests': ['tp5n']}, 06:46:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:46:14 INFO - 'talos_options': ['--xperf_path', 06:46:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:46:14 INFO - 'tests': ['tp5n']}}, 06:46:14 INFO - 'talos.zip': {'path': '', 06:46:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:46:14 INFO - Running post-action listener: _resource_record_post_action 06:46:14 INFO - [mozharness: 2016-10-20 13:46:14.833271Z] Finished populate-webroot step (success) 06:46:14 INFO - [mozharness: 2016-10-20 13:46:14.833359Z] Running create-virtualenv step. 06:46:14 INFO - Running pre-action listener: _resource_record_pre_action 06:46:14 INFO - Running main action method: create_virtualenv 06:46:14 INFO - Creating virtualenv /builds/slave/test/build/venv 06:46: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 06:46:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:46:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:46:14 INFO - Using real prefix '/usr' 06:46:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:46:15 INFO - Installing distribute.............................................................................................................................................................................................done. 06:46:17 INFO - Installing pip.................done. 06:46:17 INFO - Return code: 0 06:46:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:46:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:46:17 INFO - Reading from file tmpfile_stdout 06:46:17 INFO - Output received: 06:46:17 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) 06:46:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:46: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')]} 06:46:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46: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')]} 06:46:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c4d9eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e28930>, '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 0x1e29830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e29cc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1476971161.480285-1013204608', '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 06:46: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', 'pip>=1.5'] in /builds/slave/test/build 06:46: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 pip>=1.5 06:46:17 INFO - Using env: {'DISPLAY': ':0', 06:46:17 INFO - 'HOME': '/home/cltbld', 06:46:17 INFO - 'LANG': 'en_US.UTF-8', 06:46:17 INFO - 'LANGUAGE': 'en_US:en', 06:46:17 INFO - 'LOGNAME': 'cltbld', 06:46:17 INFO - 'MAIL': '/var/mail/cltbld', 06:46:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:17 INFO - 'MOZ_NO_REMOTE': '1', 06:46:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:17 INFO - 'NO_EM_RESTART': '1', 06:46:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:17 INFO - 'PWD': '/builds/slave/test', 06:46:17 INFO - 'SHELL': '/bin/bash', 06:46:17 INFO - 'SHLVL': '1', 06:46:17 INFO - 'TERM': 'linux', 06:46:17 INFO - 'TMOUT': '86400', 06:46:17 INFO - 'USER': 'cltbld', 06:46:17 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1476971161.480285-1013204608', 06:46:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:17 INFO - '_': '/tools/buildbot/bin/python'} 06:46:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46: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 06:46:17 INFO - Cleaning up... 06:46:17 INFO - Return code: 0 06:46:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:46: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')]} 06:46:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46: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')]} 06:46:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46: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 0x7f2c4d9eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e28930>, '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 0x1e29830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e29cc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1476971161.480285-1013204608', '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 06:46: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 06:46: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 06:46:17 INFO - Using env: {'DISPLAY': ':0', 06:46:17 INFO - 'HOME': '/home/cltbld', 06:46:17 INFO - 'LANG': 'en_US.UTF-8', 06:46:17 INFO - 'LANGUAGE': 'en_US:en', 06:46:17 INFO - 'LOGNAME': 'cltbld', 06:46:17 INFO - 'MAIL': '/var/mail/cltbld', 06:46:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:17 INFO - 'MOZ_NO_REMOTE': '1', 06:46:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:17 INFO - 'NO_EM_RESTART': '1', 06:46:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:17 INFO - 'PWD': '/builds/slave/test', 06:46:17 INFO - 'SHELL': '/bin/bash', 06:46:17 INFO - 'SHLVL': '1', 06:46:17 INFO - 'TERM': 'linux', 06:46:17 INFO - 'TMOUT': '86400', 06:46:17 INFO - 'USER': 'cltbld', 06:46:17 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1476971161.480285-1013204608', 06:46:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:17 INFO - '_': '/tools/buildbot/bin/python'} 06:46:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:18 INFO - Downloading/unpacking psutil>=3.1.1 06:46:18 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 06:46:18 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 06:46:18 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 06:46:18 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 06:46:18 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 06:46:18 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 06:46:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:46:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:46:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:46:20 INFO - Installing collected packages: psutil 06:46:20 INFO - Running setup.py install for psutil 06:46:20 INFO - building 'psutil._psutil_linux' extension 06:46:20 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 06:46:20 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 06:46:20 INFO - building 'psutil._psutil_posix' extension 06:46:20 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 06:46:20 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 06:46:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:46:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:46:20 INFO - Successfully installed psutil 06:46:20 INFO - Cleaning up... 06:46:20 INFO - Return code: 0 06:46:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:46:20 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')]} 06:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:20 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')]} 06:46:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:20 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 0x7f2c4d9eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e28930>, '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 0x1e29830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e29cc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1476971161.480285-1013204608', '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 06:46:20 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 06:46:20 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 06:46:20 INFO - Using env: {'DISPLAY': ':0', 06:46:20 INFO - 'HOME': '/home/cltbld', 06:46:20 INFO - 'LANG': 'en_US.UTF-8', 06:46:20 INFO - 'LANGUAGE': 'en_US:en', 06:46:20 INFO - 'LOGNAME': 'cltbld', 06:46:20 INFO - 'MAIL': '/var/mail/cltbld', 06:46:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:20 INFO - 'MOZ_NO_REMOTE': '1', 06:46:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:20 INFO - 'NO_EM_RESTART': '1', 06:46:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:20 INFO - 'PWD': '/builds/slave/test', 06:46:20 INFO - 'SHELL': '/bin/bash', 06:46:20 INFO - 'SHLVL': '1', 06:46:20 INFO - 'TERM': 'linux', 06:46:20 INFO - 'TMOUT': '86400', 06:46:20 INFO - 'USER': 'cltbld', 06:46:20 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1476971161.480285-1013204608', 06:46:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:20 INFO - '_': '/tools/buildbot/bin/python'} 06:46:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:46: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 06:46: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 06:46: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 06:46: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 06:46: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 06:46: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 06:46:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:46:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:46:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:46:22 INFO - Installing collected packages: mozsystemmonitor 06:46:22 INFO - Running setup.py install for mozsystemmonitor 06:46:22 INFO - Successfully installed mozsystemmonitor 06:46:22 INFO - Cleaning up... 06:46:22 INFO - Return code: 0 06:46:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:46: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')]} 06:46:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46: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')]} 06:46:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:23 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 0x7f2c4d9eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e28930>, '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 0x1e29830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e29cc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1476971161.480285-1013204608', '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 06:46:23 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 06:46:23 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 06:46:23 INFO - Using env: {'DISPLAY': ':0', 06:46:23 INFO - 'HOME': '/home/cltbld', 06:46:23 INFO - 'LANG': 'en_US.UTF-8', 06:46:23 INFO - 'LANGUAGE': 'en_US:en', 06:46:23 INFO - 'LOGNAME': 'cltbld', 06:46:23 INFO - 'MAIL': '/var/mail/cltbld', 06:46:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:23 INFO - 'MOZ_NO_REMOTE': '1', 06:46:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:23 INFO - 'NO_EM_RESTART': '1', 06:46:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:23 INFO - 'PWD': '/builds/slave/test', 06:46:23 INFO - 'SHELL': '/bin/bash', 06:46:23 INFO - 'SHLVL': '1', 06:46:23 INFO - 'TERM': 'linux', 06:46:23 INFO - 'TMOUT': '86400', 06:46:23 INFO - 'USER': 'cltbld', 06:46:23 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1476971161.480285-1013204608', 06:46:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:23 INFO - '_': '/tools/buildbot/bin/python'} 06:46:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:23 INFO - Downloading/unpacking jsonschema==2.5.1 06:46:23 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 06:46:23 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 06:46:23 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 06:46:23 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 06:46:23 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 06:46:23 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 06:46:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:46:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:46: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 06:46: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 06:46: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 06:46: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 06:46: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 06:46: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 06:46:25 INFO - Downloading functools32-3.2.3-2.tar.gz 06:46:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:46:25 INFO - warning: no files found matching '*.txt' 06:46:25 INFO - no previously-included directories found matching 'build' 06:46:25 INFO - no previously-included directories found matching 'dist' 06:46:25 INFO - no previously-included directories found matching '.git*' 06:46:25 INFO - Installing collected packages: jsonschema, functools32 06:46:25 INFO - Running setup.py install for functools32 06:46:25 INFO - warning: no files found matching '*.txt' 06:46:25 INFO - no previously-included directories found matching 'build' 06:46:25 INFO - no previously-included directories found matching 'dist' 06:46:25 INFO - no previously-included directories found matching '.git*' 06:46:25 INFO - Successfully installed jsonschema functools32 06:46:25 INFO - Cleaning up... 06:46:25 INFO - Return code: 0 06:46:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:46: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')]} 06:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46: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')]} 06:46:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46: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', '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 0x7f2c4d9eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e28930>, '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 0x1e29830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e29cc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1476971161.480285-1013204608', '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 06:46: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:46: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 functools32==3.2.3-2 06:46:25 INFO - Using env: {'DISPLAY': ':0', 06:46:25 INFO - 'HOME': '/home/cltbld', 06:46:25 INFO - 'LANG': 'en_US.UTF-8', 06:46:25 INFO - 'LANGUAGE': 'en_US:en', 06:46:25 INFO - 'LOGNAME': 'cltbld', 06:46:25 INFO - 'MAIL': '/var/mail/cltbld', 06:46:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:25 INFO - 'MOZ_NO_REMOTE': '1', 06:46:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:25 INFO - 'NO_EM_RESTART': '1', 06:46:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:25 INFO - 'PWD': '/builds/slave/test', 06:46:25 INFO - 'SHELL': '/bin/bash', 06:46:25 INFO - 'SHLVL': '1', 06:46:25 INFO - 'TERM': 'linux', 06:46:25 INFO - 'TMOUT': '86400', 06:46:25 INFO - 'USER': 'cltbld', 06:46:25 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1476971161.480285-1013204608', 06:46:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:25 INFO - '_': '/tools/buildbot/bin/python'} 06:46:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:46:25 INFO - Cleaning up... 06:46:25 INFO - Return code: 0 06:46:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:46: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')]} 06:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46: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')]} 06:46:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46: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 0x7f2c4d9eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e28930>, '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 0x1e29830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e29cc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1476971161.480285-1013204608', '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 06:46: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 06:46: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 06:46:25 INFO - Using env: {'DISPLAY': ':0', 06:46:25 INFO - 'HOME': '/home/cltbld', 06:46:25 INFO - 'LANG': 'en_US.UTF-8', 06:46:25 INFO - 'LANGUAGE': 'en_US:en', 06:46:25 INFO - 'LOGNAME': 'cltbld', 06:46:25 INFO - 'MAIL': '/var/mail/cltbld', 06:46:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:25 INFO - 'MOZ_NO_REMOTE': '1', 06:46:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:25 INFO - 'NO_EM_RESTART': '1', 06:46:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:25 INFO - 'PWD': '/builds/slave/test', 06:46:25 INFO - 'SHELL': '/bin/bash', 06:46:25 INFO - 'SHLVL': '1', 06:46:25 INFO - 'TERM': 'linux', 06:46:25 INFO - 'TMOUT': '86400', 06:46:25 INFO - 'USER': 'cltbld', 06:46:25 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1476971161.480285-1013204608', 06:46:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:25 INFO - '_': '/tools/buildbot/bin/python'} 06:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:26 INFO - Downloading/unpacking blobuploader==1.2.4 06:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:46:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:27 INFO - Downloading blobuploader-1.2.4.tar.gz 06:46:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:46:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:46:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:46:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:46:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:28 INFO - Downloading docopt-0.6.1.tar.gz 06:46:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:46:28 INFO - Installing collected packages: blobuploader, requests, docopt 06:46:28 INFO - Running setup.py install for blobuploader 06:46:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:46:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:46:28 INFO - Running setup.py install for requests 06:46:29 INFO - Running setup.py install for docopt 06:46:29 INFO - Successfully installed blobuploader requests docopt 06:46:29 INFO - Cleaning up... 06:46:29 INFO - Return code: 0 06:46:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:46:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:46:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:29 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 0x7f2c4d9eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e28930>, '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 0x1e29830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e29cc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1476971161.480285-1013204608', '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 06:46:29 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 06:46:29 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 06:46:29 INFO - Using env: {'DISPLAY': ':0', 06:46:29 INFO - 'HOME': '/home/cltbld', 06:46:29 INFO - 'LANG': 'en_US.UTF-8', 06:46:29 INFO - 'LANGUAGE': 'en_US:en', 06:46:29 INFO - 'LOGNAME': 'cltbld', 06:46:29 INFO - 'MAIL': '/var/mail/cltbld', 06:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:29 INFO - 'MOZ_NO_REMOTE': '1', 06:46:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:29 INFO - 'NO_EM_RESTART': '1', 06:46:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:29 INFO - 'PWD': '/builds/slave/test', 06:46:29 INFO - 'SHELL': '/bin/bash', 06:46:29 INFO - 'SHLVL': '1', 06:46:29 INFO - 'TERM': 'linux', 06:46:29 INFO - 'TMOUT': '86400', 06:46:29 INFO - 'USER': 'cltbld', 06:46:29 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1476971161.480285-1013204608', 06:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:29 INFO - '_': '/tools/buildbot/bin/python'} 06:46:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:46:29 INFO - Running setup.py (path:/tmp/pip-DTTlIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:46:29 INFO - Running setup.py (path:/tmp/pip-C_NpGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:46:29 INFO - Running setup.py (path:/tmp/pip-qPYk3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:46:29 INFO - Running setup.py (path:/tmp/pip-5_ax1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:46:29 INFO - Running setup.py (path:/tmp/pip-H3otNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:46:29 INFO - Running setup.py (path:/tmp/pip-SG_ufO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:46:30 INFO - Running setup.py (path:/tmp/pip-0djX9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:46:30 INFO - Running setup.py (path:/tmp/pip-RW7_3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:46:30 INFO - Running setup.py (path:/tmp/pip-qSYROS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:46:30 INFO - Running setup.py (path:/tmp/pip-LEy7vN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:46:30 INFO - Running setup.py (path:/tmp/pip-eaCXdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:46:30 INFO - Running setup.py (path:/tmp/pip-RZMUCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:46:30 INFO - Running setup.py (path:/tmp/pip-p2HoVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:46:30 INFO - Running setup.py (path:/tmp/pip-U_xXYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:46:30 INFO - Running setup.py (path:/tmp/pip-lUWv8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:46:30 INFO - Running setup.py (path:/tmp/pip-1k0mDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:46:30 INFO - Running setup.py (path:/tmp/pip-bIYlyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:46:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:46:30 INFO - Running setup.py install for manifestparser 06:46:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:46:30 INFO - Running setup.py install for mozcrash 06:46:30 INFO - Running setup.py install for mozdebug 06:46:31 INFO - Running setup.py install for mozdevice 06:46:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:46:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:46:31 INFO - Running setup.py install for mozfile 06:46:31 INFO - Running setup.py install for mozhttpd 06:46:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:46:31 INFO - Running setup.py install for mozinfo 06:46:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:46:31 INFO - Running setup.py install for mozInstall 06:46:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:46:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:46:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:46:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:46:31 INFO - Running setup.py install for mozleak 06:46:31 INFO - Running setup.py install for mozlog 06:46:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:46:31 INFO - Running setup.py install for moznetwork 06:46:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:46:31 INFO - Running setup.py install for mozprocess 06:46:32 INFO - Running setup.py install for mozprofile 06:46:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:46:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:46:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:46:32 INFO - Running setup.py install for mozrunner 06:46:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:46:32 INFO - Running setup.py install for mozscreenshot 06:46:32 INFO - Running setup.py install for moztest 06:46:32 INFO - Running setup.py install for mozversion 06:46:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:46:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:46:32 INFO - Cleaning up... 06:46:32 INFO - Return code: 0 06:46:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:46: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')]} 06:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46: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')]} 06:46:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46: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 0x7f2c4d9eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e28930>, '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 0x1e29830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e29cc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1476971161.480285-1013204608', '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 06:46: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 06:46: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 06:46:32 INFO - Using env: {'DISPLAY': ':0', 06:46:32 INFO - 'HOME': '/home/cltbld', 06:46:32 INFO - 'LANG': 'en_US.UTF-8', 06:46:32 INFO - 'LANGUAGE': 'en_US:en', 06:46:32 INFO - 'LOGNAME': 'cltbld', 06:46:32 INFO - 'MAIL': '/var/mail/cltbld', 06:46:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:32 INFO - 'MOZ_NO_REMOTE': '1', 06:46:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:32 INFO - 'NO_EM_RESTART': '1', 06:46:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:32 INFO - 'PWD': '/builds/slave/test', 06:46:32 INFO - 'SHELL': '/bin/bash', 06:46:32 INFO - 'SHLVL': '1', 06:46:32 INFO - 'TERM': 'linux', 06:46:32 INFO - 'TMOUT': '86400', 06:46:32 INFO - 'USER': 'cltbld', 06:46:32 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1476971161.480285-1013204608', 06:46:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:32 INFO - '_': '/tools/buildbot/bin/python'} 06:46:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:46:32 INFO - Running setup.py (path:/tmp/pip-TSOF4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:46: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)) 06:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:46:32 INFO - Running setup.py (path:/tmp/pip-0jIdge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:46:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:46:32 INFO - Running setup.py (path:/tmp/pip-Z9GLTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:46:33 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)) 06:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:46:33 INFO - Running setup.py (path:/tmp/pip-VI1Luq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:46:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:46:33 INFO - Running setup.py (path:/tmp/pip-DMwkiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:46:33 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)) 06:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:46:33 INFO - Running setup.py (path:/tmp/pip-BkbALv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:46:33 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)) 06:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:46:33 INFO - Running setup.py (path:/tmp/pip-IOnp4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:46:33 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)) 06:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:46:33 INFO - Running setup.py (path:/tmp/pip-Tt8x1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:46:33 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)) 06:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:46:33 INFO - Running setup.py (path:/tmp/pip-p29KIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:46:33 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)) 06:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:46:33 INFO - Running setup.py (path:/tmp/pip-AUyIA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:46:33 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)) 06:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:46:33 INFO - Running setup.py (path:/tmp/pip-58tjTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:46: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)) 06:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:46:33 INFO - Running setup.py (path:/tmp/pip-qION5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:46: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)) 06:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:46:33 INFO - Running setup.py (path:/tmp/pip-3r7IUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:46: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)) 06:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:46:33 INFO - Running setup.py (path:/tmp/pip-LI6Ork-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:46:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:46:33 INFO - Running setup.py (path:/tmp/pip-Uj2Ctv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:46: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)) 06:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:46:33 INFO - Running setup.py (path:/tmp/pip-B_hSDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:46: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)) 06:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:46:33 INFO - Running setup.py (path:/tmp/pip-eZ6X8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:46:34 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)) 06:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:46:34 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)) 06:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:46:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:46:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:35 INFO - Downloading blessings-1.6.tar.gz 06:46:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:46:36 INFO - Installing collected packages: blessings 06:46:36 INFO - Running setup.py install for blessings 06:46:36 INFO - Successfully installed blessings 06:46:36 INFO - Cleaning up... 06:46:36 INFO - Return code: 0 06:46:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:46:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:46:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:46:36 INFO - Reading from file tmpfile_stdout 06:46:36 INFO - Current package versions: 06:46:36 INFO - argparse == 1.2.1 06:46:36 INFO - blessings == 1.6 06:46:36 INFO - blobuploader == 1.2.4 06:46:36 INFO - docopt == 0.6.1 06:46:36 INFO - functools32 == 3.2.3-2 06:46:36 INFO - jsonschema == 2.5.1 06:46:36 INFO - manifestparser == 1.1 06:46:36 INFO - mozInstall == 1.12 06:46:36 INFO - mozcrash == 0.17 06:46:36 INFO - mozdebug == 0.1 06:46:36 INFO - mozdevice == 0.48 06:46:36 INFO - mozfile == 1.2 06:46:36 INFO - mozhttpd == 0.7 06:46:36 INFO - mozinfo == 0.9 06:46:36 INFO - mozleak == 0.1 06:46:36 INFO - mozlog == 3.4 06:46:36 INFO - moznetwork == 0.27 06:46:36 INFO - mozprocess == 0.23 06:46:36 INFO - mozprofile == 0.28 06:46:36 INFO - mozrunner == 6.12 06:46:36 INFO - mozscreenshot == 0.1 06:46:36 INFO - mozsystemmonitor == 0.3 06:46:36 INFO - moztest == 0.7 06:46:36 INFO - mozversion == 1.4 06:46:36 INFO - psutil == 3.1.1 06:46:36 INFO - requests == 1.2.3 06:46:36 INFO - wsgiref == 0.1.2 06:46:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:46: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')]} 06:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46: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')]} 06:46:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46:36 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 0x7f2c4d9eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e28930>, '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 0x1e29830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e29cc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1476971161.480285-1013204608', '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 06:46:36 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 06:46:36 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 06:46:36 INFO - Using env: {'DISPLAY': ':0', 06:46:36 INFO - 'HOME': '/home/cltbld', 06:46:36 INFO - 'LANG': 'en_US.UTF-8', 06:46:36 INFO - 'LANGUAGE': 'en_US:en', 06:46:36 INFO - 'LOGNAME': 'cltbld', 06:46:36 INFO - 'MAIL': '/var/mail/cltbld', 06:46:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:36 INFO - 'MOZ_NO_REMOTE': '1', 06:46:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:36 INFO - 'NO_EM_RESTART': '1', 06:46:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:36 INFO - 'PWD': '/builds/slave/test', 06:46:36 INFO - 'SHELL': '/bin/bash', 06:46:36 INFO - 'SHLVL': '1', 06:46:36 INFO - 'TERM': 'linux', 06:46:36 INFO - 'TMOUT': '86400', 06:46:36 INFO - 'USER': 'cltbld', 06:46:36 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1476971161.480285-1013204608', 06:46:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:36 INFO - '_': '/tools/buildbot/bin/python'} 06:46:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46: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)) 06:46: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)) 06:46: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)) 06:46: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)) 06:46: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)) 06:46: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)) 06:46: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)) 06:46: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)) 06:46: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)) 06:46: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)) 06:46: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)) 06:46:36 INFO - Cleaning up... 06:46:36 INFO - Return code: 0 06:46:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:46: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')]} 06:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46: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')]} 06:46:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:46: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 0x7f2c4d9eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e28930>, '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 0x1e29830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e29cc0>, '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': '337fe3f4b1febe37b85fccc40000019e-1476971161.480285-1013204608', '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 06:46: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 06:46: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 06:46:36 INFO - Using env: {'DISPLAY': ':0', 06:46:36 INFO - 'HOME': '/home/cltbld', 06:46:36 INFO - 'LANG': 'en_US.UTF-8', 06:46:36 INFO - 'LANGUAGE': 'en_US:en', 06:46:36 INFO - 'LOGNAME': 'cltbld', 06:46:36 INFO - 'MAIL': '/var/mail/cltbld', 06:46:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:36 INFO - 'MOZ_NO_REMOTE': '1', 06:46:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:36 INFO - 'NO_EM_RESTART': '1', 06:46:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:36 INFO - 'PWD': '/builds/slave/test', 06:46:36 INFO - 'SHELL': '/bin/bash', 06:46:36 INFO - 'SHLVL': '1', 06:46:36 INFO - 'TERM': 'linux', 06:46:36 INFO - 'TMOUT': '86400', 06:46:36 INFO - 'USER': 'cltbld', 06:46:36 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1476971161.480285-1013204608', 06:46:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:36 INFO - '_': '/tools/buildbot/bin/python'} 06:46:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:46:36 INFO - Cleaning up... 06:46:36 INFO - Return code: 0 06:46:36 INFO - Running post-action listener: _resource_record_post_action 06:46:36 INFO - Running post-action listener: _start_resource_monitoring 06:46:36 INFO - Starting resource monitoring. 06:46:36 INFO - [mozharness: 2016-10-20 13:46:36.958241Z] Finished create-virtualenv step (success) 06:46:36 INFO - [mozharness: 2016-10-20 13:46:36.958704Z] Running install step. 06:46:36 INFO - Running pre-action listener: _resource_record_pre_action 06:46:36 INFO - Running main action method: install 06:46:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:46:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:46:37 INFO - Reading from file tmpfile_stdout 06:46:37 INFO - Detecting whether we're running mozinstall >=1.0... 06:46:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:46:37 INFO - Reading from file tmpfile_stdout 06:46:37 INFO - Output received: 06:46:37 INFO - Usage: mozinstall [options] installer 06:46:37 INFO - Options: 06:46:37 INFO - -h, --help show this help message and exit 06:46:37 INFO - -d DEST, --destination=DEST 06:46:37 INFO - Directory to install application into. [default: 06:46:37 INFO - "/builds/slave/test"] 06:46:37 INFO - --app=APP Application being installed. [default: firefox] 06:46:37 INFO - mkdir: /builds/slave/test/build/application 06:46:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:46:54 INFO - Reading from file tmpfile_stdout 06:46:54 INFO - Output received: 06:46:54 INFO - /builds/slave/test/build/application/firefox/firefox 06:46:54 INFO - Running post-action listener: _resource_record_post_action 06:46:54 INFO - [mozharness: 2016-10-20 13:46:54.228259Z] Finished install step (success) 06:46:54 INFO - [mozharness: 2016-10-20 13:46:54.228508Z] Running run-tests step. 06:46:54 INFO - Running pre-action listener: _resource_record_pre_action 06:46:54 INFO - Running main action method: run_tests 06:46:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:46:54 INFO - Python 2.7.3 06:46:54 INFO - Return code: 0 06:46:54 INFO - grabbing minidump binary from tooltool 06:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:46:54 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 0x1e28930>, '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 0x1e29830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e29cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:46:54 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 06:46:54 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 06:46:54 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 06:46:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:46:54 INFO - Return code: 0 06:46:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:46:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:46:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:46:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:46:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:46:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476959407/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 06:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476959407/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 06:46:54 INFO - Using env: {'DISPLAY': ':0', 06:46:54 INFO - 'HOME': '/home/cltbld', 06:46:54 INFO - 'LANG': 'en_US.UTF-8', 06:46:54 INFO - 'LANGUAGE': 'en_US:en', 06:46:54 INFO - 'LOGNAME': 'cltbld', 06:46:54 INFO - 'MAIL': '/var/mail/cltbld', 06:46:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:46:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:54 INFO - 'MOZ_NO_REMOTE': '1', 06:46:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:46:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:54 INFO - 'NO_EM_RESTART': '1', 06:46:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:54 INFO - 'PWD': '/builds/slave/test', 06:46:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:46:54 INFO - 'SHELL': '/bin/bash', 06:46:54 INFO - 'SHLVL': '1', 06:46:54 INFO - 'TERM': 'linux', 06:46:54 INFO - 'TMOUT': '86400', 06:46:54 INFO - 'USER': 'cltbld', 06:46:54 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1476971161.480285-1013204608', 06:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:54 INFO - '_': '/tools/buildbot/bin/python'} 06:46:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476959407/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 06:46:54 INFO - mozversion application_buildid: 20161020033007 06:46:54 INFO - mozversion application_changeset: 99a239e1866a57f987b08dad796528e4ea30e622 06:46:54 INFO - mozversion application_display_name: Nightly 06:46:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:46:54 INFO - mozversion application_name: Firefox 06:46:54 INFO - mozversion application_remotingname: firefox 06:46:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:46:54 INFO - mozversion application_vendor: Mozilla 06:46:54 INFO - mozversion application_version: 52.0a1 06:46:54 INFO - mozversion platform_buildid: 20161020033007 06:46:54 INFO - mozversion platform_changeset: 99a239e1866a57f987b08dad796528e4ea30e622 06:46:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:46:54 INFO - mozversion platform_version: 52.0a1 06:46:54 INFO - using testdate: 1476971214 06:46:54 INFO - actual date: 1476971214 06:46:54 INFO - starting webserver on 'localhost:45892' 06:46:54 INFO - SUITE-START | Running 2 tests 06:46:54 INFO - TEST-START | dromaeo_css 06:46:54 INFO - operating with platform_type : linux_ 06:46:54 INFO - Initialising browser for dromaeo_css test... 06:46:54 INFO - TEST-INFO | started process 20716 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV5TBYq/profile http://localhost:45892/getInfo.html) 06:46:58 INFO - PROCESS | 20716 | __metrics Screen width/height:1600/1200 06:46:58 INFO - PROCESS | 20716 | colorDepth:24 06:46:58 INFO - PROCESS | 20716 | Browser inner width/height: 1024/697 06:46:58 INFO - PROCESS | 20716 | __metrics 06:46:59 INFO - PROCESS | 20716 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:46:59 INFO - PROCESS | 20716 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:46:59 INFO - PROCESS | 20716 | console.error: PushService: 06:46:59 INFO - PROCESS | 20716 | stateChangeProcessEnqueue: Error transitioning state 06:46:59 INFO - PROCESS | 20716 | UnknownError 06:47:00 INFO - TEST-INFO | 20716: exit 0 06:47:00 INFO - Browser initialized. 06:47:00 INFO - Running cycle 1/1 for dromaeo_css test... 06:47:00 INFO - TEST-INFO | started process 20800 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV5TBYq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:47:12 INFO - PROCESS | 20800 | RSS: Main: 172421120 06:47:12 INFO - PROCESS | 20800 | 06:48:03 INFO - PROCESS | 20800 | 1476971283948 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] 06:50:14 INFO - PROCESS | 20800 | Cycle 1(1): loaded http://localhost:45892/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45892/tests/dromaeo/cssquery-ext.html) 06:50:16 INFO - PROCESS | 20800 | RSS: Main: 274927616 06:50:16 INFO - PROCESS | 20800 | 06:53:18 INFO - PROCESS | 20800 | Cycle 1(1): loaded http://localhost:45892/tests/dromaeo/cssquery-ext.html (next: http://localhost:45892/tests/dromaeo/cssquery-jquery.html) 06:53:19 INFO - PROCESS | 20800 | RSS: Main: 286531584 06:53:19 INFO - PROCESS | 20800 | 06:56:21 INFO - PROCESS | 20800 | Cycle 1(1): loaded http://localhost:45892/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45892/tests/dromaeo/cssquery-mootools.html) 06:56:22 INFO - PROCESS | 20800 | RSS: Main: 248127488 06:56:22 INFO - PROCESS | 20800 | 06:59:24 INFO - PROCESS | 20800 | Cycle 1(1): loaded http://localhost:45892/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45892/tests/dromaeo/cssquery-prototype.html) 06:59:24 INFO - PROCESS | 20800 | RSS: Main: 265535488 06:59:24 INFO - PROCESS | 20800 | 07:02:27 INFO - PROCESS | 20800 | Cycle 1(1): loaded http://localhost:45892/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45892/tests/dromaeo/cssquery-yui.html) 07:02:28 INFO - PROCESS | 20800 | RSS: Main: 214749184 07:02:28 INFO - PROCESS | 20800 | 07:05:31 INFO - PROCESS | 20800 | Cycle 1(1): loaded http://localhost:45892/tests/dromaeo/cssquery-yui.html (next: http://localhost:45892/tests/dromaeo/cssquery-dojo.html) 07:05:31 INFO - PROCESS | 20800 | RSS: Main: 305737728 07:05:31 INFO - PROCESS | 20800 | 07:05:31 INFO - PROCESS | 20800 | __start_tp_report 07:05:31 INFO - PROCESS | 20800 | _x_x_mozilla_page_load 07:05:31 INFO - PROCESS | 20800 | _x_x_mozilla_page_load_details 07:05:31 INFO - PROCESS | 20800 | |i|pagename|runs| 07:05:31 INFO - PROCESS | 20800 | |0;dojo.html;3013.7739669524785;3049.725524702778;3051.618547681539;3078.184281165493;3099.271671157279;5085.262636917654;5143.845684629462;5182.274481572583;5202.531772140506;5259.6581222220575;5166.225066240057;5200.583953283738;5235.293235413218;5266.920996185051;5285.127953887613;4686.9531304687025;4691.0617876424685;4740.976295118519;4752.738599377033;4759.643026772988;4776.47458779534;4818.108649899762;4872.3422337984275;4875.098106850244;4922.876928076791;4632.745199014086;4796.856094317176;4797;4850.442199147108;4876;4645.094206629708;4707.882302942454;4711.623070154379;4713.552212539803;4714.811407543694;4649.1399091167905;4705.1765940960195;4727.976360118212;4761.857144285642;4797.160496913027;5173.534381905609;5195.980899323496;5198.636095473318;5205.9219111713355;5241.475852414766;5357.544608708265;5400.351957765093;5541.0580201365865;5541.196526503675;5550.916736248919;5481.150421684645;5484.396716361197;5491.862703432406;5497.202905578709;5517.089680202802;5081.8729531762;5153.5361817436615;5159.432462429129;5159.922601160985;5162.19985902182;5607.214989901417;5614.07367784311;5620.18507316445;5623.409541998113;5625;5340.572754179734;5401.432849550819;5403.2705584746345;5405.108157154104;5418.756155972991;5467.316585426822;5480.424555421703;5485.670859748428;5490.286262785892;5495.395506494282;5493.533049690821;5514.531264842533;5516.889662206733;5558;5589.888202235932;5514.145307477347;5523.088690366045;5528.419515950848;5531.751071201806;5596.860078497989;4177.49870015594;4219.2194444027955;4245.00296853352;4245.532991370947;4302.118065796504;3777.1501412182038;3813.466114743938;3829.272438236726;3843.7693738375788;3900.863469778544;5246.973765131226;5253.579713622901;5258.027264955996;5261.316028916216;5296.814611488579;5543.61194716374;5551.139573366135;5551.944480555143;5559.054960656698;5559.471850174227;5178.223266510054;5230.215467679803;5240.9213861792105;5253.973730131325;5289.444608316148;4845.152098382769;4846.878828029327;4848.054629347314;4895.902081958341;4910.705357678551;5745.454181852718;5747.827565173052;5755.309362876482;5758.222639943638;5764.337101233412;5454.236406902957;5509.862253443696;5548.639338443149;5580.051391263576;5598.1322894951345;5735.913961290667;5746.597738158289;5747.48272655463;5794.217780599565;5803.042497987784;5436.7553460093595;5494.395616482264;5495;5496.5053145217125;5496.890062198813;5281.392639846313;5412.296401467784;5526.309211348582;5585.664860108244;5589.105743081088;5425.538829199562;5480.862978425412;5481.808136715196;5535.972320138373;5539.806106786243;5445.428230035947;5452.781888724407;5453.863653408696;5462.535684466865;5465.863353416196;5241.371035475615;5304.549113325411;5430.945690543044;5438.075527160313;5499.202615620793;5438.619296649196;5467.507924286833;5472.972635136958;5473.124300111963;5553.4724201200825;5302.469753024667;5338.065838478328;5351.357837059578;5352.518273355417;5416.972915135557 07:05:31 INFO - PROCESS | 20800 | |1;ext.html;559.9872684954942;589.5931807053133;604.7339170764866;610.3804638292131;612.0452094732218;31579.68420315796;32258.8387058065;42973.57026429735;43458.78270608642;43730.99999999992;41054.794726026324;45090.77454612722;45111.32333015007;45117.548824511745;45177.77411112948;8820.779480512974;8970.910290897073;8970.955145224265;8973.192412682858;8982.59578318974;7909.367250619936;8077.919220807805;8739.082396348387;10332.948335258314;10693.78612427751;10823.945880270627;10885.292455990375;10889.782204355908;10893.564257429693;10897.618583349584;10594.25840191187;10668.413237271947;10671.35971841692;10684.946575267151;10689.78620427591;7848.529088254723;8083.110857805636;10194.745131371701;10535.578576856917;10550.630727924563;41593.79203103996;41788.37317440241;41862.37206441906;41891.1621767563;41948;3250.414925313443;3253.804771713681;3328.5301880159136;3527.4885141654318;3806.9809650951843;31508;31638.367232655448;32232.35535289281;32510.837445812856;33550.664493355;4151.107511884959;4187.602177793105;4378.255696531597;4404.846828061317;4417.159616244973;313039;314491;315516;316989;317100;58732.11901821476;59098.704506477196;59285.40714592885;59291.70354148288;59424.70287648534;63119.684401577695;63546.682266588374;63589.36410635927;63655;63696.681516593046;15388.615284617974;15649.530514084596;15651.139187344805;15652.530424087068;15655.608609784846;10758.40828754426;11313.943430282796;11419.60031398897;11434.142439316918;11467.885321146681;15083.54749357521;17453.7381939271;17926.731099033525;17929.551761205814;18634.534136646693;5612.915806262909;6157.168782214344;6224.937750622526;6280.497560195174;6314.273858506239;955.47926380123;1008.5918925492248;1146.2606618730872;1157.346099453806;1159.0611604600301;31317.530237046463;31498.685013149574;31525.52711709326;31677.683223167474;31921.840390797897;1083.160550573312;1088.4448931045065;1151.9747424791942;1166.055495049013;1198.1672737447564;15963.920180399024;16673.833261667227;16784.15944402267;16817.327306907588;16859.24133413999;479434;482254;483168;484522;485039;49696;50283.74858125686;55704.16443753347;57352.42647573554;57690.42309576934;1294.9611511654666;1306.8105124756858;1319.3271431569776;1337.5385492005244;1345.878870901643;30390.392192155592;33175.502367464025;33275.33449331048;33279.667203327655;33567.66432335743;51454.22818657648;51890.74054629703;51922.740386297824;51991;52141.7392913033;301569;303167;303960;304038;304236.95763042086;40110.59889401068;40789;41004.384934226604;41115.383269250386;41670;45940.310895337265;46775.766121169174;46784.298235525814;47292;47537;39186;39791.40312895251;39823.40264895971;40336;41556.792216038724;39335.213295734495;39634.207315854095;40624.25065941952;40646;41287.793561032006;40682.59317406788;41155.17689646131;41420;41507.1698566033;41543.58456415518;33868.83065584656;36323.63676363203;36860.81569592135;37063.44404833876;37138.25723485461;27471.587926180724;27988.720112799427;27994.300142496602;28011.439771204055;28049 07:05:31 INFO - PROCESS | 20800 | |2;jquery.html;355.960844307126;364.31690580162194;380.2547007864586;384.9307124717551;400.6914675699711;14271;18406;19176.23295068199;20109.899450502726;20301.0864511097;18645.440636780884;18935.81064189358;19513.41459756206;19685.803141968576;19720.112594933227;5511.476409741068;5770.509506691937;5771.365149833536;5771.595988280822;5789.015867302569;5637.943620563783;5646.717664116798;5910.940890591103;5936.792212272571;6020.6688632125215;6007.849803754919;6015.368386319439;6024.879502409971;6026.487748541379;6029.457348838604;5671.432856714317;5932.317783454915;5967.403259674042;6030.065339872327;6035.607685500472;5630.831075067755;5773.134029895549;5823.941760582382;5829.621074630136;5835.766569337221;13651.249181295025;13735.931320343434;13757.862421375758;13772;13784.241866697328;2091.968620470694;2186.35502526755;2436.1229957215387;2445.5108978204253;2964.7035296470394;9740.172085372751;10023.799524009552;10234.1300989416;11018.44907754609;14958.40166393343;1796.3982066007773;1888.499547619882;1890.5179179309189;1915.205189846212;1941.0682872221412;80354;84363.57818210931;84693;85337;86397.56801216016;10508.211884108723;10521.316114452537;10543.42011189392;10797.406142662228;10930.945345273381;15183.62040948963;15202.543923682308;15232.847671523365;15233.390664373523;15239.466618668293;7251.782446526613;7501.174870764212;7534.0582427196605;7710.575918324434;7744.845103097907;6894.827629309308;7059.399951004119;7074.151101867706;7348.742794002184;7410.666520006613;4454.933176002362;4572.588467037983;4608.470025947059;4629.236176030984;4724.078804633064;1833.9266429342945;1841.6500864835639;1851.3705340184401;1875.4842418335068;1907.7901430842596;939.736873675372;974.4250891973628;997.1623835977668;1027.9640212592524;1086.28305318491;18171.182296796676;19572.70640940387;19605.50986225327;19712.310069147512;19719.40841774749;944.2870632672289;945.8675785390051;971.2133172130597;987.0721521769514;1011.0546638892658;10278.766548014286;10877.292975956538;10958.342499450058;11036.11711063113;11052.944735276273;421903;425977;436237;438680;439571;91435.54282228679;93621.53189234146;93791;94031.36545201045;94253;965.8068386322764;1004.2116938203475;1038.9064984151462;1046.7226185060965;1047.1518070363031;16645.750313745062;17246.22391992338;17508.82491175072;17593.912030439766;17632.82367176312;38095;38275;41706;42439;43104.56895431005;56015.71992140176;56451.71774141267;57950.420495794504;58161.709191453774;59519;8096.87854682192;8346.916530834857;8587.785305367166;8605.440646357967;8679.479231246145;11961.282323060645;12868.613941581767;13354.198748075147;13466.865331346562;13558.525451609146;10968.341899485737;11719.76560468803;11979.161458697807;12212.877871221173;12395.876041239471;11496;11590.594329198437;11631.88368116308;11719.41402929833;11745.588904388305;11824.586139485076;12015.699607509532;12053.57812476559;12165.817512737493;12262.570810021607;8306.127856574973;8442.197991190827;8501.95749021251;8516.276116530164;8757.124287571192;10325.586976520855;11440.599579014695;11535.769284614093;12041.976432003377;12233.449494772934 07:05:31 INFO - PROCESS | 20800 | |3;mootools.html;1305.5822136916179;1433.4266293482606;1447.3414596358657;1545.8686011689006;1735.600811813283;7516.173220945691;8204;8389.454685445442;8394.832103357929;8719.302455803536;8455.239028487435;8501.957490212555;8549;8558.871616925735;8560.400771945966;2231.4421394651336;2252.0653928619604;2257.446925503254;2258.8418810683174;2259.051198496627;2193.2762188477764;2234.218023691703;2269.8751568663715;2274.431392151962;2276.044061494168;2212.3031245157804;2212.7787221277904;2217.678436626696;2240;2279.8746068966284;2133.8826364549946;2167.100653228908;2173.9565208695894;2176.281826997095;2177.0856240379;2139.8716077035274;2146.495573540217;2156.870587764739;2157.6979222908803;2165.4586353411646;8375.95812020936;8518.616662250213;8539.231469167804;8558.486490810572;8580.957095214546;5017.096922553938;5179.585633149377;5185.118529849935;5250.448702886219;5258.000979813862;3363.5459213006175;3490.825458727079;3562.786232826039;3577.123604716835;3592.8742494012845;1014.4623349624711;1070.582472835587;1090.4220762995626;1105.5688281570194;1107.2083460325825;10595.152387809034;10660.62687805931;10709.839352409643;10719.946400267949;10726.19553533488;4088.448059511928;4153.418521407006;4299.452197209002;4299.656027517791;4433.563987909396;8901.599428025755;8901.821963560693;8906.777330566787;8908.153725396078;8912.8663070054;5079.263506791494;5079.415867175248;5099.796008159707;5100.974495127501;5101.0308041472745;4205.243056249843;4231.597998190167;4678.345031695565;4736.8105275788585;4751.572358487752;3472.4617684258474;3520.4015317396106;3573.5175751273246;3574.1243395367783;3697.4638677391627;1111.377628528027;1127.2954403497813;1129.1023636209234;1140.8288756686563;1141.3494308244387;837.7193640130503;872.3936863879669;887.3433659092225;894.5974311559825;935.8362286599818;5559.24950131727;5575.052241118939;5674.801381951612;5704.1443783432815;5917.378675239124;927.3925578745932;937.7046230437527;952.0859974424629;953.594722243044;960.3805545423163;3896.1428485733095;3974.3044967131214;4013.234605303836;4076.8369265229057;4093.91812163761;9782.51087445625;10481.895181048245;10501.684949451528;10645.627403040857;10653.467326633638;10115.949420252999;10337.896621033844;10427.217958653131;10528.63149789769;10530.420826854443;7512.286332798375;7762.184970578121;7775.22247775218;7780.377569794403;7811.882821757678;5459.918101228564;5602.691851948182;5652.63257888236;5702.401247868914;5815.82552523425;9732.562034708313;9787.853182202414;9818;9844.556994935101;9958.900410995797;9408.153266206074;9788.657396991071;9789.85315220258;9926.354786938826;9937.801243975224;6840.213375461686;7038.2961703829205;7534.54792712439;7757.806054848674;7764.145943946049;7835.764927052198;8003.359731221604;8054.23484768946;8163.755087347389;8223.9588802058;7071.46963977714;7282.52663576887;7300.96349518249;7463.514871533333;7585.317321441097;7183.568985860865;7219.744809904438;7320.1215854097845;7370.48406611532;7442.330190282901;6816.352446517573;6823.181218253642;6858.245592984668;6880.277570854988;6891.310868913069;4966.776495057658;5039.974800126122;5050.747462626928;5083.262926875508;5094.108531006985;4765.666403351732;4908.042931628298;5021.5229553192385;5113.233015047773;5196.896062078813 07:05:31 INFO - PROCESS | 20800 | |4;prototype.html;315.6354410655692;323.8218979561241;332.07517064974036;332.54773508029064;333.08069727551947;5257.842264732055;5351;5446.863828404292;5450.890982180354;5472.835814925548;5331.173668081454;5337.70642614656;5368.892622147565;5384.461553844613;5404.783923617194;4144.9792751036275;4164.708470407073;4197.832086716543;4215.662746980234;4215.768132752697;4123.484564429446;4157.251694694954;4170.645495132902;4186.681195423447;4246.917036155776;4170.103427763031;4172.374143878412;4174.831047306759;4185.895352616179;4187.769672668002;4149.419081328617;4159.480064991876;4170.4995400551825;4172.144710334389;4174.66602671787;3657.2319812839337;3657.56109266887;3668.248009158116;3671.210689701727;3671.430928206132;5099.388073431212;5256.237845512379;5257.894842103136;5263.815641480636;5274.525292723635;4731.509574484026;4756.548127927876;4793.137235297645;4795.4964728703335;4800.423949126092;5374.7850085996515;5496;5568.972155139239;5579.609427340088;5613.691246981414;3938;3945.309570825123;3950.960490395088;3951.38753493209;3980.383040628707;5417.485338892799;5603.075492543725;5720.141978703186;5766.826995190109;5774.393688662714;3927.7839718815167;3999.6200360965663;4006.419069234945;4034.6282264029783;4037.2639764900787;4091.89770255746;4091.97954010228;4094.7133700641266;4116.670666346685;4139.089400331922;4492.752898590544;4714.363560919232;4721.197396442613;4739.526047395302;4745.264484004984;5520.558355331564;5530.087535556588;5530.668159910419;5534.889302213933;5566.749496272678;1393.2963853254244;1414.7594908865312;1418.985810141906;1424.4017512644714;1428.778539326406;835.511225932836;896.6861598440494;901.193431878465;912.8361339292455;921.8156368726281;4757.4072130688855;4768.213244814636;4772.665913386099;4773.641976851681;4777.539567122934;5011.398632164163;5025.39695236574;5026.346574945233;5043.621728370387;5050.49495050492;4752.762361881962;4774.618030557547;4778.880527986828;4784.282357646381;5072.949270507248;2976.821390716564;3020.2298413904755;3023.8639261232856;3033.5601337805892;3045.8933937312086;5884.529237660977;5885.852258809577;5899.528037756969;5915.970420147958;5956.795985485312;5532;5723.570732195102;5758.798442054592;5767.192593036978;5824.650520968756;5795.797147099831;5823.854403639943;5854.862975014089;5856.267966504187;5873.618214816109;5523.6409633373705;5725.450220863091;5748.6203311205845;5785.190073389645;5787.074068149076;5641.351244606923;5661.943380566142;5665.20687103814;5667.376588575171;5714.9142762857755;5666.376698563237;5762.481376675952;5821.243238378984;5895.852603684943;5943.108533719977;4055.1686904185162;4085.5505894351004;4099.8360065598235;4109.568495308069;4116.444280022159;5683.630564013326;5847.093700476433;5852.561057920588;5861.948318088635;5864.824055278348;5537.723113844211;5564;5573.7770489179975;5575.386707462095;5580.748866300945;5556.777728890799;5561.777528898799;5569.832905012856;5572.4706152915405;5632.183333416713;5324.760385782726;5543.77824887;5553.194786755817;5582.469665381782;5644.6613203207935;5607.943920560742;5631.915521267266;5633.4084921082695;5636.520895723909;5636.549076073986;5506.585916731652;5518.420565840529;5566.52684521804;5617.185508101221;5628.971855140698 07:05:31 INFO - PROCESS | 20800 | |5;yui.html;727.3780917315695;734.5812886654602;735.727780721133;741.0884611927332;765.7702689193243;15807.44673936411;16578.336866525326;16587.668246635076;16591;16595.751063734053;14259.92870035651;14504.564863054098;14514.27428628567;14514.709705805877;14521.854781452183;660.0429377402761;674.9898751518731;782.5265714242886;794.1224946434179;808.0545761459077;801.6993627389729;806.733777853307;818.8321394114192;818.938579606529;819.9877001844977;856.1267507142711;857.8756080368343;858.5964596639601;858.6222062292602;858.7466697324304;690.0994202565649;850.1201256699349;850.7277671145235;851.7402192331336;852.6035393542032;514.8738559053019;607.7234858139536;620.5066971757464;623.803501896901;624.881272558217;14102.435902563886;14126.92936535321;14133.081349712236;14145.929270353583;14151.080179788281;13725.588232353046;13873.930630346784;14026.08830426019;14033.298335083307;14598.854011459856;12948.805767913489;13011.79078102696;13044.739105217937;13167;13410.329483525882;4216.683748718828;4274.679399045084;4327.848525301631;4333.155034768221;4475.955240447586;78857;79679.6016019922;79892;80267.19732802655;80627.5968620159;10628;10728.356298622108;10759.3544387337;10886.61896833607;11265.15511336653;21321.25375611846;21353.25263615766;21388.893055534623;21517.89241053816;21571.78428215698;7999.560024198725;8080.636371363303;8309;8367.497950123012;8373.455725377831;4364.869053928387;4402.229609818269;4468.776561171993;4573.885652858705;4669.322948172564;3403.2002479417315;3491.790492570454;3522.982385088058;3525.471179323122;3526.9118272043406;589.0957380421033;589.1310317281975;596.4035964035965;597.316073096311;605.6245128020568;584.8070136854827;594.7977687586241;597.7160848596968;633.1610615933906;672.525869262169;8562.529060901586;8629.654813807378;8738.794497574176;8902.821943561223;9061.64621727694;545.6562365709577;630.2625927664552;631.5011141198494;663.2140913018089;687.2577616174519;3998.8200530975596;4429.158459892675;4461.977690111528;4468.798904049326;4583.742210577179;117299.41350293365;119509.40245298891;120312;121863.45526077705;122013;102563.46154807684;105106;105366.47316763367;106179;108023;89504;89860.5506972461;90076;93572;95365.52317238509;8297.668093276201;8322.20939010793;8427.367947403847;8635;8874.689385871463;38902.610973889896;47824.760876195396;49996.25005624846;50617.74691126521;52077.21884171816;62922.68538657461;63974.68012660093;65289.34710652833;65892.34107658862;69915;12685.175463594836;12804.871951280367;12813.615591532269;12973.416196271379;13062.738745225231;14215.786763198766;14748.460369511455;15037.398504060153;15040.398384064514;15252.23738813077;10284;13670.794938075738;13764.518241861486;13898.652533686738;14944;11566.30602163873;11729.237599556001;12413.717867343614;13538.728791138325;13546.864531354955;13004.804927926278;13218.801717974045;13331.66670833237;14288.714225715219;14820.184889831164;10765.869583693599;10795.244332896622;11247.943760281147;11302.60440884598;11397.487113080097;11188.720281993015;11938.880611194125;12127.332996684914;12197.878021220029;12494 07:05:31 INFO - PROCESS | 20800 | __end_tp_report 07:05:31 INFO - PROCESS | 20800 | __start_cc_report 07:05:31 INFO - PROCESS | 20800 | _x_x_mozilla_cycle_collect,1458 07:05:31 INFO - PROCESS | 20800 | __end_cc_report 07:05:31 INFO - PROCESS | 20800 | __startTimestamp1476972331546__endTimestamp 07:05:31 INFO - PROCESS | 20800 | 07:05:31 INFO - PROCESS | 20800 | ------- Summary: start ------- 07:05:31 INFO - PROCESS | 20800 | Number of tests: 6 07:05:31 INFO - PROCESS | 20800 | 07:05:31 INFO - PROCESS | 20800 | [#0] dojo.html Cycles:165 Average:5161.51 Median:5352.52 stddev:565.83 (10.6%) stddev-sans-first:541.90 07:05:31 INFO - PROCESS | 20800 | Values: 3013.8 3049.7 3051.6 3078.2 3099.3 5085.3 5143.8 5182.3 5202.5 5259.7 5166.2 5200.6 5235.3 5266.9 5285.1 4687.0 4691.1 4741.0 4752.7 4759.6 4776.5 4818.1 4872.3 4875.1 4922.9 4632.7 4796.9 4797.0 4850.4 4876.0 4645.1 4707.9 4711.6 4713.6 4714.8 4649.1 4705.2 4728.0 4761.9 4797.2 5173.5 5196.0 5198.6 5205.9 5241.5 5357.5 5400.4 5541.1 5541.2 5550.9 5481.2 5484.4 5491.9 5497.2 5517.1 5081.9 5153.5 5159.4 5159.9 5162.2 5607.2 5614.1 5620.2 5623.4 5625.0 5340.6 5401.4 5403.3 5405.1 5418.8 5467.3 5480.4 5485.7 5490.3 5495.4 5493.5 5514.5 5516.9 5558.0 5589.9 5514.1 5523.1 5528.4 5531.8 5596.9 4177.5 4219.2 4245.0 4245.5 4302.1 3777.2 3813.5 3829.3 3843.8 3900.9 5247.0 5253.6 5258.0 5261.3 5296.8 5543.6 5551.1 5551.9 5559.1 5559.5 5178.2 5230.2 5240.9 5254.0 5289.4 4845.2 4846.9 4848.1 4895.9 4910.7 5745.5 5747.8 5755.3 5758.2 5764.3 5454.2 5509.9 5548.6 5580.1 5598.1 5735.9 5746.6 5747.5 5794.2 5803.0 5436.8 5494.4 5495.0 5496.5 5496.9 5281.4 5412.3 5526.3 5585.7 5589.1 5425.5 5480.9 5481.8 5536.0 5539.8 5445.4 5452.8 5453.9 5462.5 5465.9 5241.4 5304.5 5430.9 5438.1 5499.2 5438.6 5467.5 5473.0 5473.1 5553.5 5302.5 5338.1 5351.4 5352.5 5417.0 07:05:31 INFO - PROCESS | 20800 | 07:05:31 INFO - PROCESS | 20800 | [#1] ext.html Cycles:180 Average:54266.72 Median:21496.49 stddev:99252.16 (461.7%) stddev-sans-first:99448.67 07:05:31 INFO - PROCESS | 20800 | Values: 560.0 589.6 604.7 610.4 612.0 31579.7 32258.8 42973.6 43458.8 43731.0 41054.8 45090.8 45111.3 45117.5 45177.8 8820.8 8970.9 8971.0 8973.2 8982.6 7909.4 8077.9 8739.1 10332.9 10693.8 10823.9 10885.3 10889.8 10893.6 10897.6 10594.3 10668.4 10671.4 10684.9 10689.8 7848.5 8083.1 10194.7 10535.6 10550.6 41593.8 41788.4 41862.4 41891.2 41948.0 3250.4 3253.8 3328.5 3527.5 3807.0 31508.0 31638.4 32232.4 32510.8 33550.7 4151.1 4187.6 4378.3 4404.8 4417.2 313039.0 314491.0 315516.0 316989.0 317100.0 58732.1 59098.7 59285.4 59291.7 59424.7 63119.7 63546.7 63589.4 63655.0 63696.7 15388.6 15649.5 15651.1 15652.5 15655.6 10758.4 11313.9 11419.6 11434.1 11467.9 15083.5 17453.7 17926.7 17929.6 18634.5 5612.9 6157.2 6224.9 6280.5 6314.3 955.5 1008.6 1146.3 1157.3 1159.1 31317.5 31498.7 31525.5 31677.7 31921.8 1083.2 1088.4 1152.0 1166.1 1198.2 15963.9 16673.8 16784.2 16817.3 16859.2 479434.0 482254.0 483168.0 484522.0 485039.0 49696.0 50283.7 55704.2 57352.4 57690.4 1295.0 1306.8 1319.3 1337.5 1345.9 30390.4 33175.5 33275.3 33279.7 33567.7 51454.2 51890.7 51922.7 51991.0 52141.7 301569.0 303167.0 303960.0 304038.0 304237.0 40110.6 40789.0 41004.4 41115.4 41670.0 45940.3 46775.8 46784.3 47292.0 47537.0 39186.0 39791.4 39823.4 40336.0 41556.8 39335.2 39634.2 40624.3 40646.0 41287.8 40682.6 41155.2 41420.0 41507.2 41543.6 33868.8 36323.6 36860.8 37063.4 37138.3 27471.6 27988.7 27994.3 28011.4 28049.0 07:05:31 INFO - PROCESS | 20800 | 07:05:31 INFO - PROCESS | 20800 | [#2] jquery.html Cycles:180 Average:27216.00 Median:1660.33 stddev:71806.81 (4324.8%) stddev-sans-first:71979.93 07:05:31 INFO - PROCESS | 20800 | Values: 356.0 364.3 380.3 384.9 400.7 14271.0 18406.0 19176.2 20109.9 20301.1 18645.4 18935.8 19513.4 19685.8 19720.1 5511.5 5770.5 5771.4 5771.6 5789.0 5637.9 5646.7 5910.9 5936.8 6020.7 6007.8 6015.4 6024.9 6026.5 6029.5 5671.4 5932.3 5967.4 6030.1 6035.6 5630.8 5773.1 5823.9 5829.6 5835.8 13651.2 13735.9 13757.9 13772.0 13784.2 2092.0 2186.4 2436.1 2445.5 2964.7 9740.2 10023.8 10234.1 11018.4 14958.4 1796.4 1888.5 1890.5 1915.2 1941.1 80354.0 84363.6 84693.0 85337.0 86397.6 10508.2 10521.3 10543.4 10797.4 10930.9 15183.6 15202.5 15232.8 15233.4 15239.5 7251.8 7501.2 7534.1 7710.6 7744.8 6894.8 7059.4 7074.2 7348.7 7410.7 4454.9 4572.6 4608.5 4629.2 4724.1 1833.9 1841.7 1851.4 1875.5 1907.8 939.7 974.4 997.2 1028.0 1086.3 18171.2 19572.7 19605.5 19712.3 19719.4 944.3 945.9 971.2 987.1 1011.1 10278.8 10877.3 10958.3 11036.1 11052.9 421903.0 425977.0 436237.0 438680.0 439571.0 91435.5 93621.5 93791.0 94031.4 94253.0 965.8 1004.2 1038.9 1046.7 1047.2 16645.8 17246.2 17508.8 17593.9 17632.8 38095.0 38275.0 41706.0 42439.0 43104.6 56015.7 56451.7 57950.4 58161.7 59519.0 8096.9 8346.9 8587.8 8605.4 8679.5 11961.3 12868.6 13354.2 13466.9 13558.5 10968.3 11719.8 11979.2 12212.9 12395.9 11496.0 11590.6 11631.9 11719.4 11745.6 11824.6 12015.7 12053.6 12165.8 12262.6 8306.1 8442.2 8502.0 8516.3 8757.1 10325.6 11440.6 11535.8 12042.0 12233.4 07:05:31 INFO - PROCESS | 20800 | 07:05:31 INFO - PROCESS | 20800 | [#3] mootools.html Cycles:180 Average:5501.52 Median:5100.39 stddev:3070.57 (60.2%) stddev-sans-first:3062.99 07:05:31 INFO - PROCESS | 20800 | Values: 1305.6 1433.4 1447.3 1545.9 1735.6 7516.2 8204.0 8389.5 8394.8 8719.3 8455.2 8502.0 8549.0 8558.9 8560.4 2231.4 2252.1 2257.4 2258.8 2259.1 2193.3 2234.2 2269.9 2274.4 2276.0 2212.3 2212.8 2217.7 2240.0 2279.9 2133.9 2167.1 2174.0 2176.3 2177.1 2139.9 2146.5 2156.9 2157.7 2165.5 8376.0 8518.6 8539.2 8558.5 8581.0 5017.1 5179.6 5185.1 5250.4 5258.0 3363.5 3490.8 3562.8 3577.1 3592.9 1014.5 1070.6 1090.4 1105.6 1107.2 10595.2 10660.6 10709.8 10719.9 10726.2 4088.4 4153.4 4299.5 4299.7 4433.6 8901.6 8901.8 8906.8 8908.2 8912.9 5079.3 5079.4 5099.8 5101.0 5101.0 4205.2 4231.6 4678.3 4736.8 4751.6 3472.5 3520.4 3573.5 3574.1 3697.5 1111.4 1127.3 1129.1 1140.8 1141.3 837.7 872.4 887.3 894.6 935.8 5559.2 5575.1 5674.8 5704.1 5917.4 927.4 937.7 952.1 953.6 960.4 3896.1 3974.3 4013.2 4076.8 4093.9 9782.5 10481.9 10501.7 10645.6 10653.5 10115.9 10337.9 10427.2 10528.6 10530.4 7512.3 7762.2 7775.2 7780.4 7811.9 5459.9 5602.7 5652.6 5702.4 5815.8 9732.6 9787.9 9818.0 9844.6 9958.9 9408.2 9788.7 9789.9 9926.4 9937.8 6840.2 7038.3 7534.5 7757.8 7764.1 7835.8 8003.4 8054.2 8163.8 8224.0 7071.5 7282.5 7301.0 7463.5 7585.3 7183.6 7219.7 7320.1 7370.5 7442.3 6816.4 6823.2 6858.2 6880.3 6891.3 4966.8 5040.0 5050.7 5083.3 5094.1 4765.7 4908.0 5021.5 5113.2 5196.9 07:05:31 INFO - PROCESS | 20800 | 07:05:31 INFO - PROCESS | 20800 | [#4] prototype.html Cycles:180 Average:4648.74 Median:5299.64 stddev:1367.27 (25.8%) stddev-sans-first:1331.86 07:05:31 INFO - PROCESS | 20800 | Values: 315.6 323.8 332.1 332.5 333.1 5257.8 5351.0 5446.9 5450.9 5472.8 5331.2 5337.7 5368.9 5384.5 5404.8 4145.0 4164.7 4197.8 4215.7 4215.8 4123.5 4157.3 4170.6 4186.7 4246.9 4170.1 4172.4 4174.8 4185.9 4187.8 4149.4 4159.5 4170.5 4172.1 4174.7 3657.2 3657.6 3668.2 3671.2 3671.4 5099.4 5256.2 5257.9 5263.8 5274.5 4731.5 4756.5 4793.1 4795.5 4800.4 5374.8 5496.0 5569.0 5579.6 5613.7 3938.0 3945.3 3951.0 3951.4 3980.4 5417.5 5603.1 5720.1 5766.8 5774.4 3927.8 3999.6 4006.4 4034.6 4037.3 4091.9 4092.0 4094.7 4116.7 4139.1 4492.8 4714.4 4721.2 4739.5 4745.3 5520.6 5530.1 5530.7 5534.9 5566.7 1393.3 1414.8 1419.0 1424.4 1428.8 835.5 896.7 901.2 912.8 921.8 4757.4 4768.2 4772.7 4773.6 4777.5 5011.4 5025.4 5026.3 5043.6 5050.5 4752.8 4774.6 4778.9 4784.3 5072.9 2976.8 3020.2 3023.9 3033.6 3045.9 5884.5 5885.9 5899.5 5916.0 5956.8 5532.0 5723.6 5758.8 5767.2 5824.7 5795.8 5823.9 5854.9 5856.3 5873.6 5523.6 5725.5 5748.6 5785.2 5787.1 5641.4 5661.9 5665.2 5667.4 5714.9 5666.4 5762.5 5821.2 5895.9 5943.1 4055.2 4085.6 4099.8 4109.6 4116.4 5683.6 5847.1 5852.6 5861.9 5864.8 5537.7 5564.0 5573.8 5575.4 5580.7 5556.8 5561.8 5569.8 5572.5 5632.2 5324.8 5543.8 5553.2 5582.5 5644.7 5607.9 5631.9 5633.4 5636.5 5636.5 5506.6 5518.4 5566.5 5617.2 5629.0 07:05:31 INFO - PROCESS | 20800 | 07:05:31 INFO - PROCESS | 20800 | [#5] yui.html Cycles:180 Average:20950.25 Median:4349.01 stddev:30946.00 (711.6%) stddev-sans-first:30995.56 07:05:31 INFO - PROCESS | 20800 | Values: 727.4 734.6 735.7 741.1 765.8 15807.4 16578.3 16587.7 16591.0 16595.8 14259.9 14504.6 14514.3 14514.7 14521.9 660.0 675.0 782.5 794.1 808.1 801.7 806.7 818.8 818.9 820.0 856.1 857.9 858.6 858.6 858.7 690.1 850.1 850.7 851.7 852.6 514.9 607.7 620.5 623.8 624.9 14102.4 14126.9 14133.1 14145.9 14151.1 13725.6 13873.9 14026.1 14033.3 14598.9 12948.8 13011.8 13044.7 13167.0 13410.3 4216.7 4274.7 4327.8 4333.2 4476.0 78857.0 79679.6 79892.0 80267.2 80627.6 10628.0 10728.4 10759.4 10886.6 11265.2 21321.3 21353.3 21388.9 21517.9 21571.8 7999.6 8080.6 8309.0 8367.5 8373.5 4364.9 4402.2 4468.8 4573.9 4669.3 3403.2 3491.8 3523.0 3525.5 3526.9 589.1 589.1 596.4 597.3 605.6 584.8 594.8 597.7 633.2 672.5 8562.5 8629.7 8738.8 8902.8 9061.6 545.7 630.3 631.5 663.2 687.3 3998.8 4429.2 4462.0 4468.8 4583.7 117299.4 119509.4 120312.0 121863.5 122013.0 102563.5 105106.0 105366.5 106179.0 108023.0 89504.0 89860.6 90076.0 93572.0 95365.5 8297.7 8322.2 8427.4 8635.0 8874.7 38902.6 47824.8 49996.3 50617.7 52077.2 62922.7 63974.7 65289.3 65892.3 69915.0 12685.2 12804.9 12813.6 12973.4 13062.7 14215.8 14748.5 15037.4 15040.4 15252.2 10284.0 13670.8 13764.5 13898.7 14944.0 11566.3 11729.2 12413.7 13538.7 13546.9 13004.8 13218.8 13331.7 14288.7 14820.2 10765.9 10795.2 11247.9 11302.6 11397.5 11188.7 11938.9 12127.3 12197.9 12494.0 07:05:31 INFO - PROCESS | 20800 | -------- Summary: end -------- 07:05:31 INFO - PROCESS | 20800 | 07:05:32 INFO - TEST-INFO | 20800: exit 0 07:05:32 INFO - TEST-OK | dromaeo_css | took 1117931ms 07:05:32 INFO - TEST-START | kraken 07:05:32 INFO - operating with platform_type : linux_ 07:05:32 INFO - Initialising browser for kraken test... 07:05:32 INFO - TEST-INFO | started process 21102 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMR9BNC/profile http://localhost:45892/getInfo.html) 07:05:36 INFO - PROCESS | 21102 | __metrics Screen width/height:1600/1200 07:05:36 INFO - PROCESS | 21102 | colorDepth:24 07:05:36 INFO - PROCESS | 21102 | Browser inner width/height: 1024/697 07:05:36 INFO - PROCESS | 21102 | __metrics 07:05:37 INFO - PROCESS | 21102 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:05:37 INFO - PROCESS | 21102 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:05:37 INFO - PROCESS | 21102 | console.error: PushService: 07:05:37 INFO - PROCESS | 21102 | stateChangeProcessEnqueue: Error transitioning state 07:05:37 INFO - PROCESS | 21102 | UnknownError 07:05:38 INFO - TEST-INFO | 21102: exit 0 07:05:38 INFO - Browser initialized. 07:05:38 INFO - Running cycle 1/1 for kraken test... 07:05:38 INFO - TEST-INFO | started process 21186 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMR9BNC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:05:50 INFO - PROCESS | 21186 | RSS: Main: 172154880 07:05:50 INFO - PROCESS | 21186 | 07:05:52 INFO - PROCESS | 21186 | Cycle 1(1): loaded http://localhost:45892/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45892/tests/kraken/driver.html?testName=audio-beat-detection) 07:05:53 INFO - PROCESS | 21186 | RSS: Main: 229191680 07:05:53 INFO - PROCESS | 21186 | 07:05:56 INFO - PROCESS | 21186 | Cycle 1(1): loaded http://localhost:45892/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45892/tests/kraken/driver.html?testName=audio-dft) 07:05:56 INFO - PROCESS | 21186 | RSS: Main: 215633920 07:05:56 INFO - PROCESS | 21186 | 07:06:00 INFO - PROCESS | 21186 | Cycle 1(1): loaded http://localhost:45892/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45892/tests/kraken/driver.html?testName=audio-fft) 07:06:00 INFO - PROCESS | 21186 | RSS: Main: 296787968 07:06:00 INFO - PROCESS | 21186 | 07:06:02 INFO - PROCESS | 21186 | Cycle 1(1): loaded http://localhost:45892/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45892/tests/kraken/driver.html?testName=audio-oscillator) 07:06:03 INFO - PROCESS | 21186 | RSS: Main: 206622720 07:06:03 INFO - PROCESS | 21186 | 07:06:05 INFO - PROCESS | 21186 | Cycle 1(1): loaded http://localhost:45892/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45892/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:06:06 INFO - PROCESS | 21186 | RSS: Main: 211427328 07:06:06 INFO - PROCESS | 21186 | 07:06:09 INFO - PROCESS | 21186 | Cycle 1(1): loaded http://localhost:45892/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45892/tests/kraken/driver.html?testName=imaging-darkroom) 07:06:09 INFO - PROCESS | 21186 | RSS: Main: 247533568 07:06:09 INFO - PROCESS | 21186 | 07:06:13 INFO - PROCESS | 21186 | Cycle 1(1): loaded http://localhost:45892/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45892/tests/kraken/driver.html?testName=imaging-desaturate) 07:06:13 INFO - PROCESS | 21186 | RSS: Main: 246161408 07:06:13 INFO - PROCESS | 21186 | 07:06:16 INFO - PROCESS | 21186 | Cycle 1(1): loaded http://localhost:45892/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45892/tests/kraken/driver.html?testName=json-parse-financial) 07:06:16 INFO - PROCESS | 21186 | RSS: Main: 246296576 07:06:16 INFO - PROCESS | 21186 | 07:06:18 INFO - PROCESS | 21186 | Cycle 1(1): loaded http://localhost:45892/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45892/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:06:19 INFO - PROCESS | 21186 | RSS: Main: 208674816 07:06:19 INFO - PROCESS | 21186 | 07:06:20 INFO - PROCESS | 21186 | Cycle 1(1): loaded http://localhost:45892/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45892/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:06:21 INFO - PROCESS | 21186 | RSS: Main: 216526848 07:06:21 INFO - PROCESS | 21186 | 07:06:23 INFO - PROCESS | 21186 | Cycle 1(1): loaded http://localhost:45892/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45892/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:06:24 INFO - PROCESS | 21186 | RSS: Main: 225452032 07:06:24 INFO - PROCESS | 21186 | 07:06:26 INFO - PROCESS | 21186 | Cycle 1(1): loaded http://localhost:45892/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45892/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:06:27 INFO - PROCESS | 21186 | RSS: Main: 228880384 07:06:27 INFO - PROCESS | 21186 | 07:06:30 INFO - PROCESS | 21186 | Cycle 1(1): loaded http://localhost:45892/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45892/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:06:30 INFO - PROCESS | 21186 | RSS: Main: 230555648 07:06:30 INFO - PROCESS | 21186 | 07:06:32 INFO - PROCESS | 21186 | Cycle 1(1): loaded http://localhost:45892/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45892/tests/kraken/driver.html?testName=ai-astar) 07:06:32 INFO - PROCESS | 21186 | RSS: Main: 281673728 07:06:32 INFO - PROCESS | 21186 | 07:06:32 INFO - PROCESS | 21186 | __start_tp_report 07:06:32 INFO - PROCESS | 21186 | _x_x_mozilla_page_load 07:06:32 INFO - PROCESS | 21186 | _x_x_mozilla_page_load_details 07:06:32 INFO - PROCESS | 21186 | |i|pagename|runs| 07:06:32 INFO - PROCESS | 21186 | |0;ai-astar;104;111;111;110;112;112;112;113;111;112 07:06:32 INFO - PROCESS | 21186 | |1;audio-beat-detection;147;122;123;167;123;126;121;121;150;123 07:06:32 INFO - PROCESS | 21186 | |2;audio-dft;161;160;159;162;160;164;160;161;161;162 07:06:32 INFO - PROCESS | 21186 | |3;audio-fft;76;76;75;110;76;76;76;75;106;76 07:06:32 INFO - PROCESS | 21186 | |4;audio-oscillator;83;82;121;83;84;85;114;82;84;113 07:06:32 INFO - PROCESS | 21186 | |5;imaging-gaussian-blur;118;117;117;116;117;117;116;116;117;117 07:06:32 INFO - PROCESS | 21186 | |6;imaging-darkroom;147;148;148;147;146;149;148;147;146;148 07:06:32 INFO - PROCESS | 21186 | |7;imaging-desaturate;85;85;86;86;85;85;86;86;86;86 07:06:32 INFO - PROCESS | 21186 | |8;json-parse-financial;55;52;53;54;54;54;54;54;55;54 07:06:32 INFO - PROCESS | 21186 | |9;json-stringify-tinderbox;60;60;60;60;60;60;61;60;60;60 07:06:32 INFO - PROCESS | 21186 | |10;stanford-crypto-aes;80;81;81;81;86;80;81;80;79;80 07:06:32 INFO - PROCESS | 21186 | |11;stanford-crypto-ccm;144;139;167;141;151;138;133;137;184;143 07:06:32 INFO - PROCESS | 21186 | |12;stanford-crypto-pbkdf2;168;169;166;169;169;166;166;168;168;167 07:06:32 INFO - PROCESS | 21186 | |13;stanford-crypto-sha256-iterative;66;66;66;66;65;65;67;68;72;64 07:06:32 INFO - PROCESS | 21186 | __end_tp_report 07:06:32 INFO - PROCESS | 21186 | __start_cc_report 07:06:32 INFO - PROCESS | 21186 | _x_x_mozilla_cycle_collect,1663 07:06:32 INFO - PROCESS | 21186 | __end_cc_report 07:06:32 INFO - PROCESS | 21186 | __startTimestamp1476972392894__endTimestamp 07:06:32 INFO - PROCESS | 21186 | 07:06:32 INFO - PROCESS | 21186 | ------- Summary: start ------- 07:06:32 INFO - PROCESS | 21186 | Number of tests: 14 07:06:32 INFO - PROCESS | 21186 | 07:06:32 INFO - PROCESS | 21186 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:2.53 (2.3%) stddev-sans-first:0.88 07:06:32 INFO - PROCESS | 21186 | Values: 104.0 111.0 111.0 110.0 112.0 112.0 112.0 113.0 111.0 112.0 07:06:32 INFO - PROCESS | 21186 | 07:06:32 INFO - PROCESS | 21186 | [#1] audio-beat-detection Cycles:10 Average:132.30 Median:124.50 stddev:16.31 (13.1%) stddev-sans-first:16.41 07:06:32 INFO - PROCESS | 21186 | Values: 147.0 122.0 123.0 167.0 123.0 126.0 121.0 121.0 150.0 123.0 07:06:32 INFO - PROCESS | 21186 | 07:06:32 INFO - PROCESS | 21186 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.41 (0.9%) stddev-sans-first:1.50 07:06:32 INFO - PROCESS | 21186 | Values: 161.0 160.0 159.0 162.0 160.0 164.0 160.0 161.0 161.0 162.0 07:06:32 INFO - PROCESS | 21186 | 07:06:32 INFO - PROCESS | 21186 | [#3] audio-fft Cycles:10 Average:82.20 Median:76.00 stddev:13.64 (17.9%) stddev-sans-first:14.28 07:06:32 INFO - PROCESS | 21186 | Values: 76.0 76.0 75.0 110.0 76.0 76.0 76.0 75.0 106.0 76.0 07:06:32 INFO - PROCESS | 21186 | 07:06:32 INFO - PROCESS | 21186 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:83.00 stddev:15.96 (19.2%) stddev-sans-first:16.51 07:06:32 INFO - PROCESS | 21186 | Values: 83.0 82.0 121.0 83.0 84.0 85.0 114.0 82.0 84.0 113.0 07:06:32 INFO - PROCESS | 21186 | 07:06:32 INFO - PROCESS | 21186 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.50 07:06:32 INFO - PROCESS | 21186 | Values: 118.0 117.0 117.0 116.0 117.0 117.0 116.0 116.0 117.0 117.0 07:06:32 INFO - PROCESS | 21186 | 07:06:32 INFO - PROCESS | 21186 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 07:06:32 INFO - PROCESS | 21186 | Values: 147.0 148.0 148.0 147.0 146.0 149.0 148.0 147.0 146.0 148.0 07:06:32 INFO - PROCESS | 21186 | 07:06:32 INFO - PROCESS | 21186 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:86.00 stddev:0.52 (0.6%) stddev-sans-first:0.50 07:06:32 INFO - PROCESS | 21186 | Values: 85.0 85.0 86.0 86.0 85.0 85.0 86.0 86.0 86.0 86.0 07:06:32 INFO - PROCESS | 21186 | 07:06:32 INFO - PROCESS | 21186 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:0.88 (1.6%) stddev-sans-first:0.83 07:06:32 INFO - PROCESS | 21186 | Values: 55.0 52.0 53.0 54.0 54.0 54.0 54.0 54.0 55.0 54.0 07:06:32 INFO - PROCESS | 21186 | 07:06:32 INFO - PROCESS | 21186 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 07:06:32 INFO - PROCESS | 21186 | Values: 60.0 60.0 60.0 60.0 60.0 60.0 61.0 60.0 60.0 60.0 07:06:32 INFO - PROCESS | 21186 | 07:06:32 INFO - PROCESS | 21186 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:81.00 stddev:1.91 (2.4%) stddev-sans-first:2.00 07:06:32 INFO - PROCESS | 21186 | Values: 80.0 81.0 81.0 81.0 86.0 80.0 81.0 80.0 79.0 80.0 07:06:32 INFO - PROCESS | 21186 | 07:06:32 INFO - PROCESS | 21186 | [#11] stanford-crypto-ccm Cycles:10 Average:147.70 Median:143.50 stddev:15.92 (11.1%) stddev-sans-first:16.83 07:06:32 INFO - PROCESS | 21186 | Values: 144.0 139.0 167.0 141.0 151.0 138.0 133.0 137.0 184.0 143.0 07:06:32 INFO - PROCESS | 21186 | 07:06:32 INFO - PROCESS | 21186 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.60 Median:168.00 stddev:1.26 (0.8%) stddev-sans-first:1.33 07:06:32 INFO - PROCESS | 21186 | Values: 168.0 169.0 166.0 169.0 169.0 166.0 166.0 168.0 168.0 167.0 07:06:32 INFO - PROCESS | 21186 | 07:06:32 INFO - PROCESS | 21186 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.00 stddev:2.22 (3.4%) stddev-sans-first:2.35 07:06:32 INFO - PROCESS | 21186 | Values: 66.0 66.0 66.0 66.0 65.0 65.0 67.0 68.0 72.0 64.0 07:06:32 INFO - PROCESS | 21186 | -------- Summary: end -------- 07:06:32 INFO - PROCESS | 21186 | 07:06:34 INFO - TEST-INFO | 21186: exit 0 07:06:34 INFO - TEST-OK | kraken | took 61758ms 07:06:34 INFO - SUITE-END | took 1179s 07:06:34 INFO - Completed test suite (00:19:40) 07:06:34 INFO - javascript benchmark 07:06:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3013.7739669524785, 3049.725524702778, 3051.618547681539, 3078.184281165493, 3099.271671157279, 5085.262636917654, 5143.845684629462, 5182.274481572583, 5202.531772140506, 5259.6581222220575, 5166.225066240057, 5200.583953283738, 5235.293235413218, 5266.920996185051, 5285.127953887613, 4686.9531304687025, 4691.0617876424685, 4740.976295118519, 4752.738599377033, 4759.643026772988, 4776.47458779534, 4818.108649899762, 4872.3422337984275, 4875.098106850244, 4922.876928076791, 4632.745199014086, 4796.856094317176, 4797.0, 4850.442199147108, 4876.0, 4645.094206629708, 4707.882302942454, 4711.623070154379, 4713.552212539803, 4714.811407543694, 4649.1399091167905, 4705.1765940960195, 4727.976360118212, 4761.857144285642, 4797.160496913027, 5173.534381905609, 5195.980899323496, 5198.636095473318, 5205.9219111713355, 5241.475852414766, 5357.544608708265, 5400.351957765093, 5541.0580201365865, 5541.196526503675, 5550.916736248919, 5481.150421684645, 5484.396716361197, 5491.862703432406, 5497.202905578709, 5517.089680202802, 5081.8729531762, 5153.5361817436615, 5159.432462429129, 5159.922601160985, 5162.19985902182, 5607.214989901417, 5614.07367784311, 5620.18507316445, 5623.409541998113, 5625.0, 5340.572754179734, 5401.432849550819, 5403.2705584746345, 5405.108157154104, 5418.756155972991, 5467.316585426822, 5480.424555421703, 5485.670859748428, 5490.286262785892, 5495.395506494282, 5493.533049690821, 5514.531264842533, 5516.889662206733, 5558.0, 5589.888202235932, 5514.145307477347, 5523.088690366045, 5528.419515950848, 5531.751071201806, 5596.860078497989, 4177.49870015594, 4219.2194444027955, 4245.00296853352, 4245.532991370947, 4302.118065796504, 3777.1501412182038, 3813.466114743938, 3829.272438236726, 3843.7693738375788, 3900.863469778544, 5246.973765131226, 5253.579713622901, 5258.027264955996, 5261.316028916216, 5296.814611488579, 5543.61194716374, 5551.139573366135, 5551.944480555143, 5559.054960656698, 5559.471850174227, 5178.223266510054, 5230.215467679803, 5240.9213861792105, 5253.973730131325, 5289.444608316148, 4845.152098382769, 4846.878828029327, 4848.054629347314, 4895.902081958341, 4910.705357678551, 5745.454181852718, 5747.827565173052, 5755.309362876482, 5758.222639943638, 5764.337101233412, 5454.236406902957, 5509.862253443696, 5548.639338443149, 5580.051391263576, 5598.1322894951345, 5735.913961290667, 5746.597738158289, 5747.48272655463, 5794.217780599565, 5803.042497987784, 5436.7553460093595, 5494.395616482264, 5495.0, 5496.5053145217125, 5496.890062198813, 5281.392639846313, 5412.296401467784, 5526.309211348582, 5585.664860108244, 5589.105743081088, 5425.538829199562, 5480.862978425412, 5481.808136715196, 5535.972320138373, 5539.806106786243, 5445.428230035947, 5452.781888724407, 5453.863653408696, 5462.535684466865, 5465.863353416196, 5241.371035475615, 5304.549113325411, 5430.945690543044, 5438.075527160313, 5499.202615620793, 5438.619296649196, 5467.507924286833, 5472.972635136958, 5473.124300111963, 5553.4724201200825, 5302.469753024667, 5338.065838478328, 5351.357837059578, 5352.518273355417, 5416.972915135557], "value": 5124.654841540119, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.9872684954942, 589.5931807053133, 604.7339170764866, 610.3804638292131, 612.0452094732218, 31579.68420315796, 32258.8387058065, 42973.57026429735, 43458.78270608642, 43730.99999999992, 41054.794726026324, 45090.77454612722, 45111.32333015007, 45117.548824511745, 45177.77411112948, 8820.779480512974, 8970.910290897073, 8970.955145224265, 8973.192412682858, 8982.59578318974, 7909.367250619936, 8077.919220807805, 8739.082396348387, 10332.948335258314, 10693.78612427751, 10823.945880270627, 10885.292455990375, 10889.782204355908, 10893.564257429693, 10897.618583349584, 10594.25840191187, 10668.413237271947, 10671.35971841692, 10684.946575267151, 10689.78620427591, 7848.529088254723, 8083.110857805636, 10194.745131371701, 10535.578576856917, 10550.630727924563, 41593.79203103996, 41788.37317440241, 41862.37206441906, 41891.1621767563, 41948.0, 3250.414925313443, 3253.804771713681, 3328.5301880159136, 3527.4885141654318, 3806.9809650951843, 31508.0, 31638.367232655448, 32232.35535289281, 32510.837445812856, 33550.664493355, 4151.107511884959, 4187.602177793105, 4378.255696531597, 4404.846828061317, 4417.159616244973, 313039.0, 314491.0, 315516.0, 316989.0, 317100.0, 58732.11901821476, 59098.704506477196, 59285.40714592885, 59291.70354148288, 59424.70287648534, 63119.684401577695, 63546.682266588374, 63589.36410635927, 63655.0, 63696.681516593046, 15388.615284617974, 15649.530514084596, 15651.139187344805, 15652.530424087068, 15655.608609784846, 10758.40828754426, 11313.943430282796, 11419.60031398897, 11434.142439316918, 11467.885321146681, 15083.54749357521, 17453.7381939271, 17926.731099033525, 17929.551761205814, 18634.534136646693, 5612.915806262909, 6157.168782214344, 6224.937750622526, 6280.497560195174, 6314.273858506239, 955.47926380123, 1008.5918925492248, 1146.2606618730872, 1157.346099453806, 1159.0611604600301, 31317.530237046463, 31498.685013149574, 31525.52711709326, 31677.683223167474, 31921.840390797897, 1083.160550573312, 1088.4448931045065, 1151.9747424791942, 1166.055495049013, 1198.1672737447564, 15963.920180399024, 16673.833261667227, 16784.15944402267, 16817.327306907588, 16859.24133413999, 479434.0, 482254.0, 483168.0, 484522.0, 485039.0, 49696.0, 50283.74858125686, 55704.16443753347, 57352.42647573554, 57690.42309576934, 1294.9611511654666, 1306.8105124756858, 1319.3271431569776, 1337.5385492005244, 1345.878870901643, 30390.392192155592, 33175.502367464025, 33275.33449331048, 33279.667203327655, 33567.66432335743, 51454.22818657648, 51890.74054629703, 51922.740386297824, 51991.0, 52141.7392913033, 301569.0, 303167.0, 303960.0, 304038.0, 304236.95763042086, 40110.59889401068, 40789.0, 41004.384934226604, 41115.383269250386, 41670.0, 45940.310895337265, 46775.766121169174, 46784.298235525814, 47292.0, 47537.0, 39186.0, 39791.40312895251, 39823.40264895971, 40336.0, 41556.792216038724, 39335.213295734495, 39634.207315854095, 40624.25065941952, 40646.0, 41287.793561032006, 40682.59317406788, 41155.17689646131, 41420.0, 41507.1698566033, 41543.58456415518, 33868.83065584656, 36323.63676363203, 36860.81569592135, 37063.44404833876, 37138.25723485461, 27471.587926180724, 27988.720112799427, 27994.300142496602, 28011.439771204055, 28049.0], "value": 19934.532967733354, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.960844307126, 364.31690580162194, 380.2547007864586, 384.9307124717551, 400.6914675699711, 14271.0, 18406.0, 19176.23295068199, 20109.899450502726, 20301.0864511097, 18645.440636780884, 18935.81064189358, 19513.41459756206, 19685.803141968576, 19720.112594933227, 5511.476409741068, 5770.509506691937, 5771.365149833536, 5771.595988280822, 5789.015867302569, 5637.943620563783, 5646.717664116798, 5910.940890591103, 5936.792212272571, 6020.6688632125215, 6007.849803754919, 6015.368386319439, 6024.879502409971, 6026.487748541379, 6029.457348838604, 5671.432856714317, 5932.317783454915, 5967.403259674042, 6030.065339872327, 6035.607685500472, 5630.831075067755, 5773.134029895549, 5823.941760582382, 5829.621074630136, 5835.766569337221, 13651.249181295025, 13735.931320343434, 13757.862421375758, 13772.0, 13784.241866697328, 2091.968620470694, 2186.35502526755, 2436.1229957215387, 2445.5108978204253, 2964.7035296470394, 9740.172085372751, 10023.799524009552, 10234.1300989416, 11018.44907754609, 14958.40166393343, 1796.3982066007773, 1888.499547619882, 1890.5179179309189, 1915.205189846212, 1941.0682872221412, 80354.0, 84363.57818210931, 84693.0, 85337.0, 86397.56801216016, 10508.211884108723, 10521.316114452537, 10543.42011189392, 10797.406142662228, 10930.945345273381, 15183.62040948963, 15202.543923682308, 15232.847671523365, 15233.390664373523, 15239.466618668293, 7251.782446526613, 7501.174870764212, 7534.0582427196605, 7710.575918324434, 7744.845103097907, 6894.827629309308, 7059.399951004119, 7074.151101867706, 7348.742794002184, 7410.666520006613, 4454.933176002362, 4572.588467037983, 4608.470025947059, 4629.236176030984, 4724.078804633064, 1833.9266429342945, 1841.6500864835639, 1851.3705340184401, 1875.4842418335068, 1907.7901430842596, 939.736873675372, 974.4250891973628, 997.1623835977668, 1027.9640212592524, 1086.28305318491, 18171.182296796676, 19572.70640940387, 19605.50986225327, 19712.310069147512, 19719.40841774749, 944.2870632672289, 945.8675785390051, 971.2133172130597, 987.0721521769514, 1011.0546638892658, 10278.766548014286, 10877.292975956538, 10958.342499450058, 11036.11711063113, 11052.944735276273, 421903.0, 425977.0, 436237.0, 438680.0, 439571.0, 91435.54282228679, 93621.53189234146, 93791.0, 94031.36545201045, 94253.0, 965.8068386322764, 1004.2116938203475, 1038.9064984151462, 1046.7226185060965, 1047.1518070363031, 16645.750313745062, 17246.22391992338, 17508.82491175072, 17593.912030439766, 17632.82367176312, 38095.0, 38275.0, 41706.0, 42439.0, 43104.56895431005, 56015.71992140176, 56451.71774141267, 57950.420495794504, 58161.709191453774, 59519.0, 8096.87854682192, 8346.916530834857, 8587.785305367166, 8605.440646357967, 8679.479231246145, 11961.282323060645, 12868.613941581767, 13354.198748075147, 13466.865331346562, 13558.525451609146, 10968.341899485737, 11719.76560468803, 11979.161458697807, 12212.877871221173, 12395.876041239471, 11496.0, 11590.594329198437, 11631.88368116308, 11719.41402929833, 11745.588904388305, 11824.586139485076, 12015.699607509532, 12053.57812476559, 12165.817512737493, 12262.570810021607, 8306.127856574973, 8442.197991190827, 8501.95749021251, 8516.276116530164, 8757.124287571192, 10325.586976520855, 11440.599579014695, 11535.769284614093, 12041.976432003377, 12233.449494772934], "value": 9031.695939478357, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1305.5822136916179, 1433.4266293482606, 1447.3414596358657, 1545.8686011689006, 1735.600811813283, 7516.173220945691, 8204.0, 8389.454685445442, 8394.832103357929, 8719.302455803536, 8455.239028487435, 8501.957490212555, 8549.0, 8558.871616925735, 8560.400771945966, 2231.4421394651336, 2252.0653928619604, 2257.446925503254, 2258.8418810683174, 2259.051198496627, 2193.2762188477764, 2234.218023691703, 2269.8751568663715, 2274.431392151962, 2276.044061494168, 2212.3031245157804, 2212.7787221277904, 2217.678436626696, 2240.0, 2279.8746068966284, 2133.8826364549946, 2167.100653228908, 2173.9565208695894, 2176.281826997095, 2177.0856240379, 2139.8716077035274, 2146.495573540217, 2156.870587764739, 2157.6979222908803, 2165.4586353411646, 8375.95812020936, 8518.616662250213, 8539.231469167804, 8558.486490810572, 8580.957095214546, 5017.096922553938, 5179.585633149377, 5185.118529849935, 5250.448702886219, 5258.000979813862, 3363.5459213006175, 3490.825458727079, 3562.786232826039, 3577.123604716835, 3592.8742494012845, 1014.4623349624711, 1070.582472835587, 1090.4220762995626, 1105.5688281570194, 1107.2083460325825, 10595.152387809034, 10660.62687805931, 10709.839352409643, 10719.946400267949, 10726.19553533488, 4088.448059511928, 4153.418521407006, 4299.452197209002, 4299.656027517791, 4433.563987909396, 8901.599428025755, 8901.821963560693, 8906.777330566787, 8908.153725396078, 8912.8663070054, 5079.263506791494, 5079.415867175248, 5099.796008159707, 5100.974495127501, 5101.0308041472745, 4205.243056249843, 4231.597998190167, 4678.345031695565, 4736.8105275788585, 4751.572358487752, 3472.4617684258474, 3520.4015317396106, 3573.5175751273246, 3574.1243395367783, 3697.4638677391627, 1111.377628528027, 1127.2954403497813, 1129.1023636209234, 1140.8288756686563, 1141.3494308244387, 837.7193640130503, 872.3936863879669, 887.3433659092225, 894.5974311559825, 935.8362286599818, 5559.24950131727, 5575.052241118939, 5674.801381951612, 5704.1443783432815, 5917.378675239124, 927.3925578745932, 937.7046230437527, 952.0859974424629, 953.594722243044, 960.3805545423163, 3896.1428485733095, 3974.3044967131214, 4013.234605303836, 4076.8369265229057, 4093.91812163761, 9782.51087445625, 10481.895181048245, 10501.684949451528, 10645.627403040857, 10653.467326633638, 10115.949420252999, 10337.896621033844, 10427.217958653131, 10528.63149789769, 10530.420826854443, 7512.286332798375, 7762.184970578121, 7775.22247775218, 7780.377569794403, 7811.882821757678, 5459.918101228564, 5602.691851948182, 5652.63257888236, 5702.401247868914, 5815.82552523425, 9732.562034708313, 9787.853182202414, 9818.0, 9844.556994935101, 9958.900410995797, 9408.153266206074, 9788.657396991071, 9789.85315220258, 9926.354786938826, 9937.801243975224, 6840.213375461686, 7038.2961703829205, 7534.54792712439, 7757.806054848674, 7764.145943946049, 7835.764927052198, 8003.359731221604, 8054.23484768946, 8163.755087347389, 8223.9588802058, 7071.46963977714, 7282.52663576887, 7300.96349518249, 7463.514871533333, 7585.317321441097, 7183.568985860865, 7219.744809904438, 7320.1215854097845, 7370.48406611532, 7442.330190282901, 6816.352446517573, 6823.181218253642, 6858.245592984668, 6880.277570854988, 6891.310868913069, 4966.776495057658, 5039.974800126122, 5050.747462626928, 5083.262926875508, 5094.108531006985, 4765.666403351732, 4908.042931628298, 5021.5229553192385, 5113.233015047773, 5196.896062078813], "value": 4416.302897850373, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.6354410655692, 323.8218979561241, 332.07517064974036, 332.54773508029064, 333.08069727551947, 5257.842264732055, 5351.0, 5446.863828404292, 5450.890982180354, 5472.835814925548, 5331.173668081454, 5337.70642614656, 5368.892622147565, 5384.461553844613, 5404.783923617194, 4144.9792751036275, 4164.708470407073, 4197.832086716543, 4215.662746980234, 4215.768132752697, 4123.484564429446, 4157.251694694954, 4170.645495132902, 4186.681195423447, 4246.917036155776, 4170.103427763031, 4172.374143878412, 4174.831047306759, 4185.895352616179, 4187.769672668002, 4149.419081328617, 4159.480064991876, 4170.4995400551825, 4172.144710334389, 4174.66602671787, 3657.2319812839337, 3657.56109266887, 3668.248009158116, 3671.210689701727, 3671.430928206132, 5099.388073431212, 5256.237845512379, 5257.894842103136, 5263.815641480636, 5274.525292723635, 4731.509574484026, 4756.548127927876, 4793.137235297645, 4795.4964728703335, 4800.423949126092, 5374.7850085996515, 5496.0, 5568.972155139239, 5579.609427340088, 5613.691246981414, 3938.0, 3945.309570825123, 3950.960490395088, 3951.38753493209, 3980.383040628707, 5417.485338892799, 5603.075492543725, 5720.141978703186, 5766.826995190109, 5774.393688662714, 3927.7839718815167, 3999.6200360965663, 4006.419069234945, 4034.6282264029783, 4037.2639764900787, 4091.89770255746, 4091.97954010228, 4094.7133700641266, 4116.670666346685, 4139.089400331922, 4492.752898590544, 4714.363560919232, 4721.197396442613, 4739.526047395302, 4745.264484004984, 5520.558355331564, 5530.087535556588, 5530.668159910419, 5534.889302213933, 5566.749496272678, 1393.2963853254244, 1414.7594908865312, 1418.985810141906, 1424.4017512644714, 1428.778539326406, 835.511225932836, 896.6861598440494, 901.193431878465, 912.8361339292455, 921.8156368726281, 4757.4072130688855, 4768.213244814636, 4772.665913386099, 4773.641976851681, 4777.539567122934, 5011.398632164163, 5025.39695236574, 5026.346574945233, 5043.621728370387, 5050.49495050492, 4752.762361881962, 4774.618030557547, 4778.880527986828, 4784.282357646381, 5072.949270507248, 2976.821390716564, 3020.2298413904755, 3023.8639261232856, 3033.5601337805892, 3045.8933937312086, 5884.529237660977, 5885.852258809577, 5899.528037756969, 5915.970420147958, 5956.795985485312, 5532.0, 5723.570732195102, 5758.798442054592, 5767.192593036978, 5824.650520968756, 5795.797147099831, 5823.854403639943, 5854.862975014089, 5856.267966504187, 5873.618214816109, 5523.6409633373705, 5725.450220863091, 5748.6203311205845, 5785.190073389645, 5787.074068149076, 5641.351244606923, 5661.943380566142, 5665.20687103814, 5667.376588575171, 5714.9142762857755, 5666.376698563237, 5762.481376675952, 5821.243238378984, 5895.852603684943, 5943.108533719977, 4055.1686904185162, 4085.5505894351004, 4099.8360065598235, 4109.568495308069, 4116.444280022159, 5683.630564013326, 5847.093700476433, 5852.561057920588, 5861.948318088635, 5864.824055278348, 5537.723113844211, 5564.0, 5573.7770489179975, 5575.386707462095, 5580.748866300945, 5556.777728890799, 5561.777528898799, 5569.832905012856, 5572.4706152915405, 5632.183333416713, 5324.760385782726, 5543.77824887, 5553.194786755817, 5582.469665381782, 5644.6613203207935, 5607.943920560742, 5631.915521267266, 5633.4084921082695, 5636.520895723909, 5636.549076073986, 5506.585916731652, 5518.420565840529, 5566.52684521804, 5617.185508101221, 5628.971855140698], "value": 4208.899973134932, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.3780917315695, 734.5812886654602, 735.727780721133, 741.0884611927332, 765.7702689193243, 15807.44673936411, 16578.336866525326, 16587.668246635076, 16591.0, 16595.751063734053, 14259.92870035651, 14504.564863054098, 14514.27428628567, 14514.709705805877, 14521.854781452183, 660.0429377402761, 674.9898751518731, 782.5265714242886, 794.1224946434179, 808.0545761459077, 801.6993627389729, 806.733777853307, 818.8321394114192, 818.938579606529, 819.9877001844977, 856.1267507142711, 857.8756080368343, 858.5964596639601, 858.6222062292602, 858.7466697324304, 690.0994202565649, 850.1201256699349, 850.7277671145235, 851.7402192331336, 852.6035393542032, 514.8738559053019, 607.7234858139536, 620.5066971757464, 623.803501896901, 624.881272558217, 14102.435902563886, 14126.92936535321, 14133.081349712236, 14145.929270353583, 14151.080179788281, 13725.588232353046, 13873.930630346784, 14026.08830426019, 14033.298335083307, 14598.854011459856, 12948.805767913489, 13011.79078102696, 13044.739105217937, 13167.0, 13410.329483525882, 4216.683748718828, 4274.679399045084, 4327.848525301631, 4333.155034768221, 4475.955240447586, 78857.0, 79679.6016019922, 79892.0, 80267.19732802655, 80627.5968620159, 10628.0, 10728.356298622108, 10759.3544387337, 10886.61896833607, 11265.15511336653, 21321.25375611846, 21353.25263615766, 21388.893055534623, 21517.89241053816, 21571.78428215698, 7999.560024198725, 8080.636371363303, 8309.0, 8367.497950123012, 8373.455725377831, 4364.869053928387, 4402.229609818269, 4468.776561171993, 4573.885652858705, 4669.322948172564, 3403.2002479417315, 3491.790492570454, 3522.982385088058, 3525.471179323122, 3526.9118272043406, 589.0957380421033, 589.1310317281975, 596.4035964035965, 597.316073096311, 605.6245128020568, 584.8070136854827, 594.7977687586241, 597.7160848596968, 633.1610615933906, 672.525869262169, 8562.529060901586, 8629.654813807378, 8738.794497574176, 8902.821943561223, 9061.64621727694, 545.6562365709577, 630.2625927664552, 631.5011141198494, 663.2140913018089, 687.2577616174519, 3998.8200530975596, 4429.158459892675, 4461.977690111528, 4468.798904049326, 4583.742210577179, 117299.41350293365, 119509.40245298891, 120312.0, 121863.45526077705, 122013.0, 102563.46154807684, 105106.0, 105366.47316763367, 106179.0, 108023.0, 89504.0, 89860.5506972461, 90076.0, 93572.0, 95365.52317238509, 8297.668093276201, 8322.20939010793, 8427.367947403847, 8635.0, 8874.689385871463, 38902.610973889896, 47824.760876195396, 49996.25005624846, 50617.74691126521, 52077.21884171816, 62922.68538657461, 63974.68012660093, 65289.34710652833, 65892.34107658862, 69915.0, 12685.175463594836, 12804.871951280367, 12813.615591532269, 12973.416196271379, 13062.738745225231, 14215.786763198766, 14748.460369511455, 15037.398504060153, 15040.398384064514, 15252.23738813077, 10284.0, 13670.794938075738, 13764.518241861486, 13898.652533686738, 14944.0, 11566.30602163873, 11729.237599556001, 12413.717867343614, 13538.728791138325, 13546.864531354955, 13004.804927926278, 13218.801717974045, 13331.66670833237, 14288.714225715219, 14820.184889831164, 10765.869583693599, 10795.244332896622, 11247.943760281147, 11302.60440884598, 11397.487113080097, 11188.720281993015, 11938.880611194125, 12127.332996684914, 12197.878021220029, 12494.0], "value": 7402.618277463397, "unit": "score"}], "name": "dromaeo_css", "value": 7089.517436150736, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 111.0, 110.0, 112.0, 112.0, 112.0, 113.0, 111.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 122.0, 123.0, 167.0, 123.0, 126.0, 121.0, 121.0, 150.0, 123.0], "value": 132.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 159.0, 162.0, 160.0, 164.0, 160.0, 161.0, 161.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 110.0, 76.0, 76.0, 76.0, 75.0, 106.0, 76.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 121.0, 83.0, 84.0, 85.0, 114.0, 82.0, 84.0, 113.0], "value": 93.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 147.0, 146.0, 149.0, 148.0, 147.0, 146.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 86.0, 86.0, 85.0, 85.0, 86.0, 86.0, 86.0, 86.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 53.0, 54.0, 54.0, 54.0, 54.0, 54.0, 55.0, 54.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 60.0, 60.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 81.0, 81.0, 86.0, 80.0, 81.0, 80.0, 79.0, 80.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 139.0, 167.0, 141.0, 151.0, 138.0, 133.0, 137.0, 184.0, 143.0], "value": 147.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 169.0, 166.0, 169.0, 169.0, 166.0, 166.0, 168.0, 168.0, 167.0], "value": 167.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 65.0, 65.0, 67.0, 68.0, 72.0, 64.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1505.8999999999999, "alertThreshold": 2.0}]} 07:06:34 INFO - Return code: 0 07:06:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:06:34 INFO - # TBPL SUCCESS # 07:06:34 INFO - Running post-action listener: _resource_record_post_action 07:06:34 INFO - [mozharness: 2016-10-20 14:06:34.681065Z] Finished run-tests step (success) 07:06:34 INFO - Running post-run listener: _resource_record_post_run 07:06:34 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 394080256; Read time: 16; Write time: 279048 07:06:34 INFO - TinderboxPrint: CPU usage
13.1% 07:06:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 07:06:34 INFO - TinderboxPrint: I/O write bytes / time
394,080,256 / 279,048 07:06:34 INFO - TinderboxPrint: CPU idle
8,301.1 (86.9%) 07:06:34 INFO - TinderboxPrint: CPU user
1,200.0 (12.6%) 07:06:34 INFO - TinderboxPrint: Swap in / out
0 / 0 07:06:34 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 106299392; Read time: 0; Write time: 89492 07:06:34 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 287780864; Read time: 0; Write time: 189556 07:06:35 INFO - Running post-run listener: _upload_blobber_files 07:06:35 INFO - Blob upload gear active. 07:06:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:06: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 07:06: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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:06: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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:06:35 INFO - (blobuploader) - INFO - Open directory for files ... 07:06:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:06:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:06:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:06:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:06:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:06:36 INFO - (blobuploader) - INFO - Done attempting. 07:06:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:06:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:06:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:06:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:06:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:06:37 INFO - (blobuploader) - INFO - Done attempting. 07:06:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:06:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:06:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:06:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:06:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:06:40 INFO - (blobuploader) - INFO - Done attempting. 07:06:40 INFO - (blobuploader) - INFO - Iteration through files over. 07:06:40 INFO - Return code: 0 07:06:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:06:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:06:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0059213d7db3e31cc391fa19853f1cc23b16b8339dab435b7620dc54bfb41450682986266ede86ea05660b8e44e1d5e8ae85d7df167ab909d31dfbfa634914fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2eb2a6bdea87faafe9cc6634371bc5b913ee0277e586d9efe6046108b2b29679d101e42a74d3f2204b7931ee4d8af3fcbe98f22e3087be117a694d49b271e2a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba88abbae19d46d71d3742dd1dd7ca1220c41541dd027f19de2035b31eb0febec63cc2ef5058c9237b9523899e925d4d8c44106f5cfefccea276bbe9e41df5b1"} 07:06:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:06:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:06:40 INFO - Contents: 07:06:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0059213d7db3e31cc391fa19853f1cc23b16b8339dab435b7620dc54bfb41450682986266ede86ea05660b8e44e1d5e8ae85d7df167ab909d31dfbfa634914fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2eb2a6bdea87faafe9cc6634371bc5b913ee0277e586d9efe6046108b2b29679d101e42a74d3f2204b7931ee4d8af3fcbe98f22e3087be117a694d49b271e2a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba88abbae19d46d71d3742dd1dd7ca1220c41541dd027f19de2035b31eb0febec63cc2ef5058c9237b9523899e925d4d8c44106f5cfefccea276bbe9e41df5b1"} 07:06:40 INFO - Running post-run listener: copy_logs_to_upload_dir 07:06:40 INFO - Copying logs to upload dir... 07:06:40 INFO - mkdir: /builds/slave/test/build/upload/logs 07:06:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.204366 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-20 07:06:40.337630) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 07:06:40.341596) ========= 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=337fe3f4b1febe37b85fccc40000019e-1476971161.480285-1013204608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0059213d7db3e31cc391fa19853f1cc23b16b8339dab435b7620dc54bfb41450682986266ede86ea05660b8e44e1d5e8ae85d7df167ab909d31dfbfa634914fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2eb2a6bdea87faafe9cc6634371bc5b913ee0277e586d9efe6046108b2b29679d101e42a74d3f2204b7931ee4d8af3fcbe98f22e3087be117a694d49b271e2a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba88abbae19d46d71d3742dd1dd7ca1220c41541dd027f19de2035b31eb0febec63cc2ef5058c9237b9523899e925d4d8c44106f5cfefccea276bbe9e41df5b1"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476959407/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011209 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476959407/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0059213d7db3e31cc391fa19853f1cc23b16b8339dab435b7620dc54bfb41450682986266ede86ea05660b8e44e1d5e8ae85d7df167ab909d31dfbfa634914fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2eb2a6bdea87faafe9cc6634371bc5b913ee0277e586d9efe6046108b2b29679d101e42a74d3f2204b7931ee4d8af3fcbe98f22e3087be117a694d49b271e2a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba88abbae19d46d71d3742dd1dd7ca1220c41541dd027f19de2035b31eb0febec63cc2ef5058c9237b9523899e925d4d8c44106f5cfefccea276bbe9e41df5b1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 07:06:40.367330) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 07:06:40.367868) ========= 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=337fe3f4b1febe37b85fccc40000019e-1476971161.480285-1013204608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 07:06:40.453106) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 07:06:40.453425) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 07:06:40.453743) ========= ========= Total master_lag: 0.18 =========