builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1472029950.72 results: success (0) buildid: 20160823233011 builduid: 1a4d250dcce44e6ba825556523370c77 revision: eb8d56badefecf8c277d8f82d6f2f91ec8f9c4fc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 02:12:30.716858) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 02:12:30.717318) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 02:12:30.717593) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 02:12:30.729068) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 02:12:30.729476) ========= 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=745a4373a2a16df560f216e000000264-1472029950.144851-823051165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-24 02:12:31-- 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% 45.6M=0s 2016-08-24 02:12:31 (45.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113479 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 02:12:30.883777) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 02:12:30.884098) ========= 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=745a4373a2a16df560f216e000000264-1472029950.144851-823051165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013865 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 02:12:30.981768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 02:12:30.982153) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev eb8d56badefecf8c277d8f82d6f2f91ec8f9c4fc --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 eb8d56badefecf8c277d8f82d6f2f91ec8f9c4fc --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=745a4373a2a16df560f216e000000264-1472029950.144851-823051165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-24 02:12:31,428 truncating revision to first 12 chars 2016-08-24 02:12:31,428 Setting DEBUG logging. 2016-08-24 02:12:31,428 attempt 1/10 2016-08-24 02:12:31,428 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/eb8d56badefe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-24 02:12:31,784 unpacking tar archive at: fx-team-eb8d56badefe/testing/mozharness/ program finished with exit code 0 elapsedTime=0.730963 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 02:12:31.729948) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 02:12:31.730631) ========= script_repo_revision: eb8d56badefecf8c277d8f82d6f2f91ec8f9c4fc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 02:12:31.731483) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 02:12:31.732081) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 02:12:31.744704) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-24 02:12:31.745026) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1472029950.144851-823051165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:12:32 INFO - MultiFileLogger online at 20160824 02:12:32 in /builds/slave/test 02:12:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:12:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:12:32 INFO - {'append_to_log': False, 02:12:32 INFO - 'base_work_dir': '/builds/slave/test', 02:12:32 INFO - 'blob_upload_branch': 'Fx-Team', 02:12:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:12:32 INFO - 'branch': 'Fx-Team', 02:12:32 INFO - 'buildbot_json_path': 'buildprops.json', 02:12:32 INFO - 'config_files': ('talos/linux_config.py',), 02:12:32 INFO - 'default_actions': ('clobber', 02:12:32 INFO - 'read-buildbot-config', 02:12:32 INFO - 'download-and-extract', 02:12:32 INFO - 'populate-webroot', 02:12:32 INFO - 'create-virtualenv', 02:12:32 INFO - 'install', 02:12:32 INFO - 'run-tests'), 02:12:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:12:32 INFO - 'download_minidump_stackwalk': True, 02:12:32 INFO - 'download_symbols': 'ondemand', 02:12:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:12:32 INFO - 'tooltool.py': '/tools/tooltool.py', 02:12:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:12:32 INFO - '/tools/misc-python/virtualenv.py')}, 02:12:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:12:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:12:32 INFO - 'installer_path': 'installer.exe', 02:12:32 INFO - 'log_level': 'info', 02:12:32 INFO - 'log_name': 'talos', 02:12:32 INFO - 'log_to_console': True, 02:12:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:12:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:12:32 INFO - 'opt_config_files': (), 02:12:32 INFO - 'pip_index': False, 02:12:32 INFO - 'sps_profile': False, 02:12:32 INFO - 'sps_profile_interval': 0, 02:12:32 INFO - 'suite': 'dromaeojs', 02:12:32 INFO - 'system_bits': '32', 02:12:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:12:32 INFO - 'title': 'talos-linux64-ix-032', 02:12:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:12:32 INFO - 'use_talos_json': True, 02:12:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:12:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:12:32 INFO - 'work_dir': 'build'} 02:12:32 INFO - [mozharness: 2016-08-24 09:12:32.283582Z] Running clobber step. 02:12:32 INFO - Running pre-action listener: _resource_record_pre_action 02:12:32 INFO - Running main action method: clobber 02:12:32 INFO - rmtree: /builds/slave/test/build 02:12:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:12:32 INFO - Running post-action listener: _resource_record_post_action 02:12:32 INFO - [mozharness: 2016-08-24 09:12:32.744911Z] Finished clobber step (success) 02:12:32 INFO - [mozharness: 2016-08-24 09:12:32.745010Z] Running read-buildbot-config step. 02:12:32 INFO - Running pre-action listener: _resource_record_pre_action 02:12:32 INFO - Running main action method: read_buildbot_config 02:12:32 INFO - Using buildbot properties: 02:12:32 INFO - { 02:12:32 INFO - "project": "", 02:12:32 INFO - "product": "firefox", 02:12:32 INFO - "script_repo_revision": "production", 02:12:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:12:32 INFO - "repository": "", 02:12:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:12:32 INFO - "buildid": "20160823233011", 02:12:32 INFO - "pgo_build": "True", 02:12:32 INFO - "basedir": "/builds/slave/test", 02:12:32 INFO - "buildnumber": 386, 02:12:32 INFO - "slavename": "talos-linux64-ix-032", 02:12:32 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:12:32 INFO - "platform": "ubuntu64_hw", 02:12:32 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:12:32 INFO - "branch": "fx-team", 02:12:32 INFO - "repo_path": "integration/fx-team", 02:12:32 INFO - "revision": "eb8d56badefecf8c277d8f82d6f2f91ec8f9c4fc", 02:12:32 INFO - "stage_platform": "linux64-pgo", 02:12:32 INFO - "builduid": "1a4d250dcce44e6ba825556523370c77", 02:12:32 INFO - "slavebuilddir": "test" 02:12:32 INFO - } 02:12:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 02:12:32 INFO - Running post-action listener: _resource_record_post_action 02:12:32 INFO - [mozharness: 2016-08-24 09:12:32.747430Z] Finished read-buildbot-config step (success) 02:12:32 INFO - [mozharness: 2016-08-24 09:12:32.747517Z] Running download-and-extract step. 02:12:32 INFO - Running pre-action listener: _resource_record_pre_action 02:12:32 INFO - Running main action method: download_and_extract 02:12:32 INFO - mkdir: /builds/slave/test/build/tests 02:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:12:32 INFO - trying https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:12:32 INFO - Downloading https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:12:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:12:33 INFO - Downloaded 1361 bytes. 02:12:33 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 02:12:33 INFO - Using the following test package requirements: 02:12:33 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:12:33 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:33 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:12:33 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:33 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:12:33 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:33 INFO - u'jsshell-linux-x86_64.zip'], 02:12:33 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:33 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:12:33 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 02:12:33 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:33 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:12:33 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:33 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:12:33 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:33 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:12:33 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 02:12:33 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:12:33 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:12:33 INFO - trying https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:12:33 INFO - Downloading https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:12:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:12:34 INFO - Downloaded 21913467 bytes. 02:12:34 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 02:12:38 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:12: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:12:38 INFO - trying https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:12:38 INFO - Downloading https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 02:12:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:12:39 INFO - Downloaded 21913467 bytes. 02:12:39 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 02:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:12:44 INFO - trying https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 02:12:44 INFO - Downloading https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 02:12:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:12:44 INFO - Downloaded 14413981 bytes. 02:12:44 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 02:12: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:12:45 INFO - trying https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:12:45 INFO - Downloading https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:12:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:12:46 INFO - Downloaded 59587475 bytes. 02:12:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:12:46 INFO - mkdir: /builds/slave/test/properties 02:12:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:12:46 INFO - Writing to file /builds/slave/test/properties/build_url 02:12:46 INFO - Contents: 02:12:46 INFO - build_url:https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 02:12:46 INFO - Running post-action listener: _resource_record_post_action 02:12:46 INFO - Running post-action listener: set_extra_try_arguments 02:12:46 INFO - [mozharness: 2016-08-24 09:12:46.983280Z] Finished download-and-extract step (success) 02:12:46 INFO - [mozharness: 2016-08-24 09:12:46.983496Z] Running populate-webroot step. 02:12:46 INFO - Running pre-action listener: _resource_record_pre_action 02:12:46 INFO - Running main action method: populate_webroot 02:12:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:12:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:12:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:12:46 INFO - '--tppagecycles', 02:12:46 INFO - '7'], 02:12:46 INFO - 'tests': ['tsvgm']}}, 02:12:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:12:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:12:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:12:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:12:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:12:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:12:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:46 INFO - 'talos_options': ['--disable-e10s'], 02:12:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:12:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:12:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:46 INFO - 'talos_options': ['--disable-e10s'], 02:12:46 INFO - 'tests': ['damp', 'tps']}, 02:12:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:46 INFO - 'tests': ['damp', 'tps']}, 02:12:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:12:46 INFO - 'tests': ['dromaeo_dom']}, 02:12:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:12:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:12:46 INFO - 'tests': ['basic_compositor_video']}, 02:12:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:12:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:12:46 INFO - 'tests': ['a11yr', 02:12:46 INFO - 'ts_paint', 02:12:46 INFO - 'tpaint', 02:12:46 INFO - 'sessionrestore', 02:12:46 INFO - 'sessionrestore_no_auto_restore', 02:12:46 INFO - 'tabpaint']}, 02:12:46 INFO - 'other-e10s': {'tests': ['a11yr', 02:12:46 INFO - 'ts_paint', 02:12:46 INFO - 'tpaint', 02:12:46 INFO - 'sessionrestore', 02:12:46 INFO - 'sessionrestore_no_auto_restore', 02:12:46 INFO - 'tabpaint']}, 02:12:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:12:46 INFO - 'ts_paint', 02:12:46 INFO - 'tpaint', 02:12:46 INFO - 'sessionrestore', 02:12:46 INFO - 'sessionrestore_no_auto_restore', 02:12:46 INFO - 'tabpaint']}, 02:12:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:12:46 INFO - 'ts_paint', 02:12:46 INFO - 'tpaint', 02:12:46 INFO - 'sessionrestore', 02:12:46 INFO - 'sessionrestore_no_auto_restore', 02:12:46 INFO - 'tabpaint']}, 02:12:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:12:46 INFO - 'tests': ['a11yr', 02:12:47 INFO - 'ts_paint', 02:12:47 INFO - 'tpaint', 02:12:47 INFO - 'sessionrestore', 02:12:47 INFO - 'sessionrestore_no_auto_restore', 02:12:47 INFO - 'tabpaint']}, 02:12:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:12:47 INFO - 'tests': ['a11yr', 02:12:47 INFO - 'ts_paint', 02:12:47 INFO - 'tpaint', 02:12:47 INFO - 'sessionrestore', 02:12:47 INFO - 'sessionrestore_no_auto_restore', 02:12:47 INFO - 'tabpaint']}, 02:12:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:12:47 INFO - 'tests': ['tsvgx', 02:12:47 INFO - 'tsvgr_opacity', 02:12:47 INFO - 'tart', 02:12:47 INFO - 'tscrollx', 02:12:47 INFO - 'cart']}, 02:12:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:12:47 INFO - 'tsvgr_opacity', 02:12:47 INFO - 'tart', 02:12:47 INFO - 'tscrollx', 02:12:47 INFO - 'cart']}, 02:12:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:47 INFO - 'talos_options': ['--disable-e10s'], 02:12:47 INFO - 'tests': ['tp5o']}, 02:12:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:47 INFO - 'tests': ['tp5o']}, 02:12:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:47 INFO - 'talos_options': ['--disable-e10s', 02:12:47 INFO - '--xperf_path', 02:12:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:12:47 INFO - 'tests': ['tp5n']}, 02:12:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:12:47 INFO - 'talos_options': ['--xperf_path', 02:12:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:12:47 INFO - 'tests': ['tp5n']}}, 02:12:47 INFO - 'talos.zip': {'path': '', 02:12:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:12:47 INFO - Running post-action listener: _resource_record_post_action 02:12:47 INFO - [mozharness: 2016-08-24 09:12:47.002948Z] Finished populate-webroot step (success) 02:12:47 INFO - [mozharness: 2016-08-24 09:12:47.003035Z] Running create-virtualenv step. 02:12:47 INFO - Running pre-action listener: _resource_record_pre_action 02:12:47 INFO - Running main action method: create_virtualenv 02:12:47 INFO - Creating virtualenv /builds/slave/test/build/venv 02:12:47 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 02:12:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:12:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:12:47 INFO - Using real prefix '/usr' 02:12:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:12:47 INFO - Installing distribute.............................................................................................................................................................................................done. 02:12:49 INFO - Installing pip.................done. 02:12:49 INFO - Return code: 0 02:12:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:12:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:49 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 0x7f98813abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269d370>, '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 0x26a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a0d80>, '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': '745a4373a2a16df560f216e000000264-1472029950.144851-823051165', '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 02:12:49 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 02:12:49 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 02:12:49 INFO - Using env: {'DISPLAY': ':0', 02:12:49 INFO - 'HOME': '/home/cltbld', 02:12:49 INFO - 'LANG': 'en_US.UTF-8', 02:12:49 INFO - 'LANGUAGE': 'en_US:en', 02:12:49 INFO - 'LOGNAME': 'cltbld', 02:12:49 INFO - 'MAIL': '/var/mail/cltbld', 02:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:49 INFO - 'MOZ_NO_REMOTE': '1', 02:12:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:49 INFO - 'NO_EM_RESTART': '1', 02:12:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:49 INFO - 'PWD': '/builds/slave/test', 02:12:49 INFO - 'SHELL': '/bin/bash', 02:12:49 INFO - 'SHLVL': '1', 02:12:49 INFO - 'TERM': 'linux', 02:12:49 INFO - 'TMOUT': '86400', 02:12:49 INFO - 'USER': 'cltbld', 02:12:49 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472029950.144851-823051165', 02:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:49 INFO - '_': '/tools/buildbot/bin/python'} 02:12:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:49 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 02:12:49 INFO - Cleaning up... 02:12:49 INFO - Return code: 0 02:12:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:12:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:49 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 0x7f98813abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269d370>, '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 0x26a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a0d80>, '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': '745a4373a2a16df560f216e000000264-1472029950.144851-823051165', '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 02:12:49 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 02:12:49 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 02:12:49 INFO - Using env: {'DISPLAY': ':0', 02:12:49 INFO - 'HOME': '/home/cltbld', 02:12:49 INFO - 'LANG': 'en_US.UTF-8', 02:12:49 INFO - 'LANGUAGE': 'en_US:en', 02:12:49 INFO - 'LOGNAME': 'cltbld', 02:12:49 INFO - 'MAIL': '/var/mail/cltbld', 02:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:49 INFO - 'MOZ_NO_REMOTE': '1', 02:12:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:49 INFO - 'NO_EM_RESTART': '1', 02:12:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:49 INFO - 'PWD': '/builds/slave/test', 02:12:49 INFO - 'SHELL': '/bin/bash', 02:12:49 INFO - 'SHLVL': '1', 02:12:49 INFO - 'TERM': 'linux', 02:12:49 INFO - 'TMOUT': '86400', 02:12:49 INFO - 'USER': 'cltbld', 02:12:49 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472029950.144851-823051165', 02:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:49 INFO - '_': '/tools/buildbot/bin/python'} 02:12:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:50 INFO - Downloading/unpacking psutil>=3.1.1 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:12:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:12:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:12:51 INFO - Installing collected packages: psutil 02:12:51 INFO - Running setup.py install for psutil 02:12:52 INFO - building 'psutil._psutil_linux' extension 02:12:52 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 02:12:52 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 02:12:52 INFO - building 'psutil._psutil_posix' extension 02:12:52 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 02:12:52 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 02:12:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:12:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:12:52 INFO - Successfully installed psutil 02:12:52 INFO - Cleaning up... 02:12:52 INFO - Return code: 0 02:12:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98813abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269d370>, '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 0x26a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a0d80>, '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': '745a4373a2a16df560f216e000000264-1472029950.144851-823051165', '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 02:12:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:12:52 INFO - Using env: {'DISPLAY': ':0', 02:12:52 INFO - 'HOME': '/home/cltbld', 02:12:52 INFO - 'LANG': 'en_US.UTF-8', 02:12:52 INFO - 'LANGUAGE': 'en_US:en', 02:12:52 INFO - 'LOGNAME': 'cltbld', 02:12:52 INFO - 'MAIL': '/var/mail/cltbld', 02:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:52 INFO - 'MOZ_NO_REMOTE': '1', 02:12:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:52 INFO - 'NO_EM_RESTART': '1', 02:12:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:52 INFO - 'PWD': '/builds/slave/test', 02:12:52 INFO - 'SHELL': '/bin/bash', 02:12:52 INFO - 'SHLVL': '1', 02:12:52 INFO - 'TERM': 'linux', 02:12:52 INFO - 'TMOUT': '86400', 02:12:52 INFO - 'USER': 'cltbld', 02:12:52 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472029950.144851-823051165', 02:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:52 INFO - '_': '/tools/buildbot/bin/python'} 02:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:12:52 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 02:12:52 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 02:12:52 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 02:12:52 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 02:12:52 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 02:12:52 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 02:12:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:12:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:12:54 INFO - Installing collected packages: mozsystemmonitor 02:12:54 INFO - Running setup.py install for mozsystemmonitor 02:12:54 INFO - Successfully installed mozsystemmonitor 02:12:54 INFO - Cleaning up... 02:12:54 INFO - Return code: 0 02:12:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:12:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:12:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:54 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 0x7f98813abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269d370>, '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 0x26a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a0d80>, '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': '745a4373a2a16df560f216e000000264-1472029950.144851-823051165', '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 02:12:54 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 02:12:54 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 02:12:54 INFO - Using env: {'DISPLAY': ':0', 02:12:54 INFO - 'HOME': '/home/cltbld', 02:12:54 INFO - 'LANG': 'en_US.UTF-8', 02:12:54 INFO - 'LANGUAGE': 'en_US:en', 02:12:54 INFO - 'LOGNAME': 'cltbld', 02:12:54 INFO - 'MAIL': '/var/mail/cltbld', 02:12:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:54 INFO - 'MOZ_NO_REMOTE': '1', 02:12:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:54 INFO - 'NO_EM_RESTART': '1', 02:12:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:54 INFO - 'PWD': '/builds/slave/test', 02:12:54 INFO - 'SHELL': '/bin/bash', 02:12:54 INFO - 'SHLVL': '1', 02:12:54 INFO - 'TERM': 'linux', 02:12:54 INFO - 'TMOUT': '86400', 02:12:54 INFO - 'USER': 'cltbld', 02:12:54 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472029950.144851-823051165', 02:12:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:54 INFO - '_': '/tools/buildbot/bin/python'} 02:12:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:55 INFO - Downloading/unpacking jsonschema==2.5.1 02:12:55 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 02:12:55 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 02:12:55 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 02:12:55 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 02:12:55 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 02:12:55 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 02:12:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:12:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12: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 02:12:57 INFO - Downloading functools32-3.2.3-2.tar.gz 02:12:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:12:57 INFO - warning: no files found matching '*.txt' 02:12:57 INFO - no previously-included directories found matching 'build' 02:12:57 INFO - no previously-included directories found matching 'dist' 02:12:57 INFO - no previously-included directories found matching '.git*' 02:12:57 INFO - Installing collected packages: jsonschema, functools32 02:12:57 INFO - Running setup.py install for functools32 02:12:57 INFO - warning: no files found matching '*.txt' 02:12:57 INFO - no previously-included directories found matching 'build' 02:12:57 INFO - no previously-included directories found matching 'dist' 02:12:57 INFO - no previously-included directories found matching '.git*' 02:12:57 INFO - Successfully installed jsonschema functools32 02:12:57 INFO - Cleaning up... 02:12:57 INFO - Return code: 0 02:12:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:12:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:12:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98813abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269d370>, '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 0x26a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a0d80>, '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': '745a4373a2a16df560f216e000000264-1472029950.144851-823051165', '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 02:12:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:12:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:12:57 INFO - Using env: {'DISPLAY': ':0', 02:12:57 INFO - 'HOME': '/home/cltbld', 02:12:57 INFO - 'LANG': 'en_US.UTF-8', 02:12:57 INFO - 'LANGUAGE': 'en_US:en', 02:12:57 INFO - 'LOGNAME': 'cltbld', 02:12:57 INFO - 'MAIL': '/var/mail/cltbld', 02:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:57 INFO - 'MOZ_NO_REMOTE': '1', 02:12:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:57 INFO - 'NO_EM_RESTART': '1', 02:12:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:57 INFO - 'PWD': '/builds/slave/test', 02:12:57 INFO - 'SHELL': '/bin/bash', 02:12:57 INFO - 'SHLVL': '1', 02:12:57 INFO - 'TERM': 'linux', 02:12:57 INFO - 'TMOUT': '86400', 02:12:57 INFO - 'USER': 'cltbld', 02:12:57 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472029950.144851-823051165', 02:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:57 INFO - '_': '/tools/buildbot/bin/python'} 02:12:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:12:57 INFO - Cleaning up... 02:12:57 INFO - Return code: 0 02:12:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:12:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:12:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:12:57 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 0x7f98813abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269d370>, '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 0x26a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a0d80>, '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': '745a4373a2a16df560f216e000000264-1472029950.144851-823051165', '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 02:12:57 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 02:12:57 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 02:12:57 INFO - Using env: {'DISPLAY': ':0', 02:12:57 INFO - 'HOME': '/home/cltbld', 02:12:57 INFO - 'LANG': 'en_US.UTF-8', 02:12:57 INFO - 'LANGUAGE': 'en_US:en', 02:12:57 INFO - 'LOGNAME': 'cltbld', 02:12:57 INFO - 'MAIL': '/var/mail/cltbld', 02:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:57 INFO - 'MOZ_NO_REMOTE': '1', 02:12:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:57 INFO - 'NO_EM_RESTART': '1', 02:12:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:57 INFO - 'PWD': '/builds/slave/test', 02:12:57 INFO - 'SHELL': '/bin/bash', 02:12:57 INFO - 'SHLVL': '1', 02:12:57 INFO - 'TERM': 'linux', 02:12:57 INFO - 'TMOUT': '86400', 02:12:57 INFO - 'USER': 'cltbld', 02:12:57 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472029950.144851-823051165', 02:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:57 INFO - '_': '/tools/buildbot/bin/python'} 02:12:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:57 INFO - Downloading/unpacking blobuploader==1.2.4 02:12:57 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 02:12:57 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 02:12:57 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 02:12:57 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 02:12:57 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 02:12:57 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 02:12:59 INFO - Downloading blobuploader-1.2.4.tar.gz 02:12:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:12:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:12:59 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 02:12:59 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 02:12:59 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 02:12:59 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 02:12:59 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 02:12:59 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 02:13:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:13:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:13:00 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 02:13:00 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 02:13:00 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 02:13:00 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 02:13:00 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 02:13:00 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 02:13:00 INFO - Downloading docopt-0.6.1.tar.gz 02:13:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:13:00 INFO - Installing collected packages: blobuploader, requests, docopt 02:13:00 INFO - Running setup.py install for blobuploader 02:13:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:13:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:13:00 INFO - Running setup.py install for requests 02:13:01 INFO - Running setup.py install for docopt 02:13:01 INFO - Successfully installed blobuploader requests docopt 02:13:01 INFO - Cleaning up... 02:13:01 INFO - Return code: 0 02:13:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:01 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 0x7f98813abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269d370>, '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 0x26a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a0d80>, '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': '745a4373a2a16df560f216e000000264-1472029950.144851-823051165', '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 02:13:01 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 02:13:01 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 02:13:01 INFO - Using env: {'DISPLAY': ':0', 02:13:01 INFO - 'HOME': '/home/cltbld', 02:13:01 INFO - 'LANG': 'en_US.UTF-8', 02:13:01 INFO - 'LANGUAGE': 'en_US:en', 02:13:01 INFO - 'LOGNAME': 'cltbld', 02:13:01 INFO - 'MAIL': '/var/mail/cltbld', 02:13:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:01 INFO - 'MOZ_NO_REMOTE': '1', 02:13:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:01 INFO - 'NO_EM_RESTART': '1', 02:13:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:01 INFO - 'PWD': '/builds/slave/test', 02:13:01 INFO - 'SHELL': '/bin/bash', 02:13:01 INFO - 'SHLVL': '1', 02:13:01 INFO - 'TERM': 'linux', 02:13:01 INFO - 'TMOUT': '86400', 02:13:01 INFO - 'USER': 'cltbld', 02:13:01 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472029950.144851-823051165', 02:13:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:01 INFO - '_': '/tools/buildbot/bin/python'} 02:13:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:13:01 INFO - Running setup.py (path:/tmp/pip-MNv5sE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:13:01 INFO - Running setup.py (path:/tmp/pip-2atnIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:13:01 INFO - Running setup.py (path:/tmp/pip-kFBmp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:13:01 INFO - Running setup.py (path:/tmp/pip-YPCrAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:13:01 INFO - Running setup.py (path:/tmp/pip-yey44B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:13:01 INFO - Running setup.py (path:/tmp/pip-sB39ZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:13:01 INFO - Running setup.py (path:/tmp/pip-ipjavJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:13:01 INFO - Running setup.py (path:/tmp/pip-5yqMiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:13:02 INFO - Running setup.py (path:/tmp/pip-6YNMTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:13:02 INFO - Running setup.py (path:/tmp/pip-LzPs45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:13:02 INFO - Running setup.py (path:/tmp/pip-raPVNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:13:02 INFO - Running setup.py (path:/tmp/pip-M4YxaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:13:02 INFO - Running setup.py (path:/tmp/pip-0FxfH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:13:02 INFO - Running setup.py (path:/tmp/pip-GSQE1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:02 INFO - Running setup.py (path:/tmp/pip-Hp5FCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:13:02 INFO - Running setup.py (path:/tmp/pip-xf9emC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:13:02 INFO - Running setup.py (path:/tmp/pip-GFI0hD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:13:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:13:02 INFO - Running setup.py install for manifestparser 02:13:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:13:02 INFO - Running setup.py install for mozcrash 02:13:02 INFO - Running setup.py install for mozdebug 02:13:03 INFO - Running setup.py install for mozdevice 02:13:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:13:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:13:03 INFO - Running setup.py install for mozfile 02:13:03 INFO - Running setup.py install for mozhttpd 02:13:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:13:03 INFO - Running setup.py install for mozinfo 02:13:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:13:03 INFO - Running setup.py install for mozInstall 02:13:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:13:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:13:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:13:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:13:03 INFO - Running setup.py install for mozleak 02:13:03 INFO - Running setup.py install for mozlog 02:13:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:13:03 INFO - Running setup.py install for moznetwork 02:13:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:13:03 INFO - Running setup.py install for mozprocess 02:13:03 INFO - Running setup.py install for mozprofile 02:13:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:13:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:13:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:13:04 INFO - Running setup.py install for mozrunner 02:13:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:13:04 INFO - Running setup.py install for mozscreenshot 02:13:04 INFO - Running setup.py install for moztest 02:13:04 INFO - Running setup.py install for mozversion 02:13:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:13:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:13:04 INFO - Cleaning up... 02:13:04 INFO - Return code: 0 02:13:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:04 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 0x7f98813abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269d370>, '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 0x26a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a0d80>, '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': '745a4373a2a16df560f216e000000264-1472029950.144851-823051165', '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 02:13:04 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 02:13:04 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 02:13:04 INFO - Using env: {'DISPLAY': ':0', 02:13:04 INFO - 'HOME': '/home/cltbld', 02:13:04 INFO - 'LANG': 'en_US.UTF-8', 02:13:04 INFO - 'LANGUAGE': 'en_US:en', 02:13:04 INFO - 'LOGNAME': 'cltbld', 02:13:04 INFO - 'MAIL': '/var/mail/cltbld', 02:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:04 INFO - 'MOZ_NO_REMOTE': '1', 02:13:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:04 INFO - 'NO_EM_RESTART': '1', 02:13:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:04 INFO - 'PWD': '/builds/slave/test', 02:13:04 INFO - 'SHELL': '/bin/bash', 02:13:04 INFO - 'SHLVL': '1', 02:13:04 INFO - 'TERM': 'linux', 02:13:04 INFO - 'TMOUT': '86400', 02:13:04 INFO - 'USER': 'cltbld', 02:13:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472029950.144851-823051165', 02:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:04 INFO - '_': '/tools/buildbot/bin/python'} 02:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:13:04 INFO - Running setup.py (path:/tmp/pip-fvHeoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:13:04 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)) 02:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:13:04 INFO - Running setup.py (path:/tmp/pip-tWOAQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:13:04 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)) 02:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:13:04 INFO - Running setup.py (path:/tmp/pip-uLTl90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:13:04 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)) 02:13:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:13:04 INFO - Running setup.py (path:/tmp/pip-jkftF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:13:05 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)) 02:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:13:05 INFO - Running setup.py (path:/tmp/pip-IwCqv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:13:05 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)) 02:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:13:05 INFO - Running setup.py (path:/tmp/pip-FVAWIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:13:05 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)) 02:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:13:05 INFO - Running setup.py (path:/tmp/pip-wjqVzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:13:05 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)) 02:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:13:05 INFO - Running setup.py (path:/tmp/pip-8C04Yd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:13:05 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)) 02:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:13:05 INFO - Running setup.py (path:/tmp/pip-PEG4cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:13:05 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)) 02:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:13:05 INFO - Running setup.py (path:/tmp/pip-gGSOmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:13:05 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)) 02:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:13:05 INFO - Running setup.py (path:/tmp/pip-WpypOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:13:05 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)) 02:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:13:05 INFO - Running setup.py (path:/tmp/pip-3oA2nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:13:05 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)) 02:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:13:05 INFO - Running setup.py (path:/tmp/pip-j0MMkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:13:05 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)) 02:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:13:05 INFO - Running setup.py (path:/tmp/pip-DDo97j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:13:05 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)) 02:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:05 INFO - Running setup.py (path:/tmp/pip-hJpx4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:05 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)) 02:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:13:05 INFO - Running setup.py (path:/tmp/pip-wx7pGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:13:05 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)) 02:13:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:13:05 INFO - Running setup.py (path:/tmp/pip-_yExK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:13:05 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)) 02:13:05 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)) 02:13:05 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)) 02:13:05 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)) 02:13:05 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)) 02:13:05 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)) 02:13:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:13:05 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 02:13:05 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 02:13:05 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 02:13:05 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 02:13:05 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 02:13:05 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 02:13:07 INFO - Downloading blessings-1.6.tar.gz 02:13:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:13:07 INFO - Installing collected packages: blessings 02:13:07 INFO - Running setup.py install for blessings 02:13:08 INFO - Successfully installed blessings 02:13:08 INFO - Cleaning up... 02:13:08 INFO - Return code: 0 02:13:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:13:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:13:08 INFO - Reading from file tmpfile_stdout 02:13:08 INFO - Current package versions: 02:13:08 INFO - argparse == 1.2.1 02:13:08 INFO - blessings == 1.6 02:13:08 INFO - blobuploader == 1.2.4 02:13:08 INFO - docopt == 0.6.1 02:13:08 INFO - functools32 == 3.2.3-2 02:13:08 INFO - jsonschema == 2.5.1 02:13:08 INFO - manifestparser == 1.1 02:13:08 INFO - mozInstall == 1.12 02:13:08 INFO - mozcrash == 0.17 02:13:08 INFO - mozdebug == 0.1 02:13:08 INFO - mozdevice == 0.48 02:13:08 INFO - mozfile == 1.2 02:13:08 INFO - mozhttpd == 0.7 02:13:08 INFO - mozinfo == 0.9 02:13:08 INFO - mozleak == 0.1 02:13:08 INFO - mozlog == 3.3 02:13:08 INFO - moznetwork == 0.27 02:13:08 INFO - mozprocess == 0.23 02:13:08 INFO - mozprofile == 0.28 02:13:08 INFO - mozrunner == 6.12 02:13:08 INFO - mozscreenshot == 0.1 02:13:08 INFO - mozsystemmonitor == 0.3 02:13:08 INFO - moztest == 0.7 02:13:08 INFO - mozversion == 1.4 02:13:08 INFO - psutil == 3.1.1 02:13:08 INFO - requests == 1.2.3 02:13:08 INFO - wsgiref == 0.1.2 02:13:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:08 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 0x7f98813abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269d370>, '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 0x26a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a0d80>, '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': '745a4373a2a16df560f216e000000264-1472029950.144851-823051165', '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 02:13:08 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 02:13:08 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 02:13:08 INFO - Using env: {'DISPLAY': ':0', 02:13:08 INFO - 'HOME': '/home/cltbld', 02:13:08 INFO - 'LANG': 'en_US.UTF-8', 02:13:08 INFO - 'LANGUAGE': 'en_US:en', 02:13:08 INFO - 'LOGNAME': 'cltbld', 02:13:08 INFO - 'MAIL': '/var/mail/cltbld', 02:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:08 INFO - 'MOZ_NO_REMOTE': '1', 02:13:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:08 INFO - 'NO_EM_RESTART': '1', 02:13:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:08 INFO - 'PWD': '/builds/slave/test', 02:13:08 INFO - 'SHELL': '/bin/bash', 02:13:08 INFO - 'SHLVL': '1', 02:13:08 INFO - 'TERM': 'linux', 02:13:08 INFO - 'TMOUT': '86400', 02:13:08 INFO - 'USER': 'cltbld', 02:13:08 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472029950.144851-823051165', 02:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:08 INFO - '_': '/tools/buildbot/bin/python'} 02:13:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:08 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)) 02:13:08 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)) 02:13:08 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)) 02:13:08 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)) 02:13:08 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)) 02:13:08 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)) 02:13:08 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)) 02:13:08 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)) 02:13:08 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)) 02:13:08 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)) 02:13:08 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)) 02:13:08 INFO - Cleaning up... 02:13:08 INFO - Return code: 0 02:13:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:08 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 0x7f98813abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a2850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269d370>, '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 0x26a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a0d80>, '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': '745a4373a2a16df560f216e000000264-1472029950.144851-823051165', '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 02:13:08 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 02:13:08 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 02:13:08 INFO - Using env: {'DISPLAY': ':0', 02:13:08 INFO - 'HOME': '/home/cltbld', 02:13:08 INFO - 'LANG': 'en_US.UTF-8', 02:13:08 INFO - 'LANGUAGE': 'en_US:en', 02:13:08 INFO - 'LOGNAME': 'cltbld', 02:13:08 INFO - 'MAIL': '/var/mail/cltbld', 02:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:08 INFO - 'MOZ_NO_REMOTE': '1', 02:13:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:08 INFO - 'NO_EM_RESTART': '1', 02:13:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:08 INFO - 'PWD': '/builds/slave/test', 02:13:08 INFO - 'SHELL': '/bin/bash', 02:13:08 INFO - 'SHLVL': '1', 02:13:08 INFO - 'TERM': 'linux', 02:13:08 INFO - 'TMOUT': '86400', 02:13:08 INFO - 'USER': 'cltbld', 02:13:08 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472029950.144851-823051165', 02:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:08 INFO - '_': '/tools/buildbot/bin/python'} 02:13:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:13:08 INFO - Cleaning up... 02:13:08 INFO - Return code: 0 02:13:08 INFO - Running post-action listener: _resource_record_post_action 02:13:08 INFO - Running post-action listener: _start_resource_monitoring 02:13:08 INFO - Starting resource monitoring. 02:13:08 INFO - [mozharness: 2016-08-24 09:13:08.790536Z] Finished create-virtualenv step (success) 02:13:08 INFO - [mozharness: 2016-08-24 09:13:08.790984Z] Running install step. 02:13:08 INFO - Running pre-action listener: _resource_record_pre_action 02:13:08 INFO - Running main action method: install 02:13:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:13:09 INFO - Reading from file tmpfile_stdout 02:13:09 INFO - Detecting whether we're running mozinstall >=1.0... 02:13:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:13:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:13:09 INFO - Reading from file tmpfile_stdout 02:13:09 INFO - Output received: 02:13:09 INFO - Usage: mozinstall [options] installer 02:13:09 INFO - Options: 02:13:09 INFO - -h, --help show this help message and exit 02:13:09 INFO - -d DEST, --destination=DEST 02:13:09 INFO - Directory to install application into. [default: 02:13:09 INFO - "/builds/slave/test"] 02:13:09 INFO - --app=APP Application being installed. [default: firefox] 02:13:09 INFO - mkdir: /builds/slave/test/build/application 02:13:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:13:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:13:26 INFO - Reading from file tmpfile_stdout 02:13:26 INFO - Output received: 02:13:26 INFO - /builds/slave/test/build/application/firefox/firefox 02:13:26 INFO - Running post-action listener: _resource_record_post_action 02:13:26 INFO - [mozharness: 2016-08-24 09:13:26.081611Z] Finished install step (success) 02:13:26 INFO - [mozharness: 2016-08-24 09:13:26.081856Z] Running run-tests step. 02:13:26 INFO - Running pre-action listener: _resource_record_pre_action 02:13:26 INFO - Running main action method: run_tests 02:13:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:13:26 INFO - Python 2.7.3 02:13:26 INFO - Return code: 0 02:13:26 INFO - grabbing minidump binary from tooltool 02:13:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:26 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 0x269d370>, '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 0x26a08f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a0d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:13:26 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 02:13:26 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 02:13:26 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 02:13:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:13:26 INFO - Return code: 0 02:13:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:13:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:13:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:13:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:13:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:13:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:13:26 INFO - Using env: {'DISPLAY': ':0', 02:13:26 INFO - 'HOME': '/home/cltbld', 02:13:26 INFO - 'LANG': 'en_US.UTF-8', 02:13:26 INFO - 'LANGUAGE': 'en_US:en', 02:13:26 INFO - 'LOGNAME': 'cltbld', 02:13:26 INFO - 'MAIL': '/var/mail/cltbld', 02:13:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:13:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:26 INFO - 'MOZ_NO_REMOTE': '1', 02:13:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:13:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:26 INFO - 'NO_EM_RESTART': '1', 02:13:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:26 INFO - 'PWD': '/builds/slave/test', 02:13:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:13:26 INFO - 'SHELL': '/bin/bash', 02:13:26 INFO - 'SHLVL': '1', 02:13:26 INFO - 'TERM': 'linux', 02:13:26 INFO - 'TMOUT': '86400', 02:13:26 INFO - 'USER': 'cltbld', 02:13:26 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1472029950.144851-823051165', 02:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:26 INFO - '_': '/tools/buildbot/bin/python'} 02:13:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:13:26 INFO - mozversion application_buildid: 20160823233011 02:13:26 INFO - mozversion application_changeset: eb8d56badefecf8c277d8f82d6f2f91ec8f9c4fc 02:13:26 INFO - mozversion application_display_name: Nightly 02:13:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:13:26 INFO - mozversion application_name: Firefox 02:13:26 INFO - mozversion application_remotingname: firefox 02:13:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:13:26 INFO - mozversion application_vendor: Mozilla 02:13:26 INFO - mozversion application_version: 51.0a1 02:13:26 INFO - mozversion platform_buildid: 20160823233011 02:13:26 INFO - mozversion platform_changeset: eb8d56badefecf8c277d8f82d6f2f91ec8f9c4fc 02:13:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:13:26 INFO - mozversion platform_version: 51.0a1 02:13:26 INFO - using testdate: 1472030006 02:13:26 INFO - actual date: 1472030006 02:13:26 INFO - starting webserver on 'localhost:40913' 02:13:26 INFO - SUITE-START | Running 2 tests 02:13:26 INFO - TEST-START | dromaeo_css 02:13:26 INFO - operating with platform_type : linux_ 02:13:26 INFO - Initialising browser for dromaeo_css test... 02:13:26 INFO - TEST-INFO | started process 6531 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDG4Tdb/profile http://localhost:40913/getInfo.html) 02:13:30 INFO - PROCESS | 6531 | __metrics Screen width/height:1600/1200 02:13:30 INFO - PROCESS | 6531 | colorDepth:24 02:13:30 INFO - PROCESS | 6531 | Browser inner width/height: 1024/697 02:13:30 INFO - PROCESS | 6531 | __metrics 02:13:31 INFO - PROCESS | 6531 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:13:31 INFO - PROCESS | 6531 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:13:32 INFO - PROCESS | 6531 | console.error: PushService: 02:13:32 INFO - PROCESS | 6531 | stateChangeProcessEnqueue: Error transitioning state 02:13:32 INFO - PROCESS | 6531 | UnknownError 02:13:32 INFO - TEST-INFO | 6531: exit 0 02:13:32 INFO - Browser initialized. 02:13:32 INFO - Running cycle 1/1 for dromaeo_css test... 02:13:32 INFO - TEST-INFO | started process 6612 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDG4Tdb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:13:44 INFO - PROCESS | 6612 | RSS: Main: 180338688 02:13:44 INFO - PROCESS | 6612 | 02:14:36 INFO - PROCESS | 6612 | 1472030076859 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] 02:16:46 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:40913/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40913/tests/dromaeo/cssquery-ext.html) 02:16:47 INFO - PROCESS | 6612 | RSS: Main: 273342464 02:16:47 INFO - PROCESS | 6612 | 02:19:50 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:40913/tests/dromaeo/cssquery-ext.html (next: http://localhost:40913/tests/dromaeo/cssquery-jquery.html) 02:19:50 INFO - PROCESS | 6612 | RSS: Main: 269414400 02:19:50 INFO - PROCESS | 6612 | 02:22:52 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:40913/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40913/tests/dromaeo/cssquery-mootools.html) 02:22:53 INFO - PROCESS | 6612 | RSS: Main: 250445824 02:22:53 INFO - PROCESS | 6612 | 02:25:55 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:40913/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40913/tests/dromaeo/cssquery-prototype.html) 02:25:56 INFO - PROCESS | 6612 | RSS: Main: 251400192 02:25:56 INFO - PROCESS | 6612 | 02:28:58 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:40913/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40913/tests/dromaeo/cssquery-yui.html) 02:28:59 INFO - PROCESS | 6612 | RSS: Main: 215412736 02:28:59 INFO - PROCESS | 6612 | 02:32:02 INFO - PROCESS | 6612 | Cycle 1(1): loaded http://localhost:40913/tests/dromaeo/cssquery-yui.html (next: http://localhost:40913/tests/dromaeo/cssquery-dojo.html) 02:32:02 INFO - PROCESS | 6612 | RSS: Main: 302870528 02:32:02 INFO - PROCESS | 6612 | 02:32:02 INFO - PROCESS | 6612 | __start_tp_report 02:32:02 INFO - PROCESS | 6612 | _x_x_mozilla_page_load 02:32:02 INFO - PROCESS | 6612 | _x_x_mozilla_page_load_details 02:32:02 INFO - PROCESS | 6612 | |i|pagename|runs| 02:32:02 INFO - PROCESS | 6612 | |0;dojo.html;3046.680098589648;3051.1151765987865;3064.2492589315607;3103.115612050566;3134.435801555719;5253.185756207784;5328.254044433777;5372.167314066316;5400.783968641254;5422.945770542294;5380.596455265852;5408.188771684239;5434.375046869602;5444.809431669893;5450.482204190595;4815.927761083586;4865.927011094819;4882.487338829425;4902.117618828609;5116.309298244745;5003.699778013312;5049.2678561608545;5053;5067.923981140286;5069.315642388267;4819.180739274314;4850.078485087822;4868;4917.459079501288;5015.874603134915;4884.267359896008;4931.137051016094;5042.773075211588;5048.469910659402;5049.596032317406;4821.180399332122;4901.995091006335;4906.828261010884;4915.090708218955;4921.729304888266;5426.348838139409;5429.4299098594865;5430.647007944511;5433.157860531584;5437.592180586433;5630.71846407678;5767.653940763567;5810.941890581124;5819.098039803837;5846.941530584682;5820.35976042635;5855.3851845556455;5864.501517370986;5885.411458854123;5889.85275368115;5267.578593712494;5479.315085614298;5489.505944464938;5494.670319780826;5502.642328248651;5860.794872179538;5923.822285331447;5933.525317974551;6029.306629737549;6039.818805435844;5669.801556945487;5732.942670573241;5776.595638305278;5778.27771528559;5794.652320860761;5786.826395208151;5798.304203495608;5808.332041815161;5809.82570522885;5814.418558144236;5612.550995920316;5741.339745929188;5761.337446193657;5805.187273781674;5810.360860305363;5837.416258374129;5889.352171261158;5890.352061273342;5898.439648233411;5947.791827286024;4507.414036175276;4515.774211289422;4518.480374756879;4522.638188944877;4557.111363284128;3949.8025098744947;3953.327934251184;4032.5967403260024;4041.9595804041583;4063.776492292893;5496.725163741797;5518.255035570227;5535.723213839292;5587.05020146576;5654.491095801398;5924.14099955504;5929.377415371324;5932.199153114274;5942.58401911862;5948.821535353946;5382.757775900094;5527.861803454945;5575.4424557543925;5588.6646801192055;5593.3847276799515;5045.899082018413;5075.695458272516;5076.6192535559985;5089.694618322913;5151.9484805152215;5993.550483713651;6045.21412216409;6046.2139921809885;6051.999999999912;6057.394260573908;5662.801801936913;5880.852978675567;5884.676342801187;5889;5894.70526473666;5995.310539288038;6016.127661489147;6050.788222412194;6078.411007413859;6144.631322120687;5765.221695071112;5765.538756899354;5771.59598828078;5777.537796976316;5842.474177324061;5598.188262701967;5886.028805247258;5896.115582662635;5896.823095307148;5898.292204935436;5706.857328566819;5707.6290041147195;5744.310682718101;5759.7984070559005;5828.562857785599;5721.170430287668;5745.626534275259;5769.9711501442225;5781.8554536136935;5783.334916484658;5509.944900550943;5727.8854422912145;5739.799107031234;5740.1963725077685;5740.741666625096;5734.913976290276;5769.624974376652;5780.3525995091195;5815;5888.205092312654;5658.377578466448;5675.971620141873;5676.120201368794;5678.3186017678145;5682.659040457585 02:32:02 INFO - PROCESS | 6612 | |1;ext.html;582.9213056237406;611.9785807496737;620.2711813618996;634.6763150793096;641.3810672700848;32831.67168328316;33740.66259337406;36218.637813621855;36234;43151.56848431515;41118.58881411185;45833.770831145885;46088.539114608844;46196.307055394194;46210.76894615522;8879.334049946248;9009.099090091004;9031.23234525066;9032.548372581345;9041.547922603877;8940.19538241558;9028.368014239006;9029.142231488031;9039.683611073613;9042.954785226064;9022.233110185642;9072.546372681372;9080.8637870432;9082.77293067672;9110.088991100904;9007;9035.638574457014;9039.870016248002;9045.502497362642;9050.547472626407;8902.955485222532;8978.86531702025;8984.775380615472;8985.820283594358;8988.235999940012;43386.566134338565;43919.12161756779;43936.560634393565;43973.56026439759;44000.3399949001;3768.321702093622;3819.3316169670197;3850.9229815403814;3874.4575759393706;4341.717788343748;32644.347113057607;32936.40789896439;33124.17189570256;33138.50292245618;33198;4315.82736690532;4384.714993525443;4398.582134697199;4598.057398233354;4604.976975115103;361793;363276;363514;363978;365539;60099.39900601025;60565.697171514745;60577;60587.69706151441;60621.39378606246;62951.37048629455;63029.36970630327;63141;63183;63224.367756321844;17096.658066838594;17346.826531734772;17386.739198912026;17505.7374139388;17518;13024;13117.803232951514;13123.212607243597;13141.408636611184;13143.737125257632;15609.297581608855;17632.20655070525;17687.115644217738;17706.29174833018;17740.733888991675;6366;6390.680465976682;6488.902666460007;6549.631664377575;6605.8348541285895;957.167264479907;1045.38844775807;1045.6183493025144;1112.890987269204;1139.6296203733655;33874.49188262178;34078;34109.82945085259;34175.48736768951;34222.14444638854;878.7934835313696;1112.6217086190734;1112.8608923884515;1155.5146838327923;1163.9185257032095;15788.68422631564;17639;17703.291868325123;17708.9114554429;17894.463166105037;528424;537781;539085;540836;543388;60638.39361606416;61773.38226617676;62216.688916555126;62273.37726622766;62455;1287.9742405151844;1415.2923538230884;1445.8048163498004;1448.5943935698022;1477.9778303325459;32754.34491310113;34924.65075349316;34958.65041349656;35235;35360.11599710028;52437.475625244784;53129;53164.73417633042;53170.73414632902;53201.4679853212;423215;426645;426871;428523;429103;44386.556134438244;45135.54864451445;46441.53558464507;48016.519834801205;49790.751046244535;50108.74945625249;50342.49657503525;50475.214358922494;51627.74186129045;52009;41879.37180942227;42100.57899421089;42309.42264433891;42839.3574096395;44461;42093.78953105215;42517.57482425136;43592.34611480894;44272.335914960655;44384;43346;44056.339154913345;44475;44662;45006.324905125795;34197.48703769396;36643.45034824533;37771.43342849914;40278.39582406325;40345.39481907715;28016.57975130334;28181.340628190457;28800.279992999505;29449;29515.85242073776 02:32:02 INFO - PROCESS | 6612 | |2;jquery.html;384.1989451992595;395.10311592684604;404.5751960441536;405.14716521721755;422.98096585653644;15763;19343.516412089706;19473;19509.609807803834;19769.802301976975;12639.873601263984;12975.351232438388;12988.805167922465;13068.21590704556;13138.146020508684;5216.347956505447;5392.299001129848;5432.67403955762;5434.619576629638;5445.047116754572;5172.172452407615;5308.814191503298;5317.660229499027;5326.973365133188;5355.277037599933;5338.813141540047;5353.5984801139875;5354.946450535504;5355.223492593572;5362.973185134088;5251.842444726664;5308.495692909168;5730.7707691692285;5792.797252096157;5813.331466881321;5306.071437498423;5312.335958005249;5313.548348390392;5314.601404894648;5316.76074576645;13829;13848.09987350829;13970.650733731636;14146.36341364641;16999.57501062471;2324.4886125052462;2367.869767162805;2639.8680065996814;2651.814372993891;2953.8966136185345;10344.224183186216;10446.47767611624;10626.256162068657;10732.678019659423;10964.890351096466;1922.9615407691767;1925.913333899978;1926.8169523895347;1932.420273917819;1959.706044093383;47051;62975;89426.10573894242;91458.54270728603;91601.54199229028;11071.1696622752;11288.71778205535;11364.715882102848;11441.427928603536;11741.178117531861;16016.199190040452;16079.598010049609;16091.758623620655;16097.275622597012;16119.032858028555;7756.263155000266;8103.554304513191;8160.30637395828;8277.379196560161;8297.668093276323;7638.50349727266;7653.081630204411;7711.190325015793;7930.444868859125;7937.087234967938;4921.212605983025;4927.162382395001;4937.456879743226;4943.28322393251;5045.495450454999;1860.2280053777802;1987.2051179528305;1992.3624440179294;2007.3777129090029;2023.8077382648626;891.3938521805105;1015.939043657383;1021.7854250607307;1030.953607087683;1053.7312985188728;19778.90110549438;19862.247953683313;20775.37673869786;20805.89597052005;20925.476863078242;991.0584944302941;1001.4592120255127;1013.8834034086027;1024.7438140464883;1025.974350641225;10399.584016639401;11365.261258018203;11486.368249746178;11531.827022594667;11592.826107608393;474322;474845;475194;478935;489099;81690;93839.53080234556;94525.5273723627;97233.51383243038;97792;966.7873067925045;1000.5847573257163;1005.5173516712019;1013.9391636501686;1025.4206373399006;17387.391441299493;17572;18374.540636484195;18405.63188736191;18764.46679698278;30282;32074;43388.91527711706;45588.54411455843;45810.31284530668;63243.61546061502;63601;63846.36153638404;65057;65662.67168664126;8376.288015518749;8511.402406176943;8569.700060497853;8821.558922054;8874.778130546789;12681.8097728536;13108.279044652636;13453.857056485676;13649;13732.313384330942;11459;11531.481083351437;11653.359065251492;11986.220895641756;12172.391380430767;11428;11467.541298347973;11473.713157171138;11512.82730759056;12026.699332516757;11470.025047871024;11852.644420667393;12001.81997270059;12056.397180140782;12066.577669781516;8161.326927979631;8348;8603.82792344162;8623.8706419405;8635.654573817228;9272.768180795534;11326;11518.58109796952;11565.653030409101;12098.75802483963 02:32:02 INFO - PROCESS | 6612 | |3;mootools.html;1303.9478420863165;1463.04901813821;1508.0273223770669;1628.885977981541;1755.7015307397733;8365;8651.437656552327;8681;8843.91156088439;8930.419522731017;8664.436811607256;8797.42816716913;8804.515751633673;8827.073157318486;8846.513441760717;2049.211053744312;2319.199876042771;2391.366287933695;2417.178159425795;2421.503591763693;2405.314485371661;2423.587990041697;2434.793042591382;2442.46265821519;2448;2340.9531809363802;2348.8708121053337;2349.48311371498;2359.610664240407;2413.348395933097;2350.424146084203;2351.988240058789;2359.1507057459385;2366.8047635943826;2436;2397.6523404106483;2420.0077968033197;2421.067888862783;2425.551273014498;2425.854448733082;9407;9461.810763784755;9469.905300946972;9496.857547136799;9562.90437095627;5452.100403433429;5605.831825045255;5606.691631960241;5609.803656872031;5613.410591887834;3305.5702758641223;3311.735061195123;3427.640097789746;3438.7764795288226;3444.913877153066;1119.9888001119966;1122.4387806096952;1151.936643484608;1163.6741712320563;1176.8705442401329;12579.685507862378;12667.429965651476;12695.746085078246;12747.808782868264;12755.42600582976;4267.701260911768;4534.13851368239;4616.3537104805355;4760.904781904412;4768.809247630056;9811.411315321104;9818.509074546244;9826.115649591571;9832.803343933225;9833.901660983442;5101.20931255656;5102.209157580581;5103.821366252238;5104.2088476286235;5107.41264754558;4347.652187824967;4798.304245884327;4814.772233080542;4940.505949405031;5055.797768089309;3857.633524815138;3959.148783011666;3970.3448930926074;4014.959850401517;4072.470578824734;1209.776191404593;1221.645722740413;1221.7984032634693;1228.2937311046005;1240.0141887199698;901.7925877048316;989.1987490133015;1005.3415013166388;1008.6116845014723;1009.3590569988111;5986.880262394728;5993.250843644544;6078.179445774764;6254.968725156436;6274.529410294155;466.768949370064;476.83787512246005;479.4749749024812;480.6371189751785;483.1158979068297;4021.9195616087513;4128.690348223835;4134.214499245134;4209.579042095827;4288.785560721952;10917.39954302505;11658.18392712502;11730.354830484235;11805;11811.586594469152;11425.08599312053;11592.47833847462;11740.236884602473;11762;11764.647060588197;8538.615762290712;8608.870866937;8624.266937310273;8636.956815215884;8638.438501497383;5969.134475500941;6045.335013148462;6085.513158947362;6086.300075491198;6204.7828326008375;9789.363691360039;10368.637097701545;10422.635207767691;10537.73655658584;10645.840312395476;10509.789804204025;10738.248322617654;10766.192535559707;10814.891851081704;11000.779984400428;8141.51150930946;8331.583420829056;8350.498970061815;8400.41197116196;8414.158584141782;8928.464292142233;8930.86603700932;8982.685606003759;9000.729978100668;9002.054784247559;7996.800079998046;8062.7581172564915;8071.959640201761;8092.757217283491;8417.663293468193;7756;7889.487183333065;7965.761027169194;7976.800579985546;8056.597170141352;6980.860382792417;7008.7546935857;7011.9649401754705;7020.648967551704;7045.577265364094;5273.103572392626;5276.103062479311;5306.787728490972;5358.22305765654;5382.838514844561;5183.274341592105;5214.452482489284;5229.843104706865;5324.653897496805;5474.616776825584 02:32:02 INFO - PROCESS | 6612 | |4;prototype.html;319.4648962986998;333.7563578587631;336.26358275376924;338.81077418261896;340.72401354902547;5138.820141295056;5219.164933610614;5264.894702105956;5294.920576191355;5302.727345437092;5197.66215196012;5231.424543300243;5249.42256351801;5251.737413129347;5309.601779866506;4088.284550203717;4092;4156.54278029418;4177.0994197640075;4190.706650534464;3997.600239976008;4125.546189919107;4170.874873753793;4183.79081045948;4186.6859985501205;4115.135821477494;4117.958820411787;4125.3292416571185;4125.979370103145;4139.379093136024;4098.303288440972;4100.6924480664065;4113.547509773923;4114.40341150533;4137.151883863831;3655.7258205634685;3665.157013886794;3667.3948798448223;3675.5405574303213;3679.908002299937;5050.712068422528;5077.695338279715;5082.771275292621;5101.540861322499;5154.742262886841;4634.884127896796;4671.205894997858;4673.252279635242;4674.135284972291;4678.7426691531955;5396.424733038176;5425.647332923348;5434.945650543484;5440.347158341025;5456.699881506515;3884.6503814656535;3950.1309711863346;3976.5426975897853;3981.303271927401;4021.3967904814513;5624.409437009096;5644.858878528029;5666.999999999959;5667.291588551431;5689.406966049512;4043.8180281887385;4062.5531191568903;4074.7351422157467;4075.7962101894786;4080.5108883580992;3908.2378936107752;4065.6950728694874;4075.5313138989395;4115.259253334369;4125.525564560054;4622.537746225351;4629.490756016903;4636.675432719745;4637.194497329135;4642.721436713808;5493.587980901369;5496.395396506381;5511.338639363302;5522.2544956430365;5568.387477377485;1330.6340756292097;1334.9399277032558;1383.89620778442;1392.2133994293395;1399.6850708590487;952.1906379577304;955.9091886270793;971.5482300730195;980.6613971928266;986.659602437158;5288.418273989858;5309.946900531023;5320.52115309624;5332.786688532493;5360.65155764874;5565;5565.638233514808;5568.385168301228;5574.526165275997;5578.44215578447;5197.324347834758;5247.306270128382;5278.9472105278455;5322.520973112439;5354.250404943311;2668.786497080229;2671.9445818901813;2679.4373181632077;2684.597310403455;2688.421989272316;5114.64197506171;5123.38519377677;5179;5187.184485430144;5206.843794686166;4925.261210818406;4941.975290123526;5044.344235249394;5068.594512438996;5135.305349234818;5044.798208071636;5073.7209453481155;5077.492250774893;5087.64386492942;5096.770645320969;4968.602511799119;4999.425181068097;5009.8226916675285;5010.874728131826;5025.47232540578;4559.270516717309;4852.738288045204;4889;4914.434839993446;4975.825846095369;5064.924026139684;5067.341245638044;5068.315777370008;5071.416787069535;5095.949040509548;3647;3675.7426980112205;3678.9080272993388;3684.521012268388;3718.5537735471917;4996.950030499648;5008.348914641073;5207.307625021807;5452.645578037574;5726.4273572642405;5401.756920938646;5499.7250137492165;5511.834644960658;5514.628709654727;5518.586106041983;5504.587155963239;5505.146702261156;5514.0626093565;5538.529225015919;5608.186812912023;5274.760431298719;5445.89583937152;5490.752916118704;5494.395616482264;5535.750891209986;5521.420250873601;5556.638818476786;5585;5606.495415412633;5612.214289999485;5471.37079235893;5515.669059856422;5519.254900588369;5560.7219639018695;5572.164175373727 02:32:02 INFO - PROCESS | 6612 | |5;yui.html;744.9813754656129;762.9732959346422;790.2650535002446;799.0770659887831;844.995256166983;15843;17452.38916637918;17469.650606987852;17476.912615436922;17484.562885927844;13871.583852484442;13882.097663651855;13887.305634718274;13910.374033168506;13920.443182272697;658.8352911772068;794.4121350200838;818.9058258300282;822.2106777493614;826.404988408345;812.4028838803504;812.8049268175654;813.9378111564406;814.6822739131743;815.5392203405087;868.405142477405;873.9344549158807;875.6453636277317;876.198278575103;877.4165180155221;698.3156506623512;830.4602008694336;858.4076986879096;866.4151697604092;869.6564856881496;632.9778457754003;635.7202830754453;635.8601107756333;635.9809205723835;636.3032479435011;15820.525384238492;15848.52454426369;15855.445059422866;15863.286152123066;15879.36482540697;14334.42662293507;14504.637384065378;14712.779308310384;14868.985965802553;15134;12487.439070116236;13111.082224244306;13681.179129252278;14110.435582576685;14173.220472873987;4526.705764125354;4535.954640453586;4596.655250856199;4607.262837945913;4833.347498087748;80003.5999820003;81230.18769812286;81710.59144704239;82866.17133828645;83600.58199709024;11611.129165312635;11659.183857130089;11914.582989595323;12107.970822480187;12522.87477125217;22878.199263025715;23033.88483057574;23757.16849910245;23785.52428951446;23807.761922380556;8430.915690843012;8648.524331161721;8792.912070879209;8891.155340242667;9123.224525915239;4606.95393046072;4841.636877234221;4910.189818679878;4982.800687972441;5108.055009823194;3508.5789705235024;3646.872359467459;3651.050726811048;3666.6150054244454;3669.119411341312;601;618.9690515474298;622.9875402491925;623.1182876230174;624.3693869192058;651.5817418688268;733.4462480826942;735.1729304532402;749.5015814483417;780.5667854340895;9556.95221523888;10058.899411005796;10202.33684810485;10260.486975651187;10864.837027444595;666.0641798273433;677.6103740349221;733.2081352139676;736.9631518424058;758.7382353088176;4393.824247030147;5000.3249561309485;5013.89972200554;5026.648134630614;5049.596032317406;119769.40115299542;120247;120955.39522302509;122182;129915;105189.47405262924;106463;109608.4519577397;112161;114276;93619;94560.52719736495;94630;95530;96152;9061.723486730889;9401.764955876159;9544.141027307576;9590.229346657085;9637.614495420105;45969.77015115037;49211;49323;50147;51246.48753512566;73623;74968;77890;81571;83704;12564.623061308175;12668.809967850673;12894.742105158031;12996.285204313854;13223.735525289248;14951.476698315506;14953.551393458214;15273.694526109637;15448.382064717734;16236.889204403353;14816.555503334917;15272.083674979536;15676.817602040526;15870.52388428349;15895.352195432788;14146.080504767157;14450;14663.648476623095;14745.778813318024;14810.519527910717;14005.439782408997;14670.19313937701;14792.408303668164;14806.777898331318;14862.777058344349;11201.60794372193;11386.601468948547;11646;11835.704107397383;12135.150539462153;10818.56725730962;11694.88305116938;11798.587049453228;11999.82000270014;12139.696507587381 02:32:02 INFO - PROCESS | 6612 | __end_tp_report 02:32:02 INFO - PROCESS | 6612 | __start_cc_report 02:32:02 INFO - PROCESS | 6612 | _x_x_mozilla_cycle_collect,1080 02:32:02 INFO - PROCESS | 6612 | __end_cc_report 02:32:02 INFO - PROCESS | 6612 | __startTimestamp1472031122931__endTimestamp 02:32:02 INFO - PROCESS | 6612 | 02:32:02 INFO - PROCESS | 6612 | ------- Summary: start ------- 02:32:02 INFO - PROCESS | 6612 | Number of tests: 6 02:32:02 INFO - PROCESS | 6612 | 02:32:02 INFO - PROCESS | 6612 | [#0] dojo.html Cycles:165 Average:5428.76 Median:5675.97 stddev:627.00 (11.0%) stddev-sans-first:600.43 02:32:02 INFO - PROCESS | 6612 | Values: 3046.7 3051.1 3064.2 3103.1 3134.4 5253.2 5328.3 5372.2 5400.8 5422.9 5380.6 5408.2 5434.4 5444.8 5450.5 4815.9 4865.9 4882.5 4902.1 5116.3 5003.7 5049.3 5053.0 5067.9 5069.3 4819.2 4850.1 4868.0 4917.5 5015.9 4884.3 4931.1 5042.8 5048.5 5049.6 4821.2 4902.0 4906.8 4915.1 4921.7 5426.3 5429.4 5430.6 5433.2 5437.6 5630.7 5767.7 5810.9 5819.1 5846.9 5820.4 5855.4 5864.5 5885.4 5889.9 5267.6 5479.3 5489.5 5494.7 5502.6 5860.8 5923.8 5933.5 6029.3 6039.8 5669.8 5732.9 5776.6 5778.3 5794.7 5786.8 5798.3 5808.3 5809.8 5814.4 5612.6 5741.3 5761.3 5805.2 5810.4 5837.4 5889.4 5890.4 5898.4 5947.8 4507.4 4515.8 4518.5 4522.6 4557.1 3949.8 3953.3 4032.6 4042.0 4063.8 5496.7 5518.3 5535.7 5587.1 5654.5 5924.1 5929.4 5932.2 5942.6 5948.8 5382.8 5527.9 5575.4 5588.7 5593.4 5045.9 5075.7 5076.6 5089.7 5151.9 5993.6 6045.2 6046.2 6052.0 6057.4 5662.8 5880.9 5884.7 5889.0 5894.7 5995.3 6016.1 6050.8 6078.4 6144.6 5765.2 5765.5 5771.6 5777.5 5842.5 5598.2 5886.0 5896.1 5896.8 5898.3 5706.9 5707.6 5744.3 5759.8 5828.6 5721.2 5745.6 5770.0 5781.9 5783.3 5509.9 5727.9 5739.8 5740.2 5740.7 5734.9 5769.6 5780.4 5815.0 5888.2 5658.4 5676.0 5676.1 5678.3 5682.7 02:32:02 INFO - PROCESS | 6612 | 02:32:02 INFO - PROCESS | 6612 | [#1] ext.html Cycles:180 Average:61609.67 Median:43927.84 stddev:118708.26 (270.2%) stddev-sans-first:118952.84 02:32:02 INFO - PROCESS | 6612 | Values: 582.9 612.0 620.3 634.7 641.4 32831.7 33740.7 36218.6 36234.0 43151.6 41118.6 45833.8 46088.5 46196.3 46210.8 8879.3 9009.1 9031.2 9032.5 9041.5 8940.2 9028.4 9029.1 9039.7 9043.0 9022.2 9072.5 9080.9 9082.8 9110.1 9007.0 9035.6 9039.9 9045.5 9050.5 8903.0 8978.9 8984.8 8985.8 8988.2 43386.6 43919.1 43936.6 43973.6 44000.3 3768.3 3819.3 3850.9 3874.5 4341.7 32644.3 32936.4 33124.2 33138.5 33198.0 4315.8 4384.7 4398.6 4598.1 4605.0 361793.0 363276.0 363514.0 363978.0 365539.0 60099.4 60565.7 60577.0 60587.7 60621.4 62951.4 63029.4 63141.0 63183.0 63224.4 17096.7 17346.8 17386.7 17505.7 17518.0 13024.0 13117.8 13123.2 13141.4 13143.7 15609.3 17632.2 17687.1 17706.3 17740.7 6366.0 6390.7 6488.9 6549.6 6605.8 957.2 1045.4 1045.6 1112.9 1139.6 33874.5 34078.0 34109.8 34175.5 34222.1 878.8 1112.6 1112.9 1155.5 1163.9 15788.7 17639.0 17703.3 17708.9 17894.5 528424.0 537781.0 539085.0 540836.0 543388.0 60638.4 61773.4 62216.7 62273.4 62455.0 1288.0 1415.3 1445.8 1448.6 1478.0 32754.3 34924.7 34958.7 35235.0 35360.1 52437.5 53129.0 53164.7 53170.7 53201.5 423215.0 426645.0 426871.0 428523.0 429103.0 44386.6 45135.5 46441.5 48016.5 49790.8 50108.7 50342.5 50475.2 51627.7 52009.0 41879.4 42100.6 42309.4 42839.4 44461.0 42093.8 42517.6 43592.3 44272.3 44384.0 43346.0 44056.3 44475.0 44662.0 45006.3 34197.5 36643.5 37771.4 40278.4 40345.4 28016.6 28181.3 28800.3 29449.0 29515.9 02:32:02 INFO - PROCESS | 6612 | 02:32:02 INFO - PROCESS | 6612 | [#2] jquery.html Cycles:180 Average:28344.39 Median:11624.98 stddev:79091.31 (680.4%) stddev-sans-first:79285.32 02:32:02 INFO - PROCESS | 6612 | Values: 384.2 395.1 404.6 405.1 423.0 15763.0 19343.5 19473.0 19509.6 19769.8 12639.9 12975.4 12988.8 13068.2 13138.1 5216.3 5392.3 5432.7 5434.6 5445.0 5172.2 5308.8 5317.7 5327.0 5355.3 5338.8 5353.6 5354.9 5355.2 5363.0 5251.8 5308.5 5730.8 5792.8 5813.3 5306.1 5312.3 5313.5 5314.6 5316.8 13829.0 13848.1 13970.7 14146.4 16999.6 2324.5 2367.9 2639.9 2651.8 2953.9 10344.2 10446.5 10626.3 10732.7 10964.9 1923.0 1925.9 1926.8 1932.4 1959.7 47051.0 62975.0 89426.1 91458.5 91601.5 11071.2 11288.7 11364.7 11441.4 11741.2 16016.2 16079.6 16091.8 16097.3 16119.0 7756.3 8103.6 8160.3 8277.4 8297.7 7638.5 7653.1 7711.2 7930.4 7937.1 4921.2 4927.2 4937.5 4943.3 5045.5 1860.2 1987.2 1992.4 2007.4 2023.8 891.4 1015.9 1021.8 1031.0 1053.7 19778.9 19862.2 20775.4 20805.9 20925.5 991.1 1001.5 1013.9 1024.7 1026.0 10399.6 11365.3 11486.4 11531.8 11592.8 474322.0 474845.0 475194.0 478935.0 489099.0 81690.0 93839.5 94525.5 97233.5 97792.0 966.8 1000.6 1005.5 1013.9 1025.4 17387.4 17572.0 18374.5 18405.6 18764.5 30282.0 32074.0 43388.9 45588.5 45810.3 63243.6 63601.0 63846.4 65057.0 65662.7 8376.3 8511.4 8569.7 8821.6 8874.8 12681.8 13108.3 13453.9 13649.0 13732.3 11459.0 11531.5 11653.4 11986.2 12172.4 11428.0 11467.5 11473.7 11512.8 12026.7 11470.0 11852.6 12001.8 12056.4 12066.6 8161.3 8348.0 8603.8 8623.9 8635.7 9272.8 11326.0 11518.6 11565.7 12098.8 02:32:02 INFO - PROCESS | 6612 | 02:32:02 INFO - PROCESS | 6612 | [#3] mootools.html Cycles:180 Average:5957.23 Median:2638.89 stddev:3463.31 (131.2%) stddev-sans-first:3455.37 02:32:02 INFO - PROCESS | 6612 | Values: 1303.9 1463.0 1508.0 1628.9 1755.7 8365.0 8651.4 8681.0 8843.9 8930.4 8664.4 8797.4 8804.5 8827.1 8846.5 2049.2 2319.2 2391.4 2417.2 2421.5 2405.3 2423.6 2434.8 2442.5 2448.0 2341.0 2348.9 2349.5 2359.6 2413.3 2350.4 2352.0 2359.2 2366.8 2436.0 2397.7 2420.0 2421.1 2425.6 2425.9 9407.0 9461.8 9469.9 9496.9 9562.9 5452.1 5605.8 5606.7 5609.8 5613.4 3305.6 3311.7 3427.6 3438.8 3444.9 1120.0 1122.4 1151.9 1163.7 1176.9 12579.7 12667.4 12695.7 12747.8 12755.4 4267.7 4534.1 4616.4 4760.9 4768.8 9811.4 9818.5 9826.1 9832.8 9833.9 5101.2 5102.2 5103.8 5104.2 5107.4 4347.7 4798.3 4814.8 4940.5 5055.8 3857.6 3959.1 3970.3 4015.0 4072.5 1209.8 1221.6 1221.8 1228.3 1240.0 901.8 989.2 1005.3 1008.6 1009.4 5986.9 5993.3 6078.2 6255.0 6274.5 466.8 476.8 479.5 480.6 483.1 4021.9 4128.7 4134.2 4209.6 4288.8 10917.4 11658.2 11730.4 11805.0 11811.6 11425.1 11592.5 11740.2 11762.0 11764.6 8538.6 8608.9 8624.3 8637.0 8638.4 5969.1 6045.3 6085.5 6086.3 6204.8 9789.4 10368.6 10422.6 10537.7 10645.8 10509.8 10738.2 10766.2 10814.9 11000.8 8141.5 8331.6 8350.5 8400.4 8414.2 8928.5 8930.9 8982.7 9000.7 9002.1 7996.8 8062.8 8072.0 8092.8 8417.7 7756.0 7889.5 7965.8 7976.8 8056.6 6980.9 7008.8 7012.0 7020.6 7045.6 5273.1 5276.1 5306.8 5358.2 5382.8 5183.3 5214.5 5229.8 5324.7 5474.6 02:32:02 INFO - PROCESS | 6612 | 02:32:02 INFO - PROCESS | 6612 | [#4] prototype.html Cycles:180 Average:4499.90 Median:5070.01 stddev:1298.70 (25.6%) stddev-sans-first:1263.87 02:32:02 INFO - PROCESS | 6612 | Values: 319.5 333.8 336.3 338.8 340.7 5138.8 5219.2 5264.9 5294.9 5302.7 5197.7 5231.4 5249.4 5251.7 5309.6 4088.3 4092.0 4156.5 4177.1 4190.7 3997.6 4125.5 4170.9 4183.8 4186.7 4115.1 4118.0 4125.3 4126.0 4139.4 4098.3 4100.7 4113.5 4114.4 4137.2 3655.7 3665.2 3667.4 3675.5 3679.9 5050.7 5077.7 5082.8 5101.5 5154.7 4634.9 4671.2 4673.3 4674.1 4678.7 5396.4 5425.6 5434.9 5440.3 5456.7 3884.7 3950.1 3976.5 3981.3 4021.4 5624.4 5644.9 5667.0 5667.3 5689.4 4043.8 4062.6 4074.7 4075.8 4080.5 3908.2 4065.7 4075.5 4115.3 4125.5 4622.5 4629.5 4636.7 4637.2 4642.7 5493.6 5496.4 5511.3 5522.3 5568.4 1330.6 1334.9 1383.9 1392.2 1399.7 952.2 955.9 971.5 980.7 986.7 5288.4 5309.9 5320.5 5332.8 5360.7 5565.0 5565.6 5568.4 5574.5 5578.4 5197.3 5247.3 5278.9 5322.5 5354.3 2668.8 2671.9 2679.4 2684.6 2688.4 5114.6 5123.4 5179.0 5187.2 5206.8 4925.3 4942.0 5044.3 5068.6 5135.3 5044.8 5073.7 5077.5 5087.6 5096.8 4968.6 4999.4 5009.8 5010.9 5025.5 4559.3 4852.7 4889.0 4914.4 4975.8 5064.9 5067.3 5068.3 5071.4 5095.9 3647.0 3675.7 3678.9 3684.5 3718.6 4997.0 5008.3 5207.3 5452.6 5726.4 5401.8 5499.7 5511.8 5514.6 5518.6 5504.6 5505.1 5514.1 5538.5 5608.2 5274.8 5445.9 5490.8 5494.4 5535.8 5521.4 5556.6 5585.0 5606.5 5612.2 5471.4 5515.7 5519.3 5560.7 5572.2 02:32:02 INFO - PROCESS | 6612 | 02:32:02 INFO - PROCESS | 6612 | [#5] yui.html Cycles:180 Average:22124.99 Median:4531.33 stddev:32259.12 (711.9%) stddev-sans-first:32309.67 02:32:02 INFO - PROCESS | 6612 | Values: 745.0 763.0 790.3 799.1 845.0 15843.0 17452.4 17469.7 17476.9 17484.6 13871.6 13882.1 13887.3 13910.4 13920.4 658.8 794.4 818.9 822.2 826.4 812.4 812.8 813.9 814.7 815.5 868.4 873.9 875.6 876.2 877.4 698.3 830.5 858.4 866.4 869.7 633.0 635.7 635.9 636.0 636.3 15820.5 15848.5 15855.4 15863.3 15879.4 14334.4 14504.6 14712.8 14869.0 15134.0 12487.4 13111.1 13681.2 14110.4 14173.2 4526.7 4536.0 4596.7 4607.3 4833.3 80003.6 81230.2 81710.6 82866.2 83600.6 11611.1 11659.2 11914.6 12108.0 12522.9 22878.2 23033.9 23757.2 23785.5 23807.8 8430.9 8648.5 8792.9 8891.2 9123.2 4607.0 4841.6 4910.2 4982.8 5108.1 3508.6 3646.9 3651.1 3666.6 3669.1 601.0 619.0 623.0 623.1 624.4 651.6 733.4 735.2 749.5 780.6 9557.0 10058.9 10202.3 10260.5 10864.8 666.1 677.6 733.2 737.0 758.7 4393.8 5000.3 5013.9 5026.6 5049.6 119769.4 120247.0 120955.4 122182.0 129915.0 105189.5 106463.0 109608.5 112161.0 114276.0 93619.0 94560.5 94630.0 95530.0 96152.0 9061.7 9401.8 9544.1 9590.2 9637.6 45969.8 49211.0 49323.0 50147.0 51246.5 73623.0 74968.0 77890.0 81571.0 83704.0 12564.6 12668.8 12894.7 12996.3 13223.7 14951.5 14953.6 15273.7 15448.4 16236.9 14816.6 15272.1 15676.8 15870.5 15895.4 14146.1 14450.0 14663.6 14745.8 14810.5 14005.4 14670.2 14792.4 14806.8 14862.8 11201.6 11386.6 11646.0 11835.7 12135.2 10818.6 11694.9 11798.6 11999.8 12139.7 02:32:02 INFO - PROCESS | 6612 | -------- Summary: end -------- 02:32:02 INFO - PROCESS | 6612 | 02:32:03 INFO - TEST-INFO | 6612: exit 0 02:32:03 INFO - TEST-OK | dromaeo_css | took 1117629ms 02:32:03 INFO - TEST-START | kraken 02:32:03 INFO - operating with platform_type : linux_ 02:32:03 INFO - Initialising browser for kraken test... 02:32:03 INFO - TEST-INFO | started process 6923 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp52FUD2/profile http://localhost:40913/getInfo.html) 02:32:08 INFO - PROCESS | 6923 | __metrics Screen width/height:1600/1200 02:32:08 INFO - PROCESS | 6923 | colorDepth:24 02:32:08 INFO - PROCESS | 6923 | Browser inner width/height: 1024/697 02:32:08 INFO - PROCESS | 6923 | __metrics 02:32:09 INFO - PROCESS | 6923 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:32:09 INFO - PROCESS | 6923 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:32:09 INFO - PROCESS | 6923 | console.error: PushService: 02:32:09 INFO - PROCESS | 6923 | stateChangeProcessEnqueue: Error transitioning state 02:32:09 INFO - PROCESS | 6923 | UnknownError 02:32:10 INFO - TEST-INFO | 6923: exit 0 02:32:10 INFO - Browser initialized. 02:32:10 INFO - Running cycle 1/1 for kraken test... 02:32:10 INFO - TEST-INFO | started process 7004 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp52FUD2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:32:22 INFO - PROCESS | 7004 | RSS: Main: 180084736 02:32:22 INFO - PROCESS | 7004 | 02:32:25 INFO - PROCESS | 7004 | Cycle 1(1): loaded http://localhost:40913/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40913/tests/kraken/driver.html?testName=audio-beat-detection) 02:32:26 INFO - PROCESS | 7004 | RSS: Main: 242626560 02:32:26 INFO - PROCESS | 7004 | 02:32:28 INFO - PROCESS | 7004 | Cycle 1(1): loaded http://localhost:40913/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40913/tests/kraken/driver.html?testName=audio-dft) 02:32:29 INFO - PROCESS | 7004 | RSS: Main: 225349632 02:32:29 INFO - PROCESS | 7004 | 02:32:32 INFO - PROCESS | 7004 | Cycle 1(1): loaded http://localhost:40913/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40913/tests/kraken/driver.html?testName=audio-fft) 02:32:33 INFO - PROCESS | 7004 | RSS: Main: 302055424 02:32:33 INFO - PROCESS | 7004 | 02:32:35 INFO - PROCESS | 7004 | Cycle 1(1): loaded http://localhost:40913/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40913/tests/kraken/driver.html?testName=audio-oscillator) 02:32:35 INFO - PROCESS | 7004 | RSS: Main: 211615744 02:32:35 INFO - PROCESS | 7004 | 02:32:38 INFO - PROCESS | 7004 | Cycle 1(1): loaded http://localhost:40913/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40913/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:32:38 INFO - PROCESS | 7004 | RSS: Main: 214675456 02:32:38 INFO - PROCESS | 7004 | 02:32:41 INFO - PROCESS | 7004 | Cycle 1(1): loaded http://localhost:40913/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40913/tests/kraken/driver.html?testName=imaging-darkroom) 02:32:42 INFO - PROCESS | 7004 | RSS: Main: 254320640 02:32:42 INFO - PROCESS | 7004 | 02:32:45 INFO - PROCESS | 7004 | Cycle 1(1): loaded http://localhost:40913/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40913/tests/kraken/driver.html?testName=imaging-desaturate) 02:32:46 INFO - PROCESS | 7004 | RSS: Main: 253272064 02:32:46 INFO - PROCESS | 7004 | 02:32:49 INFO - PROCESS | 7004 | Cycle 1(1): loaded http://localhost:40913/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40913/tests/kraken/driver.html?testName=json-parse-financial) 02:32:49 INFO - PROCESS | 7004 | RSS: Main: 253161472 02:32:49 INFO - PROCESS | 7004 | 02:32:51 INFO - PROCESS | 7004 | Cycle 1(1): loaded http://localhost:40913/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40913/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:32:52 INFO - PROCESS | 7004 | RSS: Main: 215986176 02:32:52 INFO - PROCESS | 7004 | 02:32:53 INFO - PROCESS | 7004 | Cycle 1(1): loaded http://localhost:40913/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40913/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:32:54 INFO - PROCESS | 7004 | RSS: Main: 223612928 02:32:54 INFO - PROCESS | 7004 | 02:32:56 INFO - PROCESS | 7004 | Cycle 1(1): loaded http://localhost:40913/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40913/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:32:57 INFO - PROCESS | 7004 | RSS: Main: 223379456 02:32:57 INFO - PROCESS | 7004 | 02:32:59 INFO - PROCESS | 7004 | Cycle 1(1): loaded http://localhost:40913/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40913/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:33:00 INFO - PROCESS | 7004 | RSS: Main: 216911872 02:33:00 INFO - PROCESS | 7004 | 02:33:03 INFO - PROCESS | 7004 | Cycle 1(1): loaded http://localhost:40913/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40913/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:33:03 INFO - PROCESS | 7004 | RSS: Main: 220119040 02:33:03 INFO - PROCESS | 7004 | 02:33:05 INFO - PROCESS | 7004 | Cycle 1(1): loaded http://localhost:40913/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40913/tests/kraken/driver.html?testName=ai-astar) 02:33:05 INFO - PROCESS | 7004 | RSS: Main: 270807040 02:33:05 INFO - PROCESS | 7004 | 02:33:05 INFO - PROCESS | 7004 | __start_tp_report 02:33:05 INFO - PROCESS | 7004 | _x_x_mozilla_page_load 02:33:05 INFO - PROCESS | 7004 | _x_x_mozilla_page_load_details 02:33:05 INFO - PROCESS | 7004 | |i|pagename|runs| 02:33:05 INFO - PROCESS | 7004 | |0;ai-astar;112;112;127;111;111;113;110;111;110;111 02:33:05 INFO - PROCESS | 7004 | |1;audio-beat-detection;150;120;156;180;128;151;148;124;192;118 02:33:05 INFO - PROCESS | 7004 | |2;audio-dft;162;161;162;159;163;163;161;161;162;161 02:33:05 INFO - PROCESS | 7004 | |3;audio-fft;76;77;77;168;74;76;74;74;167;76 02:33:05 INFO - PROCESS | 7004 | |4;audio-oscillator;87;86;151;86;84;85;147;86;85;150 02:33:05 INFO - PROCESS | 7004 | |5;imaging-gaussian-blur;117;117;117;117;117;118;117;116;117;117 02:33:05 INFO - PROCESS | 7004 | |6;imaging-darkroom;145;147;146;146;145;146;146;146;145;145 02:33:05 INFO - PROCESS | 7004 | |7;imaging-desaturate;95;95;95;95;95;95;94;96;95;95 02:33:05 INFO - PROCESS | 7004 | |8;json-parse-financial;52;50;51;52;50;53;51;51;49;52 02:33:05 INFO - PROCESS | 7004 | |9;json-stringify-tinderbox;62;60;61;61;61;60;60;61;61;61 02:33:05 INFO - PROCESS | 7004 | |10;stanford-crypto-aes;81;78;79;87;88;79;78;78;86;79 02:33:05 INFO - PROCESS | 7004 | |11;stanford-crypto-ccm;124;123;128;146;126;139;125;135;146;125 02:33:05 INFO - PROCESS | 7004 | |12;stanford-crypto-pbkdf2;163;163;162;166;163;165;164;165;167;162 02:33:05 INFO - PROCESS | 7004 | |13;stanford-crypto-sha256-iterative;68;70;66;65;66;66;65;65;63;63 02:33:05 INFO - PROCESS | 7004 | __end_tp_report 02:33:05 INFO - PROCESS | 7004 | __start_cc_report 02:33:05 INFO - PROCESS | 7004 | _x_x_mozilla_cycle_collect,1668 02:33:05 INFO - PROCESS | 7004 | __end_cc_report 02:33:05 INFO - PROCESS | 7004 | __startTimestamp1472031185945__endTimestamp 02:33:05 INFO - PROCESS | 7004 | 02:33:05 INFO - PROCESS | 7004 | ------- Summary: start ------- 02:33:05 INFO - PROCESS | 7004 | Number of tests: 14 02:33:05 INFO - PROCESS | 7004 | 02:33:05 INFO - PROCESS | 7004 | [#0] ai-astar Cycles:10 Average:112.80 Median:111.50 stddev:5.07 (4.5%) stddev-sans-first:5.37 02:33:05 INFO - PROCESS | 7004 | Values: 112.0 112.0 127.0 111.0 111.0 113.0 110.0 111.0 110.0 111.0 02:33:05 INFO - PROCESS | 7004 | 02:33:05 INFO - PROCESS | 7004 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:150.50 stddev:25.12 (16.7%) stddev-sans-first:26.62 02:33:05 INFO - PROCESS | 7004 | Values: 150.0 120.0 156.0 180.0 128.0 151.0 148.0 124.0 192.0 118.0 02:33:05 INFO - PROCESS | 7004 | 02:33:05 INFO - PROCESS | 7004 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.18 (0.7%) stddev-sans-first:1.24 02:33:05 INFO - PROCESS | 7004 | Values: 162.0 161.0 162.0 159.0 163.0 163.0 161.0 161.0 162.0 161.0 02:33:05 INFO - PROCESS | 7004 | 02:33:05 INFO - PROCESS | 7004 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:38.81 (51.1%) stddev-sans-first:40.62 02:33:05 INFO - PROCESS | 7004 | Values: 76.0 77.0 77.0 168.0 74.0 76.0 74.0 74.0 167.0 76.0 02:33:05 INFO - PROCESS | 7004 | 02:33:05 INFO - PROCESS | 7004 | [#4] audio-oscillator Cycles:10 Average:104.70 Median:85.50 stddev:30.83 (36.1%) stddev-sans-first:32.02 02:33:05 INFO - PROCESS | 7004 | Values: 87.0 86.0 151.0 86.0 84.0 85.0 147.0 86.0 85.0 150.0 02:33:05 INFO - PROCESS | 7004 | 02:33:05 INFO - PROCESS | 7004 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 02:33:05 INFO - PROCESS | 7004 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 117.0 116.0 117.0 117.0 02:33:05 INFO - PROCESS | 7004 | 02:33:05 INFO - PROCESS | 7004 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 02:33:05 INFO - PROCESS | 7004 | Values: 145.0 147.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 145.0 02:33:05 INFO - PROCESS | 7004 | 02:33:05 INFO - PROCESS | 7004 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 02:33:05 INFO - PROCESS | 7004 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 96.0 95.0 95.0 02:33:05 INFO - PROCESS | 7004 | 02:33:05 INFO - PROCESS | 7004 | [#8] json-parse-financial Cycles:10 Average:51.10 Median:51.50 stddev:1.20 (2.3%) stddev-sans-first:1.22 02:33:05 INFO - PROCESS | 7004 | Values: 52.0 50.0 51.0 52.0 50.0 53.0 51.0 51.0 49.0 52.0 02:33:05 INFO - PROCESS | 7004 | 02:33:05 INFO - PROCESS | 7004 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 02:33:05 INFO - PROCESS | 7004 | Values: 62.0 60.0 61.0 61.0 61.0 60.0 60.0 61.0 61.0 61.0 02:33:05 INFO - PROCESS | 7004 | 02:33:05 INFO - PROCESS | 7004 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:80.00 stddev:4.06 (5.1%) stddev-sans-first:4.30 02:33:05 INFO - PROCESS | 7004 | Values: 81.0 78.0 79.0 87.0 88.0 79.0 78.0 78.0 86.0 79.0 02:33:05 INFO - PROCESS | 7004 | 02:33:05 INFO - PROCESS | 7004 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:131.50 stddev:9.09 (6.9%) stddev-sans-first:9.21 02:33:05 INFO - PROCESS | 7004 | Values: 124.0 123.0 128.0 146.0 126.0 139.0 125.0 135.0 146.0 125.0 02:33:05 INFO - PROCESS | 7004 | 02:33:05 INFO - PROCESS | 7004 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.00 Median:164.50 stddev:1.70 (1.0%) stddev-sans-first:1.76 02:33:05 INFO - PROCESS | 7004 | Values: 163.0 163.0 162.0 166.0 163.0 165.0 164.0 165.0 167.0 162.0 02:33:05 INFO - PROCESS | 7004 | 02:33:05 INFO - PROCESS | 7004 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:2.11 (3.2%) stddev-sans-first:2.07 02:33:05 INFO - PROCESS | 7004 | Values: 68.0 70.0 66.0 65.0 66.0 66.0 65.0 65.0 63.0 63.0 02:33:05 INFO - PROCESS | 7004 | -------- Summary: end -------- 02:33:05 INFO - PROCESS | 7004 | 02:33:07 INFO - TEST-INFO | 7004: exit 0 02:33:07 INFO - TEST-OK | kraken | took 63237ms 02:33:07 INFO - SUITE-END | took 1180s 02:33:07 INFO - Completed test suite (00:19:41) 02:33:07 INFO - javascript benchmark 02:33:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3046.680098589648, 3051.1151765987865, 3064.2492589315607, 3103.115612050566, 3134.435801555719, 5253.185756207784, 5328.254044433777, 5372.167314066316, 5400.783968641254, 5422.945770542294, 5380.596455265852, 5408.188771684239, 5434.375046869602, 5444.809431669893, 5450.482204190595, 4815.927761083586, 4865.927011094819, 4882.487338829425, 4902.117618828609, 5116.309298244745, 5003.699778013312, 5049.2678561608545, 5053.0, 5067.923981140286, 5069.315642388267, 4819.180739274314, 4850.078485087822, 4868.0, 4917.459079501288, 5015.874603134915, 4884.267359896008, 4931.137051016094, 5042.773075211588, 5048.469910659402, 5049.596032317406, 4821.180399332122, 4901.995091006335, 4906.828261010884, 4915.090708218955, 4921.729304888266, 5426.348838139409, 5429.4299098594865, 5430.647007944511, 5433.157860531584, 5437.592180586433, 5630.71846407678, 5767.653940763567, 5810.941890581124, 5819.098039803837, 5846.941530584682, 5820.35976042635, 5855.3851845556455, 5864.501517370986, 5885.411458854123, 5889.85275368115, 5267.578593712494, 5479.315085614298, 5489.505944464938, 5494.670319780826, 5502.642328248651, 5860.794872179538, 5923.822285331447, 5933.525317974551, 6029.306629737549, 6039.818805435844, 5669.801556945487, 5732.942670573241, 5776.595638305278, 5778.27771528559, 5794.652320860761, 5786.826395208151, 5798.304203495608, 5808.332041815161, 5809.82570522885, 5814.418558144236, 5612.550995920316, 5741.339745929188, 5761.337446193657, 5805.187273781674, 5810.360860305363, 5837.416258374129, 5889.352171261158, 5890.352061273342, 5898.439648233411, 5947.791827286024, 4507.414036175276, 4515.774211289422, 4518.480374756879, 4522.638188944877, 4557.111363284128, 3949.8025098744947, 3953.327934251184, 4032.5967403260024, 4041.9595804041583, 4063.776492292893, 5496.725163741797, 5518.255035570227, 5535.723213839292, 5587.05020146576, 5654.491095801398, 5924.14099955504, 5929.377415371324, 5932.199153114274, 5942.58401911862, 5948.821535353946, 5382.757775900094, 5527.861803454945, 5575.4424557543925, 5588.6646801192055, 5593.3847276799515, 5045.899082018413, 5075.695458272516, 5076.6192535559985, 5089.694618322913, 5151.9484805152215, 5993.550483713651, 6045.21412216409, 6046.2139921809885, 6051.999999999912, 6057.394260573908, 5662.801801936913, 5880.852978675567, 5884.676342801187, 5889.0, 5894.70526473666, 5995.310539288038, 6016.127661489147, 6050.788222412194, 6078.411007413859, 6144.631322120687, 5765.221695071112, 5765.538756899354, 5771.59598828078, 5777.537796976316, 5842.474177324061, 5598.188262701967, 5886.028805247258, 5896.115582662635, 5896.823095307148, 5898.292204935436, 5706.857328566819, 5707.6290041147195, 5744.310682718101, 5759.7984070559005, 5828.562857785599, 5721.170430287668, 5745.626534275259, 5769.9711501442225, 5781.8554536136935, 5783.334916484658, 5509.944900550943, 5727.8854422912145, 5739.799107031234, 5740.1963725077685, 5740.741666625096, 5734.913976290276, 5769.624974376652, 5780.3525995091195, 5815.0, 5888.205092312654, 5658.377578466448, 5675.971620141873, 5676.120201368794, 5678.3186017678145, 5682.659040457585], "value": 5385.303963085988, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.9213056237406, 611.9785807496737, 620.2711813618996, 634.6763150793096, 641.3810672700848, 32831.67168328316, 33740.66259337406, 36218.637813621855, 36234.0, 43151.56848431515, 41118.58881411185, 45833.770831145885, 46088.539114608844, 46196.307055394194, 46210.76894615522, 8879.334049946248, 9009.099090091004, 9031.23234525066, 9032.548372581345, 9041.547922603877, 8940.19538241558, 9028.368014239006, 9029.142231488031, 9039.683611073613, 9042.954785226064, 9022.233110185642, 9072.546372681372, 9080.8637870432, 9082.77293067672, 9110.088991100904, 9007.0, 9035.638574457014, 9039.870016248002, 9045.502497362642, 9050.547472626407, 8902.955485222532, 8978.86531702025, 8984.775380615472, 8985.820283594358, 8988.235999940012, 43386.566134338565, 43919.12161756779, 43936.560634393565, 43973.56026439759, 44000.3399949001, 3768.321702093622, 3819.3316169670197, 3850.9229815403814, 3874.4575759393706, 4341.717788343748, 32644.347113057607, 32936.40789896439, 33124.17189570256, 33138.50292245618, 33198.0, 4315.82736690532, 4384.714993525443, 4398.582134697199, 4598.057398233354, 4604.976975115103, 361793.0, 363276.0, 363514.0, 363978.0, 365539.0, 60099.39900601025, 60565.697171514745, 60577.0, 60587.69706151441, 60621.39378606246, 62951.37048629455, 63029.36970630327, 63141.0, 63183.0, 63224.367756321844, 17096.658066838594, 17346.826531734772, 17386.739198912026, 17505.7374139388, 17518.0, 13024.0, 13117.803232951514, 13123.212607243597, 13141.408636611184, 13143.737125257632, 15609.297581608855, 17632.20655070525, 17687.115644217738, 17706.29174833018, 17740.733888991675, 6366.0, 6390.680465976682, 6488.902666460007, 6549.631664377575, 6605.8348541285895, 957.167264479907, 1045.38844775807, 1045.6183493025144, 1112.890987269204, 1139.6296203733655, 33874.49188262178, 34078.0, 34109.82945085259, 34175.48736768951, 34222.14444638854, 878.7934835313696, 1112.6217086190734, 1112.8608923884515, 1155.5146838327923, 1163.9185257032095, 15788.68422631564, 17639.0, 17703.291868325123, 17708.9114554429, 17894.463166105037, 528424.0, 537781.0, 539085.0, 540836.0, 543388.0, 60638.39361606416, 61773.38226617676, 62216.688916555126, 62273.37726622766, 62455.0, 1287.9742405151844, 1415.2923538230884, 1445.8048163498004, 1448.5943935698022, 1477.9778303325459, 32754.34491310113, 34924.65075349316, 34958.65041349656, 35235.0, 35360.11599710028, 52437.475625244784, 53129.0, 53164.73417633042, 53170.73414632902, 53201.4679853212, 423215.0, 426645.0, 426871.0, 428523.0, 429103.0, 44386.556134438244, 45135.54864451445, 46441.53558464507, 48016.519834801205, 49790.751046244535, 50108.74945625249, 50342.49657503525, 50475.214358922494, 51627.74186129045, 52009.0, 41879.37180942227, 42100.57899421089, 42309.42264433891, 42839.3574096395, 44461.0, 42093.78953105215, 42517.57482425136, 43592.34611480894, 44272.335914960655, 44384.0, 43346.0, 44056.339154913345, 44475.0, 44662.0, 45006.324905125795, 34197.48703769396, 36643.45034824533, 37771.43342849914, 40278.39582406325, 40345.39481907715, 28016.57975130334, 28181.340628190457, 28800.279992999505, 29449.0, 29515.85242073776], "value": 20820.57937905578, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.1989451992595, 395.10311592684604, 404.5751960441536, 405.14716521721755, 422.98096585653644, 15763.0, 19343.516412089706, 19473.0, 19509.609807803834, 19769.802301976975, 12639.873601263984, 12975.351232438388, 12988.805167922465, 13068.21590704556, 13138.146020508684, 5216.347956505447, 5392.299001129848, 5432.67403955762, 5434.619576629638, 5445.047116754572, 5172.172452407615, 5308.814191503298, 5317.660229499027, 5326.973365133188, 5355.277037599933, 5338.813141540047, 5353.5984801139875, 5354.946450535504, 5355.223492593572, 5362.973185134088, 5251.842444726664, 5308.495692909168, 5730.7707691692285, 5792.797252096157, 5813.331466881321, 5306.071437498423, 5312.335958005249, 5313.548348390392, 5314.601404894648, 5316.76074576645, 13829.0, 13848.09987350829, 13970.650733731636, 14146.36341364641, 16999.57501062471, 2324.4886125052462, 2367.869767162805, 2639.8680065996814, 2651.814372993891, 2953.8966136185345, 10344.224183186216, 10446.47767611624, 10626.256162068657, 10732.678019659423, 10964.890351096466, 1922.9615407691767, 1925.913333899978, 1926.8169523895347, 1932.420273917819, 1959.706044093383, 47051.0, 62975.0, 89426.10573894242, 91458.54270728603, 91601.54199229028, 11071.1696622752, 11288.71778205535, 11364.715882102848, 11441.427928603536, 11741.178117531861, 16016.199190040452, 16079.598010049609, 16091.758623620655, 16097.275622597012, 16119.032858028555, 7756.263155000266, 8103.554304513191, 8160.30637395828, 8277.379196560161, 8297.668093276323, 7638.50349727266, 7653.081630204411, 7711.190325015793, 7930.444868859125, 7937.087234967938, 4921.212605983025, 4927.162382395001, 4937.456879743226, 4943.28322393251, 5045.495450454999, 1860.2280053777802, 1987.2051179528305, 1992.3624440179294, 2007.3777129090029, 2023.8077382648626, 891.3938521805105, 1015.939043657383, 1021.7854250607307, 1030.953607087683, 1053.7312985188728, 19778.90110549438, 19862.247953683313, 20775.37673869786, 20805.89597052005, 20925.476863078242, 991.0584944302941, 1001.4592120255127, 1013.8834034086027, 1024.7438140464883, 1025.974350641225, 10399.584016639401, 11365.261258018203, 11486.368249746178, 11531.827022594667, 11592.826107608393, 474322.0, 474845.0, 475194.0, 478935.0, 489099.0, 81690.0, 93839.53080234556, 94525.5273723627, 97233.51383243038, 97792.0, 966.7873067925045, 1000.5847573257163, 1005.5173516712019, 1013.9391636501686, 1025.4206373399006, 17387.391441299493, 17572.0, 18374.540636484195, 18405.63188736191, 18764.46679698278, 30282.0, 32074.0, 43388.91527711706, 45588.54411455843, 45810.31284530668, 63243.61546061502, 63601.0, 63846.36153638404, 65057.0, 65662.67168664126, 8376.288015518749, 8511.402406176943, 8569.700060497853, 8821.558922054, 8874.778130546789, 12681.8097728536, 13108.279044652636, 13453.857056485676, 13649.0, 13732.313384330942, 11459.0, 11531.481083351437, 11653.359065251492, 11986.220895641756, 12172.391380430767, 11428.0, 11467.541298347973, 11473.713157171138, 11512.82730759056, 12026.699332516757, 11470.025047871024, 11852.644420667393, 12001.81997270059, 12056.397180140782, 12066.577669781516, 8161.326927979631, 8348.0, 8603.82792344162, 8623.8706419405, 8635.654573817228, 9272.768180795534, 11326.0, 11518.58109796952, 11565.653030409101, 12098.75802483963], "value": 9027.004660973442, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1303.9478420863165, 1463.04901813821, 1508.0273223770669, 1628.885977981541, 1755.7015307397733, 8365.0, 8651.437656552327, 8681.0, 8843.91156088439, 8930.419522731017, 8664.436811607256, 8797.42816716913, 8804.515751633673, 8827.073157318486, 8846.513441760717, 2049.211053744312, 2319.199876042771, 2391.366287933695, 2417.178159425795, 2421.503591763693, 2405.314485371661, 2423.587990041697, 2434.793042591382, 2442.46265821519, 2448.0, 2340.9531809363802, 2348.8708121053337, 2349.48311371498, 2359.610664240407, 2413.348395933097, 2350.424146084203, 2351.988240058789, 2359.1507057459385, 2366.8047635943826, 2436.0, 2397.6523404106483, 2420.0077968033197, 2421.067888862783, 2425.551273014498, 2425.854448733082, 9407.0, 9461.810763784755, 9469.905300946972, 9496.857547136799, 9562.90437095627, 5452.100403433429, 5605.831825045255, 5606.691631960241, 5609.803656872031, 5613.410591887834, 3305.5702758641223, 3311.735061195123, 3427.640097789746, 3438.7764795288226, 3444.913877153066, 1119.9888001119966, 1122.4387806096952, 1151.936643484608, 1163.6741712320563, 1176.8705442401329, 12579.685507862378, 12667.429965651476, 12695.746085078246, 12747.808782868264, 12755.42600582976, 4267.701260911768, 4534.13851368239, 4616.3537104805355, 4760.904781904412, 4768.809247630056, 9811.411315321104, 9818.509074546244, 9826.115649591571, 9832.803343933225, 9833.901660983442, 5101.20931255656, 5102.209157580581, 5103.821366252238, 5104.2088476286235, 5107.41264754558, 4347.652187824967, 4798.304245884327, 4814.772233080542, 4940.505949405031, 5055.797768089309, 3857.633524815138, 3959.148783011666, 3970.3448930926074, 4014.959850401517, 4072.470578824734, 1209.776191404593, 1221.645722740413, 1221.7984032634693, 1228.2937311046005, 1240.0141887199698, 901.7925877048316, 989.1987490133015, 1005.3415013166388, 1008.6116845014723, 1009.3590569988111, 5986.880262394728, 5993.250843644544, 6078.179445774764, 6254.968725156436, 6274.529410294155, 466.768949370064, 476.83787512246005, 479.4749749024812, 480.6371189751785, 483.1158979068297, 4021.9195616087513, 4128.690348223835, 4134.214499245134, 4209.579042095827, 4288.785560721952, 10917.39954302505, 11658.18392712502, 11730.354830484235, 11805.0, 11811.586594469152, 11425.08599312053, 11592.47833847462, 11740.236884602473, 11762.0, 11764.647060588197, 8538.615762290712, 8608.870866937, 8624.266937310273, 8636.956815215884, 8638.438501497383, 5969.134475500941, 6045.335013148462, 6085.513158947362, 6086.300075491198, 6204.7828326008375, 9789.363691360039, 10368.637097701545, 10422.635207767691, 10537.73655658584, 10645.840312395476, 10509.789804204025, 10738.248322617654, 10766.192535559707, 10814.891851081704, 11000.779984400428, 8141.51150930946, 8331.583420829056, 8350.498970061815, 8400.41197116196, 8414.158584141782, 8928.464292142233, 8930.86603700932, 8982.685606003759, 9000.729978100668, 9002.054784247559, 7996.800079998046, 8062.7581172564915, 8071.959640201761, 8092.757217283491, 8417.663293468193, 7756.0, 7889.487183333065, 7965.761027169194, 7976.800579985546, 8056.597170141352, 6980.860382792417, 7008.7546935857, 7011.9649401754705, 7020.648967551704, 7045.577265364094, 5273.103572392626, 5276.103062479311, 5306.787728490972, 5358.22305765654, 5382.838514844561, 5183.274341592105, 5214.452482489284, 5229.843104706865, 5324.653897496805, 5474.616776825584], "value": 4656.205232953995, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.4648962986998, 333.7563578587631, 336.26358275376924, 338.81077418261896, 340.72401354902547, 5138.820141295056, 5219.164933610614, 5264.894702105956, 5294.920576191355, 5302.727345437092, 5197.66215196012, 5231.424543300243, 5249.42256351801, 5251.737413129347, 5309.601779866506, 4088.284550203717, 4092.0, 4156.54278029418, 4177.0994197640075, 4190.706650534464, 3997.600239976008, 4125.546189919107, 4170.874873753793, 4183.79081045948, 4186.6859985501205, 4115.135821477494, 4117.958820411787, 4125.3292416571185, 4125.979370103145, 4139.379093136024, 4098.303288440972, 4100.6924480664065, 4113.547509773923, 4114.40341150533, 4137.151883863831, 3655.7258205634685, 3665.157013886794, 3667.3948798448223, 3675.5405574303213, 3679.908002299937, 5050.712068422528, 5077.695338279715, 5082.771275292621, 5101.540861322499, 5154.742262886841, 4634.884127896796, 4671.205894997858, 4673.252279635242, 4674.135284972291, 4678.7426691531955, 5396.424733038176, 5425.647332923348, 5434.945650543484, 5440.347158341025, 5456.699881506515, 3884.6503814656535, 3950.1309711863346, 3976.5426975897853, 3981.303271927401, 4021.3967904814513, 5624.409437009096, 5644.858878528029, 5666.999999999959, 5667.291588551431, 5689.406966049512, 4043.8180281887385, 4062.5531191568903, 4074.7351422157467, 4075.7962101894786, 4080.5108883580992, 3908.2378936107752, 4065.6950728694874, 4075.5313138989395, 4115.259253334369, 4125.525564560054, 4622.537746225351, 4629.490756016903, 4636.675432719745, 4637.194497329135, 4642.721436713808, 5493.587980901369, 5496.395396506381, 5511.338639363302, 5522.2544956430365, 5568.387477377485, 1330.6340756292097, 1334.9399277032558, 1383.89620778442, 1392.2133994293395, 1399.6850708590487, 952.1906379577304, 955.9091886270793, 971.5482300730195, 980.6613971928266, 986.659602437158, 5288.418273989858, 5309.946900531023, 5320.52115309624, 5332.786688532493, 5360.65155764874, 5565.0, 5565.638233514808, 5568.385168301228, 5574.526165275997, 5578.44215578447, 5197.324347834758, 5247.306270128382, 5278.9472105278455, 5322.520973112439, 5354.250404943311, 2668.786497080229, 2671.9445818901813, 2679.4373181632077, 2684.597310403455, 2688.421989272316, 5114.64197506171, 5123.38519377677, 5179.0, 5187.184485430144, 5206.843794686166, 4925.261210818406, 4941.975290123526, 5044.344235249394, 5068.594512438996, 5135.305349234818, 5044.798208071636, 5073.7209453481155, 5077.492250774893, 5087.64386492942, 5096.770645320969, 4968.602511799119, 4999.425181068097, 5009.8226916675285, 5010.874728131826, 5025.47232540578, 4559.270516717309, 4852.738288045204, 4889.0, 4914.434839993446, 4975.825846095369, 5064.924026139684, 5067.341245638044, 5068.315777370008, 5071.416787069535, 5095.949040509548, 3647.0, 3675.7426980112205, 3678.9080272993388, 3684.521012268388, 3718.5537735471917, 4996.950030499648, 5008.348914641073, 5207.307625021807, 5452.645578037574, 5726.4273572642405, 5401.756920938646, 5499.7250137492165, 5511.834644960658, 5514.628709654727, 5518.586106041983, 5504.587155963239, 5505.146702261156, 5514.0626093565, 5538.529225015919, 5608.186812912023, 5274.760431298719, 5445.89583937152, 5490.752916118704, 5494.395616482264, 5535.750891209986, 5521.420250873601, 5556.638818476786, 5585.0, 5606.495415412633, 5612.214289999485, 5471.37079235893, 5515.669059856422, 5519.254900588369, 5560.7219639018695, 5572.164175373727], "value": 4091.766927084574, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.9813754656129, 762.9732959346422, 790.2650535002446, 799.0770659887831, 844.995256166983, 15843.0, 17452.38916637918, 17469.650606987852, 17476.912615436922, 17484.562885927844, 13871.583852484442, 13882.097663651855, 13887.305634718274, 13910.374033168506, 13920.443182272697, 658.8352911772068, 794.4121350200838, 818.9058258300282, 822.2106777493614, 826.404988408345, 812.4028838803504, 812.8049268175654, 813.9378111564406, 814.6822739131743, 815.5392203405087, 868.405142477405, 873.9344549158807, 875.6453636277317, 876.198278575103, 877.4165180155221, 698.3156506623512, 830.4602008694336, 858.4076986879096, 866.4151697604092, 869.6564856881496, 632.9778457754003, 635.7202830754453, 635.8601107756333, 635.9809205723835, 636.3032479435011, 15820.525384238492, 15848.52454426369, 15855.445059422866, 15863.286152123066, 15879.36482540697, 14334.42662293507, 14504.637384065378, 14712.779308310384, 14868.985965802553, 15134.0, 12487.439070116236, 13111.082224244306, 13681.179129252278, 14110.435582576685, 14173.220472873987, 4526.705764125354, 4535.954640453586, 4596.655250856199, 4607.262837945913, 4833.347498087748, 80003.5999820003, 81230.18769812286, 81710.59144704239, 82866.17133828645, 83600.58199709024, 11611.129165312635, 11659.183857130089, 11914.582989595323, 12107.970822480187, 12522.87477125217, 22878.199263025715, 23033.88483057574, 23757.16849910245, 23785.52428951446, 23807.761922380556, 8430.915690843012, 8648.524331161721, 8792.912070879209, 8891.155340242667, 9123.224525915239, 4606.95393046072, 4841.636877234221, 4910.189818679878, 4982.800687972441, 5108.055009823194, 3508.5789705235024, 3646.872359467459, 3651.050726811048, 3666.6150054244454, 3669.119411341312, 601.0, 618.9690515474298, 622.9875402491925, 623.1182876230174, 624.3693869192058, 651.5817418688268, 733.4462480826942, 735.1729304532402, 749.5015814483417, 780.5667854340895, 9556.95221523888, 10058.899411005796, 10202.33684810485, 10260.486975651187, 10864.837027444595, 666.0641798273433, 677.6103740349221, 733.2081352139676, 736.9631518424058, 758.7382353088176, 4393.824247030147, 5000.3249561309485, 5013.89972200554, 5026.648134630614, 5049.596032317406, 119769.40115299542, 120247.0, 120955.39522302509, 122182.0, 129915.0, 105189.47405262924, 106463.0, 109608.4519577397, 112161.0, 114276.0, 93619.0, 94560.52719736495, 94630.0, 95530.0, 96152.0, 9061.723486730889, 9401.764955876159, 9544.141027307576, 9590.229346657085, 9637.614495420105, 45969.77015115037, 49211.0, 49323.0, 50147.0, 51246.48753512566, 73623.0, 74968.0, 77890.0, 81571.0, 83704.0, 12564.623061308175, 12668.809967850673, 12894.742105158031, 12996.285204313854, 13223.735525289248, 14951.476698315506, 14953.551393458214, 15273.694526109637, 15448.382064717734, 16236.889204403353, 14816.555503334917, 15272.083674979536, 15676.817602040526, 15870.52388428349, 15895.352195432788, 14146.080504767157, 14450.0, 14663.648476623095, 14745.778813318024, 14810.519527910717, 14005.439782408997, 14670.19313937701, 14792.408303668164, 14806.777898331318, 14862.777058344349, 11201.60794372193, 11386.601468948547, 11646.0, 11835.704107397383, 12135.150539462153, 10818.56725730962, 11694.88305116938, 11798.587049453228, 11999.82000270014, 12139.696507587381], "value": 7883.917949225614, "unit": "score"}], "name": "dromaeo_css", "value": 7305.723027150688, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 127.0, 111.0, 111.0, 113.0, 110.0, 111.0, 110.0, 111.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 120.0, 156.0, 180.0, 128.0, 151.0, 148.0, 124.0, 192.0, 118.0], "value": 146.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 159.0, 163.0, 163.0, 161.0, 161.0, 162.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 168.0, 74.0, 76.0, 74.0, 74.0, 167.0, 76.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 151.0, 86.0, 84.0, 85.0, 147.0, 86.0, 85.0, 150.0], "value": 104.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 116.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 51.0, 52.0, 50.0, 53.0, 51.0, 51.0, 49.0, 52.0], "value": 51.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 61.0, 61.0, 61.0, 60.0, 60.0, 61.0, 61.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 79.0, 87.0, 88.0, 79.0, 78.0, 78.0, 86.0, 79.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 123.0, 128.0, 146.0, 126.0, 139.0, 125.0, 135.0, 146.0, 125.0], "value": 131.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 166.0, 163.0, 165.0, 164.0, 165.0, 167.0, 162.0], "value": 164.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 66.0, 65.0, 66.0, 66.0, 65.0, 65.0, 63.0, 63.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1531.8999999999999, "alertThreshold": 2.0}]} 02:33:07 INFO - Return code: 0 02:33:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:33:07 INFO - # TBPL SUCCESS # 02:33:07 INFO - Running post-action listener: _resource_record_post_action 02:33:07 INFO - [mozharness: 2016-08-24 09:33:07.720459Z] Finished run-tests step (success) 02:33:07 INFO - Running post-run listener: _resource_record_post_run 02:33:07 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 406671360; Read time: 12; Write time: 625244 02:33:07 INFO - TinderboxPrint: CPU usage
13.4% 02:33:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 02:33:07 INFO - TinderboxPrint: I/O write bytes / time
406,671,360 / 625,244 02:33:07 INFO - TinderboxPrint: CPU idle
8,281.2 (86.6%) 02:33:07 INFO - TinderboxPrint: CPU user
1,205.4 (12.6%) 02:33:07 INFO - TinderboxPrint: Swap in / out
0 / 0 02:33:07 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 117985280; Read time: 0; Write time: 231372 02:33:07 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 288686080; Read time: 0; Write time: 393872 02:33:08 INFO - Running post-run listener: _upload_blobber_files 02:33:08 INFO - Blob upload gear active. 02:33:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:33:08 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 02:33:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:33:08 INFO - (blobuploader) - INFO - Open directory for files ... 02:33:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:33:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:33:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:33:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:33:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:33:12 INFO - (blobuploader) - INFO - Done attempting. 02:33:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:33:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:33:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:33:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:33:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:33:12 INFO - (blobuploader) - INFO - Done attempting. 02:33:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:33:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:33:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:33:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:33:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:33:13 INFO - (blobuploader) - INFO - Done attempting. 02:33:13 INFO - (blobuploader) - INFO - Iteration through files over. 02:33:13 INFO - Return code: 0 02:33:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:33:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:33:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34b8380dd3551f59e9cde083f1187253142cf54e78c9e12489cf3306d5efa22c4dc5f56ebe139dff44f15690bf8efec39cf88ad018ba89a4ace8b8ad4590d3a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5436f0aee4793da33a9a76aa56dae7d6cc892201a03a06b291c2bdaf2fee0d13e752eaa0742c47abf767efa7069ee73124933791c77079ac70ceae3b56204257", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/26f54cec3345d74baf7c6ccbb728a2ffab0d3a92e874e9197c90350df85735171c6913d01a767b05552253ddcd8edb16885b7fbc17ade85bbaa57604bdf58bf0"} 02:33:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:33:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:33:13 INFO - Contents: 02:33:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34b8380dd3551f59e9cde083f1187253142cf54e78c9e12489cf3306d5efa22c4dc5f56ebe139dff44f15690bf8efec39cf88ad018ba89a4ace8b8ad4590d3a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5436f0aee4793da33a9a76aa56dae7d6cc892201a03a06b291c2bdaf2fee0d13e752eaa0742c47abf767efa7069ee73124933791c77079ac70ceae3b56204257", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/26f54cec3345d74baf7c6ccbb728a2ffab0d3a92e874e9197c90350df85735171c6913d01a767b05552253ddcd8edb16885b7fbc17ade85bbaa57604bdf58bf0"} 02:33:13 INFO - Running post-run listener: copy_logs_to_upload_dir 02:33:13 INFO - Copying logs to upload dir... 02:33:13 INFO - mkdir: /builds/slave/test/build/upload/logs 02:33:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.486384 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-24 02:33:13.246228) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 02:33:13.249562) ========= 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=745a4373a2a16df560f216e000000264-1472029950.144851-823051165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34b8380dd3551f59e9cde083f1187253142cf54e78c9e12489cf3306d5efa22c4dc5f56ebe139dff44f15690bf8efec39cf88ad018ba89a4ace8b8ad4590d3a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5436f0aee4793da33a9a76aa56dae7d6cc892201a03a06b291c2bdaf2fee0d13e752eaa0742c47abf767efa7069ee73124933791c77079ac70ceae3b56204257", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/26f54cec3345d74baf7c6ccbb728a2ffab0d3a92e874e9197c90350df85735171c6913d01a767b05552253ddcd8edb16885b7fbc17ade85bbaa57604bdf58bf0"} build_url:https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011364 build_url: 'https://queue.taskcluster.net/v1/task/RjM9UiK0Qri2OmFUl2GlaA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34b8380dd3551f59e9cde083f1187253142cf54e78c9e12489cf3306d5efa22c4dc5f56ebe139dff44f15690bf8efec39cf88ad018ba89a4ace8b8ad4590d3a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5436f0aee4793da33a9a76aa56dae7d6cc892201a03a06b291c2bdaf2fee0d13e752eaa0742c47abf767efa7069ee73124933791c77079ac70ceae3b56204257", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/26f54cec3345d74baf7c6ccbb728a2ffab0d3a92e874e9197c90350df85735171c6913d01a767b05552253ddcd8edb16885b7fbc17ade85bbaa57604bdf58bf0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 02:33:13.274530) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 02:33:13.274836) ========= 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=745a4373a2a16df560f216e000000264-1472029950.144851-823051165 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 02:33:13.358950) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 02:33:13.359287) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 02:33:13.359588) ========= ========= Total master_lag: 0.25 =========