builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1469113570.1 results: success (0) buildid: 20160721053033 builduid: 5e064fda2b6645a79cfd45b6d8d7995e revision: d8a5ea157504793ff2bb2b5161103154a31f08e3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 08:06:10.097062) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 08:06:10.097553) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 08:06:10.097826) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 08:06:10.116440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 08:06:10.116824) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1469112409.232860-661854431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-21 08:06:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-07-21 08:06:10 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104195 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 08:06:10.235043) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 08:06:10.235380) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1469112409.232860-661854431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018624 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 08:06:10.285535) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 08:06:10.285902) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d8a5ea157504793ff2bb2b5161103154a31f08e3 --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 d8a5ea157504793ff2bb2b5161103154a31f08e3 --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=82c74bd3bc9a11c5833d2010000001e6-1469112409.232860-661854431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-21 08:06:10,473 truncating revision to first 12 chars 2016-07-21 08:06:10,473 Setting DEBUG logging. 2016-07-21 08:06:10,473 attempt 1/10 2016-07-21 08:06:10,473 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d8a5ea157504?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 08:06:11,711 unpacking tar archive at: fx-team-d8a5ea157504/testing/mozharness/ program finished with exit code 0 elapsedTime=1.580295 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 08:06:11.879776) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 08:06:11.880103) ========= script_repo_revision: d8a5ea157504793ff2bb2b5161103154a31f08e3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 08:06:11.880502) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 08:06:11.880834) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 08:06:11.891510) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-07-21 08:06:11.891950) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1469112409.232860-661854431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:06:12 INFO - MultiFileLogger online at 20160721 08:06:12 in /builds/slave/test 08:06:12 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 08:06:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:06:12 INFO - {'append_to_log': False, 08:06:12 INFO - 'base_work_dir': '/builds/slave/test', 08:06:12 INFO - 'blob_upload_branch': 'Fx-Team', 08:06:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:06:12 INFO - 'branch': 'Fx-Team', 08:06:12 INFO - 'buildbot_json_path': 'buildprops.json', 08:06:12 INFO - 'config_files': ('talos/linux_config.py',), 08:06:12 INFO - 'default_actions': ('clobber', 08:06:12 INFO - 'read-buildbot-config', 08:06:12 INFO - 'download-and-extract', 08:06:12 INFO - 'populate-webroot', 08:06:12 INFO - 'create-virtualenv', 08:06:12 INFO - 'install', 08:06:12 INFO - 'run-tests'), 08:06:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:06:12 INFO - 'download_minidump_stackwalk': True, 08:06:12 INFO - 'download_symbols': 'ondemand', 08:06:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:06:12 INFO - 'tooltool.py': '/tools/tooltool.py', 08:06:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:06:12 INFO - '/tools/misc-python/virtualenv.py')}, 08:06:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:06:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:06:12 INFO - 'installer_path': 'installer.exe', 08:06:12 INFO - 'log_level': 'info', 08:06:12 INFO - 'log_name': 'talos', 08:06:12 INFO - 'log_to_console': True, 08:06:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:06:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:06:12 INFO - 'opt_config_files': (), 08:06:12 INFO - 'pip_index': False, 08:06:12 INFO - 'sps_profile': False, 08:06:12 INFO - 'sps_profile_interval': 0, 08:06:12 INFO - 'suite': 'dromaeojs', 08:06:12 INFO - 'system_bits': '32', 08:06:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:06:12 INFO - 'title': 'talos-linux64-ix-066', 08:06:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:06:12 INFO - 'use_talos_json': True, 08:06:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:06:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:06:12 INFO - 'work_dir': 'build'} 08:06:12 INFO - [mozharness: 2016-07-21 15:06:12.177433Z] Running clobber step. 08:06:12 INFO - Running pre-action listener: _resource_record_pre_action 08:06:12 INFO - Running main action method: clobber 08:06:12 INFO - rmtree: /builds/slave/test/build 08:06:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:06:12 INFO - Running post-action listener: _resource_record_post_action 08:06:12 INFO - [mozharness: 2016-07-21 15:06:12.632618Z] Finished clobber step (success) 08:06:12 INFO - [mozharness: 2016-07-21 15:06:12.632720Z] Running read-buildbot-config step. 08:06:12 INFO - Running pre-action listener: _resource_record_pre_action 08:06:12 INFO - Running main action method: read_buildbot_config 08:06:12 INFO - Using buildbot properties: 08:06:12 INFO - { 08:06:12 INFO - "project": "", 08:06:12 INFO - "product": "firefox", 08:06:12 INFO - "script_repo_revision": "production", 08:06:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:06:12 INFO - "repository": "", 08:06:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:06:12 INFO - "buildid": "20160721053033", 08:06:12 INFO - "pgo_build": "True", 08:06:12 INFO - "basedir": "/builds/slave/test", 08:06:12 INFO - "buildnumber": 309, 08:06:12 INFO - "slavename": "talos-linux64-ix-066", 08:06:12 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:06:12 INFO - "platform": "ubuntu64_hw", 08:06:12 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:06:12 INFO - "branch": "fx-team", 08:06:12 INFO - "repo_path": "integration/fx-team", 08:06:12 INFO - "revision": "d8a5ea157504793ff2bb2b5161103154a31f08e3", 08:06:12 INFO - "stage_platform": "linux64-pgo", 08:06:12 INFO - "builduid": "5e064fda2b6645a79cfd45b6d8d7995e", 08:06:12 INFO - "slavebuilddir": "test" 08:06:12 INFO - } 08:06:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:06:12 INFO - Running post-action listener: _resource_record_post_action 08:06:12 INFO - [mozharness: 2016-07-21 15:06:12.635184Z] Finished read-buildbot-config step (success) 08:06:12 INFO - [mozharness: 2016-07-21 15:06:12.635274Z] Running download-and-extract step. 08:06:12 INFO - Running pre-action listener: _resource_record_pre_action 08:06:12 INFO - Running main action method: download_and_extract 08:06:12 INFO - mkdir: /builds/slave/test/build/tests 08:06: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')]} 08:06:12 INFO - https://queue.taskcluster.net/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:06:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:06:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:06:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/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 08:06:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/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 08:06:14 INFO - Downloaded 1361 bytes. 08:06:14 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:06:14 INFO - Using the following test package requirements: 08:06:14 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:06:14 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:06:14 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:06:14 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:14 INFO - u'jsshell-linux-x86_64.zip'], 08:06:14 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:06:14 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:06:14 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:06:14 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:06:14 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:06:14 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:06:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:06:14 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:06:14 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')]} 08:06:14 INFO - https://queue.taskcluster.net/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:06:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:06:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:06:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/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 08:06:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/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 08:06:19 INFO - Downloaded 24342878 bytes. 08:06:19 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'] 08:06:19 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 08:06:21 INFO - Return code: 0 08:06:21 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 08:06:21 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')]} 08:06:21 INFO - https://queue.taskcluster.net/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:06:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:06:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:06:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/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 08:06:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/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 08:06:23 INFO - Downloaded 24342878 bytes. 08:06:23 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'] 08:06:23 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 08:06:25 INFO - Return code: 0 08:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:06:25 INFO - https://queue.taskcluster.net/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:06:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:06:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:06:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/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 08:06:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/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 08:06:26 INFO - Downloaded 14403317 bytes. 08:06:26 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'] 08:06:26 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 08:06:26 INFO - Return code: 0 08:06: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')]} 08:06:26 INFO - https://queue.taskcluster.net/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:06:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:06:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:06:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/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 08:06:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D9p2TwMLRE68OP2iMqXDrA/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 08:06:28 INFO - Downloaded 60892912 bytes. 08:06:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:06:28 INFO - mkdir: /builds/slave/test/properties 08:06:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:06:28 INFO - Writing to file /builds/slave/test/properties/build_url 08:06:28 INFO - Contents: 08:06:28 INFO - build_url:https://queue.taskcluster.net/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:06:28 INFO - Running post-action listener: _resource_record_post_action 08:06:28 INFO - Running post-action listener: set_extra_try_arguments 08:06:28 INFO - [mozharness: 2016-07-21 15:06:28.792117Z] Finished download-and-extract step (success) 08:06:28 INFO - [mozharness: 2016-07-21 15:06:28.792351Z] Running populate-webroot step. 08:06:28 INFO - Running pre-action listener: _resource_record_pre_action 08:06:28 INFO - Running main action method: populate_webroot 08:06:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:06:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:06:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:06:28 INFO - '--tppagecycles', 08:06:28 INFO - '7'], 08:06:28 INFO - 'tests': ['tsvgm']}}, 08:06:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:06:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:06:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:06:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:06:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:06:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:06:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:28 INFO - 'talos_options': ['--disable-e10s'], 08:06:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:06:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:06:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:28 INFO - 'talos_options': ['--disable-e10s'], 08:06:28 INFO - 'tests': ['damp', 'tps']}, 08:06:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:28 INFO - 'tests': ['damp', 'tps']}, 08:06:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:06:28 INFO - 'tests': ['dromaeo_dom']}, 08:06:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:06:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:06:28 INFO - 'tests': ['basic_compositor_video']}, 08:06:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:06:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:06:28 INFO - 'tests': ['a11yr', 08:06:28 INFO - 'ts_paint', 08:06:28 INFO - 'tpaint', 08:06:28 INFO - 'sessionrestore', 08:06:28 INFO - 'sessionrestore_no_auto_restore', 08:06:28 INFO - 'tabpaint']}, 08:06:28 INFO - 'other-e10s': {'tests': ['a11yr', 08:06:28 INFO - 'ts_paint', 08:06:28 INFO - 'tpaint', 08:06:28 INFO - 'sessionrestore', 08:06:28 INFO - 'sessionrestore_no_auto_restore', 08:06:28 INFO - 'tabpaint']}, 08:06:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:06:28 INFO - 'ts_paint', 08:06:28 INFO - 'tpaint', 08:06:28 INFO - 'sessionrestore', 08:06:28 INFO - 'sessionrestore_no_auto_restore', 08:06:28 INFO - 'tabpaint']}, 08:06:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:06:28 INFO - 'ts_paint', 08:06:28 INFO - 'tpaint', 08:06:28 INFO - 'sessionrestore', 08:06:28 INFO - 'sessionrestore_no_auto_restore', 08:06:28 INFO - 'tabpaint']}, 08:06:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:06:28 INFO - 'tests': ['a11yr', 08:06:28 INFO - 'ts_paint', 08:06:28 INFO - 'tpaint', 08:06:28 INFO - 'sessionrestore', 08:06:28 INFO - 'sessionrestore_no_auto_restore', 08:06:28 INFO - 'tabpaint']}, 08:06:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:06:28 INFO - 'tests': ['a11yr', 08:06:28 INFO - 'ts_paint', 08:06:28 INFO - 'tpaint', 08:06:28 INFO - 'sessionrestore', 08:06:28 INFO - 'sessionrestore_no_auto_restore', 08:06:28 INFO - 'tabpaint']}, 08:06:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:06:28 INFO - 'tests': ['tsvgx', 08:06:28 INFO - 'tsvgr_opacity', 08:06:28 INFO - 'tart', 08:06:28 INFO - 'tscrollx', 08:06:28 INFO - 'cart']}, 08:06:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:06:28 INFO - 'tsvgr_opacity', 08:06:28 INFO - 'tart', 08:06:28 INFO - 'tscrollx', 08:06:28 INFO - 'cart']}, 08:06:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:28 INFO - 'talos_options': ['--disable-e10s'], 08:06:28 INFO - 'tests': ['tp5o']}, 08:06:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:28 INFO - 'tests': ['tp5o']}, 08:06:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:28 INFO - 'talos_options': ['--disable-e10s', 08:06:28 INFO - '--xperf_path', 08:06:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:06:28 INFO - 'tests': ['tp5n']}, 08:06:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:06:28 INFO - 'talos_options': ['--xperf_path', 08:06:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:06:28 INFO - 'tests': ['tp5n']}}, 08:06:28 INFO - 'talos.zip': {'path': '', 08:06:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:06:28 INFO - Running post-action listener: _resource_record_post_action 08:06:28 INFO - [mozharness: 2016-07-21 15:06:28.808833Z] Finished populate-webroot step (success) 08:06:28 INFO - [mozharness: 2016-07-21 15:06:28.808922Z] Running create-virtualenv step. 08:06:28 INFO - Running pre-action listener: _resource_record_pre_action 08:06:28 INFO - Running main action method: create_virtualenv 08:06:28 INFO - Creating virtualenv /builds/slave/test/build/venv 08:06:28 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 08:06:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:06:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:06:28 INFO - Using real prefix '/usr' 08:06:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:06:29 INFO - Installing distribute.............................................................................................................................................................................................done. 08:06:31 INFO - Installing pip.................done. 08:06:31 INFO - Return code: 0 08:06:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:06:31 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')]} 08:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:31 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')]} 08:06:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:31 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 0x21f0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af3b0>, '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 0x24b02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b0740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469112409.232860-661854431', '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 08:06:31 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 08:06:31 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 08:06:31 INFO - Using env: {'DISPLAY': ':0', 08:06:31 INFO - 'HOME': '/home/cltbld', 08:06:31 INFO - 'LANG': 'en_US.UTF-8', 08:06:31 INFO - 'LANGUAGE': 'en_US:en', 08:06:31 INFO - 'LOGNAME': 'cltbld', 08:06:31 INFO - 'MAIL': '/var/mail/cltbld', 08:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:31 INFO - 'MOZ_NO_REMOTE': '1', 08:06:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:31 INFO - 'NO_EM_RESTART': '1', 08:06:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:31 INFO - 'PWD': '/builds/slave/test', 08:06:31 INFO - 'SHELL': '/bin/bash', 08:06:31 INFO - 'SHLVL': '1', 08:06:31 INFO - 'TERM': 'linux', 08:06:31 INFO - 'TMOUT': '86400', 08:06:31 INFO - 'USER': 'cltbld', 08:06:31 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469112409.232860-661854431', 08:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:31 INFO - '_': '/tools/buildbot/bin/python'} 08:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:31 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 08:06:31 INFO - Cleaning up... 08:06:31 INFO - Return code: 0 08:06:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:06:31 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')]} 08:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:31 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')]} 08:06:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:31 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 0x21f0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af3b0>, '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 0x24b02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b0740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469112409.232860-661854431', '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 08:06:31 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 08:06:31 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 08:06:31 INFO - Using env: {'DISPLAY': ':0', 08:06:31 INFO - 'HOME': '/home/cltbld', 08:06:31 INFO - 'LANG': 'en_US.UTF-8', 08:06:31 INFO - 'LANGUAGE': 'en_US:en', 08:06:31 INFO - 'LOGNAME': 'cltbld', 08:06:31 INFO - 'MAIL': '/var/mail/cltbld', 08:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:31 INFO - 'MOZ_NO_REMOTE': '1', 08:06:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:31 INFO - 'NO_EM_RESTART': '1', 08:06:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:31 INFO - 'PWD': '/builds/slave/test', 08:06:31 INFO - 'SHELL': '/bin/bash', 08:06:31 INFO - 'SHLVL': '1', 08:06:31 INFO - 'TERM': 'linux', 08:06:31 INFO - 'TMOUT': '86400', 08:06:31 INFO - 'USER': 'cltbld', 08:06:31 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469112409.232860-661854431', 08:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:31 INFO - '_': '/tools/buildbot/bin/python'} 08:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:31 INFO - Downloading/unpacking psutil>=3.1.1 08:06:31 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 08:06:31 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 08:06:31 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 08:06:31 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 08:06:31 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 08:06:31 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 08:06:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:06:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:06:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:06:34 INFO - Installing collected packages: psutil 08:06:34 INFO - Running setup.py install for psutil 08:06:34 INFO - building 'psutil._psutil_linux' extension 08:06:34 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 08:06:34 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 08:06:34 INFO - building 'psutil._psutil_posix' extension 08:06:34 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 08:06:34 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 08:06:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:06:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:06:34 INFO - Successfully installed psutil 08:06:34 INFO - Cleaning up... 08:06:34 INFO - Return code: 0 08:06:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:06:34 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')]} 08:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:34 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')]} 08:06:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:34 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 0x21f0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af3b0>, '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 0x24b02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b0740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469112409.232860-661854431', '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 08:06:34 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 08:06:34 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 08:06:34 INFO - Using env: {'DISPLAY': ':0', 08:06:34 INFO - 'HOME': '/home/cltbld', 08:06:34 INFO - 'LANG': 'en_US.UTF-8', 08:06:34 INFO - 'LANGUAGE': 'en_US:en', 08:06:34 INFO - 'LOGNAME': 'cltbld', 08:06:34 INFO - 'MAIL': '/var/mail/cltbld', 08:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:34 INFO - 'MOZ_NO_REMOTE': '1', 08:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:34 INFO - 'NO_EM_RESTART': '1', 08:06:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:34 INFO - 'PWD': '/builds/slave/test', 08:06:34 INFO - 'SHELL': '/bin/bash', 08:06:34 INFO - 'SHLVL': '1', 08:06:34 INFO - 'TERM': 'linux', 08:06:34 INFO - 'TMOUT': '86400', 08:06:34 INFO - 'USER': 'cltbld', 08:06:34 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469112409.232860-661854431', 08:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:34 INFO - '_': '/tools/buildbot/bin/python'} 08:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:06:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:06:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:06:36 INFO - Installing collected packages: mozsystemmonitor 08:06:36 INFO - Running setup.py install for mozsystemmonitor 08:06:36 INFO - Successfully installed mozsystemmonitor 08:06:36 INFO - Cleaning up... 08:06:36 INFO - Return code: 0 08:06:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af3b0>, '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 0x24b02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b0740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469112409.232860-661854431', '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 08:06:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:06:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:06:36 INFO - Using env: {'DISPLAY': ':0', 08:06:36 INFO - 'HOME': '/home/cltbld', 08:06:36 INFO - 'LANG': 'en_US.UTF-8', 08:06:36 INFO - 'LANGUAGE': 'en_US:en', 08:06:36 INFO - 'LOGNAME': 'cltbld', 08:06:36 INFO - 'MAIL': '/var/mail/cltbld', 08:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:36 INFO - 'MOZ_NO_REMOTE': '1', 08:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:36 INFO - 'NO_EM_RESTART': '1', 08:06:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:36 INFO - 'PWD': '/builds/slave/test', 08:06:36 INFO - 'SHELL': '/bin/bash', 08:06:36 INFO - 'SHLVL': '1', 08:06:36 INFO - 'TERM': 'linux', 08:06:36 INFO - 'TMOUT': '86400', 08:06:36 INFO - 'USER': 'cltbld', 08:06:36 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469112409.232860-661854431', 08:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:36 INFO - '_': '/tools/buildbot/bin/python'} 08:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:37 INFO - Downloading/unpacking jsonschema==2.5.1 08:06:37 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 08:06:37 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 08:06:37 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 08:06:37 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 08:06:37 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 08:06:37 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 08:06:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:06:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:06:40 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 08:06:40 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 08:06:40 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 08:06:40 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 08:06:40 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 08:06:40 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 08:06:40 INFO - Downloading functools32-3.2.3-2.tar.gz 08:06:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:06:40 INFO - warning: no files found matching '*.txt' 08:06:41 INFO - no previously-included directories found matching 'build' 08:06:41 INFO - no previously-included directories found matching 'dist' 08:06:41 INFO - no previously-included directories found matching '.git*' 08:06:41 INFO - Installing collected packages: jsonschema, functools32 08:06:41 INFO - Running setup.py install for functools32 08:06:41 INFO - warning: no files found matching '*.txt' 08:06:41 INFO - no previously-included directories found matching 'build' 08:06:41 INFO - no previously-included directories found matching 'dist' 08:06:41 INFO - no previously-included directories found matching '.git*' 08:06:41 INFO - Successfully installed jsonschema functools32 08:06:41 INFO - Cleaning up... 08:06:41 INFO - Return code: 0 08:06:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:06:41 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')]} 08:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:41 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')]} 08:06:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:41 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 0x21f0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af3b0>, '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 0x24b02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b0740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469112409.232860-661854431', '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 08:06:41 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 08:06:41 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 08:06:41 INFO - Using env: {'DISPLAY': ':0', 08:06:41 INFO - 'HOME': '/home/cltbld', 08:06:41 INFO - 'LANG': 'en_US.UTF-8', 08:06:41 INFO - 'LANGUAGE': 'en_US:en', 08:06:41 INFO - 'LOGNAME': 'cltbld', 08:06:41 INFO - 'MAIL': '/var/mail/cltbld', 08:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:41 INFO - 'MOZ_NO_REMOTE': '1', 08:06:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:41 INFO - 'NO_EM_RESTART': '1', 08:06:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:41 INFO - 'PWD': '/builds/slave/test', 08:06:41 INFO - 'SHELL': '/bin/bash', 08:06:41 INFO - 'SHLVL': '1', 08:06:41 INFO - 'TERM': 'linux', 08:06:41 INFO - 'TMOUT': '86400', 08:06:41 INFO - 'USER': 'cltbld', 08:06:41 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469112409.232860-661854431', 08:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:41 INFO - '_': '/tools/buildbot/bin/python'} 08:06:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:41 INFO - Downloading/unpacking blobuploader==1.2.4 08:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:43 INFO - Downloading blobuploader-1.2.4.tar.gz 08:06:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:06:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:06:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:44 INFO - Downloading docopt-0.6.1.tar.gz 08:06:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:06:44 INFO - Installing collected packages: blobuploader, requests, docopt 08:06:44 INFO - Running setup.py install for blobuploader 08:06:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:06:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:06:44 INFO - Running setup.py install for requests 08:06:44 INFO - Running setup.py install for docopt 08:06:44 INFO - Successfully installed blobuploader requests docopt 08:06:44 INFO - Cleaning up... 08:06:44 INFO - Return code: 0 08:06:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:44 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 0x21f0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af3b0>, '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 0x24b02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b0740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469112409.232860-661854431', '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 08:06:44 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 08:06:44 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 08:06:44 INFO - Using env: {'DISPLAY': ':0', 08:06:44 INFO - 'HOME': '/home/cltbld', 08:06:44 INFO - 'LANG': 'en_US.UTF-8', 08:06:44 INFO - 'LANGUAGE': 'en_US:en', 08:06:44 INFO - 'LOGNAME': 'cltbld', 08:06:44 INFO - 'MAIL': '/var/mail/cltbld', 08:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:44 INFO - 'MOZ_NO_REMOTE': '1', 08:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:44 INFO - 'NO_EM_RESTART': '1', 08:06:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:44 INFO - 'PWD': '/builds/slave/test', 08:06:44 INFO - 'SHELL': '/bin/bash', 08:06:44 INFO - 'SHLVL': '1', 08:06:44 INFO - 'TERM': 'linux', 08:06:44 INFO - 'TMOUT': '86400', 08:06:44 INFO - 'USER': 'cltbld', 08:06:44 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469112409.232860-661854431', 08:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:44 INFO - '_': '/tools/buildbot/bin/python'} 08:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:06:44 INFO - Running setup.py (path:/tmp/pip-hsC4eu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:06:45 INFO - Running setup.py (path:/tmp/pip-i6dtU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:06:45 INFO - Running setup.py (path:/tmp/pip-MGCjGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:06:45 INFO - Running setup.py (path:/tmp/pip-JGfHHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:06:45 INFO - Running setup.py (path:/tmp/pip-2QKCwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:06:45 INFO - Running setup.py (path:/tmp/pip-Kd8Lap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:06:45 INFO - Running setup.py (path:/tmp/pip-geMyhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:06:45 INFO - Running setup.py (path:/tmp/pip-dI_tUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:06:45 INFO - Running setup.py (path:/tmp/pip-9WkQoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:06:45 INFO - Running setup.py (path:/tmp/pip-GZKB6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:06:45 INFO - Running setup.py (path:/tmp/pip-RI9sag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:06:45 INFO - Running setup.py (path:/tmp/pip-G1PfqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:06:45 INFO - Running setup.py (path:/tmp/pip-ifTQ2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:06:45 INFO - Running setup.py (path:/tmp/pip-faeNSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:06:45 INFO - Running setup.py (path:/tmp/pip-lffhPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:06:46 INFO - Running setup.py (path:/tmp/pip-Oap1Ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:06:46 INFO - Running setup.py (path:/tmp/pip-UPAT5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:06:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:06:46 INFO - Running setup.py install for manifestparser 08:06:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:06:46 INFO - Running setup.py install for mozcrash 08:06:46 INFO - Running setup.py install for mozdebug 08:06:46 INFO - Running setup.py install for mozdevice 08:06:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:06:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:06:46 INFO - Running setup.py install for mozfile 08:06:46 INFO - Running setup.py install for mozhttpd 08:06:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:06:46 INFO - Running setup.py install for mozinfo 08:06:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:06:46 INFO - Running setup.py install for mozInstall 08:06:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:06:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:06:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:06:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:06:47 INFO - Running setup.py install for mozleak 08:06:47 INFO - Running setup.py install for mozlog 08:06:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:06:47 INFO - Running setup.py install for moznetwork 08:06:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:06:47 INFO - Running setup.py install for mozprocess 08:06:47 INFO - Running setup.py install for mozprofile 08:06:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:06:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:06:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:06:47 INFO - Running setup.py install for mozrunner 08:06:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:06:47 INFO - Running setup.py install for mozscreenshot 08:06:47 INFO - Running setup.py install for moztest 08:06:47 INFO - Running setup.py install for mozversion 08:06:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:06:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:06:47 INFO - Cleaning up... 08:06:47 INFO - Return code: 0 08:06:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:06:47 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')]} 08:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:47 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')]} 08:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:48 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 0x21f0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af3b0>, '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 0x24b02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b0740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469112409.232860-661854431', '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 08:06:48 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 08:06:48 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 08:06:48 INFO - Using env: {'DISPLAY': ':0', 08:06:48 INFO - 'HOME': '/home/cltbld', 08:06:48 INFO - 'LANG': 'en_US.UTF-8', 08:06:48 INFO - 'LANGUAGE': 'en_US:en', 08:06:48 INFO - 'LOGNAME': 'cltbld', 08:06:48 INFO - 'MAIL': '/var/mail/cltbld', 08:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:48 INFO - 'MOZ_NO_REMOTE': '1', 08:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:48 INFO - 'NO_EM_RESTART': '1', 08:06:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:48 INFO - 'PWD': '/builds/slave/test', 08:06:48 INFO - 'SHELL': '/bin/bash', 08:06:48 INFO - 'SHLVL': '1', 08:06:48 INFO - 'TERM': 'linux', 08:06:48 INFO - 'TMOUT': '86400', 08:06:48 INFO - 'USER': 'cltbld', 08:06:48 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469112409.232860-661854431', 08:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:48 INFO - '_': '/tools/buildbot/bin/python'} 08:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:06:48 INFO - Running setup.py (path:/tmp/pip-KdsuCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:06:48 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)) 08:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:06:48 INFO - Running setup.py (path:/tmp/pip-L1hQcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:06:48 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)) 08:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:06:48 INFO - Running setup.py (path:/tmp/pip-6rCg77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:06:48 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)) 08:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:06:48 INFO - Running setup.py (path:/tmp/pip-5gUGr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:06:48 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)) 08:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:06:48 INFO - Running setup.py (path:/tmp/pip-vmjQpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:06:48 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)) 08:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:06:48 INFO - Running setup.py (path:/tmp/pip-L5Lu67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:06:48 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)) 08:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:06:48 INFO - Running setup.py (path:/tmp/pip-q_yWyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:06:48 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)) 08:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:06:48 INFO - Running setup.py (path:/tmp/pip-WoVtZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:06:48 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)) 08:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:06:48 INFO - Running setup.py (path:/tmp/pip-zF1RCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:06:48 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)) 08:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:06:48 INFO - Running setup.py (path:/tmp/pip-H9uE6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:06:48 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)) 08:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:06:48 INFO - Running setup.py (path:/tmp/pip-oNeoa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:06:49 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)) 08:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:06:49 INFO - Running setup.py (path:/tmp/pip-eiA7RC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:06:49 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)) 08:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:06:49 INFO - Running setup.py (path:/tmp/pip-XOr6Hg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:06:49 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)) 08:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:06:49 INFO - Running setup.py (path:/tmp/pip-117ilx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:06:49 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)) 08:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:06:49 INFO - Running setup.py (path:/tmp/pip-WatQmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:06:49 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)) 08:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:06:49 INFO - Running setup.py (path:/tmp/pip-E8J3Js-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:06:49 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)) 08:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:06:49 INFO - Running setup.py (path:/tmp/pip-NiSZLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:06:49 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)) 08:06:49 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)) 08:06:49 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)) 08:06:49 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)) 08:06:49 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)) 08:06:49 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)) 08:06:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:51 INFO - Downloading blessings-1.6.tar.gz 08:06:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:06:51 INFO - Installing collected packages: blessings 08:06:51 INFO - Running setup.py install for blessings 08:06:51 INFO - Successfully installed blessings 08:06:51 INFO - Cleaning up... 08:06:51 INFO - Return code: 0 08:06:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:06:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:06:51 INFO - Reading from file tmpfile_stdout 08:06:51 INFO - Current package versions: 08:06:51 INFO - argparse == 1.2.1 08:06:51 INFO - blessings == 1.6 08:06:51 INFO - blobuploader == 1.2.4 08:06:51 INFO - docopt == 0.6.1 08:06:51 INFO - functools32 == 3.2.3-2 08:06:51 INFO - jsonschema == 2.5.1 08:06:51 INFO - manifestparser == 1.1 08:06:51 INFO - mozInstall == 1.12 08:06:51 INFO - mozcrash == 0.17 08:06:51 INFO - mozdebug == 0.1 08:06:51 INFO - mozdevice == 0.48 08:06:51 INFO - mozfile == 1.2 08:06:51 INFO - mozhttpd == 0.7 08:06:51 INFO - mozinfo == 0.9 08:06:51 INFO - mozleak == 0.1 08:06:51 INFO - mozlog == 3.3 08:06:51 INFO - moznetwork == 0.27 08:06:51 INFO - mozprocess == 0.23 08:06:51 INFO - mozprofile == 0.28 08:06:51 INFO - mozrunner == 6.12 08:06:51 INFO - mozscreenshot == 0.1 08:06:51 INFO - mozsystemmonitor == 0.3 08:06:51 INFO - moztest == 0.7 08:06:51 INFO - mozversion == 1.4 08:06:51 INFO - psutil == 3.1.1 08:06:51 INFO - requests == 1.2.3 08:06:51 INFO - wsgiref == 0.1.2 08:06:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:06: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')]} 08:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06: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')]} 08:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:51 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 0x21f0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af3b0>, '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 0x24b02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b0740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469112409.232860-661854431', '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 08:06:51 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 08:06:51 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 08:06:51 INFO - Using env: {'DISPLAY': ':0', 08:06:51 INFO - 'HOME': '/home/cltbld', 08:06:51 INFO - 'LANG': 'en_US.UTF-8', 08:06:51 INFO - 'LANGUAGE': 'en_US:en', 08:06:51 INFO - 'LOGNAME': 'cltbld', 08:06:51 INFO - 'MAIL': '/var/mail/cltbld', 08:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:51 INFO - 'MOZ_NO_REMOTE': '1', 08:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:51 INFO - 'NO_EM_RESTART': '1', 08:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:51 INFO - 'PWD': '/builds/slave/test', 08:06:51 INFO - 'SHELL': '/bin/bash', 08:06:51 INFO - 'SHLVL': '1', 08:06:51 INFO - 'TERM': 'linux', 08:06:51 INFO - 'TMOUT': '86400', 08:06:51 INFO - 'USER': 'cltbld', 08:06:51 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469112409.232860-661854431', 08:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:51 INFO - '_': '/tools/buildbot/bin/python'} 08:06:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:52 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)) 08:06:52 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)) 08:06:52 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)) 08:06:52 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)) 08:06:52 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)) 08:06:52 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)) 08:06:52 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)) 08:06:52 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)) 08:06:52 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)) 08:06:52 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)) 08:06:52 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)) 08:06:52 INFO - Cleaning up... 08:06:52 INFO - Return code: 0 08:06:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:06:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:06:52 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 0x21f0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24b1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24af3b0>, '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 0x24b02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b0740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1469112409.232860-661854431', '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 08:06:52 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 08:06:52 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 08:06:52 INFO - Using env: {'DISPLAY': ':0', 08:06:52 INFO - 'HOME': '/home/cltbld', 08:06:52 INFO - 'LANG': 'en_US.UTF-8', 08:06:52 INFO - 'LANGUAGE': 'en_US:en', 08:06:52 INFO - 'LOGNAME': 'cltbld', 08:06:52 INFO - 'MAIL': '/var/mail/cltbld', 08:06:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:52 INFO - 'MOZ_NO_REMOTE': '1', 08:06:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:52 INFO - 'NO_EM_RESTART': '1', 08:06:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:52 INFO - 'PWD': '/builds/slave/test', 08:06:52 INFO - 'SHELL': '/bin/bash', 08:06:52 INFO - 'SHLVL': '1', 08:06:52 INFO - 'TERM': 'linux', 08:06:52 INFO - 'TMOUT': '86400', 08:06:52 INFO - 'USER': 'cltbld', 08:06:52 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469112409.232860-661854431', 08:06:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:52 INFO - '_': '/tools/buildbot/bin/python'} 08:06:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:06:52 INFO - Cleaning up... 08:06:52 INFO - Return code: 0 08:06:52 INFO - Running post-action listener: _resource_record_post_action 08:06:52 INFO - Running post-action listener: _start_resource_monitoring 08:06:52 INFO - Starting resource monitoring. 08:06:52 INFO - [mozharness: 2016-07-21 15:06:52.318461Z] Finished create-virtualenv step (success) 08:06:52 INFO - [mozharness: 2016-07-21 15:06:52.318947Z] Running install step. 08:06:52 INFO - Running pre-action listener: _resource_record_pre_action 08:06:52 INFO - Running main action method: install 08:06:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:06:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:06:52 INFO - Reading from file tmpfile_stdout 08:06:52 INFO - Detecting whether we're running mozinstall >=1.0... 08:06:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:06:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:06:52 INFO - Reading from file tmpfile_stdout 08:06:52 INFO - Output received: 08:06:52 INFO - Usage: mozinstall [options] installer 08:06:52 INFO - Options: 08:06:52 INFO - -h, --help show this help message and exit 08:06:52 INFO - -d DEST, --destination=DEST 08:06:52 INFO - Directory to install application into. [default: 08:06:52 INFO - "/builds/slave/test"] 08:06:52 INFO - --app=APP Application being installed. [default: firefox] 08:06:52 INFO - mkdir: /builds/slave/test/build/application 08:06:52 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'] 08:06:52 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 08:07:09 INFO - Reading from file tmpfile_stdout 08:07:09 INFO - Output received: 08:07:09 INFO - /builds/slave/test/build/application/firefox/firefox 08:07:09 INFO - Running post-action listener: _resource_record_post_action 08:07:09 INFO - [mozharness: 2016-07-21 15:07:09.884646Z] Finished install step (success) 08:07:09 INFO - [mozharness: 2016-07-21 15:07:09.884896Z] Running run-tests step. 08:07:09 INFO - Running pre-action listener: _resource_record_pre_action 08:07:09 INFO - Running main action method: run_tests 08:07:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:07:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:07:09 INFO - Python 2.7.3 08:07:09 INFO - Return code: 0 08:07:09 INFO - grabbing minidump binary from tooltool 08:07:09 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')]} 08:07:09 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 0x24af3b0>, '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 0x24b02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24b0740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:07:09 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 08:07:09 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 08:07:09 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 08:07:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:07:09 INFO - Return code: 0 08:07:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:07:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:07:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:07:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:07:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:07:09 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/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 08:07:09 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/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 08:07:09 INFO - Using env: {'DISPLAY': ':0', 08:07:09 INFO - 'HOME': '/home/cltbld', 08:07:09 INFO - 'LANG': 'en_US.UTF-8', 08:07:09 INFO - 'LANGUAGE': 'en_US:en', 08:07:09 INFO - 'LOGNAME': 'cltbld', 08:07:09 INFO - 'MAIL': '/var/mail/cltbld', 08:07:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:07:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:09 INFO - 'MOZ_NO_REMOTE': '1', 08:07:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:09 INFO - 'NO_EM_RESTART': '1', 08:07:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:09 INFO - 'PWD': '/builds/slave/test', 08:07:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:07:09 INFO - 'SHELL': '/bin/bash', 08:07:09 INFO - 'SHLVL': '1', 08:07:09 INFO - 'TERM': 'linux', 08:07:09 INFO - 'TMOUT': '86400', 08:07:09 INFO - 'USER': 'cltbld', 08:07:09 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1469112409.232860-661854431', 08:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:09 INFO - '_': '/tools/buildbot/bin/python'} 08:07:09 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/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 08:07:10 INFO - mozversion application_buildid: 20160721053033 08:07:10 INFO - mozversion application_changeset: d8a5ea157504793ff2bb2b5161103154a31f08e3 08:07:10 INFO - mozversion application_display_name: Nightly 08:07:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:07:10 INFO - mozversion application_name: Firefox 08:07:10 INFO - mozversion application_remotingname: firefox 08:07:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:07:10 INFO - mozversion application_vendor: Mozilla 08:07:10 INFO - mozversion application_version: 50.0a1 08:07:10 INFO - mozversion platform_buildid: 20160721053033 08:07:10 INFO - mozversion platform_changeset: d8a5ea157504793ff2bb2b5161103154a31f08e3 08:07:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:07:10 INFO - mozversion platform_version: 50.0a1 08:07:10 INFO - using testdate: 1469113630 08:07:10 INFO - actual date: 1469113630 08:07:10 INFO - starting webserver on 'localhost:41432' 08:07:10 INFO - SUITE-START | Running 2 tests 08:07:10 INFO - TEST-START | dromaeo_css 08:07:10 INFO - operating with platform_type : linux_ 08:07:10 INFO - Initialising browser for dromaeo_css test... 08:07:10 INFO - TEST-INFO | started process 12065 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRobGmY/profile http://localhost:41432/getInfo.html) 08:07:14 INFO - PROCESS | 12065 | __metrics Screen width/height:1600/1200 08:07:14 INFO - PROCESS | 12065 | colorDepth:24 08:07:14 INFO - PROCESS | 12065 | Browser inner width/height: 1024/697 08:07:14 INFO - PROCESS | 12065 | __metrics 08:07:15 INFO - PROCESS | 12065 | 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" 08:07:15 INFO - PROCESS | 12065 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:07:15 INFO - PROCESS | 12065 | console.error: PushService: 08:07:15 INFO - PROCESS | 12065 | stateChangeProcessEnqueue: Error transitioning state 08:07:15 INFO - PROCESS | 12065 | UnknownError 08:07:16 INFO - TEST-INFO | 12065: exit 0 08:07:16 INFO - Browser initialized. 08:07:16 INFO - Running cycle 1/1 for dromaeo_css test... 08:07:16 INFO - TEST-INFO | started process 12147 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRobGmY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:07:28 INFO - PROCESS | 12147 | RSS: Main: 157798400 08:07:28 INFO - PROCESS | 12147 | 08:08:19 INFO - PROCESS | 12147 | 1469113699907 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] 08:10:27 INFO - PROCESS | 12147 | Cycle 1(1): loaded http://localhost:41432/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41432/tests/dromaeo/cssquery-ext.html) 08:10:29 INFO - PROCESS | 12147 | RSS: Main: 262033408 08:10:29 INFO - PROCESS | 12147 | 08:13:31 INFO - PROCESS | 12147 | Cycle 1(1): loaded http://localhost:41432/tests/dromaeo/cssquery-ext.html (next: http://localhost:41432/tests/dromaeo/cssquery-jquery.html) 08:13:32 INFO - PROCESS | 12147 | RSS: Main: 244428800 08:13:32 INFO - PROCESS | 12147 | 08:16:33 INFO - PROCESS | 12147 | Cycle 1(1): loaded http://localhost:41432/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41432/tests/dromaeo/cssquery-mootools.html) 08:16:34 INFO - PROCESS | 12147 | RSS: Main: 206848000 08:16:34 INFO - PROCESS | 12147 | 08:19:36 INFO - PROCESS | 12147 | Cycle 1(1): loaded http://localhost:41432/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41432/tests/dromaeo/cssquery-prototype.html) 08:19:37 INFO - PROCESS | 12147 | RSS: Main: 184758272 08:19:37 INFO - PROCESS | 12147 | 08:22:39 INFO - PROCESS | 12147 | Cycle 1(1): loaded http://localhost:41432/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41432/tests/dromaeo/cssquery-yui.html) 08:22:40 INFO - PROCESS | 12147 | RSS: Main: 185667584 08:22:40 INFO - PROCESS | 12147 | 08:25:43 INFO - PROCESS | 12147 | Cycle 1(1): loaded http://localhost:41432/tests/dromaeo/cssquery-yui.html (next: http://localhost:41432/tests/dromaeo/cssquery-dojo.html) 08:25:43 INFO - PROCESS | 12147 | RSS: Main: 273297408 08:25:43 INFO - PROCESS | 12147 | 08:25:43 INFO - PROCESS | 12147 | __start_tp_report 08:25:43 INFO - PROCESS | 12147 | _x_x_mozilla_page_load 08:25:43 INFO - PROCESS | 12147 | _x_x_mozilla_page_load_details 08:25:43 INFO - PROCESS | 12147 | |i|pagename|runs| 08:25:43 INFO - PROCESS | 12147 | |0;dojo.html;3046.9999999999995;3063.29544204833;3095.5047192449197;3098.9535156972634;3109.7667674924387;5200.167973124301;5273.630845840783;5397.379301380342;5462.071447853859;5475.233467314574;5345.011172933;5388.78444862205;5392.299001129848;5428.4842939920745;5462.644928079682;4847.272909063642;4902.460729319772;4917.680350777206;4920.3357546731095;5070.771815268322;4996.350474438336;5006.524380183895;5030.320906677606;5042.294078828967;5053.646244762868;4832.685875418087;4869;4881.463039065682;4920.852374428737;4984.202527595586;4878.438979517366;4888.997755460122;4896.1186986342445;5015.673981191211;5027.899442011139;4870.14772414826;4889.3888263967;4901.142300097468;4919.803207871681;4956.900861982776;5274.736263186825;5294.285271488377;5404.891902161974;5413.837584872421;5451.591130665176;5705.486506214419;5735.0823868181305;5754.079347304453;5764.827055188351;5767.5962682612235;5751.798687045934;5753.539716822686;5800.303963524404;5801.332846722638;5820.796272130455;5197.480251974772;5361.544268737123;5434.402215756264;5438.293021907166;5446.618736688473;5989.431004054695;5990.880182396328;6024.819255422344;6041.335453100155;6047.15339852421;5721.084626459747;5731.226284451629;5776.1624564437925;5780.508656764222;5784.334801497797;5583.525400341016;5697.003024470784;5770.42295770428;5815.447532484407;5872.412758724179;5770.10563362671;5777.508911742465;5806.071028635482;5811.82564523065;5834.883302333929;5743.684097374601;5791.218185544897;5801.477866991991;5814;5819.505342045889;4284.057507348379;4319.460067491564;4360.803763830635;4428.357888106271;4428.689991700615;3924.0778417071965;3935.193285376491;3966;3989.202159568098;4022.416749571296;5426.620136590401;5437.075697131497;5444.700541470178;5444.945550544444;5446.400895901447;5677.914831277534;5715.142728590745;5796.449337312949;5815.709214539256;5831.504322132666;5391.353037635509;5431.049566325877;5432.158015507603;5477.67133971963;5485.369182544058;5009.0983622948215;5012.423571289275;5015.122353588107;5017.448080711119;5058.924116138187;5824.912626310609;5930.970345148246;5938.584299099021;5990.251218597676;5993.130996005555;5836.387179346278;5867.911981320369;5875.236219291465;5916.112583112395;5934.080217566284;6027.246594175728;6036.758529658764;6044.486218671286;6044.607100538451;6057.909131363122;5489.176623506506;5689.061304884814;5705.572082093942;5755.683437410982;5756.884862302814;5838.620489668158;5904.793332233351;5911.615744976562;5953.76184952597;5963.194968679173;5674.4609262121685;5716;5718.628289161191;5733.283339582552;5765.855853603525;5521.834344969658;5553.08374118266;5742.08126699726;5753.741081651252;5755.942440575708;5503.064479038493;5592.748326325406;5595.8880822384135;5631;5645.548356131418;5604.159376093456;5639.013172694844;5662.490375866192;5699.829005129853;5705.800296989585;5413.53984911287;5481.561475081904;5502.504774570308;5509.393966663744;5529.30883639545 08:25:43 INFO - PROCESS | 12147 | |1;ext.html;595.6426144313413;618.1222663817379;640.3308542573011;643.462708638287;653.61110139467;31994;32354.514682279783;43805.561944380504;44442.33336499947;44600.553994460046;46135.30797038047;46461.535384646144;46664;46671.76664116683;46716.53283467164;8782.38523303369;8959.686410975617;8962.820743585124;8965.865512017292;8969.77575560613;8922.955385223066;9013.684521041765;9014.86477702835;9021.36850420471;9024.413413128159;8993.955030224839;9040.547972601344;9049.819003619923;9061.546922653873;9061.818763624724;8960.955195224014;8999.145081217273;9020.594073266719;9037.322200834931;9050.683226087056;8879.422837515542;8903.821923561558;8951.104889511062;8956.910430895672;8957.283417326598;44100.55899440996;44153.33769993453;44284.335734964;44455.33317000248;44536.55463445356;3437.74216933731;3470.6008808987035;3509.3507701075127;3656.323580137683;4416.381706561084;33479.33041339184;33494.49758253628;33696.32607347839;34045.127517986504;34066.148346291295;4386.6929314947965;4430.4240448741775;4431.426089115055;4512.796924138422;4656.674032817704;262361;263884;263927;263972;265346;59081.704591476766;59161;59517;59576;59595.10607340893;62052.37947620556;62069.68965155145;62270.44323891939;62271.68864155741;62580.374196258366;15141.848581514265;15363.539093827203;15367.692646147014;15371.077735335915;15379.61550961235;11879.940600297115;11960.222585531912;11964.162508624488;11964.40177991097;11972.341521216242;14625.195614241318;16280.67438651244;16309.266083026292;16363.263653135638;16566.917165414096;6330.651814150266;6494.772682956074;6494.805155845333;6527.836804079936;6708.731650734014;733.7870760663594;1017.3793985668736;1052.9789404211872;1131.4569006876745;1174.2836869509592;33392;33934.49098263528;34008.829955850066;34352.48471272933;34676.47985280223;1100.6367898593605;1118.7315044389288;1160.4719852467108;1176.823476478518;1243.1360204657856;17288.394906178222;17582.560435989202;17793.7330940036;17797.555061123316;17802.732959005625;539812;545349;545715;545963;547814;61603.69198153981;61735;61737.07394389088;61862;61876.69061654663;1234.4259919137644;1343.3081962789172;1351.1825345665927;1358.0290092583652;1388.590365842079;31570.36859262756;35537.466937995436;36059.459108112875;36205.63794362128;36303.27393452169;54225.45774542362;54815.72592137014;54901;55138.448615513335;55148;523108;529838;530049;530728;531818;37148.844052330925;38029.239415210985;44815.32777008413;47342.52657473381;47837.76081119711;50078.24882626836;50362.2445663308;50437.747811260706;50772.74613626908;51549.226761597856;42264;43215;43847.78076109599;44389.77805110954;45099.09801804011;43338.56661433471;43883.561164387946;44210.33684494671;44758.55241447544;44820.32769508395;43211.56788432076;44670.77664611656;44997.55002450065;45098.77450612726;45293;36437.27125457529;38307;38757;39341;39730;29627.703722962495;29677.5548366779;29913.85043074771;29986;30249.848750756104 08:25:43 INFO - PROCESS | 12147 | |2;jquery.html;371.30380536494056;382.69766884161515;393.73029474809755;394.21944549791397;403.9656629186519;18664.440066797983;19393.224271029176;20146.697799533;20315.187392504282;20324.08541615629;18699.158537865795;19391.903040484813;19746.70379944302;19856.007199639997;19863.702044469308;5634.126710359901;5798.449147331018;5848.941510584904;7190.101237345332;7542.924570754277;7244.71021159153;7488.588127653004;7559.395248380144;7566.39468842494;7568.697252109909;7496.100467943855;7617.542947423172;7650.923490765104;7654.081510218782;7661.578613176301;7388.889166662504;7585.924140758577;7603.733869314575;7644.961775191144;7673.808154796119;7182.928170718278;7352.375048120916;7423.183449820515;7428.9628551856895;7430.256974302581;26479.205623831123;26709.19872403831;27122.18633441;27173.456530869273;27176;2425.575524283261;2594.1828324077856;2640.828346157513;2712.1727872998727;2712.796540259488;16087.839121608751;16260.83739162605;16323;16523.6695266094;16856.662866742718;2065.483629092727;2202.812760915324;2214.070090561968;2218.9001494932604;2249.246502421691;63178;80645.59677201576;92101.07898920993;99276.50361748217;101590.49204753929;17689;17791.110444477985;18339.908300458414;18502.334789868975;18513.90743046303;32466.35067298641;32567.51148732771;32575.18562035968;32612.67387326144;32636.347273054882;8582;9284.303677224236;9527.857082143773;9579.808403831885;9782.070703283176;7878.251566101211;7934.880976785353;8167.101618821925;8195.098539160688;8227.053888802864;8836.690715824916;8856.3800533962;9075.863862041942;9274.768130796649;9357.111074447917;3308.569885914864;3550.804705741209;3610.855565777392;3647.598764135943;3652.945205821915;919.6275508418967;952.8904176019846;999.9500024998721;1043.7442826507402;1061.8354155105972;20269.695954560695;20397.38807835767;20580.382588522367;20608.896955515425;20977.58044839125;990.8365119755304;1035.7980193862275;1045.4981608827804;1064.387976913278;1074.7635520185547;10502.369857808402;11363.090952723762;11431.942840285745;11438.428078596036;11441.370724610226;373229;377694;377955;499775;506021;103388.52560641516;104735.4763226179;104811;107634;110222;1010.2826992835022;1010.6563768318807;1053.2995557953875;1061.9256652034437;1071.5445935477392;17551.210195541487;18198.818011820244;18634.534136646693;18634.906825465787;18924.52688682739;44429;44806.3279050808;44917.550824491336;45859.54140458553;47324.76337618427;52515.47484525259;62291.688541557;63681.36318636754;64047.67976160089;65647.67176164089;11910.344931028876;12375.62873113808;12500.06249531307;12631.87368126307;13068.411921463747;14225.573232803032;14252.572422827332;14355.425782968565;14402.351894164578;14514.491992780202;11931.522739090338;12259.570915017932;12266.75466490683;12668.873311267138;12896.871031289567;8187.345012399113;8192.262696357357;8425.95787021061;8577.614007369808;8624.353173512138;8272.090070092165;8522.190391912758;8610.526421046652;8731.738047858575;8789.165029322205;11264.887351126385;12363.443645035815;12409.75180496367;12468.812967805308;12659.303738294482;8369.66521339164;8497.362697797565;12027.218230815319;12260.203086799329;12349.93825030869 08:25:43 INFO - PROCESS | 12147 | |3;mootools.html;1378.9931050344746;1500.4373359990004;1535.7235697574438;1676.9161541922908;1797.92124725165;8384.580770961451;8774.912250877498;8799.032106468292;8900.6204038374;8949.060348663394;8839.24866386358;8869.37914345996;8930.330225233101;8955.552222388887;9002.32482563807;2079.5321052763156;2320.93037208884;2351.8706471144037;2375.762423757619;2378.4410663494064;2352.294311706481;2372.727136379321;2374.6081896487144;2377.0135393811547;2379.4527258730504;2355.5642206191824;2355.7997570206467;2357.693499845018;2362.681038059857;2404.146527982567;1986.980130198694;2053.3121404329568;2361.480474295652;2368.96446553301;2370.0756704885107;2046.6725323948097;2186;2251.133313674231;2255.560165767676;2265.2411442166895;8785.297176225951;8823.779405514913;8824.69113581028;8836;8843.336749743796;5197.350331208599;5296.894062118775;5334.893302133974;5357.43746906577;5368.812091576776;3236.6277878044093;3346.0798280472823;3412.6416726243633;3461.4288642373976;3462.2036931505895;1104.0560320925654;1107.1143085531623;1112.1603189591888;1120.843081968525;1123.3484578944274;12361.93819030899;12457.626271211879;12503.937480312541;12506.937465312707;12518.874811251862;4417.7791110445;4611.469680986663;4670.299455081765;4749.95250047502;4763.571278584944;9786.266030047775;9796.363236389754;9805.656802011896;9870.457124858201;9891.258155638356;5209.739513024334;5209.895802083937;5210.7915683373;5220.634555581073;5220.765065572058;4043.3934909763184;4275;4701.95298047022;4831.73425461603;4847.200211965057;3755.342815007363;3839.9808000959815;3951.1900060487533;3962.227365663726;4029.6977726670616;1095.2169199022578;1100.3233011697907;1100.5872797700863;1106.4910141334915;1148.7530181011123;916.5005072235648;993.3443927008284;999.3211404839939;1027.1320733979776;1051.7475805806705;6116;6132.080187971751;6154.261488621394;6159.84600384985;6364.204474440695;472.78724573941867;491.64847134298435;492.97535123243694;501.7039946431623;1055.266589720137;4260.616544510947;4392.934105988413;4404;4434.17967675981;4454.37638730578;10899.346039237671;11202.607908723156;11247.775044499227;11302.660920172408;11336.43317834105;11119.833202501968;11150.49822757978;11162.832557511643;11167.83248251277;11190.272632278877;7663.731769388045;7682.615869206629;8043.39674524413;8053.1141574426765;8208.466449680871;6289.874202516015;6343.492520598434;6452.645104519296;6458.418742313214;6507.893658078233;10200.795984080129;10305.484725763832;10306.12397946183;10487.580496780349;10509.527071281658;9172.35793494449;9461.195798357217;10186.694399168036;10388.220883433622;10650.360978341325;7469.327760501581;7643;7670.0795904491815;7854.9399549788295;7936.444448888753;8736.602143656984;8818.118188181386;8864.379493435397;8887.822243555222;8894.33292503052;7664.770056898302;7684.3084122429245;7698.384129269757;7785.416093792875;7789.805254868674;7591.620418978919;7627.618619068913;7646.464747467624;7782.221777822172;7890;7218.783436496913;7245.963770181115;7266.600336981517;7272.745453909088;7286.599237042014;5158.09733296664;5171.612129090258;5265.657732247391;5375.81184658535;5376.919346209888;5209.296744939385;5216.895662086661;5224.754077947951;5269.499397557226;5436.266104076058 08:25:43 INFO - PROCESS | 12147 | |4;prototype.html;324.27686259641;324.95775549178603;329.15735716565587;330.8180500724602;332.24580202939313;5275.1296036154035;5345.305110335656;5349.5185433311;5363.168708850125;5364.141737322029;5253.474652534745;5270.710110943896;5313.495217954298;5320.893582128355;5335.813246536372;4065.369867670501;4147.2203583588125;4176.60322269384;4202.747835129887;4224.302990006645;4136;4156.91686166278;4170.77060761658;4171.707980441371;4184.748915065091;4113.177364527091;4117.835286588533;4133.9173216535655;4134.449581406972;4150.58494150584;3876.8255428505786;3978.4827972363696;4107.958920410788;4184.309588917825;4184.769837658928;3625.8730944417084;3635.363811333006;3640.927181456356;3652.470391793175;3682.668559829628;5076.213186956028;5114.846554603368;5131.332926719502;5136.357955255593;5137.948620513822;4498.50516443191;4570.268756998864;4737.976310118462;4742.122707299126;4759.143354196243;5444.3194600674915;5471.5896307777075;5474.233607294982;5483.259759932398;5488.945110548923;4052.4124002019835;4068.2880495913096;4070.6743460523385;4071.633552980246;4078.1028173801715;5656.377798442168;5734.8279551613105;5760.2511673482595;5766.192733017339;5788.131780232957;4107.199096176217;4112.835486580563;4114.958850411457;4150.306227457565;4179.6029377209115;4218.367244913287;4220.303649897794;4222.303319952173;4224.598663126998;4227;4633.49031606523;4717.693349932243;4764.95235047652;4768.523147685204;4789.425268967746;5507.5593952483705;5509.834704958857;5512.862178445571;5522.806701765499;5581.134924086773;1400.3278426355407;1428.7499687554637;1436.3392839294042;1459.3870574358796;1460.4158336665207;911.8267529169436;958.3435346787472;961.0101595356793;962.5043102802063;973.8003709239589;4719.867231864328;4760.500147484534;4809.398825146856;4827.879303017453;4839.685420447659;5002.1496345621335;5010.3737032870895;5016.272640467112;5022.547970682656;5035.496450355008;4573.405457290531;4786.880327991828;4794.017226468565;4809.759512024385;4833.685810422311;2713.6879258885087;2894.522403803391;2958.8520573971214;2968.625099920055;2979.6275465566805;5687.317521897316;5804.158397032406;5867.618604790675;5897.675627840425;5910.704464776744;5571.220029195916;5719.7426115824055;5746.13807928814;5831.271091113611;5858.414158584107;5786.681732504669;5810.912836307459;5811.79658711943;5825.708474711774;5829.708514574169;5633.63381380209;5648.745806438638;5657.2928383952;5657.575681823797;5674.77300907959;5374.193870919394;5621.747021383966;5632.774689012557;5665.631733937281;5680.602357834912;5792.21805056312;5833.82498525045;5836;5862.882742345215;5905.2913650360515;4049.57479464652;4066.877993660195;4070.1656160486436;4075.449814275035;4077.327241005201;5374.919376209438;5625.718714064198;5697.743601537858;5711.857628474405;5728.598998070095;5559.416261292506;5582.944170558242;5583.944160558342;5588.161775733673;5649.830505084854;5357.410684824744;5578.8047418341785;5579.721013949367;5593.881223755184;5612.85967850807;5513.669179849061;5525.917111243254;5527.613067085265;5530.391656917655;5538.529225015919;5607;5621.747021383966;5655.4910058094965;5660.37735849048;5687.146927960839;5196.220566914993;5447.945520544744;5451.155070964007;5486.835394938158;5558.194061860927 08:25:43 INFO - PROCESS | 12147 | |5;yui.html;739.2275072549186;807.1807115777483;819.9016118065829;844.4004756622797;849.6176720475784;13583.864161358384;14401.927990360047;14406.639834004129;14427.567172984802;14445.566633001014;13414.66463338417;14331.140131592112;14444.5666630001;14451.494197703056;14507.49223777168;676.3067855448156;812.910579836219;826.7271800305884;833.5123952487802;836.2014276366056;789.794653390117;812.8211793405471;823.6293667849462;826.9338452923752;827.5613924619961;860.1957170045996;862.3230763850379;863.2834747159842;863.6243234193146;863.6502216602286;693.3136195166799;855.4140413816556;859.866720658299;859.8839156713857;860.535310932096;606.2997238189897;612.4977518434886;624.7157543317779;626.7305058824703;628.9905651415232;14041.859581404158;14065.36705848229;14081.436742530286;14090.647733806634;14125.364358603887;13784.172949623055;13894;14271.357788899524;14282.500112496013;14488.855111448962;12965.481380744759;13073.15024523403;13148.211107333591;13216.537421190213;13558.322083895864;4305.418768466279;4339.956600434019;4433.1577000369825;4448.9544956935415;4581.473130589991;74234;74494.25505744982;75876;77493.83759243673;79069;11016.889831101586;11057;11156.219064665396;11416.885831141748;11422.543098275975;19525.121369538403;19654;19697.113629886688;19703.802961970196;19776;7455.776326710099;7471.476996610294;7613.505122167041;7741.961290193513;7881.960590197127;4232.746035237896;4253.2769429197115;4305.526392096866;4311.374850646639;4391.538888416734;3376.1053320869987;3438.2607739336163;3440.569928758905;3459.965400345964;3472.392331342005;620.7734177025444;627.1564745417406;627.4541149200224;631.3307893632764;635.841039740065;699.993000070003;711.8398360368875;711.9537230080028;725.3326939215934;768.7347864986571;9348.392354496937;9831.262655300881;10008.099271065494;10100.393976361442;10131;542.6852425593147;589.6904125334148;596.260636810352;621.8289970258215;662.5163630549629;4439.955600444019;4743.976280118577;4816.277558366273;4838.782254798542;4841.080194763054;114515.42742286235;114600;114860;118840.40579797045;121613.39193303976;61527.38472615306;89322;91944.54027729819;100864.49567752115;102466.48766756267;78134.21865781384;80153.99999999884;88488;91901.5404922971;91910.54044729733;9503.572339244889;9954.900450995687;10151.187904967437;10231.59073637076;10315.432651203955;52961.47038529565;54507.18239226494;54768;55881;56033.439665604456;70586.6470667664;79662.6016869912;79973.20026799891;80865.59567202361;82080;12198.451069702061;12237.571684990982;12291.078169137529;12425.565105221274;12443.377831108228;14307.92846035763;14409.711805764036;14510.056846304957;14945.02857314271;14972.925135374253;13582.728345432839;13593.388297526437;13623.659408514866;14052.297385130498;14718.55844324672;13005.674858128623;13057.21656700601;13166.407511661806;13244.337783110614;13748;12530.185537940004;13001.219926804422;13258.734825303247;13346.799798003232;13355;10338.689839304832;10491.895081049091;10581.4709264538;10874.184436167478;11013.339199648046;11249.212555121063;11418.429078545872;11519.214521749142;11670.70823229426;11763.176577639482 08:25:43 INFO - PROCESS | 12147 | __end_tp_report 08:25:43 INFO - PROCESS | 12147 | __start_cc_report 08:25:43 INFO - PROCESS | 12147 | _x_x_mozilla_cycle_collect,1028 08:25:43 INFO - PROCESS | 12147 | __end_cc_report 08:25:43 INFO - PROCESS | 12147 | __startTimestamp1469114743789__endTimestamp 08:25:43 INFO - PROCESS | 12147 | 08:25:43 INFO - PROCESS | 12147 | ------- Summary: start ------- 08:25:43 INFO - PROCESS | 12147 | Number of tests: 6 08:25:43 INFO - PROCESS | 12147 | 08:25:43 INFO - PROCESS | 12147 | [#0] dojo.html Cycles:165 Average:5379.95 Median:5529.31 stddev:622.50 (11.3%) stddev-sans-first:596.90 08:25:43 INFO - PROCESS | 12147 | Values: 3047.0 3063.3 3095.5 3099.0 3109.8 5200.2 5273.6 5397.4 5462.1 5475.2 5345.0 5388.8 5392.3 5428.5 5462.6 4847.3 4902.5 4917.7 4920.3 5070.8 4996.4 5006.5 5030.3 5042.3 5053.6 4832.7 4869.0 4881.5 4920.9 4984.2 4878.4 4889.0 4896.1 5015.7 5027.9 4870.1 4889.4 4901.1 4919.8 4956.9 5274.7 5294.3 5404.9 5413.8 5451.6 5705.5 5735.1 5754.1 5764.8 5767.6 5751.8 5753.5 5800.3 5801.3 5820.8 5197.5 5361.5 5434.4 5438.3 5446.6 5989.4 5990.9 6024.8 6041.3 6047.2 5721.1 5731.2 5776.2 5780.5 5784.3 5583.5 5697.0 5770.4 5815.4 5872.4 5770.1 5777.5 5806.1 5811.8 5834.9 5743.7 5791.2 5801.5 5814.0 5819.5 4284.1 4319.5 4360.8 4428.4 4428.7 3924.1 3935.2 3966.0 3989.2 4022.4 5426.6 5437.1 5444.7 5444.9 5446.4 5677.9 5715.1 5796.4 5815.7 5831.5 5391.4 5431.0 5432.2 5477.7 5485.4 5009.1 5012.4 5015.1 5017.4 5058.9 5824.9 5931.0 5938.6 5990.3 5993.1 5836.4 5867.9 5875.2 5916.1 5934.1 6027.2 6036.8 6044.5 6044.6 6057.9 5489.2 5689.1 5705.6 5755.7 5756.9 5838.6 5904.8 5911.6 5953.8 5963.2 5674.5 5716.0 5718.6 5733.3 5765.9 5521.8 5553.1 5742.1 5753.7 5755.9 5503.1 5592.7 5595.9 5631.0 5645.5 5604.2 5639.0 5662.5 5699.8 5705.8 5413.5 5481.6 5502.5 5509.4 5529.3 08:25:43 INFO - PROCESS | 12147 | 08:25:43 INFO - PROCESS | 12147 | [#1] ext.html Cycles:180 Average:61911.89 Median:44568.55 stddev:123515.46 (277.1%) stddev-sans-first:123776.16 08:25:43 INFO - PROCESS | 12147 | Values: 595.6 618.1 640.3 643.5 653.6 31994.0 32354.5 43805.6 44442.3 44600.6 46135.3 46461.5 46664.0 46671.8 46716.5 8782.4 8959.7 8962.8 8965.9 8969.8 8923.0 9013.7 9014.9 9021.4 9024.4 8994.0 9040.5 9049.8 9061.5 9061.8 8961.0 8999.1 9020.6 9037.3 9050.7 8879.4 8903.8 8951.1 8956.9 8957.3 44100.6 44153.3 44284.3 44455.3 44536.6 3437.7 3470.6 3509.4 3656.3 4416.4 33479.3 33494.5 33696.3 34045.1 34066.1 4386.7 4430.4 4431.4 4512.8 4656.7 262361.0 263884.0 263927.0 263972.0 265346.0 59081.7 59161.0 59517.0 59576.0 59595.1 62052.4 62069.7 62270.4 62271.7 62580.4 15141.8 15363.5 15367.7 15371.1 15379.6 11879.9 11960.2 11964.2 11964.4 11972.3 14625.2 16280.7 16309.3 16363.3 16566.9 6330.7 6494.8 6494.8 6527.8 6708.7 733.8 1017.4 1053.0 1131.5 1174.3 33392.0 33934.5 34008.8 34352.5 34676.5 1100.6 1118.7 1160.5 1176.8 1243.1 17288.4 17582.6 17793.7 17797.6 17802.7 539812.0 545349.0 545715.0 545963.0 547814.0 61603.7 61735.0 61737.1 61862.0 61876.7 1234.4 1343.3 1351.2 1358.0 1388.6 31570.4 35537.5 36059.5 36205.6 36303.3 54225.5 54815.7 54901.0 55138.4 55148.0 523108.0 529838.0 530049.0 530728.0 531818.0 37148.8 38029.2 44815.3 47342.5 47837.8 50078.2 50362.2 50437.7 50772.7 51549.2 42264.0 43215.0 43847.8 44389.8 45099.1 43338.6 43883.6 44210.3 44758.6 44820.3 43211.6 44670.8 44997.6 45098.8 45293.0 36437.3 38307.0 38757.0 39341.0 39730.0 29627.7 29677.6 29913.9 29986.0 30249.8 08:25:43 INFO - PROCESS | 12147 | 08:25:43 INFO - PROCESS | 12147 | [#2] jquery.html Cycles:180 Average:29585.28 Median:32516.93 stddev:71908.76 (221.1%) stddev-sans-first:72077.02 08:25:43 INFO - PROCESS | 12147 | Values: 371.3 382.7 393.7 394.2 404.0 18664.4 19393.2 20146.7 20315.2 20324.1 18699.2 19391.9 19746.7 19856.0 19863.7 5634.1 5798.4 5848.9 7190.1 7542.9 7244.7 7488.6 7559.4 7566.4 7568.7 7496.1 7617.5 7650.9 7654.1 7661.6 7388.9 7585.9 7603.7 7645.0 7673.8 7182.9 7352.4 7423.2 7429.0 7430.3 26479.2 26709.2 27122.2 27173.5 27176.0 2425.6 2594.2 2640.8 2712.2 2712.8 16087.8 16260.8 16323.0 16523.7 16856.7 2065.5 2202.8 2214.1 2218.9 2249.2 63178.0 80645.6 92101.1 99276.5 101590.5 17689.0 17791.1 18339.9 18502.3 18513.9 32466.4 32567.5 32575.2 32612.7 32636.3 8582.0 9284.3 9527.9 9579.8 9782.1 7878.3 7934.9 8167.1 8195.1 8227.1 8836.7 8856.4 9075.9 9274.8 9357.1 3308.6 3550.8 3610.9 3647.6 3652.9 919.6 952.9 1000.0 1043.7 1061.8 20269.7 20397.4 20580.4 20608.9 20977.6 990.8 1035.8 1045.5 1064.4 1074.8 10502.4 11363.1 11431.9 11438.4 11441.4 373229.0 377694.0 377955.0 499775.0 506021.0 103388.5 104735.5 104811.0 107634.0 110222.0 1010.3 1010.7 1053.3 1061.9 1071.5 17551.2 18198.8 18634.5 18634.9 18924.5 44429.0 44806.3 44917.6 45859.5 47324.8 52515.5 62291.7 63681.4 64047.7 65647.7 11910.3 12375.6 12500.1 12631.9 13068.4 14225.6 14252.6 14355.4 14402.4 14514.5 11931.5 12259.6 12266.8 12668.9 12896.9 8187.3 8192.3 8426.0 8577.6 8624.4 8272.1 8522.2 8610.5 8731.7 8789.2 11264.9 12363.4 12409.8 12468.8 12659.3 8369.7 8497.4 12027.2 12260.2 12349.9 08:25:43 INFO - PROCESS | 12147 | 08:25:43 INFO - PROCESS | 12147 | [#3] mootools.html Cycles:180 Average:5835.14 Median:4839.47 stddev:3348.67 (69.2%) stddev-sans-first:3341.32 08:25:43 INFO - PROCESS | 12147 | Values: 1379.0 1500.4 1535.7 1676.9 1797.9 8384.6 8774.9 8799.0 8900.6 8949.1 8839.2 8869.4 8930.3 8955.6 9002.3 2079.5 2320.9 2351.9 2375.8 2378.4 2352.3 2372.7 2374.6 2377.0 2379.5 2355.6 2355.8 2357.7 2362.7 2404.1 1987.0 2053.3 2361.5 2369.0 2370.1 2046.7 2186.0 2251.1 2255.6 2265.2 8785.3 8823.8 8824.7 8836.0 8843.3 5197.4 5296.9 5334.9 5357.4 5368.8 3236.6 3346.1 3412.6 3461.4 3462.2 1104.1 1107.1 1112.2 1120.8 1123.3 12361.9 12457.6 12503.9 12506.9 12518.9 4417.8 4611.5 4670.3 4750.0 4763.6 9786.3 9796.4 9805.7 9870.5 9891.3 5209.7 5209.9 5210.8 5220.6 5220.8 4043.4 4275.0 4702.0 4831.7 4847.2 3755.3 3840.0 3951.2 3962.2 4029.7 1095.2 1100.3 1100.6 1106.5 1148.8 916.5 993.3 999.3 1027.1 1051.7 6116.0 6132.1 6154.3 6159.8 6364.2 472.8 491.6 493.0 501.7 1055.3 4260.6 4392.9 4404.0 4434.2 4454.4 10899.3 11202.6 11247.8 11302.7 11336.4 11119.8 11150.5 11162.8 11167.8 11190.3 7663.7 7682.6 8043.4 8053.1 8208.5 6289.9 6343.5 6452.6 6458.4 6507.9 10200.8 10305.5 10306.1 10487.6 10509.5 9172.4 9461.2 10186.7 10388.2 10650.4 7469.3 7643.0 7670.1 7854.9 7936.4 8736.6 8818.1 8864.4 8887.8 8894.3 7664.8 7684.3 7698.4 7785.4 7789.8 7591.6 7627.6 7646.5 7782.2 7890.0 7218.8 7246.0 7266.6 7272.7 7286.6 5158.1 5171.6 5265.7 5375.8 5376.9 5209.3 5216.9 5224.8 5269.5 5436.3 08:25:43 INFO - PROCESS | 12147 | 08:25:43 INFO - PROCESS | 12147 | [#4] prototype.html Cycles:180 Average:4627.82 Median:5224.85 stddev:1350.31 (25.8%) stddev-sans-first:1314.90 08:25:43 INFO - PROCESS | 12147 | Values: 324.3 325.0 329.2 330.8 332.2 5275.1 5345.3 5349.5 5363.2 5364.1 5253.5 5270.7 5313.5 5320.9 5335.8 4065.4 4147.2 4176.6 4202.7 4224.3 4136.0 4156.9 4170.8 4171.7 4184.7 4113.2 4117.8 4133.9 4134.4 4150.6 3876.8 3978.5 4108.0 4184.3 4184.8 3625.9 3635.4 3640.9 3652.5 3682.7 5076.2 5114.8 5131.3 5136.4 5137.9 4498.5 4570.3 4738.0 4742.1 4759.1 5444.3 5471.6 5474.2 5483.3 5488.9 4052.4 4068.3 4070.7 4071.6 4078.1 5656.4 5734.8 5760.3 5766.2 5788.1 4107.2 4112.8 4115.0 4150.3 4179.6 4218.4 4220.3 4222.3 4224.6 4227.0 4633.5 4717.7 4765.0 4768.5 4789.4 5507.6 5509.8 5512.9 5522.8 5581.1 1400.3 1428.7 1436.3 1459.4 1460.4 911.8 958.3 961.0 962.5 973.8 4719.9 4760.5 4809.4 4827.9 4839.7 5002.1 5010.4 5016.3 5022.5 5035.5 4573.4 4786.9 4794.0 4809.8 4833.7 2713.7 2894.5 2958.9 2968.6 2979.6 5687.3 5804.2 5867.6 5897.7 5910.7 5571.2 5719.7 5746.1 5831.3 5858.4 5786.7 5810.9 5811.8 5825.7 5829.7 5633.6 5648.7 5657.3 5657.6 5674.8 5374.2 5621.7 5632.8 5665.6 5680.6 5792.2 5833.8 5836.0 5862.9 5905.3 4049.6 4066.9 4070.2 4075.4 4077.3 5374.9 5625.7 5697.7 5711.9 5728.6 5559.4 5582.9 5583.9 5588.2 5649.8 5357.4 5578.8 5579.7 5593.9 5612.9 5513.7 5525.9 5527.6 5530.4 5538.5 5607.0 5621.7 5655.5 5660.4 5687.1 5196.2 5447.9 5451.2 5486.8 5558.2 08:25:43 INFO - PROCESS | 12147 | 08:25:43 INFO - PROCESS | 12147 | [#5] yui.html Cycles:180 Average:20645.31 Median:4305.47 stddev:29877.01 (693.9%) stddev-sans-first:29923.43 08:25:43 INFO - PROCESS | 12147 | Values: 739.2 807.2 819.9 844.4 849.6 13583.9 14401.9 14406.6 14427.6 14445.6 13414.7 14331.1 14444.6 14451.5 14507.5 676.3 812.9 826.7 833.5 836.2 789.8 812.8 823.6 826.9 827.6 860.2 862.3 863.3 863.6 863.7 693.3 855.4 859.9 859.9 860.5 606.3 612.5 624.7 626.7 629.0 14041.9 14065.4 14081.4 14090.6 14125.4 13784.2 13894.0 14271.4 14282.5 14488.9 12965.5 13073.2 13148.2 13216.5 13558.3 4305.4 4340.0 4433.2 4449.0 4581.5 74234.0 74494.3 75876.0 77493.8 79069.0 11016.9 11057.0 11156.2 11416.9 11422.5 19525.1 19654.0 19697.1 19703.8 19776.0 7455.8 7471.5 7613.5 7742.0 7882.0 4232.7 4253.3 4305.5 4311.4 4391.5 3376.1 3438.3 3440.6 3460.0 3472.4 620.8 627.2 627.5 631.3 635.8 700.0 711.8 712.0 725.3 768.7 9348.4 9831.3 10008.1 10100.4 10131.0 542.7 589.7 596.3 621.8 662.5 4440.0 4744.0 4816.3 4838.8 4841.1 114515.4 114600.0 114860.0 118840.4 121613.4 61527.4 89322.0 91944.5 100864.5 102466.5 78134.2 80154.0 88488.0 91901.5 91910.5 9503.6 9954.9 10151.2 10231.6 10315.4 52961.5 54507.2 54768.0 55881.0 56033.4 70586.6 79662.6 79973.2 80865.6 82080.0 12198.5 12237.6 12291.1 12425.6 12443.4 14307.9 14409.7 14510.1 14945.0 14972.9 13582.7 13593.4 13623.7 14052.3 14718.6 13005.7 13057.2 13166.4 13244.3 13748.0 12530.2 13001.2 13258.7 13346.8 13355.0 10338.7 10491.9 10581.5 10874.2 11013.3 11249.2 11418.4 11519.2 11670.7 11763.2 08:25:43 INFO - PROCESS | 12147 | -------- Summary: end -------- 08:25:43 INFO - PROCESS | 12147 | 08:25:44 INFO - TEST-INFO | 12147: exit 0 08:25:44 INFO - TEST-OK | dromaeo_css | took 1114378ms 08:25:44 INFO - TEST-START | kraken 08:25:44 INFO - operating with platform_type : linux_ 08:25:44 INFO - Initialising browser for kraken test... 08:25:44 INFO - TEST-INFO | started process 12340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeXgcSQ/profile http://localhost:41432/getInfo.html) 08:25:48 INFO - PROCESS | 12340 | __metrics Screen width/height:1600/1200 08:25:48 INFO - PROCESS | 12340 | colorDepth:24 08:25:48 INFO - PROCESS | 12340 | Browser inner width/height: 1024/697 08:25:48 INFO - PROCESS | 12340 | __metrics 08:25:49 INFO - PROCESS | 12340 | 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" 08:25:49 INFO - PROCESS | 12340 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:25:50 INFO - TEST-INFO | 12340: exit 0 08:25:50 INFO - Browser initialized. 08:25:50 INFO - Running cycle 1/1 for kraken test... 08:25:50 INFO - TEST-INFO | started process 12422 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeXgcSQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:26:02 INFO - PROCESS | 12422 | RSS: Main: 157564928 08:26:02 INFO - PROCESS | 12422 | 08:26:04 INFO - PROCESS | 12422 | Cycle 1(1): loaded http://localhost:41432/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41432/tests/kraken/driver.html?testName=audio-beat-detection) 08:26:05 INFO - PROCESS | 12422 | RSS: Main: 214515712 08:26:05 INFO - PROCESS | 12422 | 08:26:08 INFO - PROCESS | 12422 | Cycle 1(1): loaded http://localhost:41432/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41432/tests/kraken/driver.html?testName=audio-dft) 08:26:08 INFO - PROCESS | 12422 | RSS: Main: 192561152 08:26:08 INFO - PROCESS | 12422 | 08:26:12 INFO - PROCESS | 12422 | Cycle 1(1): loaded http://localhost:41432/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41432/tests/kraken/driver.html?testName=audio-fft) 08:26:12 INFO - PROCESS | 12422 | RSS: Main: 269697024 08:26:12 INFO - PROCESS | 12422 | 08:26:14 INFO - PROCESS | 12422 | Cycle 1(1): loaded http://localhost:41432/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41432/tests/kraken/driver.html?testName=audio-oscillator) 08:26:15 INFO - PROCESS | 12422 | RSS: Main: 180396032 08:26:15 INFO - PROCESS | 12422 | 08:26:17 INFO - PROCESS | 12422 | Cycle 1(1): loaded http://localhost:41432/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41432/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:26:18 INFO - PROCESS | 12422 | RSS: Main: 184516608 08:26:18 INFO - PROCESS | 12422 | 08:26:21 INFO - PROCESS | 12422 | Cycle 1(1): loaded http://localhost:41432/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41432/tests/kraken/driver.html?testName=imaging-darkroom) 08:26:21 INFO - PROCESS | 12422 | RSS: Main: 219992064 08:26:21 INFO - PROCESS | 12422 | 08:26:25 INFO - PROCESS | 12422 | Cycle 1(1): loaded http://localhost:41432/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41432/tests/kraken/driver.html?testName=imaging-desaturate) 08:26:25 INFO - PROCESS | 12422 | RSS: Main: 220377088 08:26:25 INFO - PROCESS | 12422 | 08:26:28 INFO - PROCESS | 12422 | Cycle 1(1): loaded http://localhost:41432/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41432/tests/kraken/driver.html?testName=json-parse-financial) 08:26:29 INFO - PROCESS | 12422 | RSS: Main: 220139520 08:26:29 INFO - PROCESS | 12422 | 08:26:30 INFO - PROCESS | 12422 | Cycle 1(1): loaded http://localhost:41432/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41432/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:26:31 INFO - PROCESS | 12422 | RSS: Main: 183848960 08:26:31 INFO - PROCESS | 12422 | 08:26:32 INFO - PROCESS | 12422 | Cycle 1(1): loaded http://localhost:41432/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41432/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:26:33 INFO - PROCESS | 12422 | RSS: Main: 191082496 08:26:33 INFO - PROCESS | 12422 | 08:26:35 INFO - PROCESS | 12422 | Cycle 1(1): loaded http://localhost:41432/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41432/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:26:36 INFO - PROCESS | 12422 | RSS: Main: 194981888 08:26:36 INFO - PROCESS | 12422 | 08:26:38 INFO - PROCESS | 12422 | Cycle 1(1): loaded http://localhost:41432/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41432/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:26:39 INFO - PROCESS | 12422 | RSS: Main: 189407232 08:26:39 INFO - PROCESS | 12422 | 08:26:42 INFO - PROCESS | 12422 | Cycle 1(1): loaded http://localhost:41432/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41432/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:26:42 INFO - PROCESS | 12422 | RSS: Main: 193748992 08:26:42 INFO - PROCESS | 12422 | 08:26:44 INFO - PROCESS | 12422 | Cycle 1(1): loaded http://localhost:41432/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41432/tests/kraken/driver.html?testName=ai-astar) 08:26:44 INFO - PROCESS | 12422 | RSS: Main: 244473856 08:26:44 INFO - PROCESS | 12422 | 08:26:44 INFO - PROCESS | 12422 | __start_tp_report 08:26:44 INFO - PROCESS | 12422 | _x_x_mozilla_page_load 08:26:44 INFO - PROCESS | 12422 | _x_x_mozilla_page_load_details 08:26:44 INFO - PROCESS | 12422 | |i|pagename|runs| 08:26:44 INFO - PROCESS | 12422 | |0;ai-astar;102;110;112;110;110;112;109;110;111;111 08:26:44 INFO - PROCESS | 12422 | |1;audio-beat-detection;143;115;119;183;116;119;148;116;160;122 08:26:44 INFO - PROCESS | 12422 | |2;audio-dft;162;161;164;160;160;159;161;162;162;160 08:26:44 INFO - PROCESS | 12422 | |3;audio-fft;75;75;76;110;75;75;75;74;97;75 08:26:44 INFO - PROCESS | 12422 | |4;audio-oscillator;83;84;111;84;83;83;134;83;83;119 08:26:44 INFO - PROCESS | 12422 | |5;imaging-gaussian-blur;117;117;116;117;116;117;116;117;117;117 08:26:44 INFO - PROCESS | 12422 | |6;imaging-darkroom;145;147;145;146;146;146;145;145;145;146 08:26:44 INFO - PROCESS | 12422 | |7;imaging-desaturate;96;94;95;95;94;95;95;95;95;95 08:26:44 INFO - PROCESS | 12422 | |8;json-parse-financial;65;51;51;50;50;50;50;52;49;50 08:26:44 INFO - PROCESS | 12422 | |9;json-stringify-tinderbox;63;65;62;63;63;63;63;63;65;64 08:26:44 INFO - PROCESS | 12422 | |10;stanford-crypto-aes;77;81;76;75;76;81;76;75;75;80 08:26:44 INFO - PROCESS | 12422 | |11;stanford-crypto-ccm;131;119;120;124;118;118;125;127;199;123 08:26:44 INFO - PROCESS | 12422 | |12;stanford-crypto-pbkdf2;161;160;158;158;155;157;157;156;155;155 08:26:44 INFO - PROCESS | 12422 | |13;stanford-crypto-sha256-iterative;70;63;64;63;63;62;62;62;61;61 08:26:44 INFO - PROCESS | 12422 | __end_tp_report 08:26:44 INFO - PROCESS | 12422 | __start_cc_report 08:26:44 INFO - PROCESS | 12422 | _x_x_mozilla_cycle_collect,1673 08:26:44 INFO - PROCESS | 12422 | __end_cc_report 08:26:44 INFO - PROCESS | 12422 | __startTimestamp1469114804642__endTimestamp 08:26:44 INFO - PROCESS | 12422 | 08:26:44 INFO - PROCESS | 12422 | ------- Summary: start ------- 08:26:44 INFO - PROCESS | 12422 | Number of tests: 14 08:26:44 INFO - PROCESS | 12422 | 08:26:44 INFO - PROCESS | 12422 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:2.87 (2.6%) stddev-sans-first:1.01 08:26:44 INFO - PROCESS | 12422 | Values: 102.0 110.0 112.0 110.0 110.0 112.0 109.0 110.0 111.0 111.0 08:26:44 INFO - PROCESS | 12422 | 08:26:44 INFO - PROCESS | 12422 | [#1] audio-beat-detection Cycles:10 Average:134.10 Median:132.50 stddev:23.47 (17.7%) stddev-sans-first:24.67 08:26:44 INFO - PROCESS | 12422 | Values: 143.0 115.0 119.0 183.0 116.0 119.0 148.0 116.0 160.0 122.0 08:26:44 INFO - PROCESS | 12422 | 08:26:44 INFO - PROCESS | 12422 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.45 (0.9%) stddev-sans-first:1.50 08:26:44 INFO - PROCESS | 12422 | Values: 162.0 161.0 164.0 160.0 160.0 159.0 161.0 162.0 162.0 160.0 08:26:44 INFO - PROCESS | 12422 | 08:26:44 INFO - PROCESS | 12422 | [#3] audio-fft Cycles:10 Average:80.70 Median:75.00 stddev:12.41 (16.5%) stddev-sans-first:12.99 08:26:44 INFO - PROCESS | 12422 | Values: 75.0 75.0 76.0 110.0 75.0 75.0 75.0 74.0 97.0 75.0 08:26:44 INFO - PROCESS | 12422 | 08:26:44 INFO - PROCESS | 12422 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:83.00 stddev:19.19 (23.1%) stddev-sans-first:19.88 08:26:44 INFO - PROCESS | 12422 | Values: 83.0 84.0 111.0 84.0 83.0 83.0 134.0 83.0 83.0 119.0 08:26:44 INFO - PROCESS | 12422 | 08:26:44 INFO - PROCESS | 12422 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:26:44 INFO - PROCESS | 12422 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 08:26:44 INFO - PROCESS | 12422 | 08:26:44 INFO - PROCESS | 12422 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 08:26:44 INFO - PROCESS | 12422 | Values: 145.0 147.0 145.0 146.0 146.0 146.0 145.0 145.0 145.0 146.0 08:26:44 INFO - PROCESS | 12422 | 08:26:44 INFO - PROCESS | 12422 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 08:26:44 INFO - PROCESS | 12422 | Values: 96.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 08:26:44 INFO - PROCESS | 12422 | 08:26:44 INFO - PROCESS | 12422 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:50.50 stddev:4.71 (9.3%) stddev-sans-first:0.87 08:26:44 INFO - PROCESS | 12422 | Values: 65.0 51.0 51.0 50.0 50.0 50.0 50.0 52.0 49.0 50.0 08:26:44 INFO - PROCESS | 12422 | 08:26:44 INFO - PROCESS | 12422 | [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:63.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 08:26:44 INFO - PROCESS | 12422 | Values: 63.0 65.0 62.0 63.0 63.0 63.0 63.0 63.0 65.0 64.0 08:26:44 INFO - PROCESS | 12422 | 08:26:44 INFO - PROCESS | 12422 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:76.50 stddev:2.49 (3.2%) stddev-sans-first:2.64 08:26:44 INFO - PROCESS | 12422 | Values: 77.0 81.0 76.0 75.0 76.0 81.0 76.0 75.0 75.0 80.0 08:26:44 INFO - PROCESS | 12422 | 08:26:44 INFO - PROCESS | 12422 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:124.50 stddev:24.47 (19.7%) stddev-sans-first:25.95 08:26:44 INFO - PROCESS | 12422 | Values: 131.0 119.0 120.0 124.0 118.0 118.0 125.0 127.0 199.0 123.0 08:26:44 INFO - PROCESS | 12422 | 08:26:44 INFO - PROCESS | 12422 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.20 Median:157.50 stddev:2.10 (1.3%) stddev-sans-first:1.72 08:26:44 INFO - PROCESS | 12422 | Values: 161.0 160.0 158.0 158.0 155.0 157.0 157.0 156.0 155.0 155.0 08:26:44 INFO - PROCESS | 12422 | 08:26:44 INFO - PROCESS | 12422 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.00 stddev:2.60 (4.1%) stddev-sans-first:1.00 08:26:44 INFO - PROCESS | 12422 | Values: 70.0 63.0 64.0 63.0 63.0 62.0 62.0 62.0 61.0 61.0 08:26:44 INFO - PROCESS | 12422 | -------- Summary: end -------- 08:26:44 INFO - PROCESS | 12422 | 08:26:45 INFO - TEST-INFO | 12422: exit 0 08:26:45 INFO - TEST-OK | kraken | took 61040ms 08:26:45 INFO - SUITE-END | took 1175s 08:26:45 INFO - Completed test suite (00:19:35) 08:26:45 INFO - javascript benchmark 08:26:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3046.9999999999995, 3063.29544204833, 3095.5047192449197, 3098.9535156972634, 3109.7667674924387, 5200.167973124301, 5273.630845840783, 5397.379301380342, 5462.071447853859, 5475.233467314574, 5345.011172933, 5388.78444862205, 5392.299001129848, 5428.4842939920745, 5462.644928079682, 4847.272909063642, 4902.460729319772, 4917.680350777206, 4920.3357546731095, 5070.771815268322, 4996.350474438336, 5006.524380183895, 5030.320906677606, 5042.294078828967, 5053.646244762868, 4832.685875418087, 4869.0, 4881.463039065682, 4920.852374428737, 4984.202527595586, 4878.438979517366, 4888.997755460122, 4896.1186986342445, 5015.673981191211, 5027.899442011139, 4870.14772414826, 4889.3888263967, 4901.142300097468, 4919.803207871681, 4956.900861982776, 5274.736263186825, 5294.285271488377, 5404.891902161974, 5413.837584872421, 5451.591130665176, 5705.486506214419, 5735.0823868181305, 5754.079347304453, 5764.827055188351, 5767.5962682612235, 5751.798687045934, 5753.539716822686, 5800.303963524404, 5801.332846722638, 5820.796272130455, 5197.480251974772, 5361.544268737123, 5434.402215756264, 5438.293021907166, 5446.618736688473, 5989.431004054695, 5990.880182396328, 6024.819255422344, 6041.335453100155, 6047.15339852421, 5721.084626459747, 5731.226284451629, 5776.1624564437925, 5780.508656764222, 5784.334801497797, 5583.525400341016, 5697.003024470784, 5770.42295770428, 5815.447532484407, 5872.412758724179, 5770.10563362671, 5777.508911742465, 5806.071028635482, 5811.82564523065, 5834.883302333929, 5743.684097374601, 5791.218185544897, 5801.477866991991, 5814.0, 5819.505342045889, 4284.057507348379, 4319.460067491564, 4360.803763830635, 4428.357888106271, 4428.689991700615, 3924.0778417071965, 3935.193285376491, 3966.0, 3989.202159568098, 4022.416749571296, 5426.620136590401, 5437.075697131497, 5444.700541470178, 5444.945550544444, 5446.400895901447, 5677.914831277534, 5715.142728590745, 5796.449337312949, 5815.709214539256, 5831.504322132666, 5391.353037635509, 5431.049566325877, 5432.158015507603, 5477.67133971963, 5485.369182544058, 5009.0983622948215, 5012.423571289275, 5015.122353588107, 5017.448080711119, 5058.924116138187, 5824.912626310609, 5930.970345148246, 5938.584299099021, 5990.251218597676, 5993.130996005555, 5836.387179346278, 5867.911981320369, 5875.236219291465, 5916.112583112395, 5934.080217566284, 6027.246594175728, 6036.758529658764, 6044.486218671286, 6044.607100538451, 6057.909131363122, 5489.176623506506, 5689.061304884814, 5705.572082093942, 5755.683437410982, 5756.884862302814, 5838.620489668158, 5904.793332233351, 5911.615744976562, 5953.76184952597, 5963.194968679173, 5674.4609262121685, 5716.0, 5718.628289161191, 5733.283339582552, 5765.855853603525, 5521.834344969658, 5553.08374118266, 5742.08126699726, 5753.741081651252, 5755.942440575708, 5503.064479038493, 5592.748326325406, 5595.8880822384135, 5631.0, 5645.548356131418, 5604.159376093456, 5639.013172694844, 5662.490375866192, 5699.829005129853, 5705.800296989585, 5413.53984911287, 5481.561475081904, 5502.504774570308, 5509.393966663744, 5529.30883639545], "value": 5336.981358397036, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.6426144313413, 618.1222663817379, 640.3308542573011, 643.462708638287, 653.61110139467, 31994.0, 32354.514682279783, 43805.561944380504, 44442.33336499947, 44600.553994460046, 46135.30797038047, 46461.535384646144, 46664.0, 46671.76664116683, 46716.53283467164, 8782.38523303369, 8959.686410975617, 8962.820743585124, 8965.865512017292, 8969.77575560613, 8922.955385223066, 9013.684521041765, 9014.86477702835, 9021.36850420471, 9024.413413128159, 8993.955030224839, 9040.547972601344, 9049.819003619923, 9061.546922653873, 9061.818763624724, 8960.955195224014, 8999.145081217273, 9020.594073266719, 9037.322200834931, 9050.683226087056, 8879.422837515542, 8903.821923561558, 8951.104889511062, 8956.910430895672, 8957.283417326598, 44100.55899440996, 44153.33769993453, 44284.335734964, 44455.33317000248, 44536.55463445356, 3437.74216933731, 3470.6008808987035, 3509.3507701075127, 3656.323580137683, 4416.381706561084, 33479.33041339184, 33494.49758253628, 33696.32607347839, 34045.127517986504, 34066.148346291295, 4386.6929314947965, 4430.4240448741775, 4431.426089115055, 4512.796924138422, 4656.674032817704, 262361.0, 263884.0, 263927.0, 263972.0, 265346.0, 59081.704591476766, 59161.0, 59517.0, 59576.0, 59595.10607340893, 62052.37947620556, 62069.68965155145, 62270.44323891939, 62271.68864155741, 62580.374196258366, 15141.848581514265, 15363.539093827203, 15367.692646147014, 15371.077735335915, 15379.61550961235, 11879.940600297115, 11960.222585531912, 11964.162508624488, 11964.40177991097, 11972.341521216242, 14625.195614241318, 16280.67438651244, 16309.266083026292, 16363.263653135638, 16566.917165414096, 6330.651814150266, 6494.772682956074, 6494.805155845333, 6527.836804079936, 6708.731650734014, 733.7870760663594, 1017.3793985668736, 1052.9789404211872, 1131.4569006876745, 1174.2836869509592, 33392.0, 33934.49098263528, 34008.829955850066, 34352.48471272933, 34676.47985280223, 1100.6367898593605, 1118.7315044389288, 1160.4719852467108, 1176.823476478518, 1243.1360204657856, 17288.394906178222, 17582.560435989202, 17793.7330940036, 17797.555061123316, 17802.732959005625, 539812.0, 545349.0, 545715.0, 545963.0, 547814.0, 61603.69198153981, 61735.0, 61737.07394389088, 61862.0, 61876.69061654663, 1234.4259919137644, 1343.3081962789172, 1351.1825345665927, 1358.0290092583652, 1388.590365842079, 31570.36859262756, 35537.466937995436, 36059.459108112875, 36205.63794362128, 36303.27393452169, 54225.45774542362, 54815.72592137014, 54901.0, 55138.448615513335, 55148.0, 523108.0, 529838.0, 530049.0, 530728.0, 531818.0, 37148.844052330925, 38029.239415210985, 44815.32777008413, 47342.52657473381, 47837.76081119711, 50078.24882626836, 50362.2445663308, 50437.747811260706, 50772.74613626908, 51549.226761597856, 42264.0, 43215.0, 43847.78076109599, 44389.77805110954, 45099.09801804011, 43338.56661433471, 43883.561164387946, 44210.33684494671, 44758.55241447544, 44820.32769508395, 43211.56788432076, 44670.77664611656, 44997.55002450065, 45098.77450612726, 45293.0, 36437.27125457529, 38307.0, 38757.0, 39341.0, 39730.0, 29627.703722962495, 29677.5548366779, 29913.85043074771, 29986.0, 30249.848750756104], "value": 20663.003326714483, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.30380536494056, 382.69766884161515, 393.73029474809755, 394.21944549791397, 403.9656629186519, 18664.440066797983, 19393.224271029176, 20146.697799533, 20315.187392504282, 20324.08541615629, 18699.158537865795, 19391.903040484813, 19746.70379944302, 19856.007199639997, 19863.702044469308, 5634.126710359901, 5798.449147331018, 5848.941510584904, 7190.101237345332, 7542.924570754277, 7244.71021159153, 7488.588127653004, 7559.395248380144, 7566.39468842494, 7568.697252109909, 7496.100467943855, 7617.542947423172, 7650.923490765104, 7654.081510218782, 7661.578613176301, 7388.889166662504, 7585.924140758577, 7603.733869314575, 7644.961775191144, 7673.808154796119, 7182.928170718278, 7352.375048120916, 7423.183449820515, 7428.9628551856895, 7430.256974302581, 26479.205623831123, 26709.19872403831, 27122.18633441, 27173.456530869273, 27176.0, 2425.575524283261, 2594.1828324077856, 2640.828346157513, 2712.1727872998727, 2712.796540259488, 16087.839121608751, 16260.83739162605, 16323.0, 16523.6695266094, 16856.662866742718, 2065.483629092727, 2202.812760915324, 2214.070090561968, 2218.9001494932604, 2249.246502421691, 63178.0, 80645.59677201576, 92101.07898920993, 99276.50361748217, 101590.49204753929, 17689.0, 17791.110444477985, 18339.908300458414, 18502.334789868975, 18513.90743046303, 32466.35067298641, 32567.51148732771, 32575.18562035968, 32612.67387326144, 32636.347273054882, 8582.0, 9284.303677224236, 9527.857082143773, 9579.808403831885, 9782.070703283176, 7878.251566101211, 7934.880976785353, 8167.101618821925, 8195.098539160688, 8227.053888802864, 8836.690715824916, 8856.3800533962, 9075.863862041942, 9274.768130796649, 9357.111074447917, 3308.569885914864, 3550.804705741209, 3610.855565777392, 3647.598764135943, 3652.945205821915, 919.6275508418967, 952.8904176019846, 999.9500024998721, 1043.7442826507402, 1061.8354155105972, 20269.695954560695, 20397.38807835767, 20580.382588522367, 20608.896955515425, 20977.58044839125, 990.8365119755304, 1035.7980193862275, 1045.4981608827804, 1064.387976913278, 1074.7635520185547, 10502.369857808402, 11363.090952723762, 11431.942840285745, 11438.428078596036, 11441.370724610226, 373229.0, 377694.0, 377955.0, 499775.0, 506021.0, 103388.52560641516, 104735.4763226179, 104811.0, 107634.0, 110222.0, 1010.2826992835022, 1010.6563768318807, 1053.2995557953875, 1061.9256652034437, 1071.5445935477392, 17551.210195541487, 18198.818011820244, 18634.534136646693, 18634.906825465787, 18924.52688682739, 44429.0, 44806.3279050808, 44917.550824491336, 45859.54140458553, 47324.76337618427, 52515.47484525259, 62291.688541557, 63681.36318636754, 64047.67976160089, 65647.67176164089, 11910.344931028876, 12375.62873113808, 12500.06249531307, 12631.87368126307, 13068.411921463747, 14225.573232803032, 14252.572422827332, 14355.425782968565, 14402.351894164578, 14514.491992780202, 11931.522739090338, 12259.570915017932, 12266.75466490683, 12668.873311267138, 12896.871031289567, 8187.345012399113, 8192.262696357357, 8425.95787021061, 8577.614007369808, 8624.353173512138, 8272.090070092165, 8522.190391912758, 8610.526421046652, 8731.738047858575, 8789.165029322205, 11264.887351126385, 12363.443645035815, 12409.75180496367, 12468.812967805308, 12659.303738294482, 8369.66521339164, 8497.362697797565, 12027.218230815319, 12260.203086799329, 12349.93825030869], "value": 10715.412591922011, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1378.9931050344746, 1500.4373359990004, 1535.7235697574438, 1676.9161541922908, 1797.92124725165, 8384.580770961451, 8774.912250877498, 8799.032106468292, 8900.6204038374, 8949.060348663394, 8839.24866386358, 8869.37914345996, 8930.330225233101, 8955.552222388887, 9002.32482563807, 2079.5321052763156, 2320.93037208884, 2351.8706471144037, 2375.762423757619, 2378.4410663494064, 2352.294311706481, 2372.727136379321, 2374.6081896487144, 2377.0135393811547, 2379.4527258730504, 2355.5642206191824, 2355.7997570206467, 2357.693499845018, 2362.681038059857, 2404.146527982567, 1986.980130198694, 2053.3121404329568, 2361.480474295652, 2368.96446553301, 2370.0756704885107, 2046.6725323948097, 2186.0, 2251.133313674231, 2255.560165767676, 2265.2411442166895, 8785.297176225951, 8823.779405514913, 8824.69113581028, 8836.0, 8843.336749743796, 5197.350331208599, 5296.894062118775, 5334.893302133974, 5357.43746906577, 5368.812091576776, 3236.6277878044093, 3346.0798280472823, 3412.6416726243633, 3461.4288642373976, 3462.2036931505895, 1104.0560320925654, 1107.1143085531623, 1112.1603189591888, 1120.843081968525, 1123.3484578944274, 12361.93819030899, 12457.626271211879, 12503.937480312541, 12506.937465312707, 12518.874811251862, 4417.7791110445, 4611.469680986663, 4670.299455081765, 4749.95250047502, 4763.571278584944, 9786.266030047775, 9796.363236389754, 9805.656802011896, 9870.457124858201, 9891.258155638356, 5209.739513024334, 5209.895802083937, 5210.7915683373, 5220.634555581073, 5220.765065572058, 4043.3934909763184, 4275.0, 4701.95298047022, 4831.73425461603, 4847.200211965057, 3755.342815007363, 3839.9808000959815, 3951.1900060487533, 3962.227365663726, 4029.6977726670616, 1095.2169199022578, 1100.3233011697907, 1100.5872797700863, 1106.4910141334915, 1148.7530181011123, 916.5005072235648, 993.3443927008284, 999.3211404839939, 1027.1320733979776, 1051.7475805806705, 6116.0, 6132.080187971751, 6154.261488621394, 6159.84600384985, 6364.204474440695, 472.78724573941867, 491.64847134298435, 492.97535123243694, 501.7039946431623, 1055.266589720137, 4260.616544510947, 4392.934105988413, 4404.0, 4434.17967675981, 4454.37638730578, 10899.346039237671, 11202.607908723156, 11247.775044499227, 11302.660920172408, 11336.43317834105, 11119.833202501968, 11150.49822757978, 11162.832557511643, 11167.83248251277, 11190.272632278877, 7663.731769388045, 7682.615869206629, 8043.39674524413, 8053.1141574426765, 8208.466449680871, 6289.874202516015, 6343.492520598434, 6452.645104519296, 6458.418742313214, 6507.893658078233, 10200.795984080129, 10305.484725763832, 10306.12397946183, 10487.580496780349, 10509.527071281658, 9172.35793494449, 9461.195798357217, 10186.694399168036, 10388.220883433622, 10650.360978341325, 7469.327760501581, 7643.0, 7670.0795904491815, 7854.9399549788295, 7936.444448888753, 8736.602143656984, 8818.118188181386, 8864.379493435397, 8887.822243555222, 8894.33292503052, 7664.770056898302, 7684.3084122429245, 7698.384129269757, 7785.416093792875, 7789.805254868674, 7591.620418978919, 7627.618619068913, 7646.464747467624, 7782.221777822172, 7890.0, 7218.783436496913, 7245.963770181115, 7266.600336981517, 7272.745453909088, 7286.599237042014, 5158.09733296664, 5171.612129090258, 5265.657732247391, 5375.81184658535, 5376.919346209888, 5209.296744939385, 5216.895662086661, 5224.754077947951, 5269.499397557226, 5436.266104076058], "value": 4597.573693347749, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.27686259641, 324.95775549178603, 329.15735716565587, 330.8180500724602, 332.24580202939313, 5275.1296036154035, 5345.305110335656, 5349.5185433311, 5363.168708850125, 5364.141737322029, 5253.474652534745, 5270.710110943896, 5313.495217954298, 5320.893582128355, 5335.813246536372, 4065.369867670501, 4147.2203583588125, 4176.60322269384, 4202.747835129887, 4224.302990006645, 4136.0, 4156.91686166278, 4170.77060761658, 4171.707980441371, 4184.748915065091, 4113.177364527091, 4117.835286588533, 4133.9173216535655, 4134.449581406972, 4150.58494150584, 3876.8255428505786, 3978.4827972363696, 4107.958920410788, 4184.309588917825, 4184.769837658928, 3625.8730944417084, 3635.363811333006, 3640.927181456356, 3652.470391793175, 3682.668559829628, 5076.213186956028, 5114.846554603368, 5131.332926719502, 5136.357955255593, 5137.948620513822, 4498.50516443191, 4570.268756998864, 4737.976310118462, 4742.122707299126, 4759.143354196243, 5444.3194600674915, 5471.5896307777075, 5474.233607294982, 5483.259759932398, 5488.945110548923, 4052.4124002019835, 4068.2880495913096, 4070.6743460523385, 4071.633552980246, 4078.1028173801715, 5656.377798442168, 5734.8279551613105, 5760.2511673482595, 5766.192733017339, 5788.131780232957, 4107.199096176217, 4112.835486580563, 4114.958850411457, 4150.306227457565, 4179.6029377209115, 4218.367244913287, 4220.303649897794, 4222.303319952173, 4224.598663126998, 4227.0, 4633.49031606523, 4717.693349932243, 4764.95235047652, 4768.523147685204, 4789.425268967746, 5507.5593952483705, 5509.834704958857, 5512.862178445571, 5522.806701765499, 5581.134924086773, 1400.3278426355407, 1428.7499687554637, 1436.3392839294042, 1459.3870574358796, 1460.4158336665207, 911.8267529169436, 958.3435346787472, 961.0101595356793, 962.5043102802063, 973.8003709239589, 4719.867231864328, 4760.500147484534, 4809.398825146856, 4827.879303017453, 4839.685420447659, 5002.1496345621335, 5010.3737032870895, 5016.272640467112, 5022.547970682656, 5035.496450355008, 4573.405457290531, 4786.880327991828, 4794.017226468565, 4809.759512024385, 4833.685810422311, 2713.6879258885087, 2894.522403803391, 2958.8520573971214, 2968.625099920055, 2979.6275465566805, 5687.317521897316, 5804.158397032406, 5867.618604790675, 5897.675627840425, 5910.704464776744, 5571.220029195916, 5719.7426115824055, 5746.13807928814, 5831.271091113611, 5858.414158584107, 5786.681732504669, 5810.912836307459, 5811.79658711943, 5825.708474711774, 5829.708514574169, 5633.63381380209, 5648.745806438638, 5657.2928383952, 5657.575681823797, 5674.77300907959, 5374.193870919394, 5621.747021383966, 5632.774689012557, 5665.631733937281, 5680.602357834912, 5792.21805056312, 5833.82498525045, 5836.0, 5862.882742345215, 5905.2913650360515, 4049.57479464652, 4066.877993660195, 4070.1656160486436, 4075.449814275035, 4077.327241005201, 5374.919376209438, 5625.718714064198, 5697.743601537858, 5711.857628474405, 5728.598998070095, 5559.416261292506, 5582.944170558242, 5583.944160558342, 5588.161775733673, 5649.830505084854, 5357.410684824744, 5578.8047418341785, 5579.721013949367, 5593.881223755184, 5612.85967850807, 5513.669179849061, 5525.917111243254, 5527.613067085265, 5530.391656917655, 5538.529225015919, 5607.0, 5621.747021383966, 5655.4910058094965, 5660.37735849048, 5687.146927960839, 5196.220566914993, 5447.945520544744, 5451.155070964007, 5486.835394938158, 5558.194061860927], "value": 4199.2786527739345, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.2275072549186, 807.1807115777483, 819.9016118065829, 844.4004756622797, 849.6176720475784, 13583.864161358384, 14401.927990360047, 14406.639834004129, 14427.567172984802, 14445.566633001014, 13414.66463338417, 14331.140131592112, 14444.5666630001, 14451.494197703056, 14507.49223777168, 676.3067855448156, 812.910579836219, 826.7271800305884, 833.5123952487802, 836.2014276366056, 789.794653390117, 812.8211793405471, 823.6293667849462, 826.9338452923752, 827.5613924619961, 860.1957170045996, 862.3230763850379, 863.2834747159842, 863.6243234193146, 863.6502216602286, 693.3136195166799, 855.4140413816556, 859.866720658299, 859.8839156713857, 860.535310932096, 606.2997238189897, 612.4977518434886, 624.7157543317779, 626.7305058824703, 628.9905651415232, 14041.859581404158, 14065.36705848229, 14081.436742530286, 14090.647733806634, 14125.364358603887, 13784.172949623055, 13894.0, 14271.357788899524, 14282.500112496013, 14488.855111448962, 12965.481380744759, 13073.15024523403, 13148.211107333591, 13216.537421190213, 13558.322083895864, 4305.418768466279, 4339.956600434019, 4433.1577000369825, 4448.9544956935415, 4581.473130589991, 74234.0, 74494.25505744982, 75876.0, 77493.83759243673, 79069.0, 11016.889831101586, 11057.0, 11156.219064665396, 11416.885831141748, 11422.543098275975, 19525.121369538403, 19654.0, 19697.113629886688, 19703.802961970196, 19776.0, 7455.776326710099, 7471.476996610294, 7613.505122167041, 7741.961290193513, 7881.960590197127, 4232.746035237896, 4253.2769429197115, 4305.526392096866, 4311.374850646639, 4391.538888416734, 3376.1053320869987, 3438.2607739336163, 3440.569928758905, 3459.965400345964, 3472.392331342005, 620.7734177025444, 627.1564745417406, 627.4541149200224, 631.3307893632764, 635.841039740065, 699.993000070003, 711.8398360368875, 711.9537230080028, 725.3326939215934, 768.7347864986571, 9348.392354496937, 9831.262655300881, 10008.099271065494, 10100.393976361442, 10131.0, 542.6852425593147, 589.6904125334148, 596.260636810352, 621.8289970258215, 662.5163630549629, 4439.955600444019, 4743.976280118577, 4816.277558366273, 4838.782254798542, 4841.080194763054, 114515.42742286235, 114600.0, 114860.0, 118840.40579797045, 121613.39193303976, 61527.38472615306, 89322.0, 91944.54027729819, 100864.49567752115, 102466.48766756267, 78134.21865781384, 80153.99999999884, 88488.0, 91901.5404922971, 91910.54044729733, 9503.572339244889, 9954.900450995687, 10151.187904967437, 10231.59073637076, 10315.432651203955, 52961.47038529565, 54507.18239226494, 54768.0, 55881.0, 56033.439665604456, 70586.6470667664, 79662.6016869912, 79973.20026799891, 80865.59567202361, 82080.0, 12198.451069702061, 12237.571684990982, 12291.078169137529, 12425.565105221274, 12443.377831108228, 14307.92846035763, 14409.711805764036, 14510.056846304957, 14945.02857314271, 14972.925135374253, 13582.728345432839, 13593.388297526437, 13623.659408514866, 14052.297385130498, 14718.55844324672, 13005.674858128623, 13057.21656700601, 13166.407511661806, 13244.337783110614, 13748.0, 12530.185537940004, 13001.219926804422, 13258.734825303247, 13346.799798003232, 13355.0, 10338.689839304832, 10491.895081049091, 10581.4709264538, 10874.184436167478, 11013.339199648046, 11249.212555121063, 11418.429078545872, 11519.214521749142, 11670.70823229426, 11763.176577639482], "value": 7473.942145853514, "unit": "score"}], "name": "dromaeo_css", "value": 7446.748542792102, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 112.0, 110.0, 110.0, 112.0, 109.0, 110.0, 111.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 115.0, 119.0, 183.0, 116.0, 119.0, 148.0, 116.0, 160.0, 122.0], "value": 134.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 164.0, 160.0, 160.0, 159.0, 161.0, 162.0, 162.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 110.0, 75.0, 75.0, 75.0, 74.0, 97.0, 75.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 111.0, 84.0, 83.0, 83.0, 134.0, 83.0, 83.0, 119.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 51.0, 51.0, 50.0, 50.0, 50.0, 50.0, 52.0, 49.0, 50.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 62.0, 63.0, 63.0, 63.0, 63.0, 63.0, 65.0, 64.0], "value": 63.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 81.0, 76.0, 75.0, 76.0, 81.0, 76.0, 75.0, 75.0, 80.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 119.0, 120.0, 124.0, 118.0, 118.0, 125.0, 127.0, 199.0, 123.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 158.0, 158.0, 155.0, 157.0, 157.0, 156.0, 155.0, 155.0], "value": 157.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 63.0, 64.0, 63.0, 63.0, 62.0, 62.0, 62.0, 61.0, 61.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1480.6000000000001, "alertThreshold": 2.0}]} 08:26:45 INFO - Return code: 0 08:26:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:26:45 INFO - # TBPL SUCCESS # 08:26:45 INFO - Running post-action listener: _resource_record_post_action 08:26:45 INFO - [mozharness: 2016-07-21 15:26:45.972208Z] Finished run-tests step (success) 08:26:45 INFO - Running post-run listener: _resource_record_post_run 08:26:46 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 221184; Write bytes: 553123840; Read time: 60; Write time: 515352 08:26:46 INFO - TinderboxPrint: CPU usage
13.1% 08:26:46 INFO - TinderboxPrint: I/O read bytes / time
221,184 / 60 08:26:46 INFO - TinderboxPrint: I/O write bytes / time
553,123,840 / 515,352 08:26:46 INFO - TinderboxPrint: CPU idle
8,278.4 (86.9%) 08:26:46 INFO - TinderboxPrint: CPU user
1,196.4 (12.6%) 08:26:46 INFO - TinderboxPrint: Swap in / out
0 / 0 08:26:46 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 257429504; Read time: 0; Write time: 293304 08:26:46 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 217088; Write bytes: 295694336; Read time: 48; Write time: 222048 08:26:46 INFO - Running post-run listener: _upload_blobber_files 08:26:46 INFO - Blob upload gear active. 08:26:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:26:46 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 08:26:46 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'] 08:26:46 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 08:26:47 INFO - (blobuploader) - INFO - Open directory for files ... 08:26:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:26:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:27:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:27:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:27:06 INFO - (blobuploader) - INFO - Done attempting. 08:27:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:27:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:27:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:27:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:27:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:27:06 INFO - (blobuploader) - INFO - Done attempting. 08:27:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:27:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:27:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:27:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:27:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:27:07 INFO - (blobuploader) - INFO - Done attempting. 08:27:07 INFO - (blobuploader) - INFO - Iteration through files over. 08:27:07 INFO - Return code: 0 08:27:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:27:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:27:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/377a25b946856e524dbb4e7a430f9b334d168cffde98297a3ce4aa044de298a6dd0ced392acb0a317458a49b8b74047fb8264d2f2de0286507f0b6eb3fd3aa6b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c04406939891b9fc91cc16071d80990d49f0404bd75f8fdcf0d77eddae4b0119ba58644936ef6f6d8a88e9e98cace96542c234c57390e520be27896de7366123", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ede656c3c98342054fea868151de8b341d1d037c83da4b0667f8fc61a00ced059df2ca5c7e934365dbdd67c4889bc67851922cdbaca83e6b32eae46fe2d60aa"} 08:27:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:27:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:27:07 INFO - Contents: 08:27:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/377a25b946856e524dbb4e7a430f9b334d168cffde98297a3ce4aa044de298a6dd0ced392acb0a317458a49b8b74047fb8264d2f2de0286507f0b6eb3fd3aa6b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c04406939891b9fc91cc16071d80990d49f0404bd75f8fdcf0d77eddae4b0119ba58644936ef6f6d8a88e9e98cace96542c234c57390e520be27896de7366123", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ede656c3c98342054fea868151de8b341d1d037c83da4b0667f8fc61a00ced059df2ca5c7e934365dbdd67c4889bc67851922cdbaca83e6b32eae46fe2d60aa"} 08:27:07 INFO - Running post-run listener: copy_logs_to_upload_dir 08:27:07 INFO - Copying logs to upload dir... 08:27:07 INFO - mkdir: /builds/slave/test/build/upload/logs 08:27:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.780744 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-07-21 08:27:07.666236) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 08:27:07.669836) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1469112409.232860-661854431 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/377a25b946856e524dbb4e7a430f9b334d168cffde98297a3ce4aa044de298a6dd0ced392acb0a317458a49b8b74047fb8264d2f2de0286507f0b6eb3fd3aa6b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c04406939891b9fc91cc16071d80990d49f0404bd75f8fdcf0d77eddae4b0119ba58644936ef6f6d8a88e9e98cace96542c234c57390e520be27896de7366123", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ede656c3c98342054fea868151de8b341d1d037c83da4b0667f8fc61a00ced059df2ca5c7e934365dbdd67c4889bc67851922cdbaca83e6b32eae46fe2d60aa"} build_url:https://queue.taskcluster.net/v1/task/D9p2TwMLRE68OP2iMqXDrA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011457 build_url: 'https://queue.taskcluster.net/v1/task/D9p2TwMLRE68OP2iMqXDrA/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/377a25b946856e524dbb4e7a430f9b334d168cffde98297a3ce4aa044de298a6dd0ced392acb0a317458a49b8b74047fb8264d2f2de0286507f0b6eb3fd3aa6b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c04406939891b9fc91cc16071d80990d49f0404bd75f8fdcf0d77eddae4b0119ba58644936ef6f6d8a88e9e98cace96542c234c57390e520be27896de7366123", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5ede656c3c98342054fea868151de8b341d1d037c83da4b0667f8fc61a00ced059df2ca5c7e934365dbdd67c4889bc67851922cdbaca83e6b32eae46fe2d60aa"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 08:27:07.695592) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 08:27:07.695936) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1469112409.232860-661854431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 08:27:07.780219) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 08:27:07.780545) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 08:27:07.780840) ========= ========= Total master_lag: 0.15 =========