builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-034 starttime: 1469186840.56 results: success (0) buildid: 20160722031926 builduid: fd75585090834f429ea9e214d5121ff5 revision: 129c925e216d801c622922a669e720dc1d5fb5a5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 04:27:20.564757) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 04:27:20.565320) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 04:27:20.565654) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 04:27:20.664444) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 04:27:20.664756) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1469186838.60492-1747539257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-22 04:27:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.3M=0s 2016-07-22 04:27:20 (67.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.270685 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 04:27:20.950707) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 04:27:20.951081) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1469186838.60492-1747539257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.074405 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 04:27:21.039566) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-22 04:27:21.039977) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 129c925e216d801c622922a669e720dc1d5fb5a5 --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 129c925e216d801c622922a669e720dc1d5fb5a5 --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=d6bbd613908ccac0c6c9cb47000001f7-1469186838.60492-1747539257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-22 04:27:21,094 truncating revision to first 12 chars 2016-07-22 04:27:21,094 Setting DEBUG logging. 2016-07-22 04:27:21,094 attempt 1/10 2016-07-22 04:27:21,094 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/129c925e216d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-22 04:27:22,008 unpacking tar archive at: fx-team-129c925e216d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.263979 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-22 04:27:22.322656) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 04:27:22.323532) ========= script_repo_revision: 129c925e216d801c622922a669e720dc1d5fb5a5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 04:27:22.324542) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 04:27:22.325289) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 04:27:22.336954) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-22 04:27:22.337276) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=d6bbd613908ccac0c6c9cb47000001f7-1469186838.60492-1747539257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:27:22 INFO - MultiFileLogger online at 20160722 04:27:22 in /builds/slave/test 04:27:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:27:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:27:22 INFO - {'append_to_log': False, 04:27:22 INFO - 'base_work_dir': '/builds/slave/test', 04:27:22 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:27:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:27:22 INFO - 'branch': 'Fx-Team-Non-PGO', 04:27:22 INFO - 'buildbot_json_path': 'buildprops.json', 04:27:22 INFO - 'config_files': ('talos/linux_config.py',), 04:27:22 INFO - 'default_actions': ('clobber', 04:27:22 INFO - 'read-buildbot-config', 04:27:22 INFO - 'download-and-extract', 04:27:22 INFO - 'populate-webroot', 04:27:22 INFO - 'create-virtualenv', 04:27:22 INFO - 'install', 04:27:22 INFO - 'run-tests'), 04:27:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:27:22 INFO - 'download_minidump_stackwalk': True, 04:27:22 INFO - 'download_symbols': 'ondemand', 04:27:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:27:22 INFO - 'tooltool.py': '/tools/tooltool.py', 04:27:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:27:22 INFO - '/tools/misc-python/virtualenv.py')}, 04:27:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:27:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:27:22 INFO - 'installer_path': 'installer.exe', 04:27:22 INFO - 'log_level': 'info', 04:27:22 INFO - 'log_name': 'talos', 04:27:22 INFO - 'log_to_console': True, 04:27:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:27:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:27:22 INFO - 'opt_config_files': (), 04:27:22 INFO - 'pip_index': False, 04:27:22 INFO - 'sps_profile': False, 04:27:22 INFO - 'sps_profile_interval': 0, 04:27:22 INFO - 'suite': 'dromaeojs-e10s', 04:27:22 INFO - 'system_bits': '32', 04:27:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:27:22 INFO - 'title': 'talos-linux64-ix-034', 04:27:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:27:22 INFO - 'use_talos_json': True, 04:27:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:27:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:27:22 INFO - 'work_dir': 'build'} 04:27:22 INFO - [mozharness: 2016-07-22 11:27:22.701900Z] Running clobber step. 04:27:22 INFO - Running pre-action listener: _resource_record_pre_action 04:27:22 INFO - Running main action method: clobber 04:27:22 INFO - rmtree: /builds/slave/test/build 04:27:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:27:24 INFO - Running post-action listener: _resource_record_post_action 04:27:24 INFO - [mozharness: 2016-07-22 11:27:24.938191Z] Finished clobber step (success) 04:27:24 INFO - [mozharness: 2016-07-22 11:27:24.938381Z] Running read-buildbot-config step. 04:27:24 INFO - Running pre-action listener: _resource_record_pre_action 04:27:24 INFO - Running main action method: read_buildbot_config 04:27:24 INFO - Using buildbot properties: 04:27:24 INFO - { 04:27:24 INFO - "project": "", 04:27:24 INFO - "product": "firefox", 04:27:24 INFO - "script_repo_revision": "production", 04:27:24 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:27:24 INFO - "repository": "", 04:27:24 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 04:27:24 INFO - "buildid": "20160722031926", 04:27:24 INFO - "pgo_build": "False", 04:27:24 INFO - "basedir": "/builds/slave/test", 04:27:24 INFO - "buildnumber": 1501, 04:27:24 INFO - "slavename": "talos-linux64-ix-034", 04:27:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:27:24 INFO - "platform": "ubuntu64_hw", 04:27:24 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:27:24 INFO - "branch": "fx-team", 04:27:24 INFO - "repo_path": "integration/fx-team", 04:27:24 INFO - "revision": "129c925e216d801c622922a669e720dc1d5fb5a5", 04:27:24 INFO - "stage_platform": "linux64", 04:27:24 INFO - "builduid": "fd75585090834f429ea9e214d5121ff5", 04:27:24 INFO - "slavebuilddir": "test" 04:27:24 INFO - } 04:27:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/NMwYwfpFTgW3dMIbuGUezA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:27:24 INFO - Running post-action listener: _resource_record_post_action 04:27:24 INFO - [mozharness: 2016-07-22 11:27:24.942791Z] Finished read-buildbot-config step (success) 04:27:24 INFO - [mozharness: 2016-07-22 11:27:24.942946Z] Running download-and-extract step. 04:27:24 INFO - Running pre-action listener: _resource_record_pre_action 04:27:24 INFO - Running main action method: download_and_extract 04:27:24 INFO - mkdir: /builds/slave/test/build/tests 04:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:27:24 INFO - https://queue.taskcluster.net/v1/task/NMwYwfpFTgW3dMIbuGUezA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:27:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMwYwfpFTgW3dMIbuGUezA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:27:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMwYwfpFTgW3dMIbuGUezA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:27:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMwYwfpFTgW3dMIbuGUezA/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 04:27:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMwYwfpFTgW3dMIbuGUezA/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 04:27:25 INFO - Downloaded 1361 bytes. 04:27:25 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:27:25 INFO - Using the following test package requirements: 04:27:25 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:27:25 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:27:25 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:27:25 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:25 INFO - u'jsshell-linux-x86_64.zip'], 04:27:25 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:27:25 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:27:25 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:27:25 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:27:25 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:27:25 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:27:25 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:27: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')]} 04:27:25 INFO - https://queue.taskcluster.net/v1/task/NMwYwfpFTgW3dMIbuGUezA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:27:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMwYwfpFTgW3dMIbuGUezA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:27:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMwYwfpFTgW3dMIbuGUezA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:27:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMwYwfpFTgW3dMIbuGUezA/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 04:27:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMwYwfpFTgW3dMIbuGUezA/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 04:27:26 INFO - Downloaded 22737593 bytes. 04:27:26 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'] 04:27:26 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 04:27:28 INFO - Return code: 0 04:27:28 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 04:27:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:27:28 INFO - https://queue.taskcluster.net/v1/task/NMwYwfpFTgW3dMIbuGUezA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:27:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMwYwfpFTgW3dMIbuGUezA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:27:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMwYwfpFTgW3dMIbuGUezA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:27:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMwYwfpFTgW3dMIbuGUezA/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 04:27:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMwYwfpFTgW3dMIbuGUezA/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 04:27:29 INFO - Downloaded 22737593 bytes. 04:27:29 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'] 04:27:29 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 04:27:31 INFO - Return code: 0 04:27: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')]} 04:27:31 INFO - https://queue.taskcluster.net/v1/task/NMwYwfpFTgW3dMIbuGUezA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:27:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMwYwfpFTgW3dMIbuGUezA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:27:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMwYwfpFTgW3dMIbuGUezA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:27:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMwYwfpFTgW3dMIbuGUezA/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 04:27:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMwYwfpFTgW3dMIbuGUezA/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 04:27:32 INFO - Downloaded 14403289 bytes. 04:27:32 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'] 04:27:32 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 04:27:32 INFO - Return code: 0 04:27:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:27:32 INFO - https://queue.taskcluster.net/v1/task/NMwYwfpFTgW3dMIbuGUezA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:27:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMwYwfpFTgW3dMIbuGUezA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:27:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMwYwfpFTgW3dMIbuGUezA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:27:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMwYwfpFTgW3dMIbuGUezA/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 04:27:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NMwYwfpFTgW3dMIbuGUezA/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 04:27:34 INFO - Downloaded 57161826 bytes. 04:27:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NMwYwfpFTgW3dMIbuGUezA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:27:34 INFO - mkdir: /builds/slave/test/properties 04:27:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:27:34 INFO - Writing to file /builds/slave/test/properties/build_url 04:27:34 INFO - Contents: 04:27:34 INFO - build_url:https://queue.taskcluster.net/v1/task/NMwYwfpFTgW3dMIbuGUezA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:27:35 INFO - Running post-action listener: _resource_record_post_action 04:27:35 INFO - Running post-action listener: set_extra_try_arguments 04:27:35 INFO - [mozharness: 2016-07-22 11:27:35.592845Z] Finished download-and-extract step (success) 04:27:35 INFO - [mozharness: 2016-07-22 11:27:35.593085Z] Running populate-webroot step. 04:27:35 INFO - Running pre-action listener: _resource_record_pre_action 04:27:35 INFO - Running main action method: populate_webroot 04:27:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:27:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:27:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:27:35 INFO - '--tppagecycles', 04:27:35 INFO - '7'], 04:27:35 INFO - 'tests': ['tsvgm']}}, 04:27:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:27:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:27:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:27:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:27:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:27:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:27:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:35 INFO - 'talos_options': ['--disable-e10s'], 04:27:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:27:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:27:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:35 INFO - 'talos_options': ['--disable-e10s'], 04:27:35 INFO - 'tests': ['damp', 'tps']}, 04:27:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:35 INFO - 'tests': ['damp', 'tps']}, 04:27:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:27:35 INFO - 'tests': ['dromaeo_dom']}, 04:27:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:27:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:27:35 INFO - 'tests': ['basic_compositor_video']}, 04:27:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:27:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:27:35 INFO - 'tests': ['a11yr', 04:27:35 INFO - 'ts_paint', 04:27:35 INFO - 'tpaint', 04:27:35 INFO - 'sessionrestore', 04:27:35 INFO - 'sessionrestore_no_auto_restore', 04:27:35 INFO - 'tabpaint']}, 04:27:35 INFO - 'other-e10s': {'tests': ['a11yr', 04:27:35 INFO - 'ts_paint', 04:27:35 INFO - 'tpaint', 04:27:35 INFO - 'sessionrestore', 04:27:35 INFO - 'sessionrestore_no_auto_restore', 04:27:35 INFO - 'tabpaint']}, 04:27:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:27:35 INFO - 'ts_paint', 04:27:35 INFO - 'tpaint', 04:27:35 INFO - 'sessionrestore', 04:27:35 INFO - 'sessionrestore_no_auto_restore', 04:27:35 INFO - 'tabpaint']}, 04:27:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:27:35 INFO - 'ts_paint', 04:27:35 INFO - 'tpaint', 04:27:35 INFO - 'sessionrestore', 04:27:35 INFO - 'sessionrestore_no_auto_restore', 04:27:35 INFO - 'tabpaint']}, 04:27:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:27:35 INFO - 'tests': ['a11yr', 04:27:35 INFO - 'ts_paint', 04:27:35 INFO - 'tpaint', 04:27:35 INFO - 'sessionrestore', 04:27:35 INFO - 'sessionrestore_no_auto_restore', 04:27:35 INFO - 'tabpaint']}, 04:27:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:27:35 INFO - 'tests': ['a11yr', 04:27:35 INFO - 'ts_paint', 04:27:35 INFO - 'tpaint', 04:27:35 INFO - 'sessionrestore', 04:27:35 INFO - 'sessionrestore_no_auto_restore', 04:27:35 INFO - 'tabpaint']}, 04:27:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:27:35 INFO - 'tests': ['tsvgx', 04:27:35 INFO - 'tsvgr_opacity', 04:27:35 INFO - 'tart', 04:27:35 INFO - 'tscrollx', 04:27:35 INFO - 'cart']}, 04:27:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:27:35 INFO - 'tsvgr_opacity', 04:27:35 INFO - 'tart', 04:27:35 INFO - 'tscrollx', 04:27:35 INFO - 'cart']}, 04:27:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:35 INFO - 'talos_options': ['--disable-e10s'], 04:27:35 INFO - 'tests': ['tp5o']}, 04:27:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:35 INFO - 'tests': ['tp5o']}, 04:27:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:35 INFO - 'talos_options': ['--disable-e10s', 04:27:35 INFO - '--xperf_path', 04:27:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:27:35 INFO - 'tests': ['tp5n']}, 04:27:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:35 INFO - 'talos_options': ['--xperf_path', 04:27:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:27:35 INFO - 'tests': ['tp5n']}}, 04:27:35 INFO - 'talos.zip': {'path': '', 04:27:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:27:35 INFO - Running post-action listener: _resource_record_post_action 04:27:35 INFO - [mozharness: 2016-07-22 11:27:35.615150Z] Finished populate-webroot step (success) 04:27:35 INFO - [mozharness: 2016-07-22 11:27:35.615240Z] Running create-virtualenv step. 04:27:35 INFO - Running pre-action listener: _resource_record_pre_action 04:27:35 INFO - Running main action method: create_virtualenv 04:27:35 INFO - Creating virtualenv /builds/slave/test/build/venv 04:27:35 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 04:27:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:27:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:27:36 INFO - Using real prefix '/usr' 04:27:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:27:36 INFO - Installing distribute.............................................................................................................................................................................................done. 04:27:38 INFO - Installing pip.................done. 04:27:38 INFO - Return code: 0 04:27:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:27:38 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')]} 04:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:38 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')]} 04:27:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:38 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 0x28ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6b570>, '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 0x2b6c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1469186838.60492-1747539257', '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 04:27:38 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 04:27:38 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 04:27:38 INFO - Using env: {'DISPLAY': ':0', 04:27:38 INFO - 'HOME': '/home/cltbld', 04:27:38 INFO - 'LANG': 'en_US.UTF-8', 04:27:38 INFO - 'LANGUAGE': 'en_US:en', 04:27:38 INFO - 'LOGNAME': 'cltbld', 04:27:38 INFO - 'MAIL': '/var/mail/cltbld', 04:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:38 INFO - 'MOZ_NO_REMOTE': '1', 04:27:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:38 INFO - 'NO_EM_RESTART': '1', 04:27:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:38 INFO - 'PWD': '/builds/slave/test', 04:27:38 INFO - 'SHELL': '/bin/bash', 04:27:38 INFO - 'SHLVL': '1', 04:27:38 INFO - 'TERM': 'linux', 04:27:38 INFO - 'TMOUT': '86400', 04:27:38 INFO - 'USER': 'cltbld', 04:27:38 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469186838.60492-1747539257', 04:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:38 INFO - '_': '/tools/buildbot/bin/python'} 04:27:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:39 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 04:27:39 INFO - Cleaning up... 04:27:39 INFO - Return code: 0 04:27:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:27:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:27:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6b570>, '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 0x2b6c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1469186838.60492-1747539257', '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 04:27:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:27:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:27:39 INFO - Using env: {'DISPLAY': ':0', 04:27:39 INFO - 'HOME': '/home/cltbld', 04:27:39 INFO - 'LANG': 'en_US.UTF-8', 04:27:39 INFO - 'LANGUAGE': 'en_US:en', 04:27:39 INFO - 'LOGNAME': 'cltbld', 04:27:39 INFO - 'MAIL': '/var/mail/cltbld', 04:27:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:39 INFO - 'MOZ_NO_REMOTE': '1', 04:27:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:39 INFO - 'NO_EM_RESTART': '1', 04:27:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:39 INFO - 'PWD': '/builds/slave/test', 04:27:39 INFO - 'SHELL': '/bin/bash', 04:27:39 INFO - 'SHLVL': '1', 04:27:39 INFO - 'TERM': 'linux', 04:27:39 INFO - 'TMOUT': '86400', 04:27:39 INFO - 'USER': 'cltbld', 04:27:39 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469186838.60492-1747539257', 04:27:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:39 INFO - '_': '/tools/buildbot/bin/python'} 04:27:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:39 INFO - Downloading/unpacking psutil>=3.1.1 04:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:27:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:27:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:27:41 INFO - Installing collected packages: psutil 04:27:41 INFO - Running setup.py install for psutil 04:27:41 INFO - building 'psutil._psutil_linux' extension 04:27:41 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 04:27:42 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 04:27:42 INFO - building 'psutil._psutil_posix' extension 04:27:42 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 04:27:43 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 04:27:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:27:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:27:43 INFO - Successfully installed psutil 04:27:43 INFO - Cleaning up... 04:27:43 INFO - Return code: 0 04:27:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:27:43 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')]} 04:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:43 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')]} 04:27:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:43 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 0x28ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6b570>, '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 0x2b6c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1469186838.60492-1747539257', '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 04:27:43 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 04:27:43 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 04:27:43 INFO - Using env: {'DISPLAY': ':0', 04:27:43 INFO - 'HOME': '/home/cltbld', 04:27:43 INFO - 'LANG': 'en_US.UTF-8', 04:27:43 INFO - 'LANGUAGE': 'en_US:en', 04:27:43 INFO - 'LOGNAME': 'cltbld', 04:27:43 INFO - 'MAIL': '/var/mail/cltbld', 04:27:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:43 INFO - 'MOZ_NO_REMOTE': '1', 04:27:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:43 INFO - 'NO_EM_RESTART': '1', 04:27:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:43 INFO - 'PWD': '/builds/slave/test', 04:27:43 INFO - 'SHELL': '/bin/bash', 04:27:43 INFO - 'SHLVL': '1', 04:27:43 INFO - 'TERM': 'linux', 04:27:43 INFO - 'TMOUT': '86400', 04:27:43 INFO - 'USER': 'cltbld', 04:27:43 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469186838.60492-1747539257', 04:27:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:43 INFO - '_': '/tools/buildbot/bin/python'} 04:27:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27: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 04:27:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:27:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:27:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:27:45 INFO - Installing collected packages: mozsystemmonitor 04:27:45 INFO - Running setup.py install for mozsystemmonitor 04:27:45 INFO - Successfully installed mozsystemmonitor 04:27:45 INFO - Cleaning up... 04:27:45 INFO - Return code: 0 04:27:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:27:45 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')]} 04:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:45 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')]} 04:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:45 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 0x28ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6b570>, '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 0x2b6c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1469186838.60492-1747539257', '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 04:27:45 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 04:27:45 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 04:27:45 INFO - Using env: {'DISPLAY': ':0', 04:27:45 INFO - 'HOME': '/home/cltbld', 04:27:45 INFO - 'LANG': 'en_US.UTF-8', 04:27:45 INFO - 'LANGUAGE': 'en_US:en', 04:27:45 INFO - 'LOGNAME': 'cltbld', 04:27:45 INFO - 'MAIL': '/var/mail/cltbld', 04:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:45 INFO - 'MOZ_NO_REMOTE': '1', 04:27:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:45 INFO - 'NO_EM_RESTART': '1', 04:27:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:45 INFO - 'PWD': '/builds/slave/test', 04:27:45 INFO - 'SHELL': '/bin/bash', 04:27:45 INFO - 'SHLVL': '1', 04:27:45 INFO - 'TERM': 'linux', 04:27:45 INFO - 'TMOUT': '86400', 04:27:45 INFO - 'USER': 'cltbld', 04:27:45 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469186838.60492-1747539257', 04:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:45 INFO - '_': '/tools/buildbot/bin/python'} 04:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:45 INFO - Downloading/unpacking jsonschema==2.5.1 04:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:27:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:47 INFO - Downloading functools32-3.2.3-2.tar.gz 04:27:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:27:47 INFO - warning: no files found matching '*.txt' 04:27:47 INFO - no previously-included directories found matching 'build' 04:27:47 INFO - no previously-included directories found matching 'dist' 04:27:47 INFO - no previously-included directories found matching '.git*' 04:27:47 INFO - Installing collected packages: jsonschema, functools32 04:27:48 INFO - Running setup.py install for functools32 04:27:48 INFO - warning: no files found matching '*.txt' 04:27:48 INFO - no previously-included directories found matching 'build' 04:27:48 INFO - no previously-included directories found matching 'dist' 04:27:48 INFO - no previously-included directories found matching '.git*' 04:27:48 INFO - Successfully installed jsonschema functools32 04:27:48 INFO - Cleaning up... 04:27:48 INFO - Return code: 0 04:27:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:27:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:27:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:27:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:48 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 0x28ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6b570>, '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 0x2b6c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1469186838.60492-1747539257', '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 04:27:48 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 04:27:48 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 04:27:48 INFO - Using env: {'DISPLAY': ':0', 04:27:48 INFO - 'HOME': '/home/cltbld', 04:27:48 INFO - 'LANG': 'en_US.UTF-8', 04:27:48 INFO - 'LANGUAGE': 'en_US:en', 04:27:48 INFO - 'LOGNAME': 'cltbld', 04:27:48 INFO - 'MAIL': '/var/mail/cltbld', 04:27:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:48 INFO - 'MOZ_NO_REMOTE': '1', 04:27:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:48 INFO - 'NO_EM_RESTART': '1', 04:27:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:48 INFO - 'PWD': '/builds/slave/test', 04:27:48 INFO - 'SHELL': '/bin/bash', 04:27:48 INFO - 'SHLVL': '1', 04:27:48 INFO - 'TERM': 'linux', 04:27:48 INFO - 'TMOUT': '86400', 04:27:48 INFO - 'USER': 'cltbld', 04:27:48 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469186838.60492-1747539257', 04:27:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:48 INFO - '_': '/tools/buildbot/bin/python'} 04:27:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:48 INFO - Downloading/unpacking blobuploader==1.2.4 04:27:48 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 04:27:48 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 04:27:48 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 04:27:48 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 04:27:48 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 04:27:48 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 04:27:50 INFO - Downloading blobuploader-1.2.4.tar.gz 04:27:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:27:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:27:50 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 04:27:50 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 04:27:50 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 04:27:50 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 04:27:50 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 04:27:50 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 04:27:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:27:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:27:50 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 04:27:50 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 04:27:50 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 04:27:50 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 04:27:50 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 04:27:50 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 04:27:51 INFO - Downloading docopt-0.6.1.tar.gz 04:27:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:27:51 INFO - Installing collected packages: blobuploader, requests, docopt 04:27:51 INFO - Running setup.py install for blobuploader 04:27:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:27:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:27:51 INFO - Running setup.py install for requests 04:27:51 INFO - Running setup.py install for docopt 04:27:51 INFO - Successfully installed blobuploader requests docopt 04:27:51 INFO - Cleaning up... 04:27:51 INFO - Return code: 0 04:27:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27: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')]} 04:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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')]} 04:27:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:51 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 0x28ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6b570>, '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 0x2b6c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1469186838.60492-1747539257', '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 04:27:51 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 04:27:51 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 04:27:51 INFO - Using env: {'DISPLAY': ':0', 04:27:51 INFO - 'HOME': '/home/cltbld', 04:27:51 INFO - 'LANG': 'en_US.UTF-8', 04:27:51 INFO - 'LANGUAGE': 'en_US:en', 04:27:51 INFO - 'LOGNAME': 'cltbld', 04:27:51 INFO - 'MAIL': '/var/mail/cltbld', 04:27:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:51 INFO - 'MOZ_NO_REMOTE': '1', 04:27:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:51 INFO - 'NO_EM_RESTART': '1', 04:27:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:51 INFO - 'PWD': '/builds/slave/test', 04:27:51 INFO - 'SHELL': '/bin/bash', 04:27:51 INFO - 'SHLVL': '1', 04:27:51 INFO - 'TERM': 'linux', 04:27:51 INFO - 'TMOUT': '86400', 04:27:51 INFO - 'USER': 'cltbld', 04:27:51 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469186838.60492-1747539257', 04:27:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:51 INFO - '_': '/tools/buildbot/bin/python'} 04:27:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:27:51 INFO - Running setup.py (path:/tmp/pip-ss2JMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:27:52 INFO - Running setup.py (path:/tmp/pip-M0urcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:27:52 INFO - Running setup.py (path:/tmp/pip-MDr3CY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:27:52 INFO - Running setup.py (path:/tmp/pip-wluHGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:27:52 INFO - Running setup.py (path:/tmp/pip-GXf7gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:27:52 INFO - Running setup.py (path:/tmp/pip-WkCTpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:27:52 INFO - Running setup.py (path:/tmp/pip-ZpBV3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:27:52 INFO - Running setup.py (path:/tmp/pip-NO9ZjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:27:52 INFO - Running setup.py (path:/tmp/pip-GnZrlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:27:52 INFO - Running setup.py (path:/tmp/pip-q3Uihu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:27:52 INFO - Running setup.py (path:/tmp/pip-7MQzt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:27:52 INFO - Running setup.py (path:/tmp/pip-ozuUJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:27:52 INFO - Running setup.py (path:/tmp/pip-b5cwti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:27:52 INFO - Running setup.py (path:/tmp/pip-Q_V32v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:52 INFO - Running setup.py (path:/tmp/pip-vVmMSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:27:53 INFO - Running setup.py (path:/tmp/pip-1oZlXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:27:53 INFO - Running setup.py (path:/tmp/pip-zkDndb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:27:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:27:53 INFO - Running setup.py install for manifestparser 04:27:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:27:53 INFO - Running setup.py install for mozcrash 04:27:53 INFO - Running setup.py install for mozdebug 04:27:53 INFO - Running setup.py install for mozdevice 04:27:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:27:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:27:53 INFO - Running setup.py install for mozfile 04:27:53 INFO - Running setup.py install for mozhttpd 04:27:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:27:53 INFO - Running setup.py install for mozinfo 04:27:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:27:53 INFO - Running setup.py install for mozInstall 04:27:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:27:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:27:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:27:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:27:53 INFO - Running setup.py install for mozleak 04:27:54 INFO - Running setup.py install for mozlog 04:27:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:27:54 INFO - Running setup.py install for moznetwork 04:27:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:27:54 INFO - Running setup.py install for mozprocess 04:27:54 INFO - Running setup.py install for mozprofile 04:27:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:27:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:27:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:27:54 INFO - Running setup.py install for mozrunner 04:27:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:27:54 INFO - Running setup.py install for mozscreenshot 04:27:54 INFO - Running setup.py install for moztest 04:27:54 INFO - Running setup.py install for mozversion 04:27:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:27:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:27:54 INFO - Cleaning up... 04:27:54 INFO - Return code: 0 04:27:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:27:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:54 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 0x28ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6b570>, '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 0x2b6c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1469186838.60492-1747539257', '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 04:27:54 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 04:27:54 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 04:27:54 INFO - Using env: {'DISPLAY': ':0', 04:27:54 INFO - 'HOME': '/home/cltbld', 04:27:54 INFO - 'LANG': 'en_US.UTF-8', 04:27:54 INFO - 'LANGUAGE': 'en_US:en', 04:27:54 INFO - 'LOGNAME': 'cltbld', 04:27:54 INFO - 'MAIL': '/var/mail/cltbld', 04:27:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:54 INFO - 'MOZ_NO_REMOTE': '1', 04:27:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:54 INFO - 'NO_EM_RESTART': '1', 04:27:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:54 INFO - 'PWD': '/builds/slave/test', 04:27:54 INFO - 'SHELL': '/bin/bash', 04:27:54 INFO - 'SHLVL': '1', 04:27:54 INFO - 'TERM': 'linux', 04:27:54 INFO - 'TMOUT': '86400', 04:27:54 INFO - 'USER': 'cltbld', 04:27:54 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469186838.60492-1747539257', 04:27:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:54 INFO - '_': '/tools/buildbot/bin/python'} 04:27:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:27:55 INFO - Running setup.py (path:/tmp/pip-QEIzp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:27:55 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)) 04:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:27:55 INFO - Running setup.py (path:/tmp/pip-zKM514-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:27:55 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)) 04:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:27:55 INFO - Running setup.py (path:/tmp/pip-L9epaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:27:55 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)) 04:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:27:55 INFO - Running setup.py (path:/tmp/pip-6jMI8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:27:55 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)) 04:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:27:55 INFO - Running setup.py (path:/tmp/pip-dcr_03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:27:55 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)) 04:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:27:55 INFO - Running setup.py (path:/tmp/pip-DCVZy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:27:55 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)) 04:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:27:55 INFO - Running setup.py (path:/tmp/pip-r0mhsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:27:55 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)) 04:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:27:55 INFO - Running setup.py (path:/tmp/pip-zQv48V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:27:55 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)) 04:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:27:55 INFO - Running setup.py (path:/tmp/pip-fFaeQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:27:55 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)) 04:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:27:55 INFO - Running setup.py (path:/tmp/pip-4sKrl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:27:55 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)) 04:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:27:55 INFO - Running setup.py (path:/tmp/pip-DdPM8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:27:55 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)) 04:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:27:55 INFO - Running setup.py (path:/tmp/pip-rtokq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:27:56 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)) 04:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:27:56 INFO - Running setup.py (path:/tmp/pip-huUfz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:27:56 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)) 04:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:27:56 INFO - Running setup.py (path:/tmp/pip-852iFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:27:56 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)) 04:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:56 INFO - Running setup.py (path:/tmp/pip-kOw7rN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:56 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)) 04:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:27:56 INFO - Running setup.py (path:/tmp/pip-qKxIFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:27:56 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)) 04:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:27:56 INFO - Running setup.py (path:/tmp/pip-JlLre2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:27:56 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)) 04:27:56 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)) 04:27:56 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)) 04:27:56 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)) 04:27:56 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)) 04:27:56 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)) 04:27:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:27:56 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 04:27:56 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 04:27:56 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 04:27:56 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 04:27:56 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 04:27:56 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 04:27:58 INFO - Downloading blessings-1.6.tar.gz 04:27:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:27:58 INFO - Installing collected packages: blessings 04:27:58 INFO - Running setup.py install for blessings 04:27:58 INFO - Successfully installed blessings 04:27:58 INFO - Cleaning up... 04:27:58 INFO - Return code: 0 04:27:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:27:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:27:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:27:58 INFO - Reading from file tmpfile_stdout 04:27:58 INFO - Current package versions: 04:27:58 INFO - argparse == 1.2.1 04:27:58 INFO - blessings == 1.6 04:27:58 INFO - blobuploader == 1.2.4 04:27:58 INFO - docopt == 0.6.1 04:27:58 INFO - functools32 == 3.2.3-2 04:27:58 INFO - jsonschema == 2.5.1 04:27:58 INFO - manifestparser == 1.1 04:27:58 INFO - mozInstall == 1.12 04:27:58 INFO - mozcrash == 0.17 04:27:58 INFO - mozdebug == 0.1 04:27:58 INFO - mozdevice == 0.48 04:27:58 INFO - mozfile == 1.2 04:27:58 INFO - mozhttpd == 0.7 04:27:58 INFO - mozinfo == 0.9 04:27:58 INFO - mozleak == 0.1 04:27:58 INFO - mozlog == 3.3 04:27:58 INFO - moznetwork == 0.27 04:27:58 INFO - mozprocess == 0.23 04:27:58 INFO - mozprofile == 0.28 04:27:58 INFO - mozrunner == 6.12 04:27:58 INFO - mozscreenshot == 0.1 04:27:58 INFO - mozsystemmonitor == 0.3 04:27:58 INFO - moztest == 0.7 04:27:58 INFO - mozversion == 1.4 04:27:58 INFO - psutil == 3.1.1 04:27:58 INFO - requests == 1.2.3 04:27:58 INFO - wsgiref == 0.1.2 04:27:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:58 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 0x28ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6b570>, '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 0x2b6c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1469186838.60492-1747539257', '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 04:27:58 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 04:27:58 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 04:27:58 INFO - Using env: {'DISPLAY': ':0', 04:27:58 INFO - 'HOME': '/home/cltbld', 04:27:58 INFO - 'LANG': 'en_US.UTF-8', 04:27:58 INFO - 'LANGUAGE': 'en_US:en', 04:27:58 INFO - 'LOGNAME': 'cltbld', 04:27:58 INFO - 'MAIL': '/var/mail/cltbld', 04:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:58 INFO - 'MOZ_NO_REMOTE': '1', 04:27:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:58 INFO - 'NO_EM_RESTART': '1', 04:27:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:58 INFO - 'PWD': '/builds/slave/test', 04:27:58 INFO - 'SHELL': '/bin/bash', 04:27:58 INFO - 'SHLVL': '1', 04:27:58 INFO - 'TERM': 'linux', 04:27:58 INFO - 'TMOUT': '86400', 04:27:58 INFO - 'USER': 'cltbld', 04:27:58 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469186838.60492-1747539257', 04:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:58 INFO - '_': '/tools/buildbot/bin/python'} 04:27:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:59 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)) 04:27:59 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)) 04:27:59 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)) 04:27:59 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)) 04:27:59 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)) 04:27:59 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)) 04:27:59 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)) 04:27:59 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)) 04:27:59 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)) 04:27:59 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)) 04:27:59 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)) 04:27:59 INFO - Cleaning up... 04:27:59 INFO - Return code: 0 04:27:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:27:59 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')]} 04:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:59 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')]} 04:27:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:59 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 0x28ad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2adc400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6b570>, '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 0x2b6c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1469186838.60492-1747539257', '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 04:27:59 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 04:27:59 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 04:27:59 INFO - Using env: {'DISPLAY': ':0', 04:27:59 INFO - 'HOME': '/home/cltbld', 04:27:59 INFO - 'LANG': 'en_US.UTF-8', 04:27:59 INFO - 'LANGUAGE': 'en_US:en', 04:27:59 INFO - 'LOGNAME': 'cltbld', 04:27:59 INFO - 'MAIL': '/var/mail/cltbld', 04:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:59 INFO - 'MOZ_NO_REMOTE': '1', 04:27:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:59 INFO - 'NO_EM_RESTART': '1', 04:27:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:59 INFO - 'PWD': '/builds/slave/test', 04:27:59 INFO - 'SHELL': '/bin/bash', 04:27:59 INFO - 'SHLVL': '1', 04:27:59 INFO - 'TERM': 'linux', 04:27:59 INFO - 'TMOUT': '86400', 04:27:59 INFO - 'USER': 'cltbld', 04:27:59 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469186838.60492-1747539257', 04:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:59 INFO - '_': '/tools/buildbot/bin/python'} 04:27:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:27:59 INFO - Cleaning up... 04:27:59 INFO - Return code: 0 04:27:59 INFO - Running post-action listener: _resource_record_post_action 04:27:59 INFO - Running post-action listener: _start_resource_monitoring 04:27:59 INFO - Starting resource monitoring. 04:27:59 INFO - [mozharness: 2016-07-22 11:27:59.273821Z] Finished create-virtualenv step (success) 04:27:59 INFO - [mozharness: 2016-07-22 11:27:59.274248Z] Running install step. 04:27:59 INFO - Running pre-action listener: _resource_record_pre_action 04:27:59 INFO - Running main action method: install 04:27:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:27:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:27:59 INFO - Reading from file tmpfile_stdout 04:27:59 INFO - Detecting whether we're running mozinstall >=1.0... 04:27:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:27:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:27:59 INFO - Reading from file tmpfile_stdout 04:27:59 INFO - Output received: 04:27:59 INFO - Usage: mozinstall [options] installer 04:27:59 INFO - Options: 04:27:59 INFO - -h, --help show this help message and exit 04:27:59 INFO - -d DEST, --destination=DEST 04:27:59 INFO - Directory to install application into. [default: 04:27:59 INFO - "/builds/slave/test"] 04:27:59 INFO - --app=APP Application being installed. [default: firefox] 04:27:59 INFO - mkdir: /builds/slave/test/build/application 04:27:59 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'] 04:27:59 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 04:28:16 INFO - Reading from file tmpfile_stdout 04:28:16 INFO - Output received: 04:28:16 INFO - /builds/slave/test/build/application/firefox/firefox 04:28:16 INFO - Running post-action listener: _resource_record_post_action 04:28:16 INFO - [mozharness: 2016-07-22 11:28:16.092804Z] Finished install step (success) 04:28:16 INFO - [mozharness: 2016-07-22 11:28:16.093079Z] Running run-tests step. 04:28:16 INFO - Running pre-action listener: _resource_record_pre_action 04:28:16 INFO - Running main action method: run_tests 04:28:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:28:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:28:16 INFO - Python 2.7.3 04:28:16 INFO - Return code: 0 04:28:16 INFO - grabbing minidump binary from tooltool 04:28:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:28:16 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 0x2b6b570>, '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 0x2b6c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b6c900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:28:16 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 04:28:16 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 04:28:16 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 04:28:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:28:16 INFO - Return code: 0 04:28:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:28:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:28:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:28:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:28:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:28:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NMwYwfpFTgW3dMIbuGUezA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:28:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NMwYwfpFTgW3dMIbuGUezA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:28:16 INFO - Using env: {'DISPLAY': ':0', 04:28:16 INFO - 'HOME': '/home/cltbld', 04:28:16 INFO - 'LANG': 'en_US.UTF-8', 04:28:16 INFO - 'LANGUAGE': 'en_US:en', 04:28:16 INFO - 'LOGNAME': 'cltbld', 04:28:16 INFO - 'MAIL': '/var/mail/cltbld', 04:28:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:28:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:28:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:16 INFO - 'MOZ_NO_REMOTE': '1', 04:28:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:28:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:28:16 INFO - 'NO_EM_RESTART': '1', 04:28:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:28:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:16 INFO - 'PWD': '/builds/slave/test', 04:28:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:28:16 INFO - 'SHELL': '/bin/bash', 04:28:16 INFO - 'SHLVL': '1', 04:28:16 INFO - 'TERM': 'linux', 04:28:16 INFO - 'TMOUT': '86400', 04:28:16 INFO - 'USER': 'cltbld', 04:28:16 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1469186838.60492-1747539257', 04:28:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:16 INFO - '_': '/tools/buildbot/bin/python'} 04:28:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NMwYwfpFTgW3dMIbuGUezA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:28:16 INFO - mozversion application_buildid: 20160722031926 04:28:16 INFO - mozversion application_changeset: 129c925e216d801c622922a669e720dc1d5fb5a5 04:28:16 INFO - mozversion application_display_name: Nightly 04:28:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:28:16 INFO - mozversion application_name: Firefox 04:28:16 INFO - mozversion application_remotingname: firefox 04:28:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:28:16 INFO - mozversion application_vendor: Mozilla 04:28:16 INFO - mozversion application_version: 50.0a1 04:28:16 INFO - mozversion platform_buildid: 20160722031926 04:28:16 INFO - mozversion platform_changeset: 129c925e216d801c622922a669e720dc1d5fb5a5 04:28:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:28:16 INFO - mozversion platform_version: 50.0a1 04:28:16 INFO - using testdate: 1469186896 04:28:16 INFO - actual date: 1469186896 04:28:16 INFO - starting webserver on 'localhost:35302' 04:28:16 INFO - SUITE-START | Running 2 tests 04:28:16 INFO - TEST-START | dromaeo_css 04:28:16 INFO - operating with platform_type : linux_ 04:28:16 INFO - Initialising browser for dromaeo_css test... 04:28:16 INFO - TEST-INFO | started process 3304 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP3QJiP/profile http://localhost:35302/getInfo.html) 04:28:21 INFO - PROCESS | 3304 | JavaScript error: , line 0: uncaught exception: undefined 04:28:24 INFO - PROCESS | 3304 | __metrics Screen width/height:1600/1200 04:28:24 INFO - PROCESS | 3304 | colorDepth:24 04:28:24 INFO - PROCESS | 3304 | Browser inner width/height: 1024/697 04:28:24 INFO - PROCESS | 3304 | __metrics 04:28:25 ERROR - PROCESS | 3304 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 04:28:25 INFO - TEST-INFO | 3304: exit 0 04:28:25 INFO - Browser initialized. 04:28:25 INFO - Running cycle 1/1 for dromaeo_css test... 04:28:25 INFO - TEST-INFO | started process 3426 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP3QJiP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:28:37 INFO - PROCESS | 3426 | RSS: Main: 168845312 04:28:37 INFO - PROCESS | 3426 | 04:29:27 INFO - PROCESS | 3426 | 1469186967462 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] 04:31:39 INFO - PROCESS | 3426 | Cycle 1(1): loaded http://localhost:35302/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35302/tests/dromaeo/cssquery-ext.html) 04:31:41 INFO - PROCESS | 3426 | RSS: Main: 170811392 04:31:41 INFO - PROCESS | 3426 | 04:34:43 INFO - PROCESS | 3426 | Cycle 1(1): loaded http://localhost:35302/tests/dromaeo/cssquery-ext.html (next: http://localhost:35302/tests/dromaeo/cssquery-jquery.html) 04:34:43 INFO - PROCESS | 3426 | RSS: Main: 170418176 04:34:43 INFO - PROCESS | 3426 | 04:37:45 INFO - PROCESS | 3426 | Cycle 1(1): loaded http://localhost:35302/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35302/tests/dromaeo/cssquery-mootools.html) 04:37:46 INFO - PROCESS | 3426 | RSS: Main: 173428736 04:37:46 INFO - PROCESS | 3426 | 04:40:48 INFO - PROCESS | 3426 | Cycle 1(1): loaded http://localhost:35302/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35302/tests/dromaeo/cssquery-prototype.html) 04:40:49 INFO - PROCESS | 3426 | RSS: Main: 167608320 04:40:49 INFO - PROCESS | 3426 | 04:43:51 INFO - PROCESS | 3426 | Cycle 1(1): loaded http://localhost:35302/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35302/tests/dromaeo/cssquery-yui.html) 04:43:52 INFO - PROCESS | 3426 | RSS: Main: 169660416 04:43:52 INFO - PROCESS | 3426 | 04:46:55 INFO - PROCESS | 3426 | Cycle 1(1): loaded http://localhost:35302/tests/dromaeo/cssquery-yui.html (next: http://localhost:35302/tests/dromaeo/cssquery-dojo.html) 04:46:55 INFO - PROCESS | 3426 | RSS: Main: 173359104 04:46:55 INFO - PROCESS | 3426 | 04:46:55 INFO - PROCESS | 3426 | __start_tp_report 04:46:55 INFO - PROCESS | 3426 | _x_x_mozilla_page_load 04:46:55 INFO - PROCESS | 3426 | _x_x_mozilla_page_load_details 04:46:55 INFO - PROCESS | 3426 | |i|pagename|runs| 04:46:55 INFO - PROCESS | 3426 | |0;dojo.html;2623.540880345939;2651.085375545437;2662.321108117431;2667.799915006375;2674.2111077232216;4826.372571565696;4835.323054772331;4858.2712593111055;4902.0195960807805;4957.677750946195;4768.070226305872;4861.854144375666;4878.0731660984475;4893.4617192108835;4901.26481027846;4487.910241795162;4508.887277818065;4552.248878934972;4628.560286772768;4659.906801863961;4514.932276015862;4569.862904112882;4644.140833945731;4651.767411629422;4652.906941861161;4374.387585737999;4530.954690453119;4571.3828633134435;4588.609968152711;4603.700759450625;4407.471103467572;4435.866923992286;4445.333200019991;4456.331550267486;4461.196984542781;4477.6417886569;4531.274996000657;4531.388262584542;4547.590716835501;4555.111753208126;4808.663393562452;4913.238448040559;4951.405831300267;4952.455229924705;4966.15575352191;5199.064168449678;5201.583873290166;5206.193040078794;5207.895842083137;5316.707581083039;5270.104082305978;5271.6744586675395;5283.1546952487415;5286.392064912546;5289.0744119779265;4691.601213896789;4788.329633851264;4829.106615276115;4843.0313937212695;4850.466448690677;5366.382865970463;5375.81184658535;5380.085385484477;5388.137897936312;5436.483534064258;5162.225666150032;5172.353455818023;5173.586113110942;5176.430592634807;5234.869128271747;5056.165732654144;5184.5593124584075;5204.687718736888;5231.529162375405;5253.343332083489;5224.059669259494;5224.9738751306;5228;5259.421463638997;5275.182346736262;5200.453952335026;5201.479852014768;5238.057149713012;5240.737963101829;5272.736363181825;4213.768242746678;4361.542038086019;4363.301871700576;4364.432623758891;4399.032212913154;3837.2325534893134;3839.827207775657;3863.34323165057;3885.5337359516475;3895.844166233319;4560.840370587013;4580.473245576802;4587.72473651582;4589.5181005994555;4634.21218392874;5179.896402071938;5246.422893481714;5285.471452854684;5306.7611957462;5383.43473935239;4553.726776393427;4575.908481830411;4611.100835337077;4619.815207391666;4621.23749581322;4723.598494128038;4746.240601503743;4748.0978614063215;4750.358701575312;4754.429468463806;4698.389209402892;4859.514048595112;4882.194437917704;4892.51074892515;4898.363212782316;5264.52619264268;5283.365996080495;5284.233786100917;5335.093034184276;5340.546053585489;4889.9022019560125;4909.4354149273295;4924.03981223658;4928.359313289249;4991.101601711727;4971.8011279549855;5156.587473002226;5188.351456067991;5202.24567437727;5209.348831396075;5246.213068039825;5288.074586947192;5302.920456193237;5358.464153584766;5368.758405871667;5188.351456067991;5201.869953251047;5205.505476979833;5211.166213405837;5247.632665713516;4981.850544483671;5039.84880453587;5046.621503387188;5164.561012313995;5197.22041693749;5006.4743201963265;5014.749262536786;5053.31780209667;5068.138416469283;5132.178851383761;5162.457941916045;5162.8967420652125;5179.352580927384;5244.554212891947;5259.21111833228;5068.467810879804;5074.949250507448;5105.33630628016;5118.795248190031;5166.070107380708 04:46:55 INFO - PROCESS | 3426 | |1;ext.html;555.7304707217;565.5899472882161;567.5005994724644;570.997145014275;600.1567797244873;34185.82907085464;38570.22859542811;38597.80701096498;38659.61340386595;38768.61231387685;38671.22657546847;39494.40758388619;39588.20823583526;39589.802050989776;39597.40603890944;7633.961830190855;7774.378049756006;7779.611019449033;7786.610669466532;7808.3362914152085;7670.654820533089;7694.846103077935;7695.307422331989;7754.030746156731;7764.572948487859;7697.384209263246;7734.651940662656;7740.806479837993;7767.378609711238;7771.727989520368;7712.421568382394;7743;7761.805954851117;7791.298783109547;7794.298513133816;7737.916691663172;7773.650185741655;7780.066392032993;7782.610869456505;7797.220277972214;36607.63392366069;37106.8144659275;37118.62881371179;37235.627643723485;37310.25379492395;2573.2794817451145;2603.1799983005294;2631.5000149971443;2676.7724743396834;3062.739667128297;28484.572731409044;28817;28984.42031159386;29064.12807615775;29366.55950160749;3408.164999575095;3422.9828850855833;3443.6900678939014;3466.6360032196762;3510.9297814043575;181325;181764;181776;182136;182352;50366;50562;50591;50678;50927.49072509302;29258;29443.558346624817;29746.107616771533;29857.85071074631;53152.20271695928;15211.61970950713;15398.692026159413;15446.918715689793;15463.84536154624;15486.5354039379;11742.589009384801;11782.410879455992;11924.701882452835;11926.582569610022;11950.223235489666;17942;17970.820291797176;18019;18042.729359059624;18171.454856354332;6737.562058466184;6908.1364829396325;6915.239323674392;6950.374466298057;7060.399866011447;808.8988876390451;847.2417186617943;901.7655409593552;941.5527624378366;988.5403287471361;26806.731932680425;27582.310442238704;27601.15678619803;27859.72140278571;28089.859550702116;970.1228123580894;971.8396464583265;973.6008236623093;982.2044144243185;1037.3464717228098;14656.340464679115;14842.851571484363;14875.70248595022;14896.776548351783;14950.551483455514;367288;375161;375475;377552;378630;48194.27708584374;48879;48942.265866012036;48966.26550601744;49004.509954900706;1157;1196.096946805174;1206.535483838711;1218.250775772911;1226.8159776033667;26348.473030539666;27325.316867078483;27944;27958;28069.859650701615;41972.790136050346;42099;42679.78660106679;42680.35979460248;42702.1459570813;255960;256417;257101;257406;258262;24996.37509062288;25092;25512.872435637702;25518.872405637852;25604.743952560235;41838.581614183466;41859.581404186785;42249.366259505514;42286.1542769149;42433;34878;35622.64377356193;35701.28597428089;36514.8174259127;36588.45117323189;35288.82355588206;35369.82315088408;35960.8201958999;36179.81910090538;36335.273294533436;30932.845335773178;35074.29851403009;35271.470927936614;36101.458478122324;36649;31501.842490788316;33776.83111584427;33850.32299354048;33980.150496237795;34104.65895341015;25775;25832;26012.8699356502;26102.477950441265;26507 04:46:55 INFO - PROCESS | 3426 | |2;jquery.html;359.54517535317825;361.88600590813894;368.74188068352146;379.50474630607044;388.71623714688275;16041.278142483587;16880.577985550368;17365.565860853483;17454.47636570902;17577;16806.747898781527;17025.48923532296;17461.73807392887;17688;17702.822971770278;5112.642115051948;5319.813806516772;5325.068113080215;5332.680039197641;5335.253064570963;3728.608496107897;5224;5830;6100.450959413652;6119.877602447948;6193.752249909998;6203.7828675996125;6213.161223234851;6220.813375598739;6221.471174950135;5009.699418034911;5263.289455923459;5298.682079075248;5347.224652425415;5361.463853614647;5145.845624631267;5197.220416937452;5210.635255532115;5240.580753539708;5240.764165612557;17758.733618995724;17964.55088622782;18033;18314.893787214507;18523.814761852344;1794.5334213104686;1816.3915088445387;1832.248778001013;1943.7181608666665;2335.404471859682;9048.140426659456;9166.816663666756;9177.219936305422;9220.170184683344;9635.855462168072;1700.8979461232243;1747.4582879307454;1775.6626241014294;1794.5423916901236;1822.8815127016835;73428;74030.62984685042;74057.62971185164;74114.62942685306;74548.62725686391;9879.703608891601;9947.55236014381;10044;10148.071866345519;10220.846687299696;13690.726185476235;13726.588202353945;13745.518906838213;13768.586942391745;13788.793168102486;7261.963690181516;7468.738594149178;7509.737159199511;7662.73180438682;7707.537547747041;7139;7229.855402892018;7312.049433573601;7445.36714379273;7470.813229669193;4087.1825634873144;4259.7231179973205;4288.09949910516;4389.407429996973;4411.051623900877;1646.1275523972313;1688.3584237989485;1717.3302412059306;1785.5893144576821;1833.4041436532914;810.2221867007621;815.8409110223449;869.2784988459564;879.9076097009722;942.0532364973158;16602.50192494227;16606.169691515377;16787.07671078078;16928.915355423145;17117.315307387813;841.2302742990217;851.5401683091061;857.6826574167598;872.097379212512;908.0193391137556;9214.216791572791;9214.723558293263;9745.707628771148;9825.312228144105;9858.802823943624;391625;393188;401474;406727;407188;85394.57302713447;86681;87192;88193.55903220443;93484.53257733803;741.6996116572797;754.4077898849376;776.3323541754087;783.9686412543434;787.8503084413943;15541.533753987398;15764.817638676916;16243.51269461918;16305.429309974093;16668.41660541875;38121.428178577895;38348.80825595854;38354.80822595869;39384.80307598443;39480.80259598684;51887.74056129695;55095.72452137714;55355.72322138363;55857.720711396185;56966.7151664239;7293.234210407831;7378.335949764547;7426.814329641802;7559.3196612305155;7736.961315193388;10304.433256170983;11102.944485277521;11535.01952334061;11681.766364672489;12041.217320874115;9290.907090929275;9755.853662195215;9756.60973561078;10053.396796192252;10392.58429662805;9457.95271023668;9802.607895684092;10086.445245511568;10096.596136154472;10181.949090254797;8980.191782739585;9606.635141787438;9653.517324133905;9865.753356166153;10138.442385668859;7562.848743025219;7609.733659321897;7627.237276272328;7788.610569471391;7840.098388685375;8444.831103378021;9618.951905240428;9892.653757118755;10355.068043876086;10467.319624224705 04:46:55 INFO - PROCESS | 3426 | |3;mootools.html;1376.1467889908258;1409.5630354590078;1506.8493150684926;1656.6686662667469;1708.4789139312513;6863.656817159134;7457.477976541644;7548.92451075489;7924.960375198123;7931.5241085534835;7514.549127052381;7855.725049623265;7861.174576669453;7861.685532578705;7876.488028278158;2113.323736404351;2143.506993391521;2150.9462263443384;2156.4069880782754;2161.4812445013163;2095.9685604715864;2109.599176156533;2168.251953076186;2170.348895331402;2175.2712841198218;2156.892155392232;2158.57907707997;2167.696522486853;2168.024389024937;2195.067096483996;2116.9788302116935;2121.968170477444;2128.510442598196;2132.8720276783365;2146.5599552091785;2046.7543894732578;2107.8524503284775;2116.375669177596;2118.9152433902627;2122.8514004019726;7870.331021863149;7881.724139655084;7898.210178982114;7911.841763164762;7950.721724739664;4477.283634618478;4648.697834640738;4654.278586819015;4660.557247061523;4667.019925815583;2696.204619637192;2750.4636595863813;2790.3024243939017;2801.775857931381;2811.2971757060736;884.5228077728385;904.8009437923646;914.9862752058724;917.7155081924625;930.0327659234456;10621.044106030417;10660.893391066067;10694.091002264817;10710.19673524481;10720.035196832323;3901.6293452122004;4042.241624893181;4197.076643138505;4205.411242426063;4208.558101399371;8875.955620221857;8989.46063236208;9015.729528114167;9023.909760902307;9030.63877444908;4578.153041687298;4602.65480088988;4625.930611040837;4642.117997580449;4653.348531205634;3649.1059690375496;4107.219628270619;4188.518320393133;4226.492820861455;4236.9364459533135;3592.7844329340323;3654.5979942206336;3719.367707489733;3753.474513568103;3765.943510847285;1169.8479197704244;1173.9119566032582;1181.5155786127646;1203.3441774233063;1210.8244304575787;678.7285085965653;687.3161204601354;705.2770909817478;827.8344331133798;857.8327226190958;5095.363079615048;5214.739263036833;5336.306280183551;5347.385050719217;5359.946400536022;390.4689622113923;390.7616354024043;395.1287411258169;396.90275882409;914.92680585553;3464.428369319034;3733.7199710021855;4028.677705783589;4037.7779222142476;4098.139390727921;9474.242060635133;9710.805783884283;9716.31985761004;9721.222302215805;9803.558839852223;9612.75968100789;9630.47032413224;9644.228461723045;9657.130858222654;9686.321957463051;7051.576905385693;7146.749863754743;7241.058662373857;7241.927580724126;7260.927390726025;5554.555635549227;5614.63504872182;5708.65748055118;5722.256106706268;5820.476157145878;8893.443647361557;8992.370534062553;9007.864882026906;9138.817223655622;9147.405418647766;8854.203121718818;9130.086991300817;9163.450192988443;9329.673461428818;9359.344845860724;5742.3109226891365;6405.839854003687;6501.837454063686;6602.1747281589805;6752.763653272112;7630.7329243476215;7633.0458692663415;7640.617969101634;7679.040119985002;7709.113451953097;6704.396604305636;6869.416099631588;6904.516683832084;6909.136357955255;7010.824729381806;6531.3468653134305;6540.117084193573;6732.798016059526;6827.044213809972;6932.514723969273;6073.817785466443;6091;6143.416375444325;6159.199304090619;6164.599301045418;4493.6854420191585;4522.366868638327;4600.4479462464715;4630.791614377294;4638.6752927294765;4414.227510185769;4605.447346318463;4612.7001744886475;4629.375034370451;4814.927776083432 04:46:55 INFO - PROCESS | 3426 | |4;prototype.html;285.3992346111435;293.83692050911765;296.0511560448761;304.7866493454582;306.2512157774243;4881.387773047945;4949.604031677466;5094.566961808247;5152.974235128829;5188.662736922102;4988.226824842146;5050.595952323814;5081.720505372203;5085.61857860661;5107.693538387699;3978.1049263915606;4005.7596544207295;4007.9198416031663;4012.959870401288;4013.3979903014488;3908.1436317749126;3968.365061590146;4000.3399439092514;4027.1744292419985;4039.878803635881;3926.72512924094;3939.5075615548058;3941.822617982183;3949.4075888616794;3977.443157957888;3935.5867633898456;3942.1327307992196;3964.4846169998004;3972.483577134983;3975.383815508601;3507.719382449398;3511.2450823073164;3517.26137511123;3521.9295614087573;3528.1356067763304;4848.757562121879;4923.359963204796;4947.505249475023;4979.228219625964;5020.573251273646;4492.707973981681;4505.617022553087;4520.2315606347;4525.036101353586;4528.615067719248;5244.265802787613;5281.683099014072;5289.603279753996;5298.523132918056;5323.520883120537;3724.888253352404;3762.5673047599603;3771.283456143324;3782.602826703184;3825.8278377472802;5540.168974653794;5540.418256083093;5543.944560554383;5572.498475137257;5647.3505546862225;3922.2547715933883;3926.803659816998;3934.580233156645;3944.467496887941;3951.427043078795;3874.903127421837;3967.3255546557157;3973.1259122992897;3988.541317748438;3990.8204130814183;4457.2199865023495;4479.283314669638;4494.955050449519;4500.302453119772;4504.2839657282875;5324.121519949165;5355.3841308249275;5357.330333708286;5359.946400535945;5371.811986580451;1248.126311581878;1322.6296636941672;1350.9459621615222;1354.2280899887166;1358.483776165051;918.5682729117304;924.611663101499;950.3015283766426;952.1050212800085;954.9809003819885;4651.930056087119;4658.394408726844;4662.370579971728;4674;4676.719396836201;5411.18832175169;5446.611114165862;5463.426340234298;5484.945150548523;5496.972515137399;4362.8438463807115;4625.560571745679;4626.791794369262;4656.580907718321;4666.346711460398;2513.5978243481322;2529.6458495810602;2545.707243667002;2548.439343344461;2562.9743702562737;4441.822327106945;4449.377087207794;4467.865964021084;4477;4481.3726078349055;4575.428071491064;4811.350467686888;4882.633802464829;4903.714511277452;4924.852254432372;4432.82268709248;4435.911281774346;4452.261858956654;4466.6203372713035;4530.524294949048;4770.666053376231;4798.73606951621;4835.516448355136;4897.632677549127;4899.31409602663;4662.901448362822;4732.337472753748;4757.500462451393;4771.208842826985;4775.522447755336;4294.9355759663;4426.384369705099;4452.462096604904;4465.955340446554;4473.910521789481;3548.8225588719943;3573.5890372607482;3579.6957258633306;3608.783472991629;3622.4566315052953;4802.759862006816;4833.347498087714;4844.61243100544;4864.683795553277;5200.5059519345605;5142.971405718797;5253.343332083489;5276.868078298074;5294.391145018218;5299.39057008449;5329.866753331198;5333.43998880112;5333.813316533902;5338.54622357104;5350.892982140257;4967.801287948441;5148.7425628717665;5175.560077393313;5215.843524694265;5230.450802665665;5332.094008765154;5353.491418315254;5365.3293338332705;5377.973110134424;5384.596155288447;5296.9670914171365;5300.655457395257;5301.655392399482;5304.814331498379;5310.283111780015 04:46:55 INFO - PROCESS | 3426 | |5;yui.html;606.8634557224624;626.3016736338983;711.2579571365683;720.7585458871278;725.9815339574399;12403.255804651728;13569.321533923288;13680;13695;13754.793678094824;13406.530771423002;13570.864291357084;13571;13572.660683482918;13601.38793754281;623.3548277532755;750.4371721209093;770.2605498721207;770.8265640230959;772.1776308231715;768.8500742355243;785.8585454618167;791.4973991515371;794.0233512779256;794.213728408874;824.7690646618956;828.8342331533687;831.40969911363;831.4844796226348;833.1626715151265;817.8364327134567;823.8064054947083;827.1893544326564;827.4869580859876;829.0093338460482;599.8500374906273;604.8639056212361;605.7455868535226;605.8909396308662;606.0817860940679;11711.414429278502;11731.354775487345;11773.646790596296;11776.11679124069;11794.705132371673;13091.541796037189;13458.663533411645;13665.111767735065;13672.521461748891;13766.449342026408;10214.779651620418;10322.638707645196;10406.791864162675;10538.36769793807;10568.573242612303;3228.4834426491648;3263.8041717497026;3276.7050965413227;3287.342531493711;3293.901182964515;60390;61105.38894611041;61199;61367.69316153436;62137.68931155315;9555.092266234697;9622.13400793932;9627.951860240793;9716.417014979124;9889.851652225223;19916.60166796685;19982.800171998384;20024.598278120684;20073.598528029357;20291;6297.118403423525;6367.299597044322;6386.07401926718;6604.537682362188;6806.4554835613035;3553.964460355415;3564.3405969895653;3619.819009049537;3632.7457078004813;3661.139632186434;2738;2806.396624725694;2819.0837977657343;2824.3080445291034;2831.8159319644155;488.35537091039487;495.04209354898387;505.7850413574216;511.64185070450833;511.9155339368962;580.8083332500265;595.9880802383929;596.8269201931478;612.6201754911895;635.520182262389;7399.926000740032;7608.543487390774;7731.226877312224;7906.130325664172;8050.919490805017;491.1772780592493;514.580616797309;517.092502657833;524.4493282053828;608.1182285685774;3677.1174918019483;3773.132179598708;3797.5442946846556;3808.4668146459517;3815.04623844039;57125.71437142871;58180.709096455095;59100;98073;100550;83906.5804670985;84105;86721.56639216763;86855;87420.56289718638;45443.54556454459;59584.10623840732;63549.68225158937;70325.64837175781;72898.27101728915;7831;8290.46112002718;8360.247577718035;8418;8518.574071296534;43291.56708432875;43746.12507749891;44323.77838110918;45891.311630324904;45947.540524594326;39838;46413.07173856571;58596.70701646464;60739.69630151821;63047.36952630415;11462.541498339973;11467.713307167387;11703.76592468163;11741.589044383405;11926.463309150935;12892.806607901077;13031.413586388446;13677.24775137377;13742.93128534351;14158.362873670503;11589.723202305886;11702.180847340604;12005.339706315886;12017.278963262232;12669.556565520163;10547.314424562379;10753.516091776046;11016.11871050298;11050.557977681125;11094.223404361617;11193.384363860067;11680;11903.880961190624;12017.579384721843;12170.45232964501;10097.697069087939;10134;10242.180625550087;10608.52261648243;10981.286216395909;8055.959720201596;8281.792955176168;8569.185927336894;8847.380683352361;8966.730998070068 04:46:55 INFO - PROCESS | 3426 | __end_tp_report 04:46:55 INFO - PROCESS | 3426 | __start_cc_report 04:46:55 INFO - PROCESS | 3426 | _x_x_mozilla_cycle_collect,375 04:46:55 INFO - PROCESS | 3426 | __end_cc_report 04:46:55 INFO - PROCESS | 3426 | __startTimestamp1469188015624__endTimestamp 04:46:55 INFO - PROCESS | 3426 | 04:46:55 INFO - PROCESS | 3426 | ------- Summary: start ------- 04:46:55 INFO - PROCESS | 3426 | Number of tests: 6 04:46:55 INFO - PROCESS | 3426 | 04:46:55 INFO - PROCESS | 3426 | [#0] dojo.html Cycles:165 Average:4852.71 Median:4957.68 stddev:524.92 (10.6%) stddev-sans-first:496.55 04:46:55 INFO - PROCESS | 3426 | Values: 2623.5 2651.1 2662.3 2667.8 2674.2 4826.4 4835.3 4858.3 4902.0 4957.7 4768.1 4861.9 4878.1 4893.5 4901.3 4487.9 4508.9 4552.2 4628.6 4659.9 4514.9 4569.9 4644.1 4651.8 4652.9 4374.4 4531.0 4571.4 4588.6 4603.7 4407.5 4435.9 4445.3 4456.3 4461.2 4477.6 4531.3 4531.4 4547.6 4555.1 4808.7 4913.2 4951.4 4952.5 4966.2 5199.1 5201.6 5206.2 5207.9 5316.7 5270.1 5271.7 5283.2 5286.4 5289.1 4691.6 4788.3 4829.1 4843.0 4850.5 5366.4 5375.8 5380.1 5388.1 5436.5 5162.2 5172.4 5173.6 5176.4 5234.9 5056.2 5184.6 5204.7 5231.5 5253.3 5224.1 5225.0 5228.0 5259.4 5275.2 5200.5 5201.5 5238.1 5240.7 5272.7 4213.8 4361.5 4363.3 4364.4 4399.0 3837.2 3839.8 3863.3 3885.5 3895.8 4560.8 4580.5 4587.7 4589.5 4634.2 5179.9 5246.4 5285.5 5306.8 5383.4 4553.7 4575.9 4611.1 4619.8 4621.2 4723.6 4746.2 4748.1 4750.4 4754.4 4698.4 4859.5 4882.2 4892.5 4898.4 5264.5 5283.4 5284.2 5335.1 5340.5 4889.9 4909.4 4924.0 4928.4 4991.1 4971.8 5156.6 5188.4 5202.2 5209.3 5246.2 5288.1 5302.9 5358.5 5368.8 5188.4 5201.9 5205.5 5211.2 5247.6 4981.9 5039.8 5046.6 5164.6 5197.2 5006.5 5014.7 5053.3 5068.1 5132.2 5162.5 5162.9 5179.4 5244.6 5259.2 5068.5 5074.9 5105.3 5118.8 5166.1 04:46:55 INFO - PROCESS | 3426 | 04:46:55 INFO - PROCESS | 3426 | [#1] ext.html Cycles:180 Average:42700.70 Median:36140.64 stddev:74373.55 (205.8%) stddev-sans-first:74514.88 04:46:55 INFO - PROCESS | 3426 | Values: 555.7 565.6 567.5 571.0 600.2 34185.8 38570.2 38597.8 38659.6 38768.6 38671.2 39494.4 39588.2 39589.8 39597.4 7634.0 7774.4 7779.6 7786.6 7808.3 7670.7 7694.8 7695.3 7754.0 7764.6 7697.4 7734.7 7740.8 7767.4 7771.7 7712.4 7743.0 7761.8 7791.3 7794.3 7737.9 7773.7 7780.1 7782.6 7797.2 36607.6 37106.8 37118.6 37235.6 37310.3 2573.3 2603.2 2631.5 2676.8 3062.7 28484.6 28817.0 28984.4 29064.1 29366.6 3408.2 3423.0 3443.7 3466.6 3510.9 181325.0 181764.0 181776.0 182136.0 182352.0 50366.0 50562.0 50591.0 50678.0 50927.5 29258.0 29443.6 29746.1 29857.9 53152.2 15211.6 15398.7 15446.9 15463.8 15486.5 11742.6 11782.4 11924.7 11926.6 11950.2 17942.0 17970.8 18019.0 18042.7 18171.5 6737.6 6908.1 6915.2 6950.4 7060.4 808.9 847.2 901.8 941.6 988.5 26806.7 27582.3 27601.2 27859.7 28089.9 970.1 971.8 973.6 982.2 1037.3 14656.3 14842.9 14875.7 14896.8 14950.6 367288.0 375161.0 375475.0 377552.0 378630.0 48194.3 48879.0 48942.3 48966.3 49004.5 1157.0 1196.1 1206.5 1218.3 1226.8 26348.5 27325.3 27944.0 27958.0 28069.9 41972.8 42099.0 42679.8 42680.4 42702.1 255960.0 256417.0 257101.0 257406.0 258262.0 24996.4 25092.0 25512.9 25518.9 25604.7 41838.6 41859.6 42249.4 42286.2 42433.0 34878.0 35622.6 35701.3 36514.8 36588.5 35288.8 35369.8 35960.8 36179.8 36335.3 30932.8 35074.3 35271.5 36101.5 36649.0 31501.8 33776.8 33850.3 33980.2 34104.7 25775.0 25832.0 26012.9 26102.5 26507.0 04:46:55 INFO - PROCESS | 3426 | 04:46:55 INFO - PROCESS | 3426 | [#2] jquery.html Cycles:180 Average:25126.81 Median:5252.03 stddev:66432.65 (1264.9%) stddev-sans-first:66592.98 04:46:55 INFO - PROCESS | 3426 | Values: 359.5 361.9 368.7 379.5 388.7 16041.3 16880.6 17365.6 17454.5 17577.0 16806.7 17025.5 17461.7 17688.0 17702.8 5112.6 5319.8 5325.1 5332.7 5335.3 3728.6 5224.0 5830.0 6100.5 6119.9 6193.8 6203.8 6213.2 6220.8 6221.5 5009.7 5263.3 5298.7 5347.2 5361.5 5145.8 5197.2 5210.6 5240.6 5240.8 17758.7 17964.6 18033.0 18314.9 18523.8 1794.5 1816.4 1832.2 1943.7 2335.4 9048.1 9166.8 9177.2 9220.2 9635.9 1700.9 1747.5 1775.7 1794.5 1822.9 73428.0 74030.6 74057.6 74114.6 74548.6 9879.7 9947.6 10044.0 10148.1 10220.8 13690.7 13726.6 13745.5 13768.6 13788.8 7262.0 7468.7 7509.7 7662.7 7707.5 7139.0 7229.9 7312.0 7445.4 7470.8 4087.2 4259.7 4288.1 4389.4 4411.1 1646.1 1688.4 1717.3 1785.6 1833.4 810.2 815.8 869.3 879.9 942.1 16602.5 16606.2 16787.1 16928.9 17117.3 841.2 851.5 857.7 872.1 908.0 9214.2 9214.7 9745.7 9825.3 9858.8 391625.0 393188.0 401474.0 406727.0 407188.0 85394.6 86681.0 87192.0 88193.6 93484.5 741.7 754.4 776.3 784.0 787.9 15541.5 15764.8 16243.5 16305.4 16668.4 38121.4 38348.8 38354.8 39384.8 39480.8 51887.7 55095.7 55355.7 55857.7 56966.7 7293.2 7378.3 7426.8 7559.3 7737.0 10304.4 11102.9 11535.0 11681.8 12041.2 9290.9 9755.9 9756.6 10053.4 10392.6 9458.0 9802.6 10086.4 10096.6 10181.9 8980.2 9606.6 9653.5 9865.8 10138.4 7562.8 7609.7 7627.2 7788.6 7840.1 8444.8 9619.0 9892.7 10355.1 10467.3 04:46:55 INFO - PROCESS | 3426 | 04:46:55 INFO - PROCESS | 3426 | [#3] mootools.html Cycles:180 Average:5136.18 Median:5275.52 stddev:2908.76 (55.1%) stddev-sans-first:2903.20 04:46:55 INFO - PROCESS | 3426 | Values: 1376.1 1409.6 1506.8 1656.7 1708.5 6863.7 7457.5 7548.9 7925.0 7931.5 7514.5 7855.7 7861.2 7861.7 7876.5 2113.3 2143.5 2150.9 2156.4 2161.5 2096.0 2109.6 2168.3 2170.3 2175.3 2156.9 2158.6 2167.7 2168.0 2195.1 2117.0 2122.0 2128.5 2132.9 2146.6 2046.8 2107.9 2116.4 2118.9 2122.9 7870.3 7881.7 7898.2 7911.8 7950.7 4477.3 4648.7 4654.3 4660.6 4667.0 2696.2 2750.5 2790.3 2801.8 2811.3 884.5 904.8 915.0 917.7 930.0 10621.0 10660.9 10694.1 10710.2 10720.0 3901.6 4042.2 4197.1 4205.4 4208.6 8876.0 8989.5 9015.7 9023.9 9030.6 4578.2 4602.7 4625.9 4642.1 4653.3 3649.1 4107.2 4188.5 4226.5 4236.9 3592.8 3654.6 3719.4 3753.5 3765.9 1169.8 1173.9 1181.5 1203.3 1210.8 678.7 687.3 705.3 827.8 857.8 5095.4 5214.7 5336.3 5347.4 5359.9 390.5 390.8 395.1 396.9 914.9 3464.4 3733.7 4028.7 4037.8 4098.1 9474.2 9710.8 9716.3 9721.2 9803.6 9612.8 9630.5 9644.2 9657.1 9686.3 7051.6 7146.7 7241.1 7241.9 7260.9 5554.6 5614.6 5708.7 5722.3 5820.5 8893.4 8992.4 9007.9 9138.8 9147.4 8854.2 9130.1 9163.5 9329.7 9359.3 5742.3 6405.8 6501.8 6602.2 6752.8 7630.7 7633.0 7640.6 7679.0 7709.1 6704.4 6869.4 6904.5 6909.1 7010.8 6531.3 6540.1 6732.8 6827.0 6932.5 6073.8 6091.0 6143.4 6159.2 6164.6 4493.7 4522.4 4600.4 4630.8 4638.7 4414.2 4605.4 4612.7 4629.4 4814.9 04:46:55 INFO - PROCESS | 3426 | 04:46:55 INFO - PROCESS | 3426 | [#4] prototype.html Cycles:180 Average:4272.82 Median:4657.49 stddev:1232.00 (26.5%) stddev-sans-first:1198.55 04:46:55 INFO - PROCESS | 3426 | Values: 285.4 293.8 296.1 304.8 306.3 4881.4 4949.6 5094.6 5153.0 5188.7 4988.2 5050.6 5081.7 5085.6 5107.7 3978.1 4005.8 4007.9 4013.0 4013.4 3908.1 3968.4 4000.3 4027.2 4039.9 3926.7 3939.5 3941.8 3949.4 3977.4 3935.6 3942.1 3964.5 3972.5 3975.4 3507.7 3511.2 3517.3 3521.9 3528.1 4848.8 4923.4 4947.5 4979.2 5020.6 4492.7 4505.6 4520.2 4525.0 4528.6 5244.3 5281.7 5289.6 5298.5 5323.5 3724.9 3762.6 3771.3 3782.6 3825.8 5540.2 5540.4 5543.9 5572.5 5647.4 3922.3 3926.8 3934.6 3944.5 3951.4 3874.9 3967.3 3973.1 3988.5 3990.8 4457.2 4479.3 4495.0 4500.3 4504.3 5324.1 5355.4 5357.3 5359.9 5371.8 1248.1 1322.6 1350.9 1354.2 1358.5 918.6 924.6 950.3 952.1 955.0 4651.9 4658.4 4662.4 4674.0 4676.7 5411.2 5446.6 5463.4 5484.9 5497.0 4362.8 4625.6 4626.8 4656.6 4666.3 2513.6 2529.6 2545.7 2548.4 2563.0 4441.8 4449.4 4467.9 4477.0 4481.4 4575.4 4811.4 4882.6 4903.7 4924.9 4432.8 4435.9 4452.3 4466.6 4530.5 4770.7 4798.7 4835.5 4897.6 4899.3 4662.9 4732.3 4757.5 4771.2 4775.5 4294.9 4426.4 4452.5 4466.0 4473.9 3548.8 3573.6 3579.7 3608.8 3622.5 4802.8 4833.3 4844.6 4864.7 5200.5 5143.0 5253.3 5276.9 5294.4 5299.4 5329.9 5333.4 5333.8 5338.5 5350.9 4967.8 5148.7 5175.6 5215.8 5230.5 5332.1 5353.5 5365.3 5378.0 5384.6 5297.0 5300.7 5301.7 5304.8 5310.3 04:46:55 INFO - PROCESS | 3426 | 04:46:55 INFO - PROCESS | 3426 | [#5] yui.html Cycles:180 Average:16545.79 Median:493.11 stddev:22787.85 (4621.3%) stddev-sans-first:22820.35 04:46:55 INFO - PROCESS | 3426 | Values: 606.9 626.3 711.3 720.8 726.0 12403.3 13569.3 13680.0 13695.0 13754.8 13406.5 13570.9 13571.0 13572.7 13601.4 623.4 750.4 770.3 770.8 772.2 768.9 785.9 791.5 794.0 794.2 824.8 828.8 831.4 831.5 833.2 817.8 823.8 827.2 827.5 829.0 599.9 604.9 605.7 605.9 606.1 11711.4 11731.4 11773.6 11776.1 11794.7 13091.5 13458.7 13665.1 13672.5 13766.4 10214.8 10322.6 10406.8 10538.4 10568.6 3228.5 3263.8 3276.7 3287.3 3293.9 60390.0 61105.4 61199.0 61367.7 62137.7 9555.1 9622.1 9628.0 9716.4 9889.9 19916.6 19982.8 20024.6 20073.6 20291.0 6297.1 6367.3 6386.1 6604.5 6806.5 3554.0 3564.3 3619.8 3632.7 3661.1 2738.0 2806.4 2819.1 2824.3 2831.8 488.4 495.0 505.8 511.6 511.9 580.8 596.0 596.8 612.6 635.5 7399.9 7608.5 7731.2 7906.1 8050.9 491.2 514.6 517.1 524.4 608.1 3677.1 3773.1 3797.5 3808.5 3815.0 57125.7 58180.7 59100.0 98073.0 100550.0 83906.6 84105.0 86721.6 86855.0 87420.6 45443.5 59584.1 63549.7 70325.6 72898.3 7831.0 8290.5 8360.2 8418.0 8518.6 43291.6 43746.1 44323.8 45891.3 45947.5 39838.0 46413.1 58596.7 60739.7 63047.4 11462.5 11467.7 11703.8 11741.6 11926.5 12892.8 13031.4 13677.2 13742.9 14158.4 11589.7 11702.2 12005.3 12017.3 12669.6 10547.3 10753.5 11016.1 11050.6 11094.2 11193.4 11680.0 11903.9 12017.6 12170.5 10097.7 10134.0 10242.2 10608.5 10981.3 8056.0 8281.8 8569.2 8847.4 8966.7 04:46:55 INFO - PROCESS | 3426 | -------- Summary: end -------- 04:46:55 INFO - PROCESS | 3426 | 04:46:56 INFO - TEST-INFO | 3426: exit 0 04:46:56 INFO - TEST-OK | dromaeo_css | took 1119919ms 04:46:56 INFO - TEST-START | kraken 04:46:56 INFO - operating with platform_type : linux_ 04:46:56 INFO - Initialising browser for kraken test... 04:46:56 INFO - TEST-INFO | started process 3705 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQEASBh/profile http://localhost:35302/getInfo.html) 04:46:59 INFO - PROCESS | 3705 | JavaScript error: , line 0: uncaught exception: undefined 04:47:01 INFO - PROCESS | 3705 | __metrics Screen width/height:1600/1200 04:47:01 INFO - PROCESS | 3705 | colorDepth:24 04:47:01 INFO - PROCESS | 3705 | Browser inner width/height: 1024/697 04:47:01 INFO - PROCESS | 3705 | __metrics 04:47:01 ERROR - PROCESS | 3705 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 04:47:02 INFO - TEST-INFO | 3705: exit 0 04:47:02 INFO - Browser initialized. 04:47:02 INFO - Running cycle 1/1 for kraken test... 04:47:02 INFO - TEST-INFO | started process 3823 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQEASBh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:47:14 INFO - PROCESS | 3823 | RSS: Main: 169156608 04:47:14 INFO - PROCESS | 3823 | 04:47:17 INFO - PROCESS | 3823 | Cycle 1(1): loaded http://localhost:35302/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35302/tests/kraken/driver.html?testName=audio-beat-detection) 04:47:18 INFO - PROCESS | 3823 | RSS: Main: 174235648 04:47:18 INFO - PROCESS | 3823 | 04:47:20 INFO - PROCESS | 3823 | Cycle 1(1): loaded http://localhost:35302/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35302/tests/kraken/driver.html?testName=audio-dft) 04:47:21 INFO - PROCESS | 3823 | RSS: Main: 172793856 04:47:21 INFO - PROCESS | 3823 | 04:47:24 INFO - PROCESS | 3823 | Cycle 1(1): loaded http://localhost:35302/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35302/tests/kraken/driver.html?testName=audio-fft) 04:47:25 INFO - PROCESS | 3823 | RSS: Main: 169111552 04:47:25 INFO - PROCESS | 3823 | 04:47:27 INFO - PROCESS | 3823 | Cycle 1(1): loaded http://localhost:35302/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35302/tests/kraken/driver.html?testName=audio-oscillator) 04:47:27 INFO - PROCESS | 3823 | RSS: Main: 169799680 04:47:27 INFO - PROCESS | 3823 | 04:47:30 INFO - PROCESS | 3823 | Cycle 1(1): loaded http://localhost:35302/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35302/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:47:30 INFO - PROCESS | 3823 | RSS: Main: 170651648 04:47:30 INFO - PROCESS | 3823 | 04:47:33 INFO - PROCESS | 3823 | Cycle 1(1): loaded http://localhost:35302/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35302/tests/kraken/driver.html?testName=imaging-darkroom) 04:47:34 INFO - PROCESS | 3823 | RSS: Main: 171032576 04:47:34 INFO - PROCESS | 3823 | 04:47:38 INFO - PROCESS | 3823 | Cycle 1(1): loaded http://localhost:35302/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35302/tests/kraken/driver.html?testName=imaging-desaturate) 04:47:38 INFO - PROCESS | 3823 | RSS: Main: 168529920 04:47:38 INFO - PROCESS | 3823 | 04:47:41 INFO - PROCESS | 3823 | Cycle 1(1): loaded http://localhost:35302/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35302/tests/kraken/driver.html?testName=json-parse-financial) 04:47:42 INFO - PROCESS | 3823 | RSS: Main: 169734144 04:47:42 INFO - PROCESS | 3823 | 04:47:44 INFO - PROCESS | 3823 | Cycle 1(1): loaded http://localhost:35302/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35302/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:47:44 INFO - PROCESS | 3823 | RSS: Main: 170074112 04:47:44 INFO - PROCESS | 3823 | 04:47:46 INFO - PROCESS | 3823 | Cycle 1(1): loaded http://localhost:35302/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35302/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:47:47 INFO - PROCESS | 3823 | RSS: Main: 170508288 04:47:47 INFO - PROCESS | 3823 | 04:47:49 INFO - PROCESS | 3823 | Cycle 1(1): loaded http://localhost:35302/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35302/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:47:50 INFO - PROCESS | 3823 | RSS: Main: 170921984 04:47:50 INFO - PROCESS | 3823 | 04:47:52 INFO - PROCESS | 3823 | Cycle 1(1): loaded http://localhost:35302/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35302/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:47:53 INFO - PROCESS | 3823 | RSS: Main: 171094016 04:47:53 INFO - PROCESS | 3823 | 04:47:56 INFO - PROCESS | 3823 | Cycle 1(1): loaded http://localhost:35302/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35302/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:47:57 INFO - PROCESS | 3823 | RSS: Main: 170868736 04:47:57 INFO - PROCESS | 3823 | 04:47:58 INFO - PROCESS | 3823 | Cycle 1(1): loaded http://localhost:35302/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35302/tests/kraken/driver.html?testName=ai-astar) 04:47:59 INFO - PROCESS | 3823 | RSS: Main: 171601920 04:47:59 INFO - PROCESS | 3823 | 04:47:59 INFO - PROCESS | 3823 | __start_tp_report 04:47:59 INFO - PROCESS | 3823 | _x_x_mozilla_page_load 04:47:59 INFO - PROCESS | 3823 | _x_x_mozilla_page_load_details 04:47:59 INFO - PROCESS | 3823 | |i|pagename|runs| 04:47:59 INFO - PROCESS | 3823 | |0;ai-astar;106;114;107;114;114;116;117;113;113;114 04:47:59 INFO - PROCESS | 3823 | |1;audio-beat-detection;153;123;146;191;124;153;150;124;180;125 04:47:59 INFO - PROCESS | 3823 | |2;audio-dft;164;165;165;170;166;163;162;162;161;162 04:47:59 INFO - PROCESS | 3823 | |3;audio-fft;77;78;78;158;79;77;77;76;163;81 04:47:59 INFO - PROCESS | 3823 | |4;audio-oscillator;86;86;153;87;88;85;136;86;86;137 04:47:59 INFO - PROCESS | 3823 | |5;imaging-gaussian-blur;117;118;118;118;118;122;118;118;118;118 04:47:59 INFO - PROCESS | 3823 | |6;imaging-darkroom;156;151;151;148;148;150;147;148;148;147 04:47:59 INFO - PROCESS | 3823 | |7;imaging-desaturate;96;96;95;96;97;95;95;96;96;96 04:47:59 INFO - PROCESS | 3823 | |8;json-parse-financial;62;65;62;63;64;62;62;64;64;62 04:47:59 INFO - PROCESS | 3823 | |9;json-stringify-tinderbox;69;65;65;66;66;65;66;66;65;66 04:47:59 INFO - PROCESS | 3823 | |10;stanford-crypto-aes;88;86;84;81;80;79;79;80;78;89 04:47:59 INFO - PROCESS | 3823 | |11;stanford-crypto-ccm;136;147;136;133;150;133;148;134;175;141 04:47:59 INFO - PROCESS | 3823 | |12;stanford-crypto-pbkdf2;170;171;163;168;168;164;165;168;171;163 04:47:59 INFO - PROCESS | 3823 | |13;stanford-crypto-sha256-iterative;70;68;68;69;67;73;67;67;66;67 04:47:59 INFO - PROCESS | 3823 | __end_tp_report 04:47:59 INFO - PROCESS | 3823 | __start_cc_report 04:47:59 INFO - PROCESS | 3823 | _x_x_mozilla_cycle_collect,1038 04:47:59 INFO - PROCESS | 3823 | __end_cc_report 04:47:59 INFO - PROCESS | 3823 | __startTimestamp1469188079139__endTimestamp 04:47:59 INFO - PROCESS | 3823 | 04:47:59 INFO - PROCESS | 3823 | ------- Summary: start ------- 04:47:59 INFO - PROCESS | 3823 | Number of tests: 14 04:47:59 INFO - PROCESS | 3823 | 04:47:59 INFO - PROCESS | 3823 | [#0] ai-astar Cycles:10 Average:112.80 Median:114.00 stddev:3.55 (3.1%) stddev-sans-first:2.79 04:47:59 INFO - PROCESS | 3823 | Values: 106.0 114.0 107.0 114.0 114.0 116.0 117.0 113.0 113.0 114.0 04:47:59 INFO - PROCESS | 3823 | 04:47:59 INFO - PROCESS | 3823 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:151.50 stddev:24.09 (15.9%) stddev-sans-first:25.45 04:47:59 INFO - PROCESS | 3823 | Values: 153.0 123.0 146.0 191.0 124.0 153.0 150.0 124.0 180.0 125.0 04:47:59 INFO - PROCESS | 3823 | 04:47:59 INFO - PROCESS | 3823 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.50 stddev:2.67 (1.6%) stddev-sans-first:2.83 04:47:59 INFO - PROCESS | 3823 | Values: 164.0 165.0 165.0 170.0 166.0 163.0 162.0 162.0 161.0 162.0 04:47:59 INFO - PROCESS | 3823 | 04:47:59 INFO - PROCESS | 3823 | [#3] audio-fft Cycles:10 Average:94.40 Median:77.50 stddev:34.88 (45.0%) stddev-sans-first:36.43 04:47:59 INFO - PROCESS | 3823 | Values: 77.0 78.0 78.0 158.0 79.0 77.0 77.0 76.0 163.0 81.0 04:47:59 INFO - PROCESS | 3823 | 04:47:59 INFO - PROCESS | 3823 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:86.00 stddev:27.30 (31.7%) stddev-sans-first:28.25 04:47:59 INFO - PROCESS | 3823 | Values: 86.0 86.0 153.0 87.0 88.0 85.0 136.0 86.0 86.0 137.0 04:47:59 INFO - PROCESS | 3823 | 04:47:59 INFO - PROCESS | 3823 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:1.34 (1.1%) stddev-sans-first:1.33 04:47:59 INFO - PROCESS | 3823 | Values: 117.0 118.0 118.0 118.0 118.0 122.0 118.0 118.0 118.0 118.0 04:47:59 INFO - PROCESS | 3823 | 04:47:59 INFO - PROCESS | 3823 | [#6] imaging-darkroom Cycles:10 Average:149.40 Median:149.00 stddev:2.76 (1.9%) stddev-sans-first:1.58 04:47:59 INFO - PROCESS | 3823 | Values: 156.0 151.0 151.0 148.0 148.0 150.0 147.0 148.0 148.0 147.0 04:47:59 INFO - PROCESS | 3823 | 04:47:59 INFO - PROCESS | 3823 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 04:47:59 INFO - PROCESS | 3823 | Values: 96.0 96.0 95.0 96.0 97.0 95.0 95.0 96.0 96.0 96.0 04:47:59 INFO - PROCESS | 3823 | 04:47:59 INFO - PROCESS | 3823 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:63.50 stddev:1.15 (1.8%) stddev-sans-first:1.17 04:47:59 INFO - PROCESS | 3823 | Values: 62.0 65.0 62.0 63.0 64.0 62.0 62.0 64.0 64.0 62.0 04:47:59 INFO - PROCESS | 3823 | 04:47:59 INFO - PROCESS | 3823 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:1.20 (1.8%) stddev-sans-first:0.53 04:47:59 INFO - PROCESS | 3823 | Values: 69.0 65.0 65.0 66.0 66.0 65.0 66.0 66.0 65.0 66.0 04:47:59 INFO - PROCESS | 3823 | 04:47:59 INFO - PROCESS | 3823 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.50 stddev:4.03 (4.9%) stddev-sans-first:3.73 04:47:59 INFO - PROCESS | 3823 | Values: 88.0 86.0 84.0 81.0 80.0 79.0 79.0 80.0 78.0 89.0 04:47:59 INFO - PROCESS | 3823 | 04:47:59 INFO - PROCESS | 3823 | [#11] stanford-crypto-ccm Cycles:10 Average:143.30 Median:144.00 stddev:12.89 (9.0%) stddev-sans-first:13.40 04:47:59 INFO - PROCESS | 3823 | Values: 136.0 147.0 136.0 133.0 150.0 133.0 148.0 134.0 175.0 141.0 04:47:59 INFO - PROCESS | 3823 | 04:47:59 INFO - PROCESS | 3823 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.10 Median:168.00 stddev:3.14 (1.9%) stddev-sans-first:3.15 04:47:59 INFO - PROCESS | 3823 | Values: 170.0 171.0 163.0 168.0 168.0 164.0 165.0 168.0 171.0 163.0 04:47:59 INFO - PROCESS | 3823 | 04:47:59 INFO - PROCESS | 3823 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:2.04 (3.0%) stddev-sans-first:2.06 04:47:59 INFO - PROCESS | 3823 | Values: 70.0 68.0 68.0 69.0 67.0 73.0 67.0 67.0 66.0 67.0 04:47:59 INFO - PROCESS | 3823 | -------- Summary: end -------- 04:47:59 INFO - PROCESS | 3823 | 04:48:00 INFO - TEST-INFO | 3823: exit 0 04:48:00 INFO - TEST-OK | kraken | took 63905ms 04:48:00 INFO - SUITE-END | took 1183s 04:48:00 INFO - Completed test suite (00:19:44) 04:48:00 INFO - javascript benchmark 04:48:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6384.71156522523, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2623.540880345939, 2651.085375545437, 2662.321108117431, 2667.799915006375, 2674.2111077232216, 4826.372571565696, 4835.323054772331, 4858.2712593111055, 4902.0195960807805, 4957.677750946195, 4768.070226305872, 4861.854144375666, 4878.0731660984475, 4893.4617192108835, 4901.26481027846, 4487.910241795162, 4508.887277818065, 4552.248878934972, 4628.560286772768, 4659.906801863961, 4514.932276015862, 4569.862904112882, 4644.140833945731, 4651.767411629422, 4652.906941861161, 4374.387585737999, 4530.954690453119, 4571.3828633134435, 4588.609968152711, 4603.700759450625, 4407.471103467572, 4435.866923992286, 4445.333200019991, 4456.331550267486, 4461.196984542781, 4477.6417886569, 4531.274996000657, 4531.388262584542, 4547.590716835501, 4555.111753208126, 4808.663393562452, 4913.238448040559, 4951.405831300267, 4952.455229924705, 4966.15575352191, 5199.064168449678, 5201.583873290166, 5206.193040078794, 5207.895842083137, 5316.707581083039, 5270.104082305978, 5271.6744586675395, 5283.1546952487415, 5286.392064912546, 5289.0744119779265, 4691.601213896789, 4788.329633851264, 4829.106615276115, 4843.0313937212695, 4850.466448690677, 5366.382865970463, 5375.81184658535, 5380.085385484477, 5388.137897936312, 5436.483534064258, 5162.225666150032, 5172.353455818023, 5173.586113110942, 5176.430592634807, 5234.869128271747, 5056.165732654144, 5184.5593124584075, 5204.687718736888, 5231.529162375405, 5253.343332083489, 5224.059669259494, 5224.9738751306, 5228.0, 5259.421463638997, 5275.182346736262, 5200.453952335026, 5201.479852014768, 5238.057149713012, 5240.737963101829, 5272.736363181825, 4213.768242746678, 4361.542038086019, 4363.301871700576, 4364.432623758891, 4399.032212913154, 3837.2325534893134, 3839.827207775657, 3863.34323165057, 3885.5337359516475, 3895.844166233319, 4560.840370587013, 4580.473245576802, 4587.72473651582, 4589.5181005994555, 4634.21218392874, 5179.896402071938, 5246.422893481714, 5285.471452854684, 5306.7611957462, 5383.43473935239, 4553.726776393427, 4575.908481830411, 4611.100835337077, 4619.815207391666, 4621.23749581322, 4723.598494128038, 4746.240601503743, 4748.0978614063215, 4750.358701575312, 4754.429468463806, 4698.389209402892, 4859.514048595112, 4882.194437917704, 4892.51074892515, 4898.363212782316, 5264.52619264268, 5283.365996080495, 5284.233786100917, 5335.093034184276, 5340.546053585489, 4889.9022019560125, 4909.4354149273295, 4924.03981223658, 4928.359313289249, 4991.101601711727, 4971.8011279549855, 5156.587473002226, 5188.351456067991, 5202.24567437727, 5209.348831396075, 5246.213068039825, 5288.074586947192, 5302.920456193237, 5358.464153584766, 5368.758405871667, 5188.351456067991, 5201.869953251047, 5205.505476979833, 5211.166213405837, 5247.632665713516, 4981.850544483671, 5039.84880453587, 5046.621503387188, 5164.561012313995, 5197.22041693749, 5006.4743201963265, 5014.749262536786, 5053.31780209667, 5068.138416469283, 5132.178851383761, 5162.457941916045, 5162.8967420652125, 5179.352580927384, 5244.554212891947, 5259.21111833228, 5068.467810879804, 5074.949250507448, 5105.33630628016, 5118.795248190031, 5166.070107380708], "value": 4817.584651230394, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.7304707217, 565.5899472882161, 567.5005994724644, 570.997145014275, 600.1567797244873, 34185.82907085464, 38570.22859542811, 38597.80701096498, 38659.61340386595, 38768.61231387685, 38671.22657546847, 39494.40758388619, 39588.20823583526, 39589.802050989776, 39597.40603890944, 7633.961830190855, 7774.378049756006, 7779.611019449033, 7786.610669466532, 7808.3362914152085, 7670.654820533089, 7694.846103077935, 7695.307422331989, 7754.030746156731, 7764.572948487859, 7697.384209263246, 7734.651940662656, 7740.806479837993, 7767.378609711238, 7771.727989520368, 7712.421568382394, 7743.0, 7761.805954851117, 7791.298783109547, 7794.298513133816, 7737.916691663172, 7773.650185741655, 7780.066392032993, 7782.610869456505, 7797.220277972214, 36607.63392366069, 37106.8144659275, 37118.62881371179, 37235.627643723485, 37310.25379492395, 2573.2794817451145, 2603.1799983005294, 2631.5000149971443, 2676.7724743396834, 3062.739667128297, 28484.572731409044, 28817.0, 28984.42031159386, 29064.12807615775, 29366.55950160749, 3408.164999575095, 3422.9828850855833, 3443.6900678939014, 3466.6360032196762, 3510.9297814043575, 181325.0, 181764.0, 181776.0, 182136.0, 182352.0, 50366.0, 50562.0, 50591.0, 50678.0, 50927.49072509302, 29258.0, 29443.558346624817, 29746.107616771533, 29857.85071074631, 53152.20271695928, 15211.61970950713, 15398.692026159413, 15446.918715689793, 15463.84536154624, 15486.5354039379, 11742.589009384801, 11782.410879455992, 11924.701882452835, 11926.582569610022, 11950.223235489666, 17942.0, 17970.820291797176, 18019.0, 18042.729359059624, 18171.454856354332, 6737.562058466184, 6908.1364829396325, 6915.239323674392, 6950.374466298057, 7060.399866011447, 808.8988876390451, 847.2417186617943, 901.7655409593552, 941.5527624378366, 988.5403287471361, 26806.731932680425, 27582.310442238704, 27601.15678619803, 27859.72140278571, 28089.859550702116, 970.1228123580894, 971.8396464583265, 973.6008236623093, 982.2044144243185, 1037.3464717228098, 14656.340464679115, 14842.851571484363, 14875.70248595022, 14896.776548351783, 14950.551483455514, 367288.0, 375161.0, 375475.0, 377552.0, 378630.0, 48194.27708584374, 48879.0, 48942.265866012036, 48966.26550601744, 49004.509954900706, 1157.0, 1196.096946805174, 1206.535483838711, 1218.250775772911, 1226.8159776033667, 26348.473030539666, 27325.316867078483, 27944.0, 27958.0, 28069.859650701615, 41972.790136050346, 42099.0, 42679.78660106679, 42680.35979460248, 42702.1459570813, 255960.0, 256417.0, 257101.0, 257406.0, 258262.0, 24996.37509062288, 25092.0, 25512.872435637702, 25518.872405637852, 25604.743952560235, 41838.581614183466, 41859.581404186785, 42249.366259505514, 42286.1542769149, 42433.0, 34878.0, 35622.64377356193, 35701.28597428089, 36514.8174259127, 36588.45117323189, 35288.82355588206, 35369.82315088408, 35960.8201958999, 36179.81910090538, 36335.273294533436, 30932.845335773178, 35074.29851403009, 35271.470927936614, 36101.458478122324, 36649.0, 31501.842490788316, 33776.83111584427, 33850.32299354048, 33980.150496237795, 34104.65895341015, 25775.0, 25832.0, 26012.8699356502, 26102.477950441265, 26507.0], "value": 16933.091018507486, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.54517535317825, 361.88600590813894, 368.74188068352146, 379.50474630607044, 388.71623714688275, 16041.278142483587, 16880.577985550368, 17365.565860853483, 17454.47636570902, 17577.0, 16806.747898781527, 17025.48923532296, 17461.73807392887, 17688.0, 17702.822971770278, 5112.642115051948, 5319.813806516772, 5325.068113080215, 5332.680039197641, 5335.253064570963, 3728.608496107897, 5224.0, 5830.0, 6100.450959413652, 6119.877602447948, 6193.752249909998, 6203.7828675996125, 6213.161223234851, 6220.813375598739, 6221.471174950135, 5009.699418034911, 5263.289455923459, 5298.682079075248, 5347.224652425415, 5361.463853614647, 5145.845624631267, 5197.220416937452, 5210.635255532115, 5240.580753539708, 5240.764165612557, 17758.733618995724, 17964.55088622782, 18033.0, 18314.893787214507, 18523.814761852344, 1794.5334213104686, 1816.3915088445387, 1832.248778001013, 1943.7181608666665, 2335.404471859682, 9048.140426659456, 9166.816663666756, 9177.219936305422, 9220.170184683344, 9635.855462168072, 1700.8979461232243, 1747.4582879307454, 1775.6626241014294, 1794.5423916901236, 1822.8815127016835, 73428.0, 74030.62984685042, 74057.62971185164, 74114.62942685306, 74548.62725686391, 9879.703608891601, 9947.55236014381, 10044.0, 10148.071866345519, 10220.846687299696, 13690.726185476235, 13726.588202353945, 13745.518906838213, 13768.586942391745, 13788.793168102486, 7261.963690181516, 7468.738594149178, 7509.737159199511, 7662.73180438682, 7707.537547747041, 7139.0, 7229.855402892018, 7312.049433573601, 7445.36714379273, 7470.813229669193, 4087.1825634873144, 4259.7231179973205, 4288.09949910516, 4389.407429996973, 4411.051623900877, 1646.1275523972313, 1688.3584237989485, 1717.3302412059306, 1785.5893144576821, 1833.4041436532914, 810.2221867007621, 815.8409110223449, 869.2784988459564, 879.9076097009722, 942.0532364973158, 16602.50192494227, 16606.169691515377, 16787.07671078078, 16928.915355423145, 17117.315307387813, 841.2302742990217, 851.5401683091061, 857.6826574167598, 872.097379212512, 908.0193391137556, 9214.216791572791, 9214.723558293263, 9745.707628771148, 9825.312228144105, 9858.802823943624, 391625.0, 393188.0, 401474.0, 406727.0, 407188.0, 85394.57302713447, 86681.0, 87192.0, 88193.55903220443, 93484.53257733803, 741.6996116572797, 754.4077898849376, 776.3323541754087, 783.9686412543434, 787.8503084413943, 15541.533753987398, 15764.817638676916, 16243.51269461918, 16305.429309974093, 16668.41660541875, 38121.428178577895, 38348.80825595854, 38354.80822595869, 39384.80307598443, 39480.80259598684, 51887.74056129695, 55095.72452137714, 55355.72322138363, 55857.720711396185, 56966.7151664239, 7293.234210407831, 7378.335949764547, 7426.814329641802, 7559.3196612305155, 7736.961315193388, 10304.433256170983, 11102.944485277521, 11535.01952334061, 11681.766364672489, 12041.217320874115, 9290.907090929275, 9755.853662195215, 9756.60973561078, 10053.396796192252, 10392.58429662805, 9457.95271023668, 9802.607895684092, 10086.445245511568, 10096.596136154472, 10181.949090254797, 8980.191782739585, 9606.635141787438, 9653.517324133905, 9865.753356166153, 10138.442385668859, 7562.848743025219, 7609.733659321897, 7627.237276272328, 7788.610569471391, 7840.098388685375, 8444.831103378021, 9618.951905240428, 9892.653757118755, 10355.068043876086, 10467.319624224705], "value": 8222.123713926618, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.1467889908258, 1409.5630354590078, 1506.8493150684926, 1656.6686662667469, 1708.4789139312513, 6863.656817159134, 7457.477976541644, 7548.92451075489, 7924.960375198123, 7931.5241085534835, 7514.549127052381, 7855.725049623265, 7861.174576669453, 7861.685532578705, 7876.488028278158, 2113.323736404351, 2143.506993391521, 2150.9462263443384, 2156.4069880782754, 2161.4812445013163, 2095.9685604715864, 2109.599176156533, 2168.251953076186, 2170.348895331402, 2175.2712841198218, 2156.892155392232, 2158.57907707997, 2167.696522486853, 2168.024389024937, 2195.067096483996, 2116.9788302116935, 2121.968170477444, 2128.510442598196, 2132.8720276783365, 2146.5599552091785, 2046.7543894732578, 2107.8524503284775, 2116.375669177596, 2118.9152433902627, 2122.8514004019726, 7870.331021863149, 7881.724139655084, 7898.210178982114, 7911.841763164762, 7950.721724739664, 4477.283634618478, 4648.697834640738, 4654.278586819015, 4660.557247061523, 4667.019925815583, 2696.204619637192, 2750.4636595863813, 2790.3024243939017, 2801.775857931381, 2811.2971757060736, 884.5228077728385, 904.8009437923646, 914.9862752058724, 917.7155081924625, 930.0327659234456, 10621.044106030417, 10660.893391066067, 10694.091002264817, 10710.19673524481, 10720.035196832323, 3901.6293452122004, 4042.241624893181, 4197.076643138505, 4205.411242426063, 4208.558101399371, 8875.955620221857, 8989.46063236208, 9015.729528114167, 9023.909760902307, 9030.63877444908, 4578.153041687298, 4602.65480088988, 4625.930611040837, 4642.117997580449, 4653.348531205634, 3649.1059690375496, 4107.219628270619, 4188.518320393133, 4226.492820861455, 4236.9364459533135, 3592.7844329340323, 3654.5979942206336, 3719.367707489733, 3753.474513568103, 3765.943510847285, 1169.8479197704244, 1173.9119566032582, 1181.5155786127646, 1203.3441774233063, 1210.8244304575787, 678.7285085965653, 687.3161204601354, 705.2770909817478, 827.8344331133798, 857.8327226190958, 5095.363079615048, 5214.739263036833, 5336.306280183551, 5347.385050719217, 5359.946400536022, 390.4689622113923, 390.7616354024043, 395.1287411258169, 396.90275882409, 914.92680585553, 3464.428369319034, 3733.7199710021855, 4028.677705783589, 4037.7779222142476, 4098.139390727921, 9474.242060635133, 9710.805783884283, 9716.31985761004, 9721.222302215805, 9803.558839852223, 9612.75968100789, 9630.47032413224, 9644.228461723045, 9657.130858222654, 9686.321957463051, 7051.576905385693, 7146.749863754743, 7241.058662373857, 7241.927580724126, 7260.927390726025, 5554.555635549227, 5614.63504872182, 5708.65748055118, 5722.256106706268, 5820.476157145878, 8893.443647361557, 8992.370534062553, 9007.864882026906, 9138.817223655622, 9147.405418647766, 8854.203121718818, 9130.086991300817, 9163.450192988443, 9329.673461428818, 9359.344845860724, 5742.3109226891365, 6405.839854003687, 6501.837454063686, 6602.1747281589805, 6752.763653272112, 7630.7329243476215, 7633.0458692663415, 7640.617969101634, 7679.040119985002, 7709.113451953097, 6704.396604305636, 6869.416099631588, 6904.516683832084, 6909.136357955255, 7010.824729381806, 6531.3468653134305, 6540.117084193573, 6732.798016059526, 6827.044213809972, 6932.514723969273, 6073.817785466443, 6091.0, 6143.416375444325, 6159.199304090619, 6164.599301045418, 4493.6854420191585, 4522.366868638327, 4600.4479462464715, 4630.791614377294, 4638.6752927294765, 4414.227510185769, 4605.447346318463, 4612.7001744886475, 4629.375034370451, 4814.927776083432], "value": 4067.1313828542943, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.3992346111435, 293.83692050911765, 296.0511560448761, 304.7866493454582, 306.2512157774243, 4881.387773047945, 4949.604031677466, 5094.566961808247, 5152.974235128829, 5188.662736922102, 4988.226824842146, 5050.595952323814, 5081.720505372203, 5085.61857860661, 5107.693538387699, 3978.1049263915606, 4005.7596544207295, 4007.9198416031663, 4012.959870401288, 4013.3979903014488, 3908.1436317749126, 3968.365061590146, 4000.3399439092514, 4027.1744292419985, 4039.878803635881, 3926.72512924094, 3939.5075615548058, 3941.822617982183, 3949.4075888616794, 3977.443157957888, 3935.5867633898456, 3942.1327307992196, 3964.4846169998004, 3972.483577134983, 3975.383815508601, 3507.719382449398, 3511.2450823073164, 3517.26137511123, 3521.9295614087573, 3528.1356067763304, 4848.757562121879, 4923.359963204796, 4947.505249475023, 4979.228219625964, 5020.573251273646, 4492.707973981681, 4505.617022553087, 4520.2315606347, 4525.036101353586, 4528.615067719248, 5244.265802787613, 5281.683099014072, 5289.603279753996, 5298.523132918056, 5323.520883120537, 3724.888253352404, 3762.5673047599603, 3771.283456143324, 3782.602826703184, 3825.8278377472802, 5540.168974653794, 5540.418256083093, 5543.944560554383, 5572.498475137257, 5647.3505546862225, 3922.2547715933883, 3926.803659816998, 3934.580233156645, 3944.467496887941, 3951.427043078795, 3874.903127421837, 3967.3255546557157, 3973.1259122992897, 3988.541317748438, 3990.8204130814183, 4457.2199865023495, 4479.283314669638, 4494.955050449519, 4500.302453119772, 4504.2839657282875, 5324.121519949165, 5355.3841308249275, 5357.330333708286, 5359.946400535945, 5371.811986580451, 1248.126311581878, 1322.6296636941672, 1350.9459621615222, 1354.2280899887166, 1358.483776165051, 918.5682729117304, 924.611663101499, 950.3015283766426, 952.1050212800085, 954.9809003819885, 4651.930056087119, 4658.394408726844, 4662.370579971728, 4674.0, 4676.719396836201, 5411.18832175169, 5446.611114165862, 5463.426340234298, 5484.945150548523, 5496.972515137399, 4362.8438463807115, 4625.560571745679, 4626.791794369262, 4656.580907718321, 4666.346711460398, 2513.5978243481322, 2529.6458495810602, 2545.707243667002, 2548.439343344461, 2562.9743702562737, 4441.822327106945, 4449.377087207794, 4467.865964021084, 4477.0, 4481.3726078349055, 4575.428071491064, 4811.350467686888, 4882.633802464829, 4903.714511277452, 4924.852254432372, 4432.82268709248, 4435.911281774346, 4452.261858956654, 4466.6203372713035, 4530.524294949048, 4770.666053376231, 4798.73606951621, 4835.516448355136, 4897.632677549127, 4899.31409602663, 4662.901448362822, 4732.337472753748, 4757.500462451393, 4771.208842826985, 4775.522447755336, 4294.9355759663, 4426.384369705099, 4452.462096604904, 4465.955340446554, 4473.910521789481, 3548.8225588719943, 3573.5890372607482, 3579.6957258633306, 3608.783472991629, 3622.4566315052953, 4802.759862006816, 4833.347498087714, 4844.61243100544, 4864.683795553277, 5200.5059519345605, 5142.971405718797, 5253.343332083489, 5276.868078298074, 5294.391145018218, 5299.39057008449, 5329.866753331198, 5333.43998880112, 5333.813316533902, 5338.54622357104, 5350.892982140257, 4967.801287948441, 5148.7425628717665, 5175.560077393313, 5215.843524694265, 5230.450802665665, 5332.094008765154, 5353.491418315254, 5365.3293338332705, 5377.973110134424, 5384.596155288447, 5296.9670914171365, 5300.655457395257, 5301.655392399482, 5304.814331498379, 5310.283111780015], "value": 3882.9115240274505, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.8634557224624, 626.3016736338983, 711.2579571365683, 720.7585458871278, 725.9815339574399, 12403.255804651728, 13569.321533923288, 13680.0, 13695.0, 13754.793678094824, 13406.530771423002, 13570.864291357084, 13571.0, 13572.660683482918, 13601.38793754281, 623.3548277532755, 750.4371721209093, 770.2605498721207, 770.8265640230959, 772.1776308231715, 768.8500742355243, 785.8585454618167, 791.4973991515371, 794.0233512779256, 794.213728408874, 824.7690646618956, 828.8342331533687, 831.40969911363, 831.4844796226348, 833.1626715151265, 817.8364327134567, 823.8064054947083, 827.1893544326564, 827.4869580859876, 829.0093338460482, 599.8500374906273, 604.8639056212361, 605.7455868535226, 605.8909396308662, 606.0817860940679, 11711.414429278502, 11731.354775487345, 11773.646790596296, 11776.11679124069, 11794.705132371673, 13091.541796037189, 13458.663533411645, 13665.111767735065, 13672.521461748891, 13766.449342026408, 10214.779651620418, 10322.638707645196, 10406.791864162675, 10538.36769793807, 10568.573242612303, 3228.4834426491648, 3263.8041717497026, 3276.7050965413227, 3287.342531493711, 3293.901182964515, 60390.0, 61105.38894611041, 61199.0, 61367.69316153436, 62137.68931155315, 9555.092266234697, 9622.13400793932, 9627.951860240793, 9716.417014979124, 9889.851652225223, 19916.60166796685, 19982.800171998384, 20024.598278120684, 20073.598528029357, 20291.0, 6297.118403423525, 6367.299597044322, 6386.07401926718, 6604.537682362188, 6806.4554835613035, 3553.964460355415, 3564.3405969895653, 3619.819009049537, 3632.7457078004813, 3661.139632186434, 2738.0, 2806.396624725694, 2819.0837977657343, 2824.3080445291034, 2831.8159319644155, 488.35537091039487, 495.04209354898387, 505.7850413574216, 511.64185070450833, 511.9155339368962, 580.8083332500265, 595.9880802383929, 596.8269201931478, 612.6201754911895, 635.520182262389, 7399.926000740032, 7608.543487390774, 7731.226877312224, 7906.130325664172, 8050.919490805017, 491.1772780592493, 514.580616797309, 517.092502657833, 524.4493282053828, 608.1182285685774, 3677.1174918019483, 3773.132179598708, 3797.5442946846556, 3808.4668146459517, 3815.04623844039, 57125.71437142871, 58180.709096455095, 59100.0, 98073.0, 100550.0, 83906.5804670985, 84105.0, 86721.56639216763, 86855.0, 87420.56289718638, 45443.54556454459, 59584.10623840732, 63549.68225158937, 70325.64837175781, 72898.27101728915, 7831.0, 8290.46112002718, 8360.247577718035, 8418.0, 8518.574071296534, 43291.56708432875, 43746.12507749891, 44323.77838110918, 45891.311630324904, 45947.540524594326, 39838.0, 46413.07173856571, 58596.70701646464, 60739.69630151821, 63047.36952630415, 11462.541498339973, 11467.713307167387, 11703.76592468163, 11741.589044383405, 11926.463309150935, 12892.806607901077, 13031.413586388446, 13677.24775137377, 13742.93128534351, 14158.362873670503, 11589.723202305886, 11702.180847340604, 12005.339706315886, 12017.278963262232, 12669.556565520163, 10547.314424562379, 10753.516091776046, 11016.11871050298, 11050.557977681125, 11094.223404361617, 11193.384363860067, 11680.0, 11903.880961190624, 12017.579384721843, 12170.45232964501, 10097.697069087939, 10134.0, 10242.180625550087, 10608.52261648243, 10981.286216395909, 8055.959720201596, 8281.792955176168, 8569.185927336894, 8847.380683352361, 8966.730998070068], "value": 6394.48203697558, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1574.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 107.0, 114.0, 114.0, 116.0, 117.0, 113.0, 113.0, 114.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 123.0, 146.0, 191.0, 124.0, 153.0, 150.0, 124.0, 180.0, 125.0], "value": 146.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 165.0, 170.0, 166.0, 163.0, 162.0, 162.0, 161.0, 162.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 158.0, 79.0, 77.0, 77.0, 76.0, 163.0, 81.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 153.0, 87.0, 88.0, 85.0, 136.0, 86.0, 86.0, 137.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 122.0, 118.0, 118.0, 118.0, 118.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 151.0, 151.0, 148.0, 148.0, 150.0, 147.0, 148.0, 148.0, 147.0], "value": 149.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 97.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 62.0, 63.0, 64.0, 62.0, 62.0, 64.0, 64.0, 62.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 65.0, 66.0, 66.0, 65.0, 66.0, 66.0, 65.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 84.0, 81.0, 80.0, 79.0, 79.0, 80.0, 78.0, 89.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 147.0, 136.0, 133.0, 150.0, 133.0, 148.0, 134.0, 175.0, 141.0], "value": 143.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 171.0, 163.0, 168.0, 168.0, 164.0, 165.0, 168.0, 171.0, 163.0], "value": 167.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 68.0, 69.0, 67.0, 73.0, 67.0, 67.0, 66.0, 67.0], "value": 68.2, "unit": "score"}]}]} 04:48:00 INFO - Return code: 0 04:48:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:48:00 ERROR - # TBPL SUCCESS # 04:48:00 INFO - Running post-action listener: _resource_record_post_action 04:48:00 INFO - [mozharness: 2016-07-22 11:48:00.923952Z] Finished run-tests step (success) 04:48:00 INFO - Running post-run listener: _resource_record_post_run 04:48:00 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 10153984; Write bytes: 419606528; Read time: 2548; Write time: 347484 04:48:00 INFO - TinderboxPrint: CPU usage
13.4% 04:48:00 INFO - TinderboxPrint: I/O read bytes / time
10,153,984 / 2,548 04:48:00 INFO - TinderboxPrint: I/O write bytes / time
419,606,528 / 347,484 04:48:00 INFO - TinderboxPrint: CPU idle
8,299.9 (86.6%) 04:48:00 INFO - TinderboxPrint: CPU user
1,225.3 (12.8%) 04:48:00 INFO - TinderboxPrint: Swap in / out
0 / 0 04:48:00 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 82268160; Read time: 204; Write time: 108288 04:48:01 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 8413184; Write bytes: 337338368; Read time: 2292; Write time: 239196 04:48:01 INFO - Running post-run listener: _upload_blobber_files 04:48:01 INFO - Blob upload gear active. 04:48:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:48:01 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 04:48:01 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:48:01 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:48:02 INFO - (blobuploader) - INFO - Open directory for files ... 04:48:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:48:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:48:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:48:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:48:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:48:02 INFO - (blobuploader) - INFO - Done attempting. 04:48:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:48:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:48:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:48:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:48:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:48:03 INFO - (blobuploader) - INFO - Done attempting. 04:48:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:48:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:48:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:48:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:48:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:48:27 INFO - (blobuploader) - INFO - Done attempting. 04:48:27 INFO - (blobuploader) - INFO - Iteration through files over. 04:48:27 INFO - Return code: 0 04:48:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:48:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:48:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1cd6292e50c265fea449b21c07c0df1fd366136199fe01184331523676cf29d5626ba2a94b851ddbe31239be4b70ac3f73ccc4f50833f0267cdb838824cba40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/840717b6fa706ab1a730c02b2e387c1042d1d8e9ec1e0bb514273f2a451f241f24a88705cdf35603a3e6d805258a9525c81d27ba542276dae37d8840467e3f16", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/14eb979c3e926fdf6aa5a2cca90efac78e127ce6f19f71f38c57db929a6ac3cc908d6adac5b95d80b9cef5d6b6bf2db599e9ec2eaa051fad34961e79b84afb42"} 04:48:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:48:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:48:27 INFO - Contents: 04:48:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1cd6292e50c265fea449b21c07c0df1fd366136199fe01184331523676cf29d5626ba2a94b851ddbe31239be4b70ac3f73ccc4f50833f0267cdb838824cba40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/840717b6fa706ab1a730c02b2e387c1042d1d8e9ec1e0bb514273f2a451f241f24a88705cdf35603a3e6d805258a9525c81d27ba542276dae37d8840467e3f16", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/14eb979c3e926fdf6aa5a2cca90efac78e127ce6f19f71f38c57db929a6ac3cc908d6adac5b95d80b9cef5d6b6bf2db599e9ec2eaa051fad34961e79b84afb42"} 04:48:27 INFO - Running post-run listener: copy_logs_to_upload_dir 04:48:27 INFO - Copying logs to upload dir... 04:48:27 INFO - mkdir: /builds/slave/test/build/upload/logs 04:48:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.370733 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-22 04:48:27.723380) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 04:48:27.727386) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1469186838.60492-1747539257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1cd6292e50c265fea449b21c07c0df1fd366136199fe01184331523676cf29d5626ba2a94b851ddbe31239be4b70ac3f73ccc4f50833f0267cdb838824cba40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/840717b6fa706ab1a730c02b2e387c1042d1d8e9ec1e0bb514273f2a451f241f24a88705cdf35603a3e6d805258a9525c81d27ba542276dae37d8840467e3f16", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/14eb979c3e926fdf6aa5a2cca90efac78e127ce6f19f71f38c57db929a6ac3cc908d6adac5b95d80b9cef5d6b6bf2db599e9ec2eaa051fad34961e79b84afb42"} build_url:https://queue.taskcluster.net/v1/task/NMwYwfpFTgW3dMIbuGUezA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011204 build_url: 'https://queue.taskcluster.net/v1/task/NMwYwfpFTgW3dMIbuGUezA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1cd6292e50c265fea449b21c07c0df1fd366136199fe01184331523676cf29d5626ba2a94b851ddbe31239be4b70ac3f73ccc4f50833f0267cdb838824cba40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/840717b6fa706ab1a730c02b2e387c1042d1d8e9ec1e0bb514273f2a451f241f24a88705cdf35603a3e6d805258a9525c81d27ba542276dae37d8840467e3f16", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/14eb979c3e926fdf6aa5a2cca90efac78e127ce6f19f71f38c57db929a6ac3cc908d6adac5b95d80b9cef5d6b6bf2db599e9ec2eaa051fad34961e79b84afb42"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 04:48:27.757629) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 04:48:27.757998) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1469186838.60492-1747539257 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004377 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 04:48:27.841819) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 04:48:27.842599) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 04:48:27.843293) ========= ========= Total master_lag: 0.16 =========