builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1469059915.56 results: success (0) buildid: 20160720143019 builduid: 9235ecacf04e43b9b37557d2db6f7534 revision: 5f4846ed9f65d7622fdbd8993289daeb6b29b692 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 17:11:55.562755) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 17:11:55.563249) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 17:11:55.563565) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 17:11:55.580185) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 17:11:55.580569) ========= 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=a0d2d2de893abaa8702a9954000001a7-1469059914.392029-2030010091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-20 17:11:55-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.4M=0s 2016-07-20 17:11:55 (38.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158146 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 17:11:55.753820) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 17:11:55.754134) ========= 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=a0d2d2de893abaa8702a9954000001a7-1469059914.392029-2030010091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015007 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 17:11:55.804435) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-20 17:11:55.804898) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5f4846ed9f65d7622fdbd8993289daeb6b29b692 --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 5f4846ed9f65d7622fdbd8993289daeb6b29b692 --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=a0d2d2de893abaa8702a9954000001a7-1469059914.392029-2030010091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-20 17:11:55,878 truncating revision to first 12 chars 2016-07-20 17:11:55,879 Setting DEBUG logging. 2016-07-20 17:11:55,879 attempt 1/10 2016-07-20 17:11:55,879 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5f4846ed9f65?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-20 17:11:56,769 unpacking tar archive at: fx-team-5f4846ed9f65/testing/mozharness/ program finished with exit code 0 elapsedTime=1.236024 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-20 17:11:57.055561) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 17:11:57.055948) ========= script_repo_revision: 5f4846ed9f65d7622fdbd8993289daeb6b29b692 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 17:11:57.056359) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 17:11:57.056625) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 17:11:57.066674) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-20 17:11:57.067097) ========= /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=a0d2d2de893abaa8702a9954000001a7-1469059914.392029-2030010091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:11:57 INFO - MultiFileLogger online at 20160720 17:11:57 in /builds/slave/test 17:11:57 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 17:11:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:11:57 INFO - {'append_to_log': False, 17:11:57 INFO - 'base_work_dir': '/builds/slave/test', 17:11:57 INFO - 'blob_upload_branch': 'Fx-Team', 17:11:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:11:57 INFO - 'branch': 'Fx-Team', 17:11:57 INFO - 'buildbot_json_path': 'buildprops.json', 17:11:57 INFO - 'config_files': ('talos/linux_config.py',), 17:11:57 INFO - 'default_actions': ('clobber', 17:11:57 INFO - 'read-buildbot-config', 17:11:57 INFO - 'download-and-extract', 17:11:57 INFO - 'populate-webroot', 17:11:57 INFO - 'create-virtualenv', 17:11:57 INFO - 'install', 17:11:57 INFO - 'run-tests'), 17:11:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:11:57 INFO - 'download_minidump_stackwalk': True, 17:11:57 INFO - 'download_symbols': 'ondemand', 17:11:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:11:57 INFO - 'tooltool.py': '/tools/tooltool.py', 17:11:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:11:57 INFO - '/tools/misc-python/virtualenv.py')}, 17:11:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:11:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:11:57 INFO - 'installer_path': 'installer.exe', 17:11:57 INFO - 'log_level': 'info', 17:11:57 INFO - 'log_name': 'talos', 17:11:57 INFO - 'log_to_console': True, 17:11:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:11:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:11:57 INFO - 'opt_config_files': (), 17:11:57 INFO - 'pip_index': False, 17:11:57 INFO - 'sps_profile': False, 17:11:57 INFO - 'sps_profile_interval': 0, 17:11:57 INFO - 'suite': 'dromaeojs', 17:11:57 INFO - 'system_bits': '32', 17:11:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:11:57 INFO - 'title': 'talos-linux64-ix-002', 17:11:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:11:57 INFO - 'use_talos_json': True, 17:11:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:11:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:11:57 INFO - 'work_dir': 'build'} 17:11:57 INFO - [mozharness: 2016-07-21 00:11:57.310067Z] Running clobber step. 17:11:57 INFO - Running pre-action listener: _resource_record_pre_action 17:11:57 INFO - Running main action method: clobber 17:11:57 INFO - rmtree: /builds/slave/test/build 17:11:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:11:58 INFO - Running post-action listener: _resource_record_post_action 17:11:58 INFO - [mozharness: 2016-07-21 00:11:58.032510Z] Finished clobber step (success) 17:11:58 INFO - [mozharness: 2016-07-21 00:11:58.032609Z] Running read-buildbot-config step. 17:11:58 INFO - Running pre-action listener: _resource_record_pre_action 17:11:58 INFO - Running main action method: read_buildbot_config 17:11:58 INFO - Using buildbot properties: 17:11:58 INFO - { 17:11:58 INFO - "project": "", 17:11:58 INFO - "product": "firefox", 17:11:58 INFO - "script_repo_revision": "production", 17:11:58 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:11:58 INFO - "repository": "", 17:11:58 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:11:58 INFO - "buildid": "20160720143019", 17:11:58 INFO - "pgo_build": "True", 17:11:58 INFO - "basedir": "/builds/slave/test", 17:11:58 INFO - "buildnumber": 306, 17:11:58 INFO - "slavename": "talos-linux64-ix-002", 17:11:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:11:58 INFO - "platform": "ubuntu64_hw", 17:11:58 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:11:58 INFO - "branch": "fx-team", 17:11:58 INFO - "repo_path": "integration/fx-team", 17:11:58 INFO - "revision": "5f4846ed9f65d7622fdbd8993289daeb6b29b692", 17:11:58 INFO - "stage_platform": "linux64-pgo", 17:11:58 INFO - "builduid": "9235ecacf04e43b9b37557d2db6f7534", 17:11:58 INFO - "slavebuilddir": "test" 17:11:58 INFO - } 17:11:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:11:58 INFO - Running post-action listener: _resource_record_post_action 17:11:58 INFO - [mozharness: 2016-07-21 00:11:58.035020Z] Finished read-buildbot-config step (success) 17:11:58 INFO - [mozharness: 2016-07-21 00:11:58.035109Z] Running download-and-extract step. 17:11:58 INFO - Running pre-action listener: _resource_record_pre_action 17:11:58 INFO - Running main action method: download_and_extract 17:11:58 INFO - mkdir: /builds/slave/test/build/tests 17:11:58 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:58 INFO - https://queue.taskcluster.net/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:11:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:11:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:11:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:11:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:11:58 INFO - Downloaded 1361 bytes. 17:11:58 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:11:58 INFO - Using the following test package requirements: 17:11:58 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:11:58 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:11:58 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:11:58 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:58 INFO - u'jsshell-linux-x86_64.zip'], 17:11:58 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:11:58 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:11:58 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:11:58 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:11:58 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:11:58 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:11:58 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:11:58 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:11:58 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:11:58 INFO - https://queue.taskcluster.net/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:11:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:11:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:11:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:11:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:11:59 INFO - Downloaded 24343493 bytes. 17:11:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:11:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:12:01 INFO - Return code: 0 17:12:01 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:12:01 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:01 INFO - https://queue.taskcluster.net/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:12:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:12:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:12:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:12:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:12:02 INFO - Downloaded 24343493 bytes. 17:12:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:12:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:12:04 INFO - Return code: 0 17:12: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:04 INFO - https://queue.taskcluster.net/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:12:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:12:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:12:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:12:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:12:04 INFO - Downloaded 14403317 bytes. 17:12:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:12:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:12:05 INFO - Return code: 0 17:12:05 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:05 INFO - https://queue.taskcluster.net/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:12:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:12:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:12:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:12:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:12:06 INFO - Downloaded 60882358 bytes. 17:12:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:12:06 INFO - mkdir: /builds/slave/test/properties 17:12:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:12:06 INFO - Writing to file /builds/slave/test/properties/build_url 17:12:06 INFO - Contents: 17:12:06 INFO - build_url:https://queue.taskcluster.net/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:12:07 INFO - Running post-action listener: _resource_record_post_action 17:12:07 INFO - Running post-action listener: set_extra_try_arguments 17:12:07 INFO - [mozharness: 2016-07-21 00:12:07.695059Z] Finished download-and-extract step (success) 17:12:07 INFO - [mozharness: 2016-07-21 00:12:07.695290Z] Running populate-webroot step. 17:12:07 INFO - Running pre-action listener: _resource_record_pre_action 17:12:07 INFO - Running main action method: populate_webroot 17:12:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:12:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:12:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:12:07 INFO - '--tppagecycles', 17:12:07 INFO - '7'], 17:12:07 INFO - 'tests': ['tsvgm']}}, 17:12:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:12:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:12:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:12:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:12:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:12:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:12:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:07 INFO - 'talos_options': ['--disable-e10s'], 17:12:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:12:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:12:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:07 INFO - 'talos_options': ['--disable-e10s'], 17:12:07 INFO - 'tests': ['damp', 'tps']}, 17:12:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:07 INFO - 'tests': ['damp', 'tps']}, 17:12:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:12:07 INFO - 'tests': ['dromaeo_dom']}, 17:12:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:12:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:12:07 INFO - 'tests': ['basic_compositor_video']}, 17:12:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:12:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:12:07 INFO - 'tests': ['a11yr', 17:12:07 INFO - 'ts_paint', 17:12:07 INFO - 'tpaint', 17:12:07 INFO - 'sessionrestore', 17:12:07 INFO - 'sessionrestore_no_auto_restore', 17:12:07 INFO - 'tabpaint']}, 17:12:07 INFO - 'other-e10s': {'tests': ['a11yr', 17:12:07 INFO - 'ts_paint', 17:12:07 INFO - 'tpaint', 17:12:07 INFO - 'sessionrestore', 17:12:07 INFO - 'sessionrestore_no_auto_restore', 17:12:07 INFO - 'tabpaint']}, 17:12:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:12:07 INFO - 'ts_paint', 17:12:07 INFO - 'tpaint', 17:12:07 INFO - 'sessionrestore', 17:12:07 INFO - 'sessionrestore_no_auto_restore', 17:12:07 INFO - 'tabpaint']}, 17:12:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:12:07 INFO - 'ts_paint', 17:12:07 INFO - 'tpaint', 17:12:07 INFO - 'sessionrestore', 17:12:07 INFO - 'sessionrestore_no_auto_restore', 17:12:07 INFO - 'tabpaint']}, 17:12:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:12:07 INFO - 'tests': ['a11yr', 17:12:07 INFO - 'ts_paint', 17:12:07 INFO - 'tpaint', 17:12:07 INFO - 'sessionrestore', 17:12:07 INFO - 'sessionrestore_no_auto_restore', 17:12:07 INFO - 'tabpaint']}, 17:12:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:12:07 INFO - 'tests': ['a11yr', 17:12:07 INFO - 'ts_paint', 17:12:07 INFO - 'tpaint', 17:12:07 INFO - 'sessionrestore', 17:12:07 INFO - 'sessionrestore_no_auto_restore', 17:12:07 INFO - 'tabpaint']}, 17:12:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:12:07 INFO - 'tests': ['tsvgx', 17:12:07 INFO - 'tsvgr_opacity', 17:12:07 INFO - 'tart', 17:12:07 INFO - 'tscrollx', 17:12:07 INFO - 'cart']}, 17:12:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:12:07 INFO - 'tsvgr_opacity', 17:12:07 INFO - 'tart', 17:12:07 INFO - 'tscrollx', 17:12:07 INFO - 'cart']}, 17:12:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:07 INFO - 'talos_options': ['--disable-e10s'], 17:12:07 INFO - 'tests': ['tp5o']}, 17:12:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:07 INFO - 'tests': ['tp5o']}, 17:12:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:07 INFO - 'talos_options': ['--disable-e10s', 17:12:07 INFO - '--xperf_path', 17:12:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:12:07 INFO - 'tests': ['tp5n']}, 17:12:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:07 INFO - 'talos_options': ['--xperf_path', 17:12:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:12:07 INFO - 'tests': ['tp5n']}}, 17:12:07 INFO - 'talos.zip': {'path': '', 17:12:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:12:07 INFO - Running post-action listener: _resource_record_post_action 17:12:07 INFO - [mozharness: 2016-07-21 00:12:07.712396Z] Finished populate-webroot step (success) 17:12:07 INFO - [mozharness: 2016-07-21 00:12:07.712484Z] Running create-virtualenv step. 17:12:07 INFO - Running pre-action listener: _resource_record_pre_action 17:12:07 INFO - Running main action method: create_virtualenv 17:12:07 INFO - Creating virtualenv /builds/slave/test/build/venv 17:12:07 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 17:12:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:12:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:12:07 INFO - Using real prefix '/usr' 17:12:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:12:08 INFO - Installing distribute.............................................................................................................................................................................................done. 17:12:11 INFO - Installing pip.................done. 17:12:11 INFO - Return code: 0 17:12:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:12:11 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:11 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:11 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 0x234c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260b3b0>, '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 0x260c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260c740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469059914.392029-2030010091', '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 17:12:11 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 17:12:11 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 17:12:11 INFO - Using env: {'DISPLAY': ':0', 17:12:11 INFO - 'HOME': '/home/cltbld', 17:12:11 INFO - 'LANG': 'en_US.UTF-8', 17:12:11 INFO - 'LANGUAGE': 'en_US:en', 17:12:11 INFO - 'LOGNAME': 'cltbld', 17:12:11 INFO - 'MAIL': '/var/mail/cltbld', 17:12:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:11 INFO - 'MOZ_NO_REMOTE': '1', 17:12:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:11 INFO - 'NO_EM_RESTART': '1', 17:12:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:11 INFO - 'PWD': '/builds/slave/test', 17:12:11 INFO - 'SHELL': '/bin/bash', 17:12:11 INFO - 'SHLVL': '1', 17:12:11 INFO - 'TERM': 'linux', 17:12:11 INFO - 'TMOUT': '86400', 17:12:11 INFO - 'USER': 'cltbld', 17:12:11 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469059914.392029-2030010091', 17:12:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:11 INFO - '_': '/tools/buildbot/bin/python'} 17:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:12 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 17:12:12 INFO - Cleaning up... 17:12:12 INFO - Return code: 0 17:12:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:12:12 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:12 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:12 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 0x234c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260b3b0>, '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 0x260c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260c740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469059914.392029-2030010091', '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 17:12:12 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 17:12:12 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 17:12:12 INFO - Using env: {'DISPLAY': ':0', 17:12:12 INFO - 'HOME': '/home/cltbld', 17:12:12 INFO - 'LANG': 'en_US.UTF-8', 17:12:12 INFO - 'LANGUAGE': 'en_US:en', 17:12:12 INFO - 'LOGNAME': 'cltbld', 17:12:12 INFO - 'MAIL': '/var/mail/cltbld', 17:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:12 INFO - 'MOZ_NO_REMOTE': '1', 17:12:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:12 INFO - 'NO_EM_RESTART': '1', 17:12:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:12 INFO - 'PWD': '/builds/slave/test', 17:12:12 INFO - 'SHELL': '/bin/bash', 17:12:12 INFO - 'SHLVL': '1', 17:12:12 INFO - 'TERM': 'linux', 17:12:12 INFO - 'TMOUT': '86400', 17:12:12 INFO - 'USER': 'cltbld', 17:12:12 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469059914.392029-2030010091', 17:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:12 INFO - '_': '/tools/buildbot/bin/python'} 17:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:12 INFO - Downloading/unpacking psutil>=3.1.1 17:12:12 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 17:12:12 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 17:12:12 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 17:12:12 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 17:12:12 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 17:12:12 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 17:12:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:12:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:12:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:12:14 INFO - Installing collected packages: psutil 17:12:14 INFO - Running setup.py install for psutil 17:12:14 INFO - building 'psutil._psutil_linux' extension 17:12:14 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 17:12:16 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 17:12:17 INFO - building 'psutil._psutil_posix' extension 17:12:17 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 17:12:17 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 17:12:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:12:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:12:17 INFO - Successfully installed psutil 17:12:17 INFO - Cleaning up... 17:12:17 INFO - Return code: 0 17:12:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:12: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x234c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260b3b0>, '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 0x260c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260c740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469059914.392029-2030010091', '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 17:12: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:12: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 mozsystemmonitor==0.3 17:12:17 INFO - Using env: {'DISPLAY': ':0', 17:12:17 INFO - 'HOME': '/home/cltbld', 17:12:17 INFO - 'LANG': 'en_US.UTF-8', 17:12:17 INFO - 'LANGUAGE': 'en_US:en', 17:12:17 INFO - 'LOGNAME': 'cltbld', 17:12:17 INFO - 'MAIL': '/var/mail/cltbld', 17:12:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:17 INFO - 'MOZ_NO_REMOTE': '1', 17:12:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:17 INFO - 'NO_EM_RESTART': '1', 17:12:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:17 INFO - 'PWD': '/builds/slave/test', 17:12:17 INFO - 'SHELL': '/bin/bash', 17:12:17 INFO - 'SHLVL': '1', 17:12:17 INFO - 'TERM': 'linux', 17:12:17 INFO - 'TMOUT': '86400', 17:12:17 INFO - 'USER': 'cltbld', 17:12:17 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469059914.392029-2030010091', 17:12:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:17 INFO - '_': '/tools/buildbot/bin/python'} 17:12:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:12:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:12:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:12:19 INFO - Installing collected packages: mozsystemmonitor 17:12:19 INFO - Running setup.py install for mozsystemmonitor 17:12:19 INFO - Successfully installed mozsystemmonitor 17:12:19 INFO - Cleaning up... 17:12:19 INFO - Return code: 0 17:12:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x234c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260b3b0>, '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 0x260c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260c740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469059914.392029-2030010091', '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 17:12:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:12:19 INFO - Using env: {'DISPLAY': ':0', 17:12:19 INFO - 'HOME': '/home/cltbld', 17:12:19 INFO - 'LANG': 'en_US.UTF-8', 17:12:19 INFO - 'LANGUAGE': 'en_US:en', 17:12:19 INFO - 'LOGNAME': 'cltbld', 17:12:19 INFO - 'MAIL': '/var/mail/cltbld', 17:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:19 INFO - 'MOZ_NO_REMOTE': '1', 17:12:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:19 INFO - 'NO_EM_RESTART': '1', 17:12:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:19 INFO - 'PWD': '/builds/slave/test', 17:12:19 INFO - 'SHELL': '/bin/bash', 17:12:19 INFO - 'SHLVL': '1', 17:12:19 INFO - 'TERM': 'linux', 17:12:19 INFO - 'TMOUT': '86400', 17:12:19 INFO - 'USER': 'cltbld', 17:12:19 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469059914.392029-2030010091', 17:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:19 INFO - '_': '/tools/buildbot/bin/python'} 17:12:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:19 INFO - Downloading/unpacking jsonschema==2.5.1 17:12:19 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 17:12:19 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 17:12:19 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 17:12:19 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 17:12:19 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 17:12:19 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 17:12:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:12:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:12:21 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 17:12:21 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 17:12:21 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 17:12:21 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 17:12:21 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 17:12:21 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 17:12:22 INFO - Downloading functools32-3.2.3-2.tar.gz 17:12:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:12:22 INFO - warning: no files found matching '*.txt' 17:12:22 INFO - no previously-included directories found matching 'build' 17:12:22 INFO - no previously-included directories found matching 'dist' 17:12:22 INFO - no previously-included directories found matching '.git*' 17:12:22 INFO - Installing collected packages: jsonschema, functools32 17:12:22 INFO - Running setup.py install for functools32 17:12:22 INFO - warning: no files found matching '*.txt' 17:12:22 INFO - no previously-included directories found matching 'build' 17:12:22 INFO - no previously-included directories found matching 'dist' 17:12:22 INFO - no previously-included directories found matching '.git*' 17:12:22 INFO - Successfully installed jsonschema functools32 17:12:22 INFO - Cleaning up... 17:12:22 INFO - Return code: 0 17:12:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:12: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x234c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260b3b0>, '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 0x260c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260c740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469059914.392029-2030010091', '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 17:12:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:12:22 INFO - Using env: {'DISPLAY': ':0', 17:12:22 INFO - 'HOME': '/home/cltbld', 17:12:22 INFO - 'LANG': 'en_US.UTF-8', 17:12:22 INFO - 'LANGUAGE': 'en_US:en', 17:12:22 INFO - 'LOGNAME': 'cltbld', 17:12:22 INFO - 'MAIL': '/var/mail/cltbld', 17:12:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:22 INFO - 'MOZ_NO_REMOTE': '1', 17:12:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:22 INFO - 'NO_EM_RESTART': '1', 17:12:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:22 INFO - 'PWD': '/builds/slave/test', 17:12:22 INFO - 'SHELL': '/bin/bash', 17:12:22 INFO - 'SHLVL': '1', 17:12:22 INFO - 'TERM': 'linux', 17:12:22 INFO - 'TMOUT': '86400', 17:12:22 INFO - 'USER': 'cltbld', 17:12:22 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469059914.392029-2030010091', 17:12:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:22 INFO - '_': '/tools/buildbot/bin/python'} 17:12:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:22 INFO - Downloading/unpacking blobuploader==1.2.4 17:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:24 INFO - Downloading blobuploader-1.2.4.tar.gz 17:12:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:12:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:12:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:12:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:12:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:12: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 17:12: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 17:12: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 17:12: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 17:12: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 17:12: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 17:12:25 INFO - Downloading docopt-0.6.1.tar.gz 17:12:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:12:25 INFO - Installing collected packages: blobuploader, requests, docopt 17:12:25 INFO - Running setup.py install for blobuploader 17:12:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:12:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:12:25 INFO - Running setup.py install for requests 17:12:25 INFO - Running setup.py install for docopt 17:12:26 INFO - Successfully installed blobuploader requests docopt 17:12:26 INFO - Cleaning up... 17:12:26 INFO - Return code: 0 17:12:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:12:26 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:26 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:26 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 0x234c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260b3b0>, '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 0x260c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260c740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469059914.392029-2030010091', '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 17:12:26 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 17:12:26 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 17:12:26 INFO - Using env: {'DISPLAY': ':0', 17:12:26 INFO - 'HOME': '/home/cltbld', 17:12:26 INFO - 'LANG': 'en_US.UTF-8', 17:12:26 INFO - 'LANGUAGE': 'en_US:en', 17:12:26 INFO - 'LOGNAME': 'cltbld', 17:12:26 INFO - 'MAIL': '/var/mail/cltbld', 17:12:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:26 INFO - 'MOZ_NO_REMOTE': '1', 17:12:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:26 INFO - 'NO_EM_RESTART': '1', 17:12:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:26 INFO - 'PWD': '/builds/slave/test', 17:12:26 INFO - 'SHELL': '/bin/bash', 17:12:26 INFO - 'SHLVL': '1', 17:12:26 INFO - 'TERM': 'linux', 17:12:26 INFO - 'TMOUT': '86400', 17:12:26 INFO - 'USER': 'cltbld', 17:12:26 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469059914.392029-2030010091', 17:12:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:26 INFO - '_': '/tools/buildbot/bin/python'} 17:12:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:12:26 INFO - Running setup.py (path:/tmp/pip-EGnJDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:12:26 INFO - Running setup.py (path:/tmp/pip-CzOKZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:12:26 INFO - Running setup.py (path:/tmp/pip-6BZi_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:12:26 INFO - Running setup.py (path:/tmp/pip-3zV0JZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:12:26 INFO - Running setup.py (path:/tmp/pip-mHDLzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:12:26 INFO - Running setup.py (path:/tmp/pip-H_N0LU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:12:26 INFO - Running setup.py (path:/tmp/pip-r17P_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:12:26 INFO - Running setup.py (path:/tmp/pip-eV46WD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:12:26 INFO - Running setup.py (path:/tmp/pip-q_5Zdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:12:26 INFO - Running setup.py (path:/tmp/pip-bdSZCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:12:27 INFO - Running setup.py (path:/tmp/pip-_5HFkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:12:27 INFO - Running setup.py (path:/tmp/pip-mtwhh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:12:27 INFO - Running setup.py (path:/tmp/pip-Nyo6GS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:12:27 INFO - Running setup.py (path:/tmp/pip-9dM6WT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:27 INFO - Running setup.py (path:/tmp/pip-yhebSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:12:27 INFO - Running setup.py (path:/tmp/pip-X8Q2_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:12:27 INFO - Running setup.py (path:/tmp/pip-UE6ebq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:12:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:12:27 INFO - Running setup.py install for manifestparser 17:12:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:12:27 INFO - Running setup.py install for mozcrash 17:12:27 INFO - Running setup.py install for mozdebug 17:12:27 INFO - Running setup.py install for mozdevice 17:12:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:12:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:12:27 INFO - Running setup.py install for mozfile 17:12:28 INFO - Running setup.py install for mozhttpd 17:12:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:12:28 INFO - Running setup.py install for mozinfo 17:12:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:12:28 INFO - Running setup.py install for mozInstall 17:12:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:12:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:12:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:12:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:12:28 INFO - Running setup.py install for mozleak 17:12:28 INFO - Running setup.py install for mozlog 17:12:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:12:28 INFO - Running setup.py install for moznetwork 17:12:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:12:28 INFO - Running setup.py install for mozprocess 17:12:28 INFO - Running setup.py install for mozprofile 17:12:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:12:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:12:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:12:28 INFO - Running setup.py install for mozrunner 17:12:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:12:28 INFO - Running setup.py install for mozscreenshot 17:12:29 INFO - Running setup.py install for moztest 17:12:29 INFO - Running setup.py install for mozversion 17:12:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:12:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:12:29 INFO - Cleaning up... 17:12:29 INFO - Return code: 0 17:12:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:12: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:29 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 0x234c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260b3b0>, '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 0x260c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260c740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469059914.392029-2030010091', '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 17:12:29 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 17:12:29 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 17:12:29 INFO - Using env: {'DISPLAY': ':0', 17:12:29 INFO - 'HOME': '/home/cltbld', 17:12:29 INFO - 'LANG': 'en_US.UTF-8', 17:12:29 INFO - 'LANGUAGE': 'en_US:en', 17:12:29 INFO - 'LOGNAME': 'cltbld', 17:12:29 INFO - 'MAIL': '/var/mail/cltbld', 17:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:29 INFO - 'MOZ_NO_REMOTE': '1', 17:12:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:29 INFO - 'NO_EM_RESTART': '1', 17:12:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:29 INFO - 'PWD': '/builds/slave/test', 17:12:29 INFO - 'SHELL': '/bin/bash', 17:12:29 INFO - 'SHLVL': '1', 17:12:29 INFO - 'TERM': 'linux', 17:12:29 INFO - 'TMOUT': '86400', 17:12:29 INFO - 'USER': 'cltbld', 17:12:29 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469059914.392029-2030010091', 17:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:29 INFO - '_': '/tools/buildbot/bin/python'} 17:12:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:12:29 INFO - Running setup.py (path:/tmp/pip-dcupWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:12:29 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)) 17:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:12:29 INFO - Running setup.py (path:/tmp/pip-7193DD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:12:29 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)) 17:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:12:29 INFO - Running setup.py (path:/tmp/pip-uLosiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:12:29 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)) 17:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:12:29 INFO - Running setup.py (path:/tmp/pip-VWUjPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:12:29 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)) 17:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:12:29 INFO - Running setup.py (path:/tmp/pip-IThwrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:12:29 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)) 17:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:12:29 INFO - Running setup.py (path:/tmp/pip-bQAWfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:12:29 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)) 17:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:12:29 INFO - Running setup.py (path:/tmp/pip-wEtj4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:12:29 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)) 17:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:12:29 INFO - Running setup.py (path:/tmp/pip-fvmPtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:12:30 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)) 17:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:12:30 INFO - Running setup.py (path:/tmp/pip-QjJMpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:12:30 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)) 17:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:12:30 INFO - Running setup.py (path:/tmp/pip-QmAINJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 17:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:12:30 INFO - Running setup.py (path:/tmp/pip-4fy9gj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:12:30 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)) 17:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:12:30 INFO - Running setup.py (path:/tmp/pip-iENE43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:12:30 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)) 17:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:12:30 INFO - Running setup.py (path:/tmp/pip-9D36yF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:12:30 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)) 17:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:12:30 INFO - Running setup.py (path:/tmp/pip-E_VaJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:12:30 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)) 17:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:30 INFO - Running setup.py (path:/tmp/pip-TY9K5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:12:30 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)) 17:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:12:30 INFO - Running setup.py (path:/tmp/pip-UAIfPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:12:30 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)) 17:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:12:30 INFO - Running setup.py (path:/tmp/pip-vgEs6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:12:30 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)) 17:12:30 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)) 17:12:30 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)) 17:12:30 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)) 17:12:30 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)) 17:12:30 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)) 17:12:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:12:30 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 17:12:30 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 17:12:30 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 17:12:30 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 17:12:30 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 17:12:30 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 17:12:32 INFO - Downloading blessings-1.6.tar.gz 17:12:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:12:32 INFO - Installing collected packages: blessings 17:12:32 INFO - Running setup.py install for blessings 17:12:32 INFO - Successfully installed blessings 17:12:32 INFO - Cleaning up... 17:12:32 INFO - Return code: 0 17:12:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:12:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:12:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:12:33 INFO - Reading from file tmpfile_stdout 17:12:33 INFO - Current package versions: 17:12:33 INFO - argparse == 1.2.1 17:12:33 INFO - blessings == 1.6 17:12:33 INFO - blobuploader == 1.2.4 17:12:33 INFO - docopt == 0.6.1 17:12:33 INFO - functools32 == 3.2.3-2 17:12:33 INFO - jsonschema == 2.5.1 17:12:33 INFO - manifestparser == 1.1 17:12:33 INFO - mozInstall == 1.12 17:12:33 INFO - mozcrash == 0.17 17:12:33 INFO - mozdebug == 0.1 17:12:33 INFO - mozdevice == 0.48 17:12:33 INFO - mozfile == 1.2 17:12:33 INFO - mozhttpd == 0.7 17:12:33 INFO - mozinfo == 0.9 17:12:33 INFO - mozleak == 0.1 17:12:33 INFO - mozlog == 3.3 17:12:33 INFO - moznetwork == 0.27 17:12:33 INFO - mozprocess == 0.23 17:12:33 INFO - mozprofile == 0.28 17:12:33 INFO - mozrunner == 6.12 17:12:33 INFO - mozscreenshot == 0.1 17:12:33 INFO - mozsystemmonitor == 0.3 17:12:33 INFO - moztest == 0.7 17:12:33 INFO - mozversion == 1.4 17:12:33 INFO - psutil == 3.1.1 17:12:33 INFO - requests == 1.2.3 17:12:33 INFO - wsgiref == 0.1.2 17:12:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:12:33 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:33 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:33 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 0x234c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260b3b0>, '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 0x260c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260c740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469059914.392029-2030010091', '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 17:12:33 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 17:12:33 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 17:12:33 INFO - Using env: {'DISPLAY': ':0', 17:12:33 INFO - 'HOME': '/home/cltbld', 17:12:33 INFO - 'LANG': 'en_US.UTF-8', 17:12:33 INFO - 'LANGUAGE': 'en_US:en', 17:12:33 INFO - 'LOGNAME': 'cltbld', 17:12:33 INFO - 'MAIL': '/var/mail/cltbld', 17:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:33 INFO - 'MOZ_NO_REMOTE': '1', 17:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:33 INFO - 'NO_EM_RESTART': '1', 17:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:33 INFO - 'PWD': '/builds/slave/test', 17:12:33 INFO - 'SHELL': '/bin/bash', 17:12:33 INFO - 'SHLVL': '1', 17:12:33 INFO - 'TERM': 'linux', 17:12:33 INFO - 'TMOUT': '86400', 17:12:33 INFO - 'USER': 'cltbld', 17:12:33 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469059914.392029-2030010091', 17:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:33 INFO - '_': '/tools/buildbot/bin/python'} 17:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:33 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)) 17:12:33 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)) 17:12:33 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)) 17:12:33 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)) 17:12:33 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)) 17:12:33 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)) 17:12:33 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)) 17:12:33 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)) 17:12:33 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)) 17:12:33 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)) 17:12:33 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)) 17:12:33 INFO - Cleaning up... 17:12:33 INFO - Return code: 0 17:12:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:12:33 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:33 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:33 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 0x234c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260b3b0>, '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 0x260c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260c740>, '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': 'a0d2d2de893abaa8702a9954000001a7-1469059914.392029-2030010091', '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 17:12:33 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 17:12:33 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 17:12:33 INFO - Using env: {'DISPLAY': ':0', 17:12:33 INFO - 'HOME': '/home/cltbld', 17:12:33 INFO - 'LANG': 'en_US.UTF-8', 17:12:33 INFO - 'LANGUAGE': 'en_US:en', 17:12:33 INFO - 'LOGNAME': 'cltbld', 17:12:33 INFO - 'MAIL': '/var/mail/cltbld', 17:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:33 INFO - 'MOZ_NO_REMOTE': '1', 17:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:33 INFO - 'NO_EM_RESTART': '1', 17:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:33 INFO - 'PWD': '/builds/slave/test', 17:12:33 INFO - 'SHELL': '/bin/bash', 17:12:33 INFO - 'SHLVL': '1', 17:12:33 INFO - 'TERM': 'linux', 17:12:33 INFO - 'TMOUT': '86400', 17:12:33 INFO - 'USER': 'cltbld', 17:12:33 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469059914.392029-2030010091', 17:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:33 INFO - '_': '/tools/buildbot/bin/python'} 17:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:12:33 INFO - Cleaning up... 17:12:33 INFO - Return code: 0 17:12:33 INFO - Running post-action listener: _resource_record_post_action 17:12:33 INFO - Running post-action listener: _start_resource_monitoring 17:12:33 INFO - Starting resource monitoring. 17:12:33 INFO - [mozharness: 2016-07-21 00:12:33.598749Z] Finished create-virtualenv step (success) 17:12:33 INFO - [mozharness: 2016-07-21 00:12:33.599709Z] Running install step. 17:12:33 INFO - Running pre-action listener: _resource_record_pre_action 17:12:33 INFO - Running main action method: install 17:12:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:12:33 INFO - Reading from file tmpfile_stdout 17:12:33 INFO - Detecting whether we're running mozinstall >=1.0... 17:12:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:12:33 INFO - Reading from file tmpfile_stdout 17:12:33 INFO - Output received: 17:12:33 INFO - Usage: mozinstall [options] installer 17:12:33 INFO - Options: 17:12:33 INFO - -h, --help show this help message and exit 17:12:33 INFO - -d DEST, --destination=DEST 17:12:33 INFO - Directory to install application into. [default: 17:12:33 INFO - "/builds/slave/test"] 17:12:33 INFO - --app=APP Application being installed. [default: firefox] 17:12:33 INFO - mkdir: /builds/slave/test/build/application 17:12:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:12:51 INFO - Reading from file tmpfile_stdout 17:12:51 INFO - Output received: 17:12:51 INFO - /builds/slave/test/build/application/firefox/firefox 17:12:51 INFO - Running post-action listener: _resource_record_post_action 17:12:51 INFO - [mozharness: 2016-07-21 00:12:51.087523Z] Finished install step (success) 17:12:51 INFO - [mozharness: 2016-07-21 00:12:51.087802Z] Running run-tests step. 17:12:51 INFO - Running pre-action listener: _resource_record_pre_action 17:12:51 INFO - Running main action method: run_tests 17:12:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:12:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:12:51 INFO - Python 2.7.3 17:12:51 INFO - Return code: 0 17:12:51 INFO - grabbing minidump binary from tooltool 17:12:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:12:51 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 0x260b3b0>, '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 0x260c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:12:51 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 17:12:51 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 17:12:51 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 17:12:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:12:51 INFO - Return code: 0 17:12:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:12:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:12:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:12:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:12:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:12:51 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://queue.taskcluster.net/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 17:12:51 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://queue.taskcluster.net/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 17:12:51 INFO - Using env: {'DISPLAY': ':0', 17:12:51 INFO - 'HOME': '/home/cltbld', 17:12:51 INFO - 'LANG': 'en_US.UTF-8', 17:12:51 INFO - 'LANGUAGE': 'en_US:en', 17:12:51 INFO - 'LOGNAME': 'cltbld', 17:12:51 INFO - 'MAIL': '/var/mail/cltbld', 17:12:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:12:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:12:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:51 INFO - 'MOZ_NO_REMOTE': '1', 17:12:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:12:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:51 INFO - 'NO_EM_RESTART': '1', 17:12:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:51 INFO - 'PWD': '/builds/slave/test', 17:12:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:12:51 INFO - 'SHELL': '/bin/bash', 17:12:51 INFO - 'SHLVL': '1', 17:12:51 INFO - 'TERM': 'linux', 17:12:51 INFO - 'TMOUT': '86400', 17:12:51 INFO - 'USER': 'cltbld', 17:12:51 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1469059914.392029-2030010091', 17:12:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:51 INFO - '_': '/tools/buildbot/bin/python'} 17:12:51 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://queue.taskcluster.net/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 17:12:51 INFO - mozversion application_buildid: 20160720143019 17:12:51 INFO - mozversion application_changeset: 5f4846ed9f65d7622fdbd8993289daeb6b29b692 17:12:51 INFO - mozversion application_display_name: Nightly 17:12:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:12:51 INFO - mozversion application_name: Firefox 17:12:51 INFO - mozversion application_remotingname: firefox 17:12:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:12:51 INFO - mozversion application_vendor: Mozilla 17:12:51 INFO - mozversion application_version: 50.0a1 17:12:51 INFO - mozversion platform_buildid: 20160720143019 17:12:51 INFO - mozversion platform_changeset: 5f4846ed9f65d7622fdbd8993289daeb6b29b692 17:12:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:12:51 INFO - mozversion platform_version: 50.0a1 17:12:51 INFO - using testdate: 1469059971 17:12:51 INFO - actual date: 1469059971 17:12:51 INFO - starting webserver on 'localhost:44731' 17:12:51 INFO - SUITE-START | Running 2 tests 17:12:51 INFO - TEST-START | dromaeo_css 17:12:51 INFO - operating with platform_type : linux_ 17:12:51 INFO - Initialising browser for dromaeo_css test... 17:12:51 INFO - TEST-INFO | started process 3316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0DG2DK/profile http://localhost:44731/getInfo.html) 17:12:56 INFO - PROCESS | 3316 | __metrics Screen width/height:1600/1200 17:12:56 INFO - PROCESS | 3316 | colorDepth:24 17:12:56 INFO - PROCESS | 3316 | Browser inner width/height: 1024/697 17:12:56 INFO - PROCESS | 3316 | __metrics 17:12:57 INFO - PROCESS | 3316 | 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" 17:12:57 INFO - PROCESS | 3316 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:12:57 INFO - PROCESS | 3316 | console.error: PushService: 17:12:57 INFO - PROCESS | 3316 | stateChangeProcessEnqueue: Error transitioning state 17:12:57 INFO - PROCESS | 3316 | UnknownError 17:12:58 INFO - TEST-INFO | 3316: exit 0 17:12:58 INFO - Browser initialized. 17:12:58 INFO - Running cycle 1/1 for dromaeo_css test... 17:12:58 INFO - TEST-INFO | started process 3398 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0DG2DK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:13:10 INFO - PROCESS | 3398 | RSS: Main: 157147136 17:13:10 INFO - PROCESS | 3398 | 17:14:01 INFO - PROCESS | 3398 | 1469060041078 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] 17:16:10 INFO - PROCESS | 3398 | Cycle 1(1): loaded http://localhost:44731/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44731/tests/dromaeo/cssquery-ext.html) 17:16:11 INFO - PROCESS | 3398 | RSS: Main: 242761728 17:16:11 INFO - PROCESS | 3398 | 17:19:13 INFO - PROCESS | 3398 | Cycle 1(1): loaded http://localhost:44731/tests/dromaeo/cssquery-ext.html (next: http://localhost:44731/tests/dromaeo/cssquery-jquery.html) 17:19:14 INFO - PROCESS | 3398 | RSS: Main: 248557568 17:19:14 INFO - PROCESS | 3398 | 17:22:16 INFO - PROCESS | 3398 | Cycle 1(1): loaded http://localhost:44731/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44731/tests/dromaeo/cssquery-mootools.html) 17:22:16 INFO - PROCESS | 3398 | RSS: Main: 223940608 17:22:16 INFO - PROCESS | 3398 | 17:25:18 INFO - PROCESS | 3398 | Cycle 1(1): loaded http://localhost:44731/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44731/tests/dromaeo/cssquery-prototype.html) 17:25:19 INFO - PROCESS | 3398 | RSS: Main: 218218496 17:25:19 INFO - PROCESS | 3398 | 17:28:22 INFO - PROCESS | 3398 | Cycle 1(1): loaded http://localhost:44731/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44731/tests/dromaeo/cssquery-yui.html) 17:28:22 INFO - PROCESS | 3398 | RSS: Main: 187293696 17:28:22 INFO - PROCESS | 3398 | 17:31:25 INFO - PROCESS | 3398 | Cycle 1(1): loaded http://localhost:44731/tests/dromaeo/cssquery-yui.html (next: http://localhost:44731/tests/dromaeo/cssquery-dojo.html) 17:31:25 INFO - PROCESS | 3398 | RSS: Main: 278020096 17:31:25 INFO - PROCESS | 3398 | 17:31:25 INFO - PROCESS | 3398 | __start_tp_report 17:31:25 INFO - PROCESS | 3398 | _x_x_mozilla_page_load 17:31:25 INFO - PROCESS | 3398 | _x_x_mozilla_page_load_details 17:31:25 INFO - PROCESS | 3398 | |i|pagename|runs| 17:31:25 INFO - PROCESS | 3398 | |0;dojo.html;3054.2975115723384;3072.7234548890597;3088.969110308897;3099.5195744659586;3106.798058126222;5365.919511207335;5411.756470958807;5419.729013549327;5436.238926550282;5490.094134467813;5458.972705136469;5491.615586908918;5500.339959204901;5545.029619816526;5545.140503221997;4896.975515122437;4955.1080805455;4984.900301993958;5000.07498612756;5123.20590308501;5025.296458495814;5058.924116138261;5071.949280507185;5090.592752579803;5091.083604951107;4889.462159162489;4915.631327650441;4926.75366231687;4952.281919121707;5047.924281135786;4903.558679718807;4906.092372910987;4908.337374454439;4963.057019166346;5069.923951140736;4909.705417674951;4913.901721965541;4964.329815474901;4967.304577359173;4985.326980857574;5360.812371567015;5391.703456309901;5454.12733962568;5505.6696598204235;5518.641288316247;5888.322842873082;5888.941110588882;5923.703814809242;5942.078977758454;5945.227120474354;5933.910991335133;5985.760569577212;5999.280086389617;5999.850003749898;6001.4298641628975;5392;5444.6188766786345;5488.231647569343;5493.23094766733;5563.972180139073;6059.280323744878;6062.900726850605;6103.38966103395;6108.969455152785;6111.51107911366;5855.443732845373;5868.706564671749;5871.383504732027;5871.559633027455;5884.117382392676;5728.484436400744;5729.226554415184;5767.394423585547;5796.42035796417;5887.175795388649;5781.046127389018;5784.1902133701315;5801.796937107265;5867.178594996704;5875.20684707559;5754.165645981393;5755.079187330007;5817.50551203144;5823.650580965155;5837.328707198726;4390.100029493946;4419.226635338803;4424.579664931826;4426.889327766831;4487.730736155841;3884.553276373253;4029.5567487576345;4055.8174882130374;4056.675465962716;4058.066644671742;5379.435159308295;5393.649412788156;5435.864103397446;5449.945500545023;5456.781728730885;5710.3433105193435;5756.366799652035;5760.654360738369;5773.278340207474;5793.2179155814265;5358.142697168512;5454.509094181463;5475.616706830563;5491.697956612345;5512.448755124536;4996.4254110777;5057.115004874132;5061.291419201315;5078.847634570969;5125.2568377585785;6087.908681369783;6089.634621922699;6092.908606370908;6093.39066093396;6093.872633562805;5777.6822274775295;5839.766409343579;5896.086106653475;5905.232319798399;5910.940890591039;6032.54755893301;6091.934084995663;6095.619703153352;6096.130130659968;6100.096771792122;5792.797252096157;5793.652380857162;5794.333651630117;5805.303363596396;5809;5720.8283751487525;5898.852528686817;5904.114382842608;5908.3205431375945;5920.052791553331;5591.440855914376;5619.072852979212;5626.324841019104;5666.490015898589;5702.429757024264;5642.181883626933;5646.88706225865;5653;5655.971720141538;5657.4059723728415;5521.751521181476;5638.21065050885;5650.6609603422285;5656.60403771732;5674.460926212003;5691.630044047124;5698.743556540048;5747.913781293368;5800.984827655059;5847.210626565359;5637.57718171147;5649.180868773922;5650.68921209321;5662.320521537442;5667.914981275202 17:31:25 INFO - PROCESS | 3398 | |1;ext.html;592.3040427497689;620.7082671144564;623.875224955009;640.6732566391139;649.0394216559491;31986.840065799697;32575.67424325756;44345.33481997769;45017;45162.09675806482;43218.351724724154;47701.18390528758;47712.52287477124;47724;47780.761096194554;9155.862662060075;9305.302102342317;9310.06899310067;9311.16199542041;9313.44119352841;9142.725718228463;9242.214411775007;9249.491277979709;9249.722508324761;9251.6299348026;9251.6299348026;9290.489023103726;9302.20931220847;9312.115349041831;9313.441193528377;9150.633974641007;9159.267258619295;9162.267018638526;9190.678326258583;9238.86141707875;9073;9145.993940666522;9155.679551215675;9161.129692679251;9164.495952722598;44077.77961110174;44333.3349999747;44419.555804442185;44438;44451.77774111109;3486.930261394758;4041.2321658884716;4082.7142100053006;4211.663066954637;4351.108022855307;33553.6644633553;33896.49155262673;33966;34155.487667685;34230.48654270188;4387.956120438818;4402.5597440255715;4639;4645.976770116162;4654.86035418938;406482;407303;408649;408801;408934.95532522444;60770.69614651898;61330.69334653298;61376.38623613796;61711.382886171465;61749;63333.683331583044;63363.663633636264;63440.68279658665;63469;63610.363896360446;17284.91357543204;17356.47930562085;17431.65136697259;17500.912495437697;17514.211860466054;13610.795838062437;13640.65898352549;13662.863371366358;13693.589192324247;13710.52013179534;14240.928795355956;17015.447682847425;17024.14879256057;17024.48926532206;17181.82818171802;6249.375062493805;6308.716107775161;6348;6453.451456626145;6499.577527460794;1013.761765984993;1039.095986491757;1120.3166068698088;1177.587844254504;1180.9586664466703;34034;34402.65597344044;34538;34559;34697.479537806445;910.6539514984264;1076.9515371808288;1096.5832983466232;1099.3294090604725;1136.9204155709022;17056.403025894284;17250.827491725173;17457;17521.64956700859;17689.38087166943;554870;557155;559997;560372;562260;61213;61620;61820.69089654523;61893;61921.380786192465;1234.179270784918;1342.4026308292716;1358.4701966233176;1368.3021658954005;1396.2181178539847;33536.66463335336;35381.29237415289;35467.29065418729;35733.82133089318;35896.28207435784;52534;53221;53233.4676653244;53257.4674253268;53278.73360633172;314555;316042;318028;318337;318628;35794.64205357913;42009.78995105005;43187.784061079496;43577.56422435735;46062.309065364716;50051;50617.493825061276;50647.49352506575;50703.74648126736;50761;42417;43587.34618980654;43950.340744889494;44648;44833.327500086874;43028.13943721171;43374.566254338315;43579.34630980601;44061.559384405744;44198.55801442073;43313.35029974616;43793.34309985289;44190.55809441993;44538.3319250218;44585.33122003237;35790.28419431649;37270.44094338641;37330;38512.80743596264;38788.2242355157;29589.5561566581;29741.405171896873;29933.251668708457;29948.700512995463;30331.69668303377 17:31:25 INFO - PROCESS | 3398 | |2;jquery.html;390.43192155413874;391.6279534442279;398.4421809466747;399.8640462242837;423.74575254847093;18801.529961750944;20666.89666551667;20724;20844;21188.894055529738;19454.805451945474;19585.608287834235;19946.90026549865;19947.401577952685;20102.396928092145;5534.391216966131;5722.513586345166;5940.613860099102;5967.343592204854;6048.909266360986;5733.713314334287;5890.852728681774;5925.437083477084;5928.258967629046;5937.079752638327;5798.942010579883;5840.503557197643;5844.152597873306;5850.502707269887;5855.063189889618;5720.713964301768;5833.066709326508;5834.5624078194305;5835.44563266489;5949;5795.623284486537;5799.072148456269;5800.9709951450395;5801.216835727165;5811.6803575803315;14408.78386824188;20712.792872071386;23679.644805327935;23832.523349533087;24050.759492405028;2283.3492454650345;2321.93034208974;2371.1345358944036;2701.2436517775054;2705.7294270572984;10565.894341056568;10721.517531711092;10780.40707761073;14728.852711472855;15394.384224631001;1979.9802001980083;1984.709938539946;1993.990030049855;1995.5011247188204;2095.6646936490088;73698;78604.60697696474;85376;87723.56138219332;88198.5590072052;10960.725981850517;11216.158788090926;11340.659780206606;11380.374079425546;11461.770764584662;16297.71831943529;16300.429484968206;16307;16311.510654680378;16330.673386532202;8380.16198380157;8457.600491617286;8507.106753790888;8527.275181609633;8665.133486651284;8174.959125204336;8207.384446166561;8493.830123397498;8513.787155321166;8546.914530854736;4800.807967681323;4882.51174882516;4892.559669629679;4928.507149285043;5002.724850133278;1943.708443733423;1970.3202395173641;2026.625074361248;2056.167252262806;2069.6688529835455;918.5682729117304;976.6679329028165;979.9559019843981;986.413084214891;990.5641517732175;19807.504812379804;20990.265340713002;21215.15139394438;21325.36023919285;21373.251936182158;991.7570195302197;998.8851282102506;1017.4048181813722;1034.849946757716;1046.3930920066343;10839.945800270949;11359.545618175345;11512.481938312796;11597.13021523389;11622.489076420181;483655;484983;490014;490429;490586;73817.6309118451;81264.59367703124;101262.4936875311;102706;106296;902.0753727429307;904.7740311877311;925.9861102083474;934.2105920497169;937.0816599732165;18272;18333.724994124834;19081.045947702838;19121.426357209308;19123.426297211106;44893;44987.32519012152;45022;45705.54294457146;45963.08073838438;58944;61889.381106190165;62207;63005;64918.727844525216;7587.203343648837;7878.369730421437;8119.147489513516;8161.959190204011;8218.342532597497;7924.4056695749205;11259.042981346678;12124.393780311126;12225.327606981702;12735;11281.32312061279;11357.772844543228;11464.197506174487;11805.291682498733;11946.820797688215;10828.025477707044;11017.944910275397;11290.94354528255;11339.376334301693;11555.364454955059;11101.50043248072;11182.496787644739;11275.379854108103;11304.773904521699;11528.769424611628;7445.10658720957;7750.457467977188;7819.921800781919;8641.308695304235;8800.91199088001;8839.69061082859;11044.392558409365;11588.826167607323;11704.882951170379;11759.941200293944 17:31:25 INFO - PROCESS | 3398 | |3;mootools.html;1500.9624759381013;1537.907725536468;1632.110499777621;1728.3162629274666;1751.6846967545837;8936.687215947442;9404.153626173651;9405.153536181742;9445.055494450551;9459.527023648816;7964.76105716828;8275.420720549564;8536.189062039097;8548.40161188717;9265.305102117334;2280.361498780344;2310.387747246981;2310.6418505131733;2310.9653355199603;2312.3294244669028;2297.173017713622;2300.25241796416;2333.9183128590503;2343.3321503371544;2346.249200255919;1954.7263383126374;2253.7971582557566;2285.5543169082034;2326.348622385735;2326.6510023496444;2281.9885900570557;2290.793828555438;2295.414669259345;2302.8618282902994;2304.5275718477674;2222.0667319725753;2282.8243454620883;2287.1537531113427;2290.2900100968754;2290.5533420982915;8831.735047948507;8863.556822158931;8867.157620026088;8914.197722204968;8931.73204803857;5164.2770012198325;5302.496262855023;5336.919946200771;5341.439148889388;5349.732513374354;3313.267610821917;3315.651856555051;3481.8781342653137;3495.5805303363504;3502.807345595991;1132.7168207948014;1143.7426579019736;1156.9479373428217;1173.3605185174101;1189.0190592761007;13111.672208194776;13160.60518184456;13201.669958251121;13209.669758256025;13215.801762973562;4510.684252102387;4703.176944034849;4715.033418149271;4793.808247670054;4794.544518270759;10968.780624387467;10969.506372213269;10983.670489885317;10989.120870330355;10992.17558683086;5372.838814835562;5373.623846330797;5373.946260537423;5377.059014672495;5378.220158077057;4371.890702732457;4773.809047638125;4869.074875773663;4923.87690307738;4935.8025678972435;3978.7214894957656;4087.3664581989838;4119.196756632428;4172.7913604319665;4192.622663960258;1250.143651598658;1290.3354772292278;1297.2346315673797;1304.478208716521;1308.8429388473444;751.5115175136206;948.184561277301;1004.1414590525142;1011.1910471622673;1011.8532812742111;6117.84705382369;6167.309197942585;6259.80122858707;6277.340879207709;6313.3686631336495;987.7579992901641;993.9254555908336;1000.314784372707;1008.178334657252;1023.948802559869;4244.363345498138;4327.156204540147;4333.653307735373;4402.647788176938;4499.167653984024;11575.942120289345;11813.822792658117;11819.645410637695;11821.290722556674;11841.348725820162;11583.710407239718;11722.413879306001;11723.88276117245;11762.35307058103;11806;8255.339572834158;8549.572521374032;8592.52741099233;8594.87107693385;8785.780355491164;6147.293061298008;6168.537359698131;6191.752329906753;6235.625862448086;6328.746850126127;9915.30592858493;10143.949280253551;10175.084242418217;10212.795744085226;10252.64115755945;10332.173426126043;10390.272680912263;10431.94784026075;10479.214058945761;10481.161507079567;7478.663460144197;7860.567668778043;8004.359651227771;8233.135520770473;8375.832483350421;8801.38390312672;9001.324900632348;9010.414323068979;9041.819163616823;9043.23132533742;7628.694852206072;7719.787748187683;7859.52842829432;7962.243586859239;8119.634616442392;7162.319579639926;7260.564366138048;7263.16473605521;7287.672054757655;7334.889976650248;7139.143302803697;7250.891236631349;7251.202367739439;7252.709891604488;7253.709851605877;5254.238135470412;5287.391949925808;5319.989202051598;5363.517283444508;5688.715564221855;5376.166694162411;5463.098588732973;5497.560195184456;5535.225068490495;5605.5515558756015 17:31:25 INFO - PROCESS | 3398 | |4;prototype.html;329.3544652481137;336.49693707906675;341.992831112374;342.4349822792393;347.6679770818868;5381.5963802714805;5399.811006614769;5419.891602167959;5453.700046497441;5490.423505531921;5061.974690126544;5176;5196.0647083524955;5202.4537423570455;5373.81191658292;4082.5100987881347;4150.584941505848;4230.534641189467;4246.40550322955;4268.167707297078;4212.810423530948;4245.066085461193;4246.639035681971;4255.680823938202;4285.957140428587;4072.2466343726355;4191.161767646483;4202.579742025803;4227.894302642428;4247.129338485618;3986.740861844;4081.4081958116203;4181.163767246563;4192.287311157111;4227.4292970448905;3720.516332876709;3721.0883333583174;3734.2158146789207;3740.513733214692;3752.3620984432714;5154.7680354383765;5180.6373553851245;5183.637145399824;5219.451957544441;5277.3139491866195;4712.222483290253;4811.4707382187935;4856.05306965142;4863.1732605457155;4865.715641941675;5515.834524964257;5547.861303467405;5557.44425557441;5559.861003474905;5566.582506312002;4109.91780164395;4123.381492776078;4158.542560318362;4169.770662613555;4187.330027195634;5555.916661250044;5769.365369809318;5889.911651325234;5891.528677705774;5892.558058145656;4222.641075508554;4228.344606585984;4235.915281694349;4253.3619957006695;4260.594003978679;4312.849050283225;4316.892077698083;4324.329728892027;4329.112531930947;4334.349847522833;4738.431388233434;4852.272159176152;4864.6594738368685;4871.561559459595;4877.5366340197625;5591.217229587861;5605.215269862222;5651.576131790132;5666.943330566724;5688.431156884361;1405.2201028429115;1469.5150600301874;1484.606579256498;1486.873615742674;1488.2038109611306;961.1397798970022;985.280745056113;989.8762654668167;1003.4731765823001;1010.1010101010107;5242.633015688942;5260.526552610283;5307.49578790022;5333.546648534918;5335.759890804923;5456.809011684572;5604.299462567179;5605.747741351649;5654.604177707603;5666.801661941812;5254.92117618236;5285.841424757264;5287.762050707727;5315.893682126336;5340.198970154508;3005.699430056977;3006.3915805044635;3026.9114311125254;3027.7729170312314;3043.8782448702245;5605.915911261334;5805.129230615442;5841.532677385799;5847.181394604759;5858.912116318259;5735.082386818089;5764.164196191528;5768.682722450221;5791.175779629403;5801.94198058014;5838.416158384212;5866.061430171152;5875.941240587625;5884.705764711662;5900.675462849413;5427.728613569385;5788.768449261982;5790.855228619318;5794.594378393472;5801.1878337033695;5737.225474561048;5739.512141468022;5749.396313387201;5750.482456578928;5794.739236734441;5734.7132643368495;5946.375630558729;5953.940460595339;5961.433663801932;5995.310539288038;4104.507459104807;4109.725984944676;4118.320477121241;4137.793110344531;4151.256472281589;5847.473727364558;5871.178035075008;5873.5594830388745;5874.383189765013;5886.558508111994;5487.6981766003255;5663.716814159358;5685.692290773062;5709.3719690834805;5734.455226753452;5626.943730562642;5632.887342253214;5641.210230567642;5646.632968857011;5654;5053.69677819332;5398.784048638167;5557.1664250361155;5682.835018821049;5689.573282003784;5571.498565129158;5583.637063590853;5591.552675786009;5593.412691667317;5594.13290939905;5504.779808807602;5528.115501519737;5536.307961504812;5543.750531226186;5551.750171242385 17:31:25 INFO - PROCESS | 3398 | |5;yui.html;730.6237287796789;771.7568965775781;774.1871035412819;822.6709316273493;829.274384913201;15919.442819501306;17008.234629441675;17034.488965331046;17055;17061.232244548995;15685.529434116996;15872.365105395771;15884;15884.205789710497;15889.126098064602;674.470540625609;781.9843603127963;786.0881377601983;801.4510060608472;802.8795680647905;809.7125520440247;825.405707890318;825.9297959673435;825.9339252859756;825.9380546459009;872.4242000279817;877.666486735043;878.41585345745;878.5826732302169;878.6924576398274;698.5075521757149;827.0365024746163;844.2486187293314;866.4368160695535;868.9652413903436;637.8660481298933;641.0544446940771;641.3009819296942;641.8523739539932;641.8716256748622;13837;14016.789748153786;14047.157170569799;14058.156510609293;14074;14454.71090578193;14590.27048647574;14786.40854365824;14810.851891481163;14896.10623362591;13249.86750132496;13263.469461221539;13398.196108233537;13459.259740714257;13581.11722738019;4495.03356778291;4498.077894031716;4525.366448697185;4705.058988202339;4734.455537613184;76594.61702691506;77316.61341693312;77519;77717.61141194258;79698.99999999942;11617.88382116185;11659;11709.648710538697;11849.466773995191;12247.571335003233;22264.554708905733;22310.442238943833;22314.776852231593;22324.21865234709;22395.32814015582;7302.634868256566;7393.07586551681;7435.256474352522;7469.887951680729;7813.374930005586;4828.203346447796;4895.461499235082;4897.338859254026;4922.458529561745;5111.131107711698;3615.7107431405425;3713.8514459421863;3716.6097559756377;3724.863916505492;3751.118487155516;642.6336987916936;645.4287955159717;646.9094326794252;662.0301258656092;670.3330186464401;620.1163342237294;673.8618583190434;688.2944981394111;708.5819366573746;723.82628169239;9868.358556693793;9938.950305248572;9984.950075249577;9995.70012899614;10020.34867733595;594.4768603628779;660.8083655739878;673.3132205150816;708.7731925783803;734.328089797829;4333.1766964276685;4661.370714953506;4663.930041049319;4683.8360657376825;4694.718316900997;101496;101983.98016019893;104628;105759.4712026435;119393;92812.53593731989;94968;95171.52414237884;95517;95587.52206238924;25222.747772522405;61412.38587614156;84889.57555212307;86393.56803216069;88534.55732721295;9941.701748947544;10360.015798499131;10360.274780765576;10472.371657700562;10573.154147668014;38552.614473856025;43491.347629786214;50453.49546504488;52545;53823.73088134534;72254;74408;77062;78329.60835196015;79596;13565.86434135646;13801.585952421443;13950.441982320594;14096.577102686935;14231.64420889486;15188.924055379652;15307.46423875159;15633.921830390775;16009.279582419053;16453.753193702345;14625.92687036558;14673.486427974969;15173.544793656209;15284.235788210322;15590.688186235984;14377.209253491159;14383.784243236569;14741.778873317124;14975.550733478012;15439.073655580702;14469.27653617336;14496.275186240857;15086.585565598354;15104.070363059482;15232.923835380752;11391.37510170893;11466.94266528662;11632.302061876315;11673.35796531165;12182;10399.688009359732;11294.449219452861;12036.277823330629;12430.192037517532;12499.500019999097 17:31:25 INFO - PROCESS | 3398 | __end_tp_report 17:31:25 INFO - PROCESS | 3398 | __start_cc_report 17:31:25 INFO - PROCESS | 3398 | _x_x_mozilla_cycle_collect,1074 17:31:25 INFO - PROCESS | 3398 | __end_cc_report 17:31:25 INFO - PROCESS | 3398 | __startTimestamp1469061085907__endTimestamp 17:31:25 INFO - PROCESS | 3398 | 17:31:25 INFO - PROCESS | 3398 | ------- Summary: start ------- 17:31:25 INFO - PROCESS | 3398 | Number of tests: 6 17:31:25 INFO - PROCESS | 3398 | 17:31:25 INFO - PROCESS | 3398 | [#0] dojo.html Cycles:165 Average:5433.31 Median:5646.89 stddev:631.76 (11.2%) stddev-sans-first:605.50 17:31:25 INFO - PROCESS | 3398 | Values: 3054.3 3072.7 3089.0 3099.5 3106.8 5365.9 5411.8 5419.7 5436.2 5490.1 5459.0 5491.6 5500.3 5545.0 5545.1 4897.0 4955.1 4984.9 5000.1 5123.2 5025.3 5058.9 5071.9 5090.6 5091.1 4889.5 4915.6 4926.8 4952.3 5047.9 4903.6 4906.1 4908.3 4963.1 5069.9 4909.7 4913.9 4964.3 4967.3 4985.3 5360.8 5391.7 5454.1 5505.7 5518.6 5888.3 5888.9 5923.7 5942.1 5945.2 5933.9 5985.8 5999.3 5999.9 6001.4 5392.0 5444.6 5488.2 5493.2 5564.0 6059.3 6062.9 6103.4 6109.0 6111.5 5855.4 5868.7 5871.4 5871.6 5884.1 5728.5 5729.2 5767.4 5796.4 5887.2 5781.0 5784.2 5801.8 5867.2 5875.2 5754.2 5755.1 5817.5 5823.7 5837.3 4390.1 4419.2 4424.6 4426.9 4487.7 3884.6 4029.6 4055.8 4056.7 4058.1 5379.4 5393.6 5435.9 5449.9 5456.8 5710.3 5756.4 5760.7 5773.3 5793.2 5358.1 5454.5 5475.6 5491.7 5512.4 4996.4 5057.1 5061.3 5078.8 5125.3 6087.9 6089.6 6092.9 6093.4 6093.9 5777.7 5839.8 5896.1 5905.2 5910.9 6032.5 6091.9 6095.6 6096.1 6100.1 5792.8 5793.7 5794.3 5805.3 5809.0 5720.8 5898.9 5904.1 5908.3 5920.1 5591.4 5619.1 5626.3 5666.5 5702.4 5642.2 5646.9 5653.0 5656.0 5657.4 5521.8 5638.2 5650.7 5656.6 5674.5 5691.6 5698.7 5747.9 5801.0 5847.2 5637.6 5649.2 5650.7 5662.3 5667.9 17:31:25 INFO - PROCESS | 3398 | 17:31:25 INFO - PROCESS | 3398 | [#1] ext.html Cycles:180 Average:60562.32 Median:24232.06 stddev:116419.06 (480.4%) stddev-sans-first:116658.57 17:31:25 INFO - PROCESS | 3398 | Values: 592.3 620.7 623.9 640.7 649.0 31986.8 32575.7 44345.3 45017.0 45162.1 43218.4 47701.2 47712.5 47724.0 47780.8 9155.9 9305.3 9310.1 9311.2 9313.4 9142.7 9242.2 9249.5 9249.7 9251.6 9251.6 9290.5 9302.2 9312.1 9313.4 9150.6 9159.3 9162.3 9190.7 9238.9 9073.0 9146.0 9155.7 9161.1 9164.5 44077.8 44333.3 44419.6 44438.0 44451.8 3486.9 4041.2 4082.7 4211.7 4351.1 33553.7 33896.5 33966.0 34155.5 34230.5 4388.0 4402.6 4639.0 4646.0 4654.9 406482.0 407303.0 408649.0 408801.0 408935.0 60770.7 61330.7 61376.4 61711.4 61749.0 63333.7 63363.7 63440.7 63469.0 63610.4 17284.9 17356.5 17431.7 17500.9 17514.2 13610.8 13640.7 13662.9 13693.6 13710.5 14240.9 17015.4 17024.1 17024.5 17181.8 6249.4 6308.7 6348.0 6453.5 6499.6 1013.8 1039.1 1120.3 1177.6 1181.0 34034.0 34402.7 34538.0 34559.0 34697.5 910.7 1077.0 1096.6 1099.3 1136.9 17056.4 17250.8 17457.0 17521.6 17689.4 554870.0 557155.0 559997.0 560372.0 562260.0 61213.0 61620.0 61820.7 61893.0 61921.4 1234.2 1342.4 1358.5 1368.3 1396.2 33536.7 35381.3 35467.3 35733.8 35896.3 52534.0 53221.0 53233.5 53257.5 53278.7 314555.0 316042.0 318028.0 318337.0 318628.0 35794.6 42009.8 43187.8 43577.6 46062.3 50051.0 50617.5 50647.5 50703.7 50761.0 42417.0 43587.3 43950.3 44648.0 44833.3 43028.1 43374.6 43579.3 44061.6 44198.6 43313.4 43793.3 44190.6 44538.3 44585.3 35790.3 37270.4 37330.0 38512.8 38788.2 29589.6 29741.4 29933.3 29948.7 30331.7 17:31:25 INFO - PROCESS | 3398 | 17:31:25 INFO - PROCESS | 3398 | [#2] jquery.html Cycles:180 Average:29365.05 Median:395.04 stddev:80597.03 (20402.5%) stddev-sans-first:80793.76 17:31:25 INFO - PROCESS | 3398 | Values: 390.4 391.6 398.4 399.9 423.7 18801.5 20666.9 20724.0 20844.0 21188.9 19454.8 19585.6 19946.9 19947.4 20102.4 5534.4 5722.5 5940.6 5967.3 6048.9 5733.7 5890.9 5925.4 5928.3 5937.1 5798.9 5840.5 5844.2 5850.5 5855.1 5720.7 5833.1 5834.6 5835.4 5949.0 5795.6 5799.1 5801.0 5801.2 5811.7 14408.8 20712.8 23679.6 23832.5 24050.8 2283.3 2321.9 2371.1 2701.2 2705.7 10565.9 10721.5 10780.4 14728.9 15394.4 1980.0 1984.7 1994.0 1995.5 2095.7 73698.0 78604.6 85376.0 87723.6 88198.6 10960.7 11216.2 11340.7 11380.4 11461.8 16297.7 16300.4 16307.0 16311.5 16330.7 8380.2 8457.6 8507.1 8527.3 8665.1 8175.0 8207.4 8493.8 8513.8 8546.9 4800.8 4882.5 4892.6 4928.5 5002.7 1943.7 1970.3 2026.6 2056.2 2069.7 918.6 976.7 980.0 986.4 990.6 19807.5 20990.3 21215.2 21325.4 21373.3 991.8 998.9 1017.4 1034.8 1046.4 10839.9 11359.5 11512.5 11597.1 11622.5 483655.0 484983.0 490014.0 490429.0 490586.0 73817.6 81264.6 101262.5 102706.0 106296.0 902.1 904.8 926.0 934.2 937.1 18272.0 18333.7 19081.0 19121.4 19123.4 44893.0 44987.3 45022.0 45705.5 45963.1 58944.0 61889.4 62207.0 63005.0 64918.7 7587.2 7878.4 8119.1 8162.0 8218.3 7924.4 11259.0 12124.4 12225.3 12735.0 11281.3 11357.8 11464.2 11805.3 11946.8 10828.0 11017.9 11290.9 11339.4 11555.4 11101.5 11182.5 11275.4 11304.8 11528.8 7445.1 7750.5 7819.9 8641.3 8800.9 8839.7 11044.4 11588.8 11704.9 11759.9 17:31:25 INFO - PROCESS | 3398 | 17:31:25 INFO - PROCESS | 3398 | [#3] mootools.html Cycles:180 Average:5990.11 Median:4504.93 stddev:3478.94 (77.2%) stddev-sans-first:3472.34 17:31:25 INFO - PROCESS | 3398 | Values: 1501.0 1537.9 1632.1 1728.3 1751.7 8936.7 9404.2 9405.2 9445.1 9459.5 7964.8 8275.4 8536.2 8548.4 9265.3 2280.4 2310.4 2310.6 2311.0 2312.3 2297.2 2300.3 2333.9 2343.3 2346.2 1954.7 2253.8 2285.6 2326.3 2326.7 2282.0 2290.8 2295.4 2302.9 2304.5 2222.1 2282.8 2287.2 2290.3 2290.6 8831.7 8863.6 8867.2 8914.2 8931.7 5164.3 5302.5 5336.9 5341.4 5349.7 3313.3 3315.7 3481.9 3495.6 3502.8 1132.7 1143.7 1156.9 1173.4 1189.0 13111.7 13160.6 13201.7 13209.7 13215.8 4510.7 4703.2 4715.0 4793.8 4794.5 10968.8 10969.5 10983.7 10989.1 10992.2 5372.8 5373.6 5373.9 5377.1 5378.2 4371.9 4773.8 4869.1 4923.9 4935.8 3978.7 4087.4 4119.2 4172.8 4192.6 1250.1 1290.3 1297.2 1304.5 1308.8 751.5 948.2 1004.1 1011.2 1011.9 6117.8 6167.3 6259.8 6277.3 6313.4 987.8 993.9 1000.3 1008.2 1023.9 4244.4 4327.2 4333.7 4402.6 4499.2 11575.9 11813.8 11819.6 11821.3 11841.3 11583.7 11722.4 11723.9 11762.4 11806.0 8255.3 8549.6 8592.5 8594.9 8785.8 6147.3 6168.5 6191.8 6235.6 6328.7 9915.3 10143.9 10175.1 10212.8 10252.6 10332.2 10390.3 10431.9 10479.2 10481.2 7478.7 7860.6 8004.4 8233.1 8375.8 8801.4 9001.3 9010.4 9041.8 9043.2 7628.7 7719.8 7859.5 7962.2 8119.6 7162.3 7260.6 7263.2 7287.7 7334.9 7139.1 7250.9 7251.2 7252.7 7253.7 5254.2 5287.4 5320.0 5363.5 5688.7 5376.2 5463.1 5497.6 5535.2 5605.6 17:31:25 INFO - PROCESS | 3398 | 17:31:25 INFO - PROCESS | 3398 | [#4] prototype.html Cycles:180 Average:4734.12 Median:5337.98 stddev:1369.54 (25.7%) stddev-sans-first:1332.88 17:31:25 INFO - PROCESS | 3398 | Values: 329.4 336.5 342.0 342.4 347.7 5381.6 5399.8 5419.9 5453.7 5490.4 5062.0 5176.0 5196.1 5202.5 5373.8 4082.5 4150.6 4230.5 4246.4 4268.2 4212.8 4245.1 4246.6 4255.7 4286.0 4072.2 4191.2 4202.6 4227.9 4247.1 3986.7 4081.4 4181.2 4192.3 4227.4 3720.5 3721.1 3734.2 3740.5 3752.4 5154.8 5180.6 5183.6 5219.5 5277.3 4712.2 4811.5 4856.1 4863.2 4865.7 5515.8 5547.9 5557.4 5559.9 5566.6 4109.9 4123.4 4158.5 4169.8 4187.3 5555.9 5769.4 5889.9 5891.5 5892.6 4222.6 4228.3 4235.9 4253.4 4260.6 4312.8 4316.9 4324.3 4329.1 4334.3 4738.4 4852.3 4864.7 4871.6 4877.5 5591.2 5605.2 5651.6 5666.9 5688.4 1405.2 1469.5 1484.6 1486.9 1488.2 961.1 985.3 989.9 1003.5 1010.1 5242.6 5260.5 5307.5 5333.5 5335.8 5456.8 5604.3 5605.7 5654.6 5666.8 5254.9 5285.8 5287.8 5315.9 5340.2 3005.7 3006.4 3026.9 3027.8 3043.9 5605.9 5805.1 5841.5 5847.2 5858.9 5735.1 5764.2 5768.7 5791.2 5801.9 5838.4 5866.1 5875.9 5884.7 5900.7 5427.7 5788.8 5790.9 5794.6 5801.2 5737.2 5739.5 5749.4 5750.5 5794.7 5734.7 5946.4 5953.9 5961.4 5995.3 4104.5 4109.7 4118.3 4137.8 4151.3 5847.5 5871.2 5873.6 5874.4 5886.6 5487.7 5663.7 5685.7 5709.4 5734.5 5626.9 5632.9 5641.2 5646.6 5654.0 5053.7 5398.8 5557.2 5682.8 5689.6 5571.5 5583.6 5591.6 5593.4 5594.1 5504.8 5528.1 5536.3 5543.8 5551.8 17:31:25 INFO - PROCESS | 3398 | 17:31:25 INFO - PROCESS | 3398 | [#5] yui.html Cycles:180 Average:20323.78 Median:4511.72 stddev:28271.83 (626.6%) stddev-sans-first:28312.86 17:31:25 INFO - PROCESS | 3398 | Values: 730.6 771.8 774.2 822.7 829.3 15919.4 17008.2 17034.5 17055.0 17061.2 15685.5 15872.4 15884.0 15884.2 15889.1 674.5 782.0 786.1 801.5 802.9 809.7 825.4 825.9 825.9 825.9 872.4 877.7 878.4 878.6 878.7 698.5 827.0 844.2 866.4 869.0 637.9 641.1 641.3 641.9 641.9 13837.0 14016.8 14047.2 14058.2 14074.0 14454.7 14590.3 14786.4 14810.9 14896.1 13249.9 13263.5 13398.2 13459.3 13581.1 4495.0 4498.1 4525.4 4705.1 4734.5 76594.6 77316.6 77519.0 77717.6 79699.0 11617.9 11659.0 11709.6 11849.5 12247.6 22264.6 22310.4 22314.8 22324.2 22395.3 7302.6 7393.1 7435.3 7469.9 7813.4 4828.2 4895.5 4897.3 4922.5 5111.1 3615.7 3713.9 3716.6 3724.9 3751.1 642.6 645.4 646.9 662.0 670.3 620.1 673.9 688.3 708.6 723.8 9868.4 9939.0 9985.0 9995.7 10020.3 594.5 660.8 673.3 708.8 734.3 4333.2 4661.4 4663.9 4683.8 4694.7 101496.0 101984.0 104628.0 105759.5 119393.0 92812.5 94968.0 95171.5 95517.0 95587.5 25222.7 61412.4 84889.6 86393.6 88534.6 9941.7 10360.0 10360.3 10472.4 10573.2 38552.6 43491.3 50453.5 52545.0 53823.7 72254.0 74408.0 77062.0 78329.6 79596.0 13565.9 13801.6 13950.4 14096.6 14231.6 15188.9 15307.5 15633.9 16009.3 16453.8 14625.9 14673.5 15173.5 15284.2 15590.7 14377.2 14383.8 14741.8 14975.6 15439.1 14469.3 14496.3 15086.6 15104.1 15232.9 11391.4 11466.9 11632.3 11673.4 12182.0 10399.7 11294.4 12036.3 12430.2 12499.5 17:31:25 INFO - PROCESS | 3398 | -------- Summary: end -------- 17:31:25 INFO - PROCESS | 3398 | 17:31:26 INFO - TEST-INFO | 3398: exit 0 17:31:26 INFO - TEST-OK | dromaeo_css | took 1115202ms 17:31:26 INFO - TEST-START | kraken 17:31:26 INFO - operating with platform_type : linux_ 17:31:26 INFO - Initialising browser for kraken test... 17:31:26 INFO - TEST-INFO | started process 3588 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQNRQFw/profile http://localhost:44731/getInfo.html) 17:31:30 INFO - PROCESS | 3588 | __metrics Screen width/height:1600/1200 17:31:30 INFO - PROCESS | 3588 | colorDepth:24 17:31:30 INFO - PROCESS | 3588 | Browser inner width/height: 1024/697 17:31:30 INFO - PROCESS | 3588 | __metrics 17:31:31 INFO - PROCESS | 3588 | 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" 17:31:31 INFO - PROCESS | 3588 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:31:32 INFO - TEST-INFO | 3588: exit 0 17:31:32 INFO - Browser initialized. 17:31:32 INFO - Running cycle 1/1 for kraken test... 17:31:32 INFO - TEST-INFO | started process 3669 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQNRQFw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:31:44 INFO - PROCESS | 3669 | RSS: Main: 157110272 17:31:44 INFO - PROCESS | 3669 | 17:31:46 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:44731/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44731/tests/kraken/driver.html?testName=audio-beat-detection) 17:31:47 INFO - PROCESS | 3669 | RSS: Main: 213258240 17:31:47 INFO - PROCESS | 3669 | 17:31:50 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:44731/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44731/tests/kraken/driver.html?testName=audio-dft) 17:31:50 INFO - PROCESS | 3669 | RSS: Main: 192409600 17:31:50 INFO - PROCESS | 3669 | 17:31:54 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:44731/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44731/tests/kraken/driver.html?testName=audio-fft) 17:31:54 INFO - PROCESS | 3669 | RSS: Main: 269783040 17:31:54 INFO - PROCESS | 3669 | 17:31:56 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:44731/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44731/tests/kraken/driver.html?testName=audio-oscillator) 17:31:57 INFO - PROCESS | 3669 | RSS: Main: 180408320 17:31:57 INFO - PROCESS | 3669 | 17:31:59 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:44731/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44731/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:32:00 INFO - PROCESS | 3669 | RSS: Main: 184950784 17:32:00 INFO - PROCESS | 3669 | 17:32:03 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:44731/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44731/tests/kraken/driver.html?testName=imaging-darkroom) 17:32:03 INFO - PROCESS | 3669 | RSS: Main: 219439104 17:32:03 INFO - PROCESS | 3669 | 17:32:07 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:44731/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44731/tests/kraken/driver.html?testName=imaging-desaturate) 17:32:07 INFO - PROCESS | 3669 | RSS: Main: 220450816 17:32:07 INFO - PROCESS | 3669 | 17:32:10 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:44731/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44731/tests/kraken/driver.html?testName=json-parse-financial) 17:32:11 INFO - PROCESS | 3669 | RSS: Main: 219893760 17:32:11 INFO - PROCESS | 3669 | 17:32:12 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:44731/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44731/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:32:13 INFO - PROCESS | 3669 | RSS: Main: 184504320 17:32:13 INFO - PROCESS | 3669 | 17:32:14 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:44731/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44731/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:32:15 INFO - PROCESS | 3669 | RSS: Main: 189542400 17:32:15 INFO - PROCESS | 3669 | 17:32:17 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:44731/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44731/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:32:18 INFO - PROCESS | 3669 | RSS: Main: 194437120 17:32:18 INFO - PROCESS | 3669 | 17:32:20 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:44731/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44731/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:32:21 INFO - PROCESS | 3669 | RSS: Main: 188542976 17:32:21 INFO - PROCESS | 3669 | 17:32:24 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:44731/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44731/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:32:24 INFO - PROCESS | 3669 | RSS: Main: 193445888 17:32:24 INFO - PROCESS | 3669 | 17:32:26 INFO - PROCESS | 3669 | Cycle 1(1): loaded http://localhost:44731/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44731/tests/kraken/driver.html?testName=ai-astar) 17:32:26 INFO - PROCESS | 3669 | RSS: Main: 244789248 17:32:26 INFO - PROCESS | 3669 | 17:32:26 INFO - PROCESS | 3669 | __start_tp_report 17:32:26 INFO - PROCESS | 3669 | _x_x_mozilla_page_load 17:32:26 INFO - PROCESS | 3669 | _x_x_mozilla_page_load_details 17:32:26 INFO - PROCESS | 3669 | |i|pagename|runs| 17:32:26 INFO - PROCESS | 3669 | |0;ai-astar;100;113;111;109;111;111;110;111;110;109 17:32:26 INFO - PROCESS | 3669 | |1;audio-beat-detection;149;118;117;175;122;123;145;116;162;116 17:32:26 INFO - PROCESS | 3669 | |2;audio-dft;160;159;161;159;159;159;162;161;159;162 17:32:26 INFO - PROCESS | 3669 | |3;audio-fft;75;74;76;111;76;75;74;74;107;74 17:32:26 INFO - PROCESS | 3669 | |4;audio-oscillator;83;83;116;84;83;84;115;84;84;131 17:32:26 INFO - PROCESS | 3669 | |5;imaging-gaussian-blur;117;116;116;117;117;117;117;117;118;117 17:32:26 INFO - PROCESS | 3669 | |6;imaging-darkroom;146;145;146;146;145;147;147;145;145;147 17:32:26 INFO - PROCESS | 3669 | |7;imaging-desaturate;96;95;95;95;94;95;95;96;99;95 17:32:26 INFO - PROCESS | 3669 | |8;json-parse-financial;53;51;50;50;51;51;50;51;50;50 17:32:26 INFO - PROCESS | 3669 | |9;json-stringify-tinderbox;62;62;60;61;61;59;61;60;61;60 17:32:26 INFO - PROCESS | 3669 | |10;stanford-crypto-aes;76;75;76;76;75;75;75;75;79;75 17:32:26 INFO - PROCESS | 3669 | |11;stanford-crypto-ccm;127;118;118;131;118;118;117;117;196;127 17:32:26 INFO - PROCESS | 3669 | |12;stanford-crypto-pbkdf2;158;155;156;155;154;154;160;155;154;154 17:32:26 INFO - PROCESS | 3669 | |13;stanford-crypto-sha256-iterative;61;64;66;62;63;64;65;63;65;62 17:32:26 INFO - PROCESS | 3669 | __end_tp_report 17:32:26 INFO - PROCESS | 3669 | __start_cc_report 17:32:26 INFO - PROCESS | 3669 | _x_x_mozilla_cycle_collect,1643 17:32:26 INFO - PROCESS | 3669 | __end_cc_report 17:32:26 INFO - PROCESS | 3669 | __startTimestamp1469061146711__endTimestamp 17:32:26 INFO - PROCESS | 3669 | 17:32:26 INFO - PROCESS | 3669 | ------- Summary: start ------- 17:32:26 INFO - PROCESS | 3669 | Number of tests: 14 17:32:26 INFO - PROCESS | 3669 | 17:32:26 INFO - PROCESS | 3669 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.54 (3.2%) stddev-sans-first:1.24 17:32:26 INFO - PROCESS | 3669 | Values: 100.0 113.0 111.0 109.0 111.0 111.0 110.0 111.0 110.0 109.0 17:32:26 INFO - PROCESS | 3669 | 17:32:26 INFO - PROCESS | 3669 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:134.00 stddev:21.78 (16.3%) stddev-sans-first:22.44 17:32:26 INFO - PROCESS | 3669 | Values: 149.0 118.0 117.0 175.0 122.0 123.0 145.0 116.0 162.0 116.0 17:32:26 INFO - PROCESS | 3669 | 17:32:26 INFO - PROCESS | 3669 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.50 stddev:1.29 (0.8%) stddev-sans-first:1.36 17:32:26 INFO - PROCESS | 3669 | Values: 160.0 159.0 161.0 159.0 159.0 159.0 162.0 161.0 159.0 162.0 17:32:26 INFO - PROCESS | 3669 | 17:32:26 INFO - PROCESS | 3669 | [#3] audio-fft Cycles:10 Average:81.60 Median:74.50 stddev:14.49 (19.5%) stddev-sans-first:15.17 17:32:26 INFO - PROCESS | 3669 | Values: 75.0 74.0 76.0 111.0 76.0 75.0 74.0 74.0 107.0 74.0 17:32:26 INFO - PROCESS | 3669 | 17:32:26 INFO - PROCESS | 3669 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:83.50 stddev:18.42 (22.1%) stddev-sans-first:19.04 17:32:26 INFO - PROCESS | 3669 | Values: 83.0 83.0 116.0 84.0 83.0 84.0 115.0 84.0 84.0 131.0 17:32:26 INFO - PROCESS | 3669 | 17:32:26 INFO - PROCESS | 3669 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 17:32:26 INFO - PROCESS | 3669 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 17:32:26 INFO - PROCESS | 3669 | 17:32:26 INFO - PROCESS | 3669 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 17:32:26 INFO - PROCESS | 3669 | Values: 146.0 145.0 146.0 146.0 145.0 147.0 147.0 145.0 145.0 147.0 17:32:26 INFO - PROCESS | 3669 | 17:32:26 INFO - PROCESS | 3669 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:1.35 (1.4%) stddev-sans-first:1.42 17:32:26 INFO - PROCESS | 3669 | Values: 96.0 95.0 95.0 95.0 94.0 95.0 95.0 96.0 99.0 95.0 17:32:26 INFO - PROCESS | 3669 | 17:32:26 INFO - PROCESS | 3669 | [#8] json-parse-financial Cycles:10 Average:50.70 Median:51.00 stddev:0.95 (1.9%) stddev-sans-first:0.53 17:32:26 INFO - PROCESS | 3669 | Values: 53.0 51.0 50.0 50.0 51.0 51.0 50.0 51.0 50.0 50.0 17:32:26 INFO - PROCESS | 3669 | 17:32:26 INFO - PROCESS | 3669 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.95 (1.6%) stddev-sans-first:0.88 17:32:26 INFO - PROCESS | 3669 | Values: 62.0 62.0 60.0 61.0 61.0 59.0 61.0 60.0 61.0 60.0 17:32:26 INFO - PROCESS | 3669 | 17:32:26 INFO - PROCESS | 3669 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:75.50 stddev:1.25 (1.7%) stddev-sans-first:1.32 17:32:26 INFO - PROCESS | 3669 | Values: 76.0 75.0 76.0 76.0 75.0 75.0 75.0 75.0 79.0 75.0 17:32:26 INFO - PROCESS | 3669 | 17:32:26 INFO - PROCESS | 3669 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:122.50 stddev:24.20 (19.8%) stddev-sans-first:25.66 17:32:26 INFO - PROCESS | 3669 | Values: 127.0 118.0 118.0 131.0 118.0 118.0 117.0 117.0 196.0 127.0 17:32:26 INFO - PROCESS | 3669 | 17:32:26 INFO - PROCESS | 3669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.50 Median:155.00 stddev:2.01 (1.3%) stddev-sans-first:1.92 17:32:26 INFO - PROCESS | 3669 | Values: 158.0 155.0 156.0 155.0 154.0 154.0 160.0 155.0 154.0 154.0 17:32:26 INFO - PROCESS | 3669 | 17:32:26 INFO - PROCESS | 3669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:1.58 (2.5%) stddev-sans-first:1.39 17:32:26 INFO - PROCESS | 3669 | Values: 61.0 64.0 66.0 62.0 63.0 64.0 65.0 63.0 65.0 62.0 17:32:26 INFO - PROCESS | 3669 | -------- Summary: end -------- 17:32:26 INFO - PROCESS | 3669 | 17:32:27 INFO - TEST-INFO | 3669: exit 0 17:32:27 INFO - TEST-OK | kraken | took 61072ms 17:32:27 INFO - SUITE-END | took 1176s 17:32:27 INFO - Completed test suite (00:19:36) 17:32:27 INFO - javascript benchmark 17:32:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3054.2975115723384, 3072.7234548890597, 3088.969110308897, 3099.5195744659586, 3106.798058126222, 5365.919511207335, 5411.756470958807, 5419.729013549327, 5436.238926550282, 5490.094134467813, 5458.972705136469, 5491.615586908918, 5500.339959204901, 5545.029619816526, 5545.140503221997, 4896.975515122437, 4955.1080805455, 4984.900301993958, 5000.07498612756, 5123.20590308501, 5025.296458495814, 5058.924116138261, 5071.949280507185, 5090.592752579803, 5091.083604951107, 4889.462159162489, 4915.631327650441, 4926.75366231687, 4952.281919121707, 5047.924281135786, 4903.558679718807, 4906.092372910987, 4908.337374454439, 4963.057019166346, 5069.923951140736, 4909.705417674951, 4913.901721965541, 4964.329815474901, 4967.304577359173, 4985.326980857574, 5360.812371567015, 5391.703456309901, 5454.12733962568, 5505.6696598204235, 5518.641288316247, 5888.322842873082, 5888.941110588882, 5923.703814809242, 5942.078977758454, 5945.227120474354, 5933.910991335133, 5985.760569577212, 5999.280086389617, 5999.850003749898, 6001.4298641628975, 5392.0, 5444.6188766786345, 5488.231647569343, 5493.23094766733, 5563.972180139073, 6059.280323744878, 6062.900726850605, 6103.38966103395, 6108.969455152785, 6111.51107911366, 5855.443732845373, 5868.706564671749, 5871.383504732027, 5871.559633027455, 5884.117382392676, 5728.484436400744, 5729.226554415184, 5767.394423585547, 5796.42035796417, 5887.175795388649, 5781.046127389018, 5784.1902133701315, 5801.796937107265, 5867.178594996704, 5875.20684707559, 5754.165645981393, 5755.079187330007, 5817.50551203144, 5823.650580965155, 5837.328707198726, 4390.100029493946, 4419.226635338803, 4424.579664931826, 4426.889327766831, 4487.730736155841, 3884.553276373253, 4029.5567487576345, 4055.8174882130374, 4056.675465962716, 4058.066644671742, 5379.435159308295, 5393.649412788156, 5435.864103397446, 5449.945500545023, 5456.781728730885, 5710.3433105193435, 5756.366799652035, 5760.654360738369, 5773.278340207474, 5793.2179155814265, 5358.142697168512, 5454.509094181463, 5475.616706830563, 5491.697956612345, 5512.448755124536, 4996.4254110777, 5057.115004874132, 5061.291419201315, 5078.847634570969, 5125.2568377585785, 6087.908681369783, 6089.634621922699, 6092.908606370908, 6093.39066093396, 6093.872633562805, 5777.6822274775295, 5839.766409343579, 5896.086106653475, 5905.232319798399, 5910.940890591039, 6032.54755893301, 6091.934084995663, 6095.619703153352, 6096.130130659968, 6100.096771792122, 5792.797252096157, 5793.652380857162, 5794.333651630117, 5805.303363596396, 5809.0, 5720.8283751487525, 5898.852528686817, 5904.114382842608, 5908.3205431375945, 5920.052791553331, 5591.440855914376, 5619.072852979212, 5626.324841019104, 5666.490015898589, 5702.429757024264, 5642.181883626933, 5646.88706225865, 5653.0, 5655.971720141538, 5657.4059723728415, 5521.751521181476, 5638.21065050885, 5650.6609603422285, 5656.60403771732, 5674.460926212003, 5691.630044047124, 5698.743556540048, 5747.913781293368, 5800.984827655059, 5847.210626565359, 5637.57718171147, 5649.180868773922, 5650.68921209321, 5662.320521537442, 5667.914981275202], "value": 5389.232184861472, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.3040427497689, 620.7082671144564, 623.875224955009, 640.6732566391139, 649.0394216559491, 31986.840065799697, 32575.67424325756, 44345.33481997769, 45017.0, 45162.09675806482, 43218.351724724154, 47701.18390528758, 47712.52287477124, 47724.0, 47780.761096194554, 9155.862662060075, 9305.302102342317, 9310.06899310067, 9311.16199542041, 9313.44119352841, 9142.725718228463, 9242.214411775007, 9249.491277979709, 9249.722508324761, 9251.6299348026, 9251.6299348026, 9290.489023103726, 9302.20931220847, 9312.115349041831, 9313.441193528377, 9150.633974641007, 9159.267258619295, 9162.267018638526, 9190.678326258583, 9238.86141707875, 9073.0, 9145.993940666522, 9155.679551215675, 9161.129692679251, 9164.495952722598, 44077.77961110174, 44333.3349999747, 44419.555804442185, 44438.0, 44451.77774111109, 3486.930261394758, 4041.2321658884716, 4082.7142100053006, 4211.663066954637, 4351.108022855307, 33553.6644633553, 33896.49155262673, 33966.0, 34155.487667685, 34230.48654270188, 4387.956120438818, 4402.5597440255715, 4639.0, 4645.976770116162, 4654.86035418938, 406482.0, 407303.0, 408649.0, 408801.0, 408934.95532522444, 60770.69614651898, 61330.69334653298, 61376.38623613796, 61711.382886171465, 61749.0, 63333.683331583044, 63363.663633636264, 63440.68279658665, 63469.0, 63610.363896360446, 17284.91357543204, 17356.47930562085, 17431.65136697259, 17500.912495437697, 17514.211860466054, 13610.795838062437, 13640.65898352549, 13662.863371366358, 13693.589192324247, 13710.52013179534, 14240.928795355956, 17015.447682847425, 17024.14879256057, 17024.48926532206, 17181.82818171802, 6249.375062493805, 6308.716107775161, 6348.0, 6453.451456626145, 6499.577527460794, 1013.761765984993, 1039.095986491757, 1120.3166068698088, 1177.587844254504, 1180.9586664466703, 34034.0, 34402.65597344044, 34538.0, 34559.0, 34697.479537806445, 910.6539514984264, 1076.9515371808288, 1096.5832983466232, 1099.3294090604725, 1136.9204155709022, 17056.403025894284, 17250.827491725173, 17457.0, 17521.64956700859, 17689.38087166943, 554870.0, 557155.0, 559997.0, 560372.0, 562260.0, 61213.0, 61620.0, 61820.69089654523, 61893.0, 61921.380786192465, 1234.179270784918, 1342.4026308292716, 1358.4701966233176, 1368.3021658954005, 1396.2181178539847, 33536.66463335336, 35381.29237415289, 35467.29065418729, 35733.82133089318, 35896.28207435784, 52534.0, 53221.0, 53233.4676653244, 53257.4674253268, 53278.73360633172, 314555.0, 316042.0, 318028.0, 318337.0, 318628.0, 35794.64205357913, 42009.78995105005, 43187.784061079496, 43577.56422435735, 46062.309065364716, 50051.0, 50617.493825061276, 50647.49352506575, 50703.74648126736, 50761.0, 42417.0, 43587.34618980654, 43950.340744889494, 44648.0, 44833.327500086874, 43028.13943721171, 43374.566254338315, 43579.34630980601, 44061.559384405744, 44198.55801442073, 43313.35029974616, 43793.34309985289, 44190.55809441993, 44538.3319250218, 44585.33122003237, 35790.28419431649, 37270.44094338641, 37330.0, 38512.80743596264, 38788.2242355157, 29589.5561566581, 29741.405171896873, 29933.251668708457, 29948.700512995463, 30331.69668303377], "value": 20899.67153618223, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.43192155413874, 391.6279534442279, 398.4421809466747, 399.8640462242837, 423.74575254847093, 18801.529961750944, 20666.89666551667, 20724.0, 20844.0, 21188.894055529738, 19454.805451945474, 19585.608287834235, 19946.90026549865, 19947.401577952685, 20102.396928092145, 5534.391216966131, 5722.513586345166, 5940.613860099102, 5967.343592204854, 6048.909266360986, 5733.713314334287, 5890.852728681774, 5925.437083477084, 5928.258967629046, 5937.079752638327, 5798.942010579883, 5840.503557197643, 5844.152597873306, 5850.502707269887, 5855.063189889618, 5720.713964301768, 5833.066709326508, 5834.5624078194305, 5835.44563266489, 5949.0, 5795.623284486537, 5799.072148456269, 5800.9709951450395, 5801.216835727165, 5811.6803575803315, 14408.78386824188, 20712.792872071386, 23679.644805327935, 23832.523349533087, 24050.759492405028, 2283.3492454650345, 2321.93034208974, 2371.1345358944036, 2701.2436517775054, 2705.7294270572984, 10565.894341056568, 10721.517531711092, 10780.40707761073, 14728.852711472855, 15394.384224631001, 1979.9802001980083, 1984.709938539946, 1993.990030049855, 1995.5011247188204, 2095.6646936490088, 73698.0, 78604.60697696474, 85376.0, 87723.56138219332, 88198.5590072052, 10960.725981850517, 11216.158788090926, 11340.659780206606, 11380.374079425546, 11461.770764584662, 16297.71831943529, 16300.429484968206, 16307.0, 16311.510654680378, 16330.673386532202, 8380.16198380157, 8457.600491617286, 8507.106753790888, 8527.275181609633, 8665.133486651284, 8174.959125204336, 8207.384446166561, 8493.830123397498, 8513.787155321166, 8546.914530854736, 4800.807967681323, 4882.51174882516, 4892.559669629679, 4928.507149285043, 5002.724850133278, 1943.708443733423, 1970.3202395173641, 2026.625074361248, 2056.167252262806, 2069.6688529835455, 918.5682729117304, 976.6679329028165, 979.9559019843981, 986.413084214891, 990.5641517732175, 19807.504812379804, 20990.265340713002, 21215.15139394438, 21325.36023919285, 21373.251936182158, 991.7570195302197, 998.8851282102506, 1017.4048181813722, 1034.849946757716, 1046.3930920066343, 10839.945800270949, 11359.545618175345, 11512.481938312796, 11597.13021523389, 11622.489076420181, 483655.0, 484983.0, 490014.0, 490429.0, 490586.0, 73817.6309118451, 81264.59367703124, 101262.4936875311, 102706.0, 106296.0, 902.0753727429307, 904.7740311877311, 925.9861102083474, 934.2105920497169, 937.0816599732165, 18272.0, 18333.724994124834, 19081.045947702838, 19121.426357209308, 19123.426297211106, 44893.0, 44987.32519012152, 45022.0, 45705.54294457146, 45963.08073838438, 58944.0, 61889.381106190165, 62207.0, 63005.0, 64918.727844525216, 7587.203343648837, 7878.369730421437, 8119.147489513516, 8161.959190204011, 8218.342532597497, 7924.4056695749205, 11259.042981346678, 12124.393780311126, 12225.327606981702, 12735.0, 11281.32312061279, 11357.772844543228, 11464.197506174487, 11805.291682498733, 11946.820797688215, 10828.025477707044, 11017.944910275397, 11290.94354528255, 11339.376334301693, 11555.364454955059, 11101.50043248072, 11182.496787644739, 11275.379854108103, 11304.773904521699, 11528.769424611628, 7445.10658720957, 7750.457467977188, 7819.921800781919, 8641.308695304235, 8800.91199088001, 8839.69061082859, 11044.392558409365, 11588.826167607323, 11704.882951170379, 11759.941200293944], "value": 9368.912597958575, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1500.9624759381013, 1537.907725536468, 1632.110499777621, 1728.3162629274666, 1751.6846967545837, 8936.687215947442, 9404.153626173651, 9405.153536181742, 9445.055494450551, 9459.527023648816, 7964.76105716828, 8275.420720549564, 8536.189062039097, 8548.40161188717, 9265.305102117334, 2280.361498780344, 2310.387747246981, 2310.6418505131733, 2310.9653355199603, 2312.3294244669028, 2297.173017713622, 2300.25241796416, 2333.9183128590503, 2343.3321503371544, 2346.249200255919, 1954.7263383126374, 2253.7971582557566, 2285.5543169082034, 2326.348622385735, 2326.6510023496444, 2281.9885900570557, 2290.793828555438, 2295.414669259345, 2302.8618282902994, 2304.5275718477674, 2222.0667319725753, 2282.8243454620883, 2287.1537531113427, 2290.2900100968754, 2290.5533420982915, 8831.735047948507, 8863.556822158931, 8867.157620026088, 8914.197722204968, 8931.73204803857, 5164.2770012198325, 5302.496262855023, 5336.919946200771, 5341.439148889388, 5349.732513374354, 3313.267610821917, 3315.651856555051, 3481.8781342653137, 3495.5805303363504, 3502.807345595991, 1132.7168207948014, 1143.7426579019736, 1156.9479373428217, 1173.3605185174101, 1189.0190592761007, 13111.672208194776, 13160.60518184456, 13201.669958251121, 13209.669758256025, 13215.801762973562, 4510.684252102387, 4703.176944034849, 4715.033418149271, 4793.808247670054, 4794.544518270759, 10968.780624387467, 10969.506372213269, 10983.670489885317, 10989.120870330355, 10992.17558683086, 5372.838814835562, 5373.623846330797, 5373.946260537423, 5377.059014672495, 5378.220158077057, 4371.890702732457, 4773.809047638125, 4869.074875773663, 4923.87690307738, 4935.8025678972435, 3978.7214894957656, 4087.3664581989838, 4119.196756632428, 4172.7913604319665, 4192.622663960258, 1250.143651598658, 1290.3354772292278, 1297.2346315673797, 1304.478208716521, 1308.8429388473444, 751.5115175136206, 948.184561277301, 1004.1414590525142, 1011.1910471622673, 1011.8532812742111, 6117.84705382369, 6167.309197942585, 6259.80122858707, 6277.340879207709, 6313.3686631336495, 987.7579992901641, 993.9254555908336, 1000.314784372707, 1008.178334657252, 1023.948802559869, 4244.363345498138, 4327.156204540147, 4333.653307735373, 4402.647788176938, 4499.167653984024, 11575.942120289345, 11813.822792658117, 11819.645410637695, 11821.290722556674, 11841.348725820162, 11583.710407239718, 11722.413879306001, 11723.88276117245, 11762.35307058103, 11806.0, 8255.339572834158, 8549.572521374032, 8592.52741099233, 8594.87107693385, 8785.780355491164, 6147.293061298008, 6168.537359698131, 6191.752329906753, 6235.625862448086, 6328.746850126127, 9915.30592858493, 10143.949280253551, 10175.084242418217, 10212.795744085226, 10252.64115755945, 10332.173426126043, 10390.272680912263, 10431.94784026075, 10479.214058945761, 10481.161507079567, 7478.663460144197, 7860.567668778043, 8004.359651227771, 8233.135520770473, 8375.832483350421, 8801.38390312672, 9001.324900632348, 9010.414323068979, 9041.819163616823, 9043.23132533742, 7628.694852206072, 7719.787748187683, 7859.52842829432, 7962.243586859239, 8119.634616442392, 7162.319579639926, 7260.564366138048, 7263.16473605521, 7287.672054757655, 7334.889976650248, 7139.143302803697, 7250.891236631349, 7251.202367739439, 7252.709891604488, 7253.709851605877, 5254.238135470412, 5287.391949925808, 5319.989202051598, 5363.517283444508, 5688.715564221855, 5376.166694162411, 5463.098588732973, 5497.560195184456, 5535.225068490495, 5605.5515558756015], "value": 4758.525535836628, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.3544652481137, 336.49693707906675, 341.992831112374, 342.4349822792393, 347.6679770818868, 5381.5963802714805, 5399.811006614769, 5419.891602167959, 5453.700046497441, 5490.423505531921, 5061.974690126544, 5176.0, 5196.0647083524955, 5202.4537423570455, 5373.81191658292, 4082.5100987881347, 4150.584941505848, 4230.534641189467, 4246.40550322955, 4268.167707297078, 4212.810423530948, 4245.066085461193, 4246.639035681971, 4255.680823938202, 4285.957140428587, 4072.2466343726355, 4191.161767646483, 4202.579742025803, 4227.894302642428, 4247.129338485618, 3986.740861844, 4081.4081958116203, 4181.163767246563, 4192.287311157111, 4227.4292970448905, 3720.516332876709, 3721.0883333583174, 3734.2158146789207, 3740.513733214692, 3752.3620984432714, 5154.7680354383765, 5180.6373553851245, 5183.637145399824, 5219.451957544441, 5277.3139491866195, 4712.222483290253, 4811.4707382187935, 4856.05306965142, 4863.1732605457155, 4865.715641941675, 5515.834524964257, 5547.861303467405, 5557.44425557441, 5559.861003474905, 5566.582506312002, 4109.91780164395, 4123.381492776078, 4158.542560318362, 4169.770662613555, 4187.330027195634, 5555.916661250044, 5769.365369809318, 5889.911651325234, 5891.528677705774, 5892.558058145656, 4222.641075508554, 4228.344606585984, 4235.915281694349, 4253.3619957006695, 4260.594003978679, 4312.849050283225, 4316.892077698083, 4324.329728892027, 4329.112531930947, 4334.349847522833, 4738.431388233434, 4852.272159176152, 4864.6594738368685, 4871.561559459595, 4877.5366340197625, 5591.217229587861, 5605.215269862222, 5651.576131790132, 5666.943330566724, 5688.431156884361, 1405.2201028429115, 1469.5150600301874, 1484.606579256498, 1486.873615742674, 1488.2038109611306, 961.1397798970022, 985.280745056113, 989.8762654668167, 1003.4731765823001, 1010.1010101010107, 5242.633015688942, 5260.526552610283, 5307.49578790022, 5333.546648534918, 5335.759890804923, 5456.809011684572, 5604.299462567179, 5605.747741351649, 5654.604177707603, 5666.801661941812, 5254.92117618236, 5285.841424757264, 5287.762050707727, 5315.893682126336, 5340.198970154508, 3005.699430056977, 3006.3915805044635, 3026.9114311125254, 3027.7729170312314, 3043.8782448702245, 5605.915911261334, 5805.129230615442, 5841.532677385799, 5847.181394604759, 5858.912116318259, 5735.082386818089, 5764.164196191528, 5768.682722450221, 5791.175779629403, 5801.94198058014, 5838.416158384212, 5866.061430171152, 5875.941240587625, 5884.705764711662, 5900.675462849413, 5427.728613569385, 5788.768449261982, 5790.855228619318, 5794.594378393472, 5801.1878337033695, 5737.225474561048, 5739.512141468022, 5749.396313387201, 5750.482456578928, 5794.739236734441, 5734.7132643368495, 5946.375630558729, 5953.940460595339, 5961.433663801932, 5995.310539288038, 4104.507459104807, 4109.725984944676, 4118.320477121241, 4137.793110344531, 4151.256472281589, 5847.473727364558, 5871.178035075008, 5873.5594830388745, 5874.383189765013, 5886.558508111994, 5487.6981766003255, 5663.716814159358, 5685.692290773062, 5709.3719690834805, 5734.455226753452, 5626.943730562642, 5632.887342253214, 5641.210230567642, 5646.632968857011, 5654.0, 5053.69677819332, 5398.784048638167, 5557.1664250361155, 5682.835018821049, 5689.573282003784, 5571.498565129158, 5583.637063590853, 5591.552675786009, 5593.412691667317, 5594.13290939905, 5504.779808807602, 5528.115501519737, 5536.307961504812, 5543.750531226186, 5551.750171242385], "value": 4300.5480552448835, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.6237287796789, 771.7568965775781, 774.1871035412819, 822.6709316273493, 829.274384913201, 15919.442819501306, 17008.234629441675, 17034.488965331046, 17055.0, 17061.232244548995, 15685.529434116996, 15872.365105395771, 15884.0, 15884.205789710497, 15889.126098064602, 674.470540625609, 781.9843603127963, 786.0881377601983, 801.4510060608472, 802.8795680647905, 809.7125520440247, 825.405707890318, 825.9297959673435, 825.9339252859756, 825.9380546459009, 872.4242000279817, 877.666486735043, 878.41585345745, 878.5826732302169, 878.6924576398274, 698.5075521757149, 827.0365024746163, 844.2486187293314, 866.4368160695535, 868.9652413903436, 637.8660481298933, 641.0544446940771, 641.3009819296942, 641.8523739539932, 641.8716256748622, 13837.0, 14016.789748153786, 14047.157170569799, 14058.156510609293, 14074.0, 14454.71090578193, 14590.27048647574, 14786.40854365824, 14810.851891481163, 14896.10623362591, 13249.86750132496, 13263.469461221539, 13398.196108233537, 13459.259740714257, 13581.11722738019, 4495.03356778291, 4498.077894031716, 4525.366448697185, 4705.058988202339, 4734.455537613184, 76594.61702691506, 77316.61341693312, 77519.0, 77717.61141194258, 79698.99999999942, 11617.88382116185, 11659.0, 11709.648710538697, 11849.466773995191, 12247.571335003233, 22264.554708905733, 22310.442238943833, 22314.776852231593, 22324.21865234709, 22395.32814015582, 7302.634868256566, 7393.07586551681, 7435.256474352522, 7469.887951680729, 7813.374930005586, 4828.203346447796, 4895.461499235082, 4897.338859254026, 4922.458529561745, 5111.131107711698, 3615.7107431405425, 3713.8514459421863, 3716.6097559756377, 3724.863916505492, 3751.118487155516, 642.6336987916936, 645.4287955159717, 646.9094326794252, 662.0301258656092, 670.3330186464401, 620.1163342237294, 673.8618583190434, 688.2944981394111, 708.5819366573746, 723.82628169239, 9868.358556693793, 9938.950305248572, 9984.950075249577, 9995.70012899614, 10020.34867733595, 594.4768603628779, 660.8083655739878, 673.3132205150816, 708.7731925783803, 734.328089797829, 4333.1766964276685, 4661.370714953506, 4663.930041049319, 4683.8360657376825, 4694.718316900997, 101496.0, 101983.98016019893, 104628.0, 105759.4712026435, 119393.0, 92812.53593731989, 94968.0, 95171.52414237884, 95517.0, 95587.52206238924, 25222.747772522405, 61412.38587614156, 84889.57555212307, 86393.56803216069, 88534.55732721295, 9941.701748947544, 10360.015798499131, 10360.274780765576, 10472.371657700562, 10573.154147668014, 38552.614473856025, 43491.347629786214, 50453.49546504488, 52545.0, 53823.73088134534, 72254.0, 74408.0, 77062.0, 78329.60835196015, 79596.0, 13565.86434135646, 13801.585952421443, 13950.441982320594, 14096.577102686935, 14231.64420889486, 15188.924055379652, 15307.46423875159, 15633.921830390775, 16009.279582419053, 16453.753193702345, 14625.92687036558, 14673.486427974969, 15173.544793656209, 15284.235788210322, 15590.688186235984, 14377.209253491159, 14383.784243236569, 14741.778873317124, 14975.550733478012, 15439.073655580702, 14469.27653617336, 14496.275186240857, 15086.585565598354, 15104.070363059482, 15232.923835380752, 11391.37510170893, 11466.94266528662, 11632.302061876315, 11673.35796531165, 12182.0, 10399.688009359732, 11294.449219452861, 12036.277823330629, 12430.192037517532, 12499.500019999097], "value": 7693.437009180007, "unit": "score"}], "name": "dromaeo_css", "value": 7414.573724755034, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 113.0, 111.0, 109.0, 111.0, 111.0, 110.0, 111.0, 110.0, 109.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 118.0, 117.0, 175.0, 122.0, 123.0, 145.0, 116.0, 162.0, 116.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 161.0, 159.0, 159.0, 159.0, 162.0, 161.0, 159.0, 162.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 111.0, 76.0, 75.0, 74.0, 74.0, 107.0, 74.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 116.0, 84.0, 83.0, 84.0, 115.0, 84.0, 84.0, 131.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 145.0, 147.0, 147.0, 145.0, 145.0, 147.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 99.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 50.0, 50.0, 51.0, 51.0, 50.0, 51.0, 50.0, 50.0], "value": 50.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 60.0, 61.0, 61.0, 59.0, 61.0, 60.0, 61.0, 60.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 76.0, 75.0, 75.0, 75.0, 75.0, 79.0, 75.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 118.0, 118.0, 131.0, 118.0, 118.0, 117.0, 117.0, 196.0, 127.0], "value": 128.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 155.0, 156.0, 155.0, 154.0, 154.0, 160.0, 155.0, 154.0, 154.0], "value": 155.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 64.0, 66.0, 62.0, 63.0, 64.0, 65.0, 63.0, 65.0, 62.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1473.3000000000002, "alertThreshold": 2.0}]} 17:32:27 INFO - Return code: 0 17:32:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:32:28 INFO - # TBPL SUCCESS # 17:32:28 INFO - Running post-action listener: _resource_record_post_action 17:32:28 INFO - [mozharness: 2016-07-21 00:32:28.021506Z] Finished run-tests step (success) 17:32:28 INFO - Running post-run listener: _resource_record_post_run 17:32:28 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 7802880; Write bytes: 427728896; Read time: 1668; Write time: 319068 17:32:28 INFO - TinderboxPrint: CPU usage
13.0% 17:32:28 INFO - TinderboxPrint: I/O read bytes / time
7,802,880 / 1,668 17:32:28 INFO - TinderboxPrint: I/O write bytes / time
427,728,896 / 319,068 17:32:28 INFO - TinderboxPrint: CPU idle
8,291.5 (87.0%) 17:32:28 INFO - TinderboxPrint: CPU user
1,192.1 (12.5%) 17:32:28 INFO - TinderboxPrint: Swap in / out
0 / 0 17:32:28 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 99491840; Read time: 0; Write time: 77584 17:32:28 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 5562368; Write bytes: 327778304; Read time: 1484; Write time: 240812 17:32:28 INFO - Running post-run listener: _upload_blobber_files 17:32:28 INFO - Blob upload gear active. 17:32:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:32:28 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 17:32:28 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'] 17:32:28 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 17:32:29 INFO - (blobuploader) - INFO - Open directory for files ... 17:32:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:32:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:32:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:32:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:32:29 INFO - (blobuploader) - INFO - Done attempting. 17:32:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:32:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:32:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:32:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:32:43 INFO - (blobuploader) - INFO - Done attempting. 17:32:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:32:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:32:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:32:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:32:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:32:44 INFO - (blobuploader) - INFO - Done attempting. 17:32:44 INFO - (blobuploader) - INFO - Iteration through files over. 17:32:44 INFO - Return code: 0 17:32:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:32:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:32:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f03a5f9912362b5bd19c14dac37bec4b9aafb7bf1f58b3a756228ab38ba4182fcdb08b5dbb4b075c21ff2dc63ea097dc7b557b2348a2080cc8f5323f7661414", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cdbbcc1f99df24b1868e28507965b908a97c0e30eea5af48072bca0b0ef05c54628c2aaa377e8ad2e04dee03e833cfe7f54589cbea522479f32e650f950befec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c6f307fb4ada1cc689c0a74f03d0d88ef0a8286369c357c8bb62f007a0bd0ec62af397ead8dbe6d94f699a4b24aa3f9ecb6678992bcf8eb13dea1aa3f2d8051"} 17:32:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:32:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:32:44 INFO - Contents: 17:32:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f03a5f9912362b5bd19c14dac37bec4b9aafb7bf1f58b3a756228ab38ba4182fcdb08b5dbb4b075c21ff2dc63ea097dc7b557b2348a2080cc8f5323f7661414", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cdbbcc1f99df24b1868e28507965b908a97c0e30eea5af48072bca0b0ef05c54628c2aaa377e8ad2e04dee03e833cfe7f54589cbea522479f32e650f950befec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c6f307fb4ada1cc689c0a74f03d0d88ef0a8286369c357c8bb62f007a0bd0ec62af397ead8dbe6d94f699a4b24aa3f9ecb6678992bcf8eb13dea1aa3f2d8051"} 17:32:44 INFO - Running post-run listener: copy_logs_to_upload_dir 17:32:44 INFO - Copying logs to upload dir... 17:32:44 INFO - mkdir: /builds/slave/test/build/upload/logs 17:32:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.949230 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-20 17:32:44.036877) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 17:32:44.040626) ========= 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=a0d2d2de893abaa8702a9954000001a7-1469059914.392029-2030010091 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/5f03a5f9912362b5bd19c14dac37bec4b9aafb7bf1f58b3a756228ab38ba4182fcdb08b5dbb4b075c21ff2dc63ea097dc7b557b2348a2080cc8f5323f7661414", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cdbbcc1f99df24b1868e28507965b908a97c0e30eea5af48072bca0b0ef05c54628c2aaa377e8ad2e04dee03e833cfe7f54589cbea522479f32e650f950befec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c6f307fb4ada1cc689c0a74f03d0d88ef0a8286369c357c8bb62f007a0bd0ec62af397ead8dbe6d94f699a4b24aa3f9ecb6678992bcf8eb13dea1aa3f2d8051"} build_url:https://queue.taskcluster.net/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011149 build_url: 'https://queue.taskcluster.net/v1/task/BnGM8nRsQayLysUoHAmuMA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5f03a5f9912362b5bd19c14dac37bec4b9aafb7bf1f58b3a756228ab38ba4182fcdb08b5dbb4b075c21ff2dc63ea097dc7b557b2348a2080cc8f5323f7661414", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cdbbcc1f99df24b1868e28507965b908a97c0e30eea5af48072bca0b0ef05c54628c2aaa377e8ad2e04dee03e833cfe7f54589cbea522479f32e650f950befec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1c6f307fb4ada1cc689c0a74f03d0d88ef0a8286369c357c8bb62f007a0bd0ec62af397ead8dbe6d94f699a4b24aa3f9ecb6678992bcf8eb13dea1aa3f2d8051"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 17:32:44.069021) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 17:32:44.069732) ========= 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=a0d2d2de893abaa8702a9954000001a7-1469059914.392029-2030010091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 17:32:44.151448) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 17:32:44.151806) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 17:32:44.152137) ========= ========= Total master_lag: 0.18 =========